builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1494020229.1 results: success (0) revision: ff83fde8be946eabcf27ea97d4676f601c122194 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.102354) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.102752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.103019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.119780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.120059) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1494020032.761234-736481675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-05 14:37:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-05-05 14:37:09 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.163205 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.308467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.308773) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1494020032.761234-736481675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018001 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.371784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:09.372083) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ff83fde8be946eabcf27ea97d4676f601c122194 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev ff83fde8be946eabcf27ea97d4676f601c122194 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1494020032.761234-736481675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-05 14:37:09,654 truncating revision to first 12 chars 2017-05-05 14:37:09,654 Setting DEBUG logging. 2017-05-05 14:37:09,654 attempt 1/10 2017-05-05 14:37:09,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ff83fde8be94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 14:37:10,160 unpacking tar archive at: mozilla-central-ff83fde8be94/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:10.164306) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:10.164598) ========= script_repo_revision: ff83fde8be946eabcf27ea97d4676f601c122194 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:10.168001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:10.168261) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 14:37:10.178198) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-05 14:37:10.178467) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1494020032.761234-736481675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:37:10 INFO - MultiFileLogger online at 20170505 14:37:10 in /builds/slave/test 14:37:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:37:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:37:10 INFO - {'append_to_log': False, 14:37:10 INFO - 'base_work_dir': '/builds/slave/test', 14:37:10 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:37:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:37:10 INFO - 'branch': 'Firefox-Non-PGO', 14:37:10 INFO - 'buildbot_json_path': 'buildprops.json', 14:37:10 INFO - 'config_files': ('talos/linux_config.py',), 14:37:10 INFO - 'default_actions': ('clobber', 14:37:10 INFO - 'read-buildbot-config', 14:37:10 INFO - 'download-and-extract', 14:37:10 INFO - 'populate-webroot', 14:37:10 INFO - 'create-virtualenv', 14:37:10 INFO - 'install', 14:37:10 INFO - 'run-tests'), 14:37:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:37:10 INFO - 'download_minidump_stackwalk': True, 14:37:10 INFO - 'download_symbols': 'ondemand', 14:37:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:37:10 INFO - 'tooltool.py': '/tools/tooltool.py', 14:37:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:37:10 INFO - '/tools/misc-python/virtualenv.py')}, 14:37:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:37:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:37:10 INFO - 'gecko_profile': False, 14:37:10 INFO - 'gecko_profile_interval': 0, 14:37:10 INFO - 'installer_path': 'installer.exe', 14:37:10 INFO - 'log_level': 'info', 14:37:10 INFO - 'log_name': 'talos', 14:37:10 INFO - 'log_to_console': True, 14:37:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:37:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:37:10 INFO - 'opt_config_files': (), 14:37:10 INFO - 'pip_index': False, 14:37:10 INFO - 'suite': 'dromaeojs', 14:37:10 INFO - 'system_bits': '32', 14:37:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:37:10 INFO - 'title': 'talos-linux64-ix-025', 14:37:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:37:10 INFO - 'use_talos_json': True, 14:37:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:37:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:37:10 INFO - 'work_dir': 'build'} 14:37:10 INFO - [mozharness: 2017-05-05 21:37:10.558820Z] Running clobber step. 14:37:10 INFO - Running pre-action listener: _resource_record_pre_action 14:37:10 INFO - Running main action method: clobber 14:37:10 INFO - rmtree: /builds/slave/test/build 14:37:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:37:11 INFO - Running post-action listener: _resource_record_post_action 14:37:11 INFO - [mozharness: 2017-05-05 21:37:11.496312Z] Finished clobber step (success) 14:37:11 INFO - [mozharness: 2017-05-05 21:37:11.496412Z] Running read-buildbot-config step. 14:37:11 INFO - Running pre-action listener: _resource_record_pre_action 14:37:11 INFO - Running main action method: read_buildbot_config 14:37:11 INFO - Using buildbot properties: 14:37:11 INFO - { 14:37:11 INFO - "project": "", 14:37:11 INFO - "product": "firefox", 14:37:11 INFO - "who": "kwierso@gmail.com", 14:37:11 INFO - "installer_path": "public/build/target.tar.bz2", 14:37:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:37:11 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:37:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:37:11 INFO - "stage_platform": "linux64", 14:37:11 INFO - "basedir": "/builds/slave/test", 14:37:11 INFO - "buildnumber": 587, 14:37:11 INFO - "platform": "ubuntu64_hw", 14:37:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:37:11 INFO - "slavebuilddir": "test", 14:37:11 INFO - "taskId": "dTsjuue9Sd-1P65UDEMiQw", 14:37:11 INFO - "branch": "mozilla-central", 14:37:11 INFO - "script_repo_revision": "production", 14:37:11 INFO - "revision": "ff83fde8be946eabcf27ea97d4676f601c122194", 14:37:11 INFO - "slavename": "talos-linux64-ix-025", 14:37:11 INFO - "repo_path": "mozilla-central" 14:37:11 INFO - } 14:37:11 INFO - Finding installer, test and symbols from parent task. 14:37:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTsjuue9Sd-1P65UDEMiQw'}, attempt #1 14:37:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTsjuue9Sd-1P65UDEMiQw'}, attempt #1 14:37:12 INFO - Task dependencies: WnUDgc1lSIy5CIwmv0vY0g 14:37:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g'}, attempt #1 14:37:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 14:37:12 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/test_packages.json 14:37:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.crashreporter-symbols.zip 14:37:12 INFO - Running post-action listener: _resource_record_post_action 14:37:12 INFO - [mozharness: 2017-05-05 21:37:12.903247Z] Finished read-buildbot-config step (success) 14:37:12 INFO - [mozharness: 2017-05-05 21:37:12.903464Z] Running download-and-extract step. 14:37:12 INFO - Running pre-action listener: _resource_record_pre_action 14:37:12 INFO - Running main action method: download_and_extract 14:37:12 INFO - mkdir: /builds/slave/test/build/tests 14:37:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:12 INFO - trying https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.test_packages.json 14:37:12 INFO - Downloading https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:37:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:37:13 INFO - Downloaded 986 bytes. 14:37:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:37:13 INFO - Using the following test package requirements: 14:37:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:37:13 INFO - u'common': [u'target.common.tests.zip'], 14:37:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:37:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:37:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:37:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:37:13 INFO - u'mozbase': [u'target.common.tests.zip'], 14:37:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:37:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:37:13 INFO - u'web-platform': [u'target.common.tests.zip', 14:37:13 INFO - u'target.web-platform.tests.zip'], 14:37:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:37:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:37:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip 14:37:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:37:13 INFO - Fetch https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip into memory 14:37:16 INFO - Content-Length response header: 58438136 14:37:16 INFO - Bytes received: 58438136 14:37:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:37:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip 14:37:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:37:25 INFO - Fetch https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.common.tests.zip into memory 14:37:27 INFO - Content-Length response header: 58438136 14:37:27 INFO - Bytes received: 58438136 14:37:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.talos.tests.zip 14:37:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:37:38 INFO - Fetch https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.talos.tests.zip into memory 14:37:39 INFO - Content-Length response header: 14408697 14:37:39 INFO - Bytes received: 14408697 14:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:39 INFO - trying https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 14:37:39 INFO - Downloading https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:37:42 INFO - Downloaded 58380545 bytes. 14:37:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 14:37:42 INFO - mkdir: /builds/slave/test/properties 14:37:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:37:42 INFO - Writing to file /builds/slave/test/properties/build_url 14:37:42 INFO - Contents: 14:37:42 INFO - build_url:https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 14:37:42 INFO - Running post-action listener: _resource_record_post_action 14:37:42 INFO - Running post-action listener: set_extra_try_arguments 14:37:42 INFO - [mozharness: 2017-05-05 21:37:42.183301Z] Finished download-and-extract step (success) 14:37:42 INFO - [mozharness: 2017-05-05 21:37:42.183505Z] Running populate-webroot step. 14:37:42 INFO - Running pre-action listener: _resource_record_pre_action 14:37:42 INFO - Running main action method: populate_webroot 14:37:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:37:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:37:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:37:42 INFO - '--tppagecycles', 14:37:42 INFO - '7'], 14:37:42 INFO - 'tests': ['tsvgm']}}, 14:37:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:37:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:37:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:37:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:37:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:37:42 INFO - 'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:37:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:37:42 INFO - 'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['damp', 'tps']}, 14:37:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:37:42 INFO - 'tests': ['damp', 'tps']}, 14:37:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['dromaeo_dom']}, 14:37:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:37:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:37:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:37:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['a11yr', 14:37:42 INFO - 'ts_paint', 14:37:42 INFO - 'tpaint', 14:37:42 INFO - 'sessionrestore', 14:37:42 INFO - 'sessionrestore_no_auto_restore', 14:37:42 INFO - 'tabpaint']}, 14:37:42 INFO - 'other-e10s': {'tests': ['a11yr', 14:37:42 INFO - 'ts_paint', 14:37:42 INFO - 'tpaint', 14:37:42 INFO - 'sessionrestore', 14:37:42 INFO - 'sessionrestore_no_auto_restore', 14:37:42 INFO - 'tabpaint']}, 14:37:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:37:42 INFO - 'ts_paint', 14:37:42 INFO - 'tpaint', 14:37:42 INFO - 'sessionrestore', 14:37:42 INFO - 'sessionrestore_no_auto_restore', 14:37:42 INFO - 'tabpaint']}, 14:37:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:37:42 INFO - 'ts_paint', 14:37:42 INFO - 'tpaint', 14:37:42 INFO - 'sessionrestore', 14:37:42 INFO - 'sessionrestore_no_auto_restore', 14:37:42 INFO - 'tabpaint']}, 14:37:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['a11yr', 14:37:42 INFO - 'ts_paint', 14:37:42 INFO - 'tpaint', 14:37:42 INFO - 'sessionrestore', 14:37:42 INFO - 'sessionrestore_no_auto_restore', 14:37:42 INFO - 'tabpaint']}, 14:37:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['a11yr', 14:37:42 INFO - 'ts_paint', 14:37:42 INFO - 'tpaint', 14:37:42 INFO - 'sessionrestore', 14:37:42 INFO - 'sessionrestore_no_auto_restore', 14:37:42 INFO - 'tabpaint']}, 14:37:42 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:37:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:37:42 INFO - 'bloom_basic_ref']}, 14:37:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['tsvgx', 14:37:42 INFO - 'tsvgr_opacity', 14:37:42 INFO - 'tart', 14:37:42 INFO - 'tscrollx', 14:37:42 INFO - 'cart', 14:37:42 INFO - 'tsvg_static']}, 14:37:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:37:42 INFO - 'tsvgr_opacity', 14:37:42 INFO - 'tart', 14:37:42 INFO - 'tscrollx', 14:37:42 INFO - 'cart', 14:37:42 INFO - 'tsvg_static']}, 14:37:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:37:42 INFO - 'talos_options': ['--disable-e10s'], 14:37:42 INFO - 'tests': ['tp5o']}, 14:37:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:37:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:37:42 INFO - 'talos_options': ['--disable-e10s', 14:37:42 INFO - '--xperf_path', 14:37:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:42 INFO - 'tests': ['tp5n']}, 14:37:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:37:42 INFO - 'talos_options': ['--xperf_path', 14:37:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:42 INFO - 'tests': ['tp5n']}}, 14:37:42 INFO - 'talos.zip': {'path': '', 14:37:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:37:42 INFO - Running post-action listener: _resource_record_post_action 14:37:42 INFO - [mozharness: 2017-05-05 21:37:42.200432Z] Finished populate-webroot step (success) 14:37:42 INFO - [mozharness: 2017-05-05 21:37:42.200521Z] Running create-virtualenv step. 14:37:42 INFO - Running pre-action listener: _resource_record_pre_action 14:37:42 INFO - Running main action method: create_virtualenv 14:37:42 INFO - Creating virtualenv /builds/slave/test/build/venv 14:37:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:37:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:37:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:37:42 INFO - Using real prefix '/usr' 14:37:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:37:42 INFO - Installing distribute.............................................................................................................................................................................................done. 14:37:44 INFO - Installing pip.................done. 14:37:44 INFO - Return code: 0 14:37:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:37:44 INFO - Reading from file tmpfile_stdout 14:37:44 INFO - Output received: 14:37:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:37:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:37:44 INFO - Using env: {'DISPLAY': ':0', 14:37:44 INFO - 'HOME': '/home/cltbld', 14:37:44 INFO - 'LANG': 'en_US.UTF-8', 14:37:44 INFO - 'LANGUAGE': 'en_US:en', 14:37:44 INFO - 'LOGNAME': 'cltbld', 14:37:44 INFO - 'MAIL': '/var/mail/cltbld', 14:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:44 INFO - 'MOZ_NO_REMOTE': '1', 14:37:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:44 INFO - 'NO_EM_RESTART': '1', 14:37:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:44 INFO - 'PWD': '/builds/slave/test', 14:37:44 INFO - 'SHELL': '/bin/bash', 14:37:44 INFO - 'SHLVL': '1', 14:37:44 INFO - 'TERM': 'linux', 14:37:44 INFO - 'TMOUT': '86400', 14:37:44 INFO - 'USER': 'cltbld', 14:37:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:44 INFO - '_': '/tools/buildbot/bin/python'} 14:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:37:45 INFO - Cleaning up... 14:37:45 INFO - Return code: 0 14:37:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:37:45 INFO - Using env: {'DISPLAY': ':0', 14:37:45 INFO - 'HOME': '/home/cltbld', 14:37:45 INFO - 'LANG': 'en_US.UTF-8', 14:37:45 INFO - 'LANGUAGE': 'en_US:en', 14:37:45 INFO - 'LOGNAME': 'cltbld', 14:37:45 INFO - 'MAIL': '/var/mail/cltbld', 14:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:45 INFO - 'MOZ_NO_REMOTE': '1', 14:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:45 INFO - 'NO_EM_RESTART': '1', 14:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:45 INFO - 'PWD': '/builds/slave/test', 14:37:45 INFO - 'SHELL': '/bin/bash', 14:37:45 INFO - 'SHLVL': '1', 14:37:45 INFO - 'TERM': 'linux', 14:37:45 INFO - 'TMOUT': '86400', 14:37:45 INFO - 'USER': 'cltbld', 14:37:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:45 INFO - '_': '/tools/buildbot/bin/python'} 14:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:45 INFO - Downloading/unpacking psutil>=3.1.1 14:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:37:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:46 INFO - Installing collected packages: psutil 14:37:46 INFO - Running setup.py install for psutil 14:37:46 INFO - building 'psutil._psutil_linux' extension 14:37:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:37:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:37:46 INFO - building 'psutil._psutil_posix' extension 14:37:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:37:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:37:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:37:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:37:47 INFO - Successfully installed psutil 14:37:47 INFO - Cleaning up... 14:37:47 INFO - Return code: 0 14:37:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:37:47 INFO - Using env: {'DISPLAY': ':0', 14:37:47 INFO - 'HOME': '/home/cltbld', 14:37:47 INFO - 'LANG': 'en_US.UTF-8', 14:37:47 INFO - 'LANGUAGE': 'en_US:en', 14:37:47 INFO - 'LOGNAME': 'cltbld', 14:37:47 INFO - 'MAIL': '/var/mail/cltbld', 14:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:47 INFO - 'MOZ_NO_REMOTE': '1', 14:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:47 INFO - 'NO_EM_RESTART': '1', 14:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:47 INFO - 'PWD': '/builds/slave/test', 14:37:47 INFO - 'SHELL': '/bin/bash', 14:37:47 INFO - 'SHLVL': '1', 14:37:47 INFO - 'TERM': 'linux', 14:37:47 INFO - 'TMOUT': '86400', 14:37:47 INFO - 'USER': 'cltbld', 14:37:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:47 INFO - '_': '/tools/buildbot/bin/python'} 14:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:37:48 INFO - Installing collected packages: mozsystemmonitor 14:37:48 INFO - Running setup.py install for mozsystemmonitor 14:37:48 INFO - Successfully installed mozsystemmonitor 14:37:48 INFO - Cleaning up... 14:37:48 INFO - Return code: 0 14:37:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:37:48 INFO - Using env: {'DISPLAY': ':0', 14:37:48 INFO - 'HOME': '/home/cltbld', 14:37:48 INFO - 'LANG': 'en_US.UTF-8', 14:37:48 INFO - 'LANGUAGE': 'en_US:en', 14:37:48 INFO - 'LOGNAME': 'cltbld', 14:37:48 INFO - 'MAIL': '/var/mail/cltbld', 14:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:48 INFO - 'MOZ_NO_REMOTE': '1', 14:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:48 INFO - 'NO_EM_RESTART': '1', 14:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:48 INFO - 'PWD': '/builds/slave/test', 14:37:48 INFO - 'SHELL': '/bin/bash', 14:37:48 INFO - 'SHLVL': '1', 14:37:48 INFO - 'TERM': 'linux', 14:37:48 INFO - 'TMOUT': '86400', 14:37:48 INFO - 'USER': 'cltbld', 14:37:48 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:48 INFO - '_': '/tools/buildbot/bin/python'} 14:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:48 INFO - Downloading/unpacking jsonschema==2.5.1 14:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:37:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:50 INFO - Downloading functools32-3.2.3-2.tar.gz 14:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:37:50 INFO - warning: no files found matching '*.txt' 14:37:50 INFO - no previously-included directories found matching 'build' 14:37:50 INFO - no previously-included directories found matching 'dist' 14:37:50 INFO - no previously-included directories found matching '.git*' 14:37:50 INFO - Installing collected packages: jsonschema, functools32 14:37:50 INFO - Running setup.py install for functools32 14:37:50 INFO - warning: no files found matching '*.txt' 14:37:50 INFO - no previously-included directories found matching 'build' 14:37:50 INFO - no previously-included directories found matching 'dist' 14:37:50 INFO - no previously-included directories found matching '.git*' 14:37:50 INFO - Successfully installed jsonschema functools32 14:37:50 INFO - Cleaning up... 14:37:50 INFO - Return code: 0 14:37:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:37:50 INFO - Using env: {'DISPLAY': ':0', 14:37:50 INFO - 'HOME': '/home/cltbld', 14:37:50 INFO - 'LANG': 'en_US.UTF-8', 14:37:50 INFO - 'LANGUAGE': 'en_US:en', 14:37:50 INFO - 'LOGNAME': 'cltbld', 14:37:50 INFO - 'MAIL': '/var/mail/cltbld', 14:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:50 INFO - 'MOZ_NO_REMOTE': '1', 14:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:50 INFO - 'NO_EM_RESTART': '1', 14:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:50 INFO - 'PWD': '/builds/slave/test', 14:37:50 INFO - 'SHELL': '/bin/bash', 14:37:50 INFO - 'SHLVL': '1', 14:37:50 INFO - 'TERM': 'linux', 14:37:50 INFO - 'TMOUT': '86400', 14:37:50 INFO - 'USER': 'cltbld', 14:37:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:50 INFO - '_': '/tools/buildbot/bin/python'} 14:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:37:50 INFO - Cleaning up... 14:37:50 INFO - Return code: 0 14:37:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:37:50 INFO - Using env: {'DISPLAY': ':0', 14:37:50 INFO - 'HOME': '/home/cltbld', 14:37:50 INFO - 'LANG': 'en_US.UTF-8', 14:37:50 INFO - 'LANGUAGE': 'en_US:en', 14:37:50 INFO - 'LOGNAME': 'cltbld', 14:37:50 INFO - 'MAIL': '/var/mail/cltbld', 14:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:50 INFO - 'MOZ_NO_REMOTE': '1', 14:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:50 INFO - 'NO_EM_RESTART': '1', 14:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:50 INFO - 'PWD': '/builds/slave/test', 14:37:50 INFO - 'SHELL': '/bin/bash', 14:37:50 INFO - 'SHLVL': '1', 14:37:50 INFO - 'TERM': 'linux', 14:37:50 INFO - 'TMOUT': '86400', 14:37:50 INFO - 'USER': 'cltbld', 14:37:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:50 INFO - '_': '/tools/buildbot/bin/python'} 14:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:50 INFO - Downloading/unpacking blobuploader==1.2.4 14:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:51 INFO - Downloading blobuploader-1.2.4.tar.gz 14:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:37:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:37:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:52 INFO - Downloading docopt-0.6.1.tar.gz 14:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:37:52 INFO - Installing collected packages: blobuploader, requests, docopt 14:37:52 INFO - Running setup.py install for blobuploader 14:37:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:37:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:37:52 INFO - Running setup.py install for requests 14:37:52 INFO - Running setup.py install for docopt 14:37:53 INFO - Successfully installed blobuploader requests docopt 14:37:53 INFO - Cleaning up... 14:37:53 INFO - Return code: 0 14:37:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:53 INFO - Using env: {'DISPLAY': ':0', 14:37:53 INFO - 'HOME': '/home/cltbld', 14:37:53 INFO - 'LANG': 'en_US.UTF-8', 14:37:53 INFO - 'LANGUAGE': 'en_US:en', 14:37:53 INFO - 'LOGNAME': 'cltbld', 14:37:53 INFO - 'MAIL': '/var/mail/cltbld', 14:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:53 INFO - 'MOZ_NO_REMOTE': '1', 14:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:53 INFO - 'NO_EM_RESTART': '1', 14:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:53 INFO - 'PWD': '/builds/slave/test', 14:37:53 INFO - 'SHELL': '/bin/bash', 14:37:53 INFO - 'SHLVL': '1', 14:37:53 INFO - 'TERM': 'linux', 14:37:53 INFO - 'TMOUT': '86400', 14:37:53 INFO - 'USER': 'cltbld', 14:37:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:53 INFO - '_': '/tools/buildbot/bin/python'} 14:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:53 INFO - Running setup.py (path:/tmp/pip-fuCqTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:53 INFO - Running setup.py (path:/tmp/pip-YjuZsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:53 INFO - Running setup.py (path:/tmp/pip-j6khKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:53 INFO - Running setup.py (path:/tmp/pip-3VwHGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:53 INFO - Running setup.py (path:/tmp/pip-GDkkZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:53 INFO - Running setup.py (path:/tmp/pip-ihn4Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:53 INFO - Running setup.py (path:/tmp/pip-5MQI4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:53 INFO - Running setup.py (path:/tmp/pip-XlB3wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:53 INFO - Running setup.py (path:/tmp/pip-PdoNoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:53 INFO - Running setup.py (path:/tmp/pip-Y786se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:53 INFO - Running setup.py (path:/tmp/pip-eA0vnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:54 INFO - Running setup.py (path:/tmp/pip-_pmYN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:54 INFO - Running setup.py (path:/tmp/pip-Xwy2is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:54 INFO - Running setup.py (path:/tmp/pip-3cG9TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:54 INFO - Running setup.py (path:/tmp/pip-FLn1BZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:54 INFO - Running setup.py (path:/tmp/pip-dUtFTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:54 INFO - Running setup.py (path:/tmp/pip-CcTLm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:37:54 INFO - Running setup.py install for manifestparser 14:37:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:37:54 INFO - Running setup.py install for mozcrash 14:37:54 INFO - Running setup.py install for mozdebug 14:37:54 INFO - Running setup.py install for mozdevice 14:37:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:37:54 INFO - Running setup.py install for mozfile 14:37:55 INFO - Running setup.py install for mozhttpd 14:37:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Running setup.py install for mozinfo 14:37:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Running setup.py install for mozInstall 14:37:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Running setup.py install for mozleak 14:37:55 INFO - Running setup.py install for mozlog 14:37:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Running setup.py install for moznetwork 14:37:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Running setup.py install for mozprocess 14:37:55 INFO - Running setup.py install for mozprofile 14:37:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Running setup.py install for mozrunner 14:37:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:37:55 INFO - Running setup.py install for mozscreenshot 14:37:56 INFO - Running setup.py install for moztest 14:37:56 INFO - Running setup.py install for mozversion 14:37:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:37:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:37:56 INFO - Cleaning up... 14:37:56 INFO - Return code: 0 14:37:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:56 INFO - Using env: {'DISPLAY': ':0', 14:37:56 INFO - 'HOME': '/home/cltbld', 14:37:56 INFO - 'LANG': 'en_US.UTF-8', 14:37:56 INFO - 'LANGUAGE': 'en_US:en', 14:37:56 INFO - 'LOGNAME': 'cltbld', 14:37:56 INFO - 'MAIL': '/var/mail/cltbld', 14:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:56 INFO - 'MOZ_NO_REMOTE': '1', 14:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:56 INFO - 'NO_EM_RESTART': '1', 14:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:56 INFO - 'PWD': '/builds/slave/test', 14:37:56 INFO - 'SHELL': '/bin/bash', 14:37:56 INFO - 'SHLVL': '1', 14:37:56 INFO - 'TERM': 'linux', 14:37:56 INFO - 'TMOUT': '86400', 14:37:56 INFO - 'USER': 'cltbld', 14:37:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:56 INFO - '_': '/tools/buildbot/bin/python'} 14:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:37:56 INFO - Running setup.py (path:/tmp/pip-bZT9WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:37:56 INFO - Running setup.py (path:/tmp/pip-kehXsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:37:56 INFO - Running setup.py (path:/tmp/pip-1NIH_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:37:56 INFO - Running setup.py (path:/tmp/pip-g9jUmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:37:56 INFO - Running setup.py (path:/tmp/pip-02YT0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:37:56 INFO - Running setup.py (path:/tmp/pip-Bg8uJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:37:56 INFO - Running setup.py (path:/tmp/pip-40rULx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:37:57 INFO - Running setup.py (path:/tmp/pip-VU9Rck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:37:57 INFO - Running setup.py (path:/tmp/pip-PS8252-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:37:57 INFO - Running setup.py (path:/tmp/pip-LBUSK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:37:57 INFO - Running setup.py (path:/tmp/pip-BKuAj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:37:57 INFO - Running setup.py (path:/tmp/pip-0rsO81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:37:57 INFO - Running setup.py (path:/tmp/pip-Fb6oSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:37:57 INFO - Running setup.py (path:/tmp/pip-_1lcQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:57 INFO - Running setup.py (path:/tmp/pip-9vaOJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:37:57 INFO - Running setup.py (path:/tmp/pip-3Cx5ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:37:57 INFO - Running setup.py (path:/tmp/pip-WJIAxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:37:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:37:58 INFO - Downloading blessings-1.6.tar.gz 14:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:37:58 INFO - Installing collected packages: blessings 14:37:58 INFO - Running setup.py install for blessings 14:37:59 INFO - Successfully installed blessings 14:37:59 INFO - Cleaning up... 14:37:59 INFO - Return code: 0 14:37:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:59 INFO - Reading from file tmpfile_stdout 14:37:59 INFO - Current package versions: 14:37:59 INFO - argparse == 1.2.1 14:37:59 INFO - blessings == 1.6 14:37:59 INFO - blobuploader == 1.2.4 14:37:59 INFO - docopt == 0.6.1 14:37:59 INFO - functools32 == 3.2.3-2 14:37:59 INFO - jsonschema == 2.5.1 14:37:59 INFO - manifestparser == 1.1 14:37:59 INFO - mozInstall == 1.12 14:37:59 INFO - mozcrash == 1.0 14:37:59 INFO - mozdebug == 0.1 14:37:59 INFO - mozdevice == 0.50 14:37:59 INFO - mozfile == 1.2 14:37:59 INFO - mozhttpd == 0.7 14:37:59 INFO - mozinfo == 0.9 14:37:59 INFO - mozleak == 0.1 14:37:59 INFO - mozlog == 3.4 14:37:59 INFO - moznetwork == 0.27 14:37:59 INFO - mozprocess == 0.25 14:37:59 INFO - mozprofile == 0.28 14:37:59 INFO - mozrunner == 6.13 14:37:59 INFO - mozscreenshot == 0.1 14:37:59 INFO - mozsystemmonitor == 0.3 14:37:59 INFO - moztest == 0.8 14:37:59 INFO - mozversion == 1.4 14:37:59 INFO - psutil == 3.1.1 14:37:59 INFO - requests == 1.2.3 14:37:59 INFO - wsgiref == 0.1.2 14:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:37:59 INFO - Using env: {'DISPLAY': ':0', 14:37:59 INFO - 'HOME': '/home/cltbld', 14:37:59 INFO - 'LANG': 'en_US.UTF-8', 14:37:59 INFO - 'LANGUAGE': 'en_US:en', 14:37:59 INFO - 'LOGNAME': 'cltbld', 14:37:59 INFO - 'MAIL': '/var/mail/cltbld', 14:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:59 INFO - 'MOZ_NO_REMOTE': '1', 14:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:59 INFO - 'NO_EM_RESTART': '1', 14:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:59 INFO - 'PWD': '/builds/slave/test', 14:37:59 INFO - 'SHELL': '/bin/bash', 14:37:59 INFO - 'SHLVL': '1', 14:37:59 INFO - 'TERM': 'linux', 14:37:59 INFO - 'TMOUT': '86400', 14:37:59 INFO - 'USER': 'cltbld', 14:37:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:59 INFO - '_': '/tools/buildbot/bin/python'} 14:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:37:59 INFO - Cleaning up... 14:37:59 INFO - Return code: 0 14:37:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2983a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b28b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:37:59 INFO - Using env: {'DISPLAY': ':0', 14:37:59 INFO - 'HOME': '/home/cltbld', 14:37:59 INFO - 'LANG': 'en_US.UTF-8', 14:37:59 INFO - 'LANGUAGE': 'en_US:en', 14:37:59 INFO - 'LOGNAME': 'cltbld', 14:37:59 INFO - 'MAIL': '/var/mail/cltbld', 14:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:37:59 INFO - 'MOZ_NO_REMOTE': '1', 14:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:37:59 INFO - 'NO_EM_RESTART': '1', 14:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:37:59 INFO - 'PWD': '/builds/slave/test', 14:37:59 INFO - 'SHELL': '/bin/bash', 14:37:59 INFO - 'SHLVL': '1', 14:37:59 INFO - 'TERM': 'linux', 14:37:59 INFO - 'TMOUT': '86400', 14:37:59 INFO - 'USER': 'cltbld', 14:37:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:37:59 INFO - '_': '/tools/buildbot/bin/python'} 14:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:37:59 INFO - Cleaning up... 14:37:59 INFO - Return code: 0 14:37:59 INFO - Running post-action listener: _resource_record_post_action 14:37:59 INFO - Running post-action listener: _start_resource_monitoring 14:37:59 INFO - Starting resource monitoring. 14:37:59 INFO - [mozharness: 2017-05-05 21:37:59.778407Z] Finished create-virtualenv step (success) 14:37:59 INFO - [mozharness: 2017-05-05 21:37:59.778916Z] Running install step. 14:37:59 INFO - Running pre-action listener: _resource_record_pre_action 14:37:59 INFO - Running main action method: install 14:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:37:59 INFO - Reading from file tmpfile_stdout 14:37:59 INFO - Detecting whether we're running mozinstall >=1.0... 14:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:38:00 INFO - Reading from file tmpfile_stdout 14:38:00 INFO - Output received: 14:38:00 INFO - Usage: mozinstall [options] installer 14:38:00 INFO - Options: 14:38:00 INFO - -h, --help show this help message and exit 14:38:00 INFO - -d DEST, --destination=DEST 14:38:00 INFO - Directory to install application into. [default: 14:38:00 INFO - "/builds/slave/test"] 14:38:00 INFO - --app=APP Application being installed. [default: firefox] 14:38:00 INFO - mkdir: /builds/slave/test/build/application 14:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:38:14 INFO - Reading from file tmpfile_stdout 14:38:15 INFO - Output received: 14:38:15 INFO - /builds/slave/test/build/application/firefox/firefox 14:38:15 INFO - Running post-action listener: _resource_record_post_action 14:38:15 INFO - [mozharness: 2017-05-05 21:38:15.121083Z] Finished install step (success) 14:38:15 INFO - [mozharness: 2017-05-05 21:38:15.121389Z] Running run-tests step. 14:38:15 INFO - Running pre-action listener: _resource_record_pre_action 14:38:15 INFO - Running main action method: run_tests 14:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:38:15 INFO - Python 2.7.3 14:38:15 INFO - Return code: 0 14:38:15 INFO - grabbing minidump binary from tooltool 14:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26290>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b26b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b27040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:38:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:38:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:38:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:38:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:38:15 INFO - Return code: 0 14:38:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:38:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:38:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:38:15 INFO - ENV: RUST_BACKTRACE is now 1 14:38:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:38:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:38:15 INFO - Using env: {'DISPLAY': ':0', 14:38:15 INFO - 'HOME': '/home/cltbld', 14:38:15 INFO - 'LANG': 'en_US.UTF-8', 14:38:15 INFO - 'LANGUAGE': 'en_US:en', 14:38:15 INFO - 'LOGNAME': 'cltbld', 14:38:15 INFO - 'MAIL': '/var/mail/cltbld', 14:38:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:38:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:15 INFO - 'MOZ_NO_REMOTE': '1', 14:38:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:15 INFO - 'NO_EM_RESTART': '1', 14:38:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:15 INFO - 'PWD': '/builds/slave/test', 14:38:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:38:15 INFO - 'RUST_BACKTRACE': '1', 14:38:15 INFO - 'SHELL': '/bin/bash', 14:38:15 INFO - 'SHLVL': '1', 14:38:15 INFO - 'TERM': 'linux', 14:38:15 INFO - 'TMOUT': '86400', 14:38:15 INFO - 'USER': 'cltbld', 14:38:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1494020032.761234-736481675', 14:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:15 INFO - '_': '/tools/buildbot/bin/python'} 14:38:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:38:15 INFO - mozversion application_buildid: 20170505210647 14:38:15 INFO - mozversion application_changeset: ff83fde8be946eabcf27ea97d4676f601c122194 14:38:15 INFO - mozversion application_display_name: Nightly 14:38:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:38:15 INFO - mozversion application_name: Firefox 14:38:15 INFO - mozversion application_remotingname: firefox 14:38:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:38:15 INFO - mozversion application_vendor: Mozilla 14:38:15 INFO - mozversion application_version: 55.0a1 14:38:15 INFO - mozversion platform_buildid: 20170505210647 14:38:15 INFO - mozversion platform_changeset: ff83fde8be946eabcf27ea97d4676f601c122194 14:38:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:38:15 INFO - mozversion platform_version: 55.0a1 14:38:15 INFO - using testdate: 1494020295 14:38:15 INFO - actual date: 1494020295 14:38:15 INFO - starting webserver on 'localhost:54733' 14:38:15 INFO - SUITE-START | Running 2 tests 14:38:15 INFO - TEST-START | dromaeo_css 14:38:15 INFO - operating with platform_type : linux_ 14:38:15 INFO - Initialising browser for dromaeo_css test... 14:38:15 INFO - TEST-INFO | started process 26457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzjXCpz/profile http://localhost:54733/getInfo.html) 14:38:19 INFO - PID 26457 | __metrics Screen width/height:1600/1200 14:38:19 INFO - PID 26457 | colorDepth:24 14:38:19 INFO - PID 26457 | Browser inner width/height: 1024/695 14:38:19 INFO - PID 26457 | __metrics 14:38:20 INFO - PID 26457 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:38:20 INFO - PID 26457 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:38:21 INFO - TEST-INFO | 26457: exit 0 14:38:21 INFO - Browser initialized. 14:38:21 INFO - Running cycle 1/1 for dromaeo_css test... 14:38:21 INFO - TEST-INFO | started process 26552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzjXCpz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:34 INFO - PID 26552 | RSS: Main: 171724800 14:38:34 INFO - PID 26552 | 14:41:40 INFO - PID 26552 | Cycle 1(1): loaded http://localhost:54733/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54733/tests/dromaeo/cssquery-ext.html) 14:41:42 INFO - PID 26552 | RSS: Main: 309825536 14:41:42 INFO - PID 26552 | 14:44:44 INFO - PID 26552 | Cycle 1(1): loaded http://localhost:54733/tests/dromaeo/cssquery-ext.html (next: http://localhost:54733/tests/dromaeo/cssquery-jquery.html) 14:44:45 INFO - PID 26552 | RSS: Main: 232599552 14:44:45 INFO - PID 26552 | 14:47:47 INFO - PID 26552 | Cycle 1(1): loaded http://localhost:54733/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54733/tests/dromaeo/cssquery-mootools.html) 14:47:47 INFO - PID 26552 | RSS: Main: 227135488 14:47:47 INFO - PID 26552 | 14:50:50 INFO - PID 26552 | Cycle 1(1): loaded http://localhost:54733/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54733/tests/dromaeo/cssquery-prototype.html) 14:50:50 INFO - PID 26552 | RSS: Main: 183640064 14:50:50 INFO - PID 26552 | 14:53:54 INFO - PID 26552 | Cycle 1(1): loaded http://localhost:54733/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54733/tests/dromaeo/cssquery-yui.html) 14:53:54 INFO - PID 26552 | RSS: Main: 186015744 14:53:54 INFO - PID 26552 | 14:56:56 INFO - PID 26552 | Cycle 1(1): loaded http://localhost:54733/tests/dromaeo/cssquery-yui.html (next: http://localhost:54733/tests/dromaeo/cssquery-dojo.html) 14:56:57 INFO - PID 26552 | RSS: Main: 275787776 14:56:57 INFO - PID 26552 | 14:56:57 INFO - PID 26552 | __start_tp_report 14:56:57 INFO - PID 26552 | _x_x_mozilla_page_load 14:56:57 INFO - PID 26552 | _x_x_mozilla_page_load_details 14:56:57 INFO - PID 26552 | |i|pagename|runs| 14:56:57 INFO - PID 26552 | |0;dojo.html;2644.2860427684527;2676.330917270682;2693.690225624053;2716.3344980479774;2727.509048371294;5052.570531504817;5182.714950677711;5211.973940130299;5234.895302093956;5281.181416880385;5124.0776660201145;5137.255098010786;5199.324087868572;5235.424103348629;5246.029484545362;4245.787710614472;4499.280115181572;4596.7012144210685;4626.491085980556;4638.4433867935895;4615.446146462429;4630.120277147348;4635.605973492257;4669.6731228814;4686.133065382898;4509.4814096379005;4558.361829343895;4567.543245675406;4601.700889442175;4651.279051746985;4633.4208223972;4635.46692130406;4636.698614590075;4689.085628302482;4707.623390128816;4575.931361029588;4611.7694115294435;4628.675992680513;4647.767611619405;4675.579197872174;5076.340075790161;5130.3074084998425;5137.17805151174;5173.379194496647;5185.377754669426;5519.365272993577;5559.833205003856;5608.943910560883;5611.186377975171;5616.017196990551;5471.343438787371;5480.369757477902;5498.917516237259;5501;5507.476789704971;5092.134337162691;5126.6667666601925;5179.249008893689;5195.818146364934;5228.346456692913;5633.887322253532;5667.518260947783;5698.116791897262;5730.942690573124;5740.167675687086;5509.5041446270025;5560.86097847549;5561.165825126263;5569.498745112959;5593.608447408642;5616.157576363578;5622.072358060956;5663;5673.063944449203;5675.602707810413;5406.999705054499;5448.536874365644;5492.47821456961;5500.669959802424;5618.887622247532;5613.382527921925;5626.662400255997;5628.662280263197;5630.296212973379;5631.211630371751;4733.739644319527;4738.07607516531;4742.976285118552;4746.501617330199;4747.192977193886;4042.8180731867137;4079.3880917862557;4083.509978802503;4118.155778065489;4137.668986481134;4704.2473204287835;4715.646326525524;4762.190427627312;4766.213574760126;4810.855674329776;5499.367572729107;5563;5625.803096891589;5637.267155269788;5638.351589567253;4661.254199328091;4666.743329116864;4667.8599642010795;4679.204535229019;4691.695039822401;4943.703377797344;4944.505549445099;4945.035718034948;4946.703197808143;4947.208446648591;5111.642185047085;5151.407588127264;5152.27868098459;5152.27868098474;5161.716105614228;5506.008918394567;5511.972440137773;5516.724163791875;5516.779328826802;5519.696416696959;4507.954920450754;5165.457626949116;5291.76187071575;5292.4442933492965;5297.682139071668;5505.9174112387545;5506.862328441821;5514.972425137848;5515.420880807618;5516.613837031369;5615.045442274904;5623.831285061455;5626.831195064155;5629.634073785191;5676.829695109153;5205.505476979681;5265.0259701955265;5270.683758974474;5270.8155214567305;5375.623706340675;5443.346798384219;5448.291722076105;5457.454254574511;5457.863553411196;5497.835064948058;5372.919406208832;5376.489233522809;5380.677159370451;5382.515573598395;5383.353997520166;5320.946790532045;5412.539934105645;5489.725513724218;5495.065838807493;5547.805826796042;5245.895082098413;5279.234510995807;5345.930813837171;5363.356397232357;5377.032134215879 14:56:57 INFO - PID 26552 | |1;ext.html;671.2817285504512;737.0308044920929;756.7086671631422;1051.5951358726888;1067.1782727299983;25867.22398328051;32263.19342016451;32781.83609081951;32793.34413311732;32842.343153136986;34236.82881585595;34628.82685586575;34630.8268458658;34681.82659086707;34748.82625586875;5232;6955.686994085266;7109.573425594481;7124.038254835583;7125.608091554963;5423.403425623178;5525.530329921961;5526.226328314039;5526.640768350045;6384.457321127709;7079;7132.714691412337;7133.714651413938;7142.285771422842;7149.821254468654;7001.509894307401;7102.289771022908;7104.751333703295;7106.040684507629;7106.680199391039;5294.947050529522;5435.646682965634;6899.896501552481;6941.028256044158;6942;29549.556756648668;30218.244543886358;30249.09252722422;30250;30302.393952120834;3021.6525099613605;3066.095501826944;3069.6162979627547;3070.6468756093113;3071.01727447217;24248.272551823473;24281.392965175834;24330;24343;24344.878275608684;2741.424300896814;2757.352022274764;2762.337039110599;2766.349907771672;2773.5978283149034;142299;142353;142862;143151.2842435802;143358;40642;40782.388264176065;40783.796081019405;40818.59181408207;40859.79570102131;43575.56424435778;43596.346054809204;43630.78184609057;43639.563604364186;43722.34416483755;10799.67600971972;10912.727181820517;10946.781064378667;10961.725956851142;10967.341959482457;8526.31789456842;8531.146885311544;8531.274841638531;8536.274416674529;8564.272036876935;10486.26596138263;10671.839922401015;11835.349055802013;12139.696507587381;12312.569060083033;5013.323201367769;5094.49055094495;5143.331366922351;5162.92255616166;5165.948340516622;870.2298465857762;907.4600612635471;909.5437338115136;914.1589737441569;939.7744541310036;20114.2674337813;21289.36131916045;21297;21437.142514299252;21438.142474301167;932.6222879733718;956.6316967967383;975.380633297861;980.8970058143935;991.9752006199758;10853.084589777689;11086.22396432242;11215.327080375204;11332.376719280353;11343.205975581795;158745.2062739679;159157;159518;159521.01197470157;159528;39897.20205595872;40379.19241615151;40382.192356152715;40385.19229615391;40492.797536012724;1165.7260543772206;1209.8608660004213;1213.375111817397;1215.0801733261426;1219.3171823778712;19675.606487869874;19794.307199247956;20056.398308050782;21114.57770844544;21283.893580532;29995.55006674858;30026.249343765707;30247.69752302449;30315;30426.695733042387;149291;149677;149694.251528746;150219;150719;28454.857725711237;28506.714932850406;28995.85502072476;29168.124956251348;29257.22056404638;29995.850020749756;30299.848500757354;30613.08160755181;34276.828615856764;35450.64549354473;25644.230673079837;26236.21291361262;26938.865305673346;27323.72676273212;27502.587461188497;25635.35911602225;26091.347716306485;26683.332916676463;26767.330816729736;26998.32504187411;29266.561001584567;29305;29369.55945660774;29369.7063029367;29383.853080734458;25621.743782561934;25777.613335800354;25846.566003408996;27539.862300688368;27840.44319113647;21617.351479455643;22387.32838014862;22533;22601.321960341214;22692.319230423112 14:56:57 INFO - PID 26552 | |2;jquery.html;386.95743468218507;399.3483271080027;426.5563813633821;431.8574870292804;433.42571093301376;16249.268782904768;17099.487015389528;17575.560610984732;17724.556886077855;17738.20178091986;18691.626167476643;18787.624247515043;19089.80910190901;19153.808461915378;19284.421467356;5327.467253274671;5370.838874833761;5450.972745136269;5457.918131228034;5508.9724551377185;5433.701146436944;5527.309086364205;5531.419200983899;5536.114221724525;5542.75057622406;5214.817481388152;5419.241306217133;5461.508464238218;5500.724963751816;5502.697351645658;5384;5426.186072089218;5428.61999660022;5439.918401223965;5446.645968012067;4725.22033864412;4872.269159626049;4912.673578133884;4919.311296418504;4938.827141050082;21228.469288267763;21493.892530537247;21804.781952180434;21953;22118.447038824157;1609.1712767924528;1641.9261133249033;1642.2117383655793;1642.581141808843;1643.2112585958687;14530.636734081627;14734.926325368411;14934.626634334229;15054.623634409118;15158.166300853449;2085.8644188127873;2103.074647155247;2158.4819643285655;2167.5231449081175;2175.2060497918305;80715.5964220181;80936.19063809345;81032;82196;82274.58862705708;10580.841287380696;10828.187885908588;11116.388598627153;11198.776024479464;11206.831897521544;15452;15455.768163477333;15460.149691766836;15466.458673946358;15497.225138743242;6664.900026499607;6859.176898772179;6888.931110688929;7033.6483175841;7053.365197132282;6150.169727086875;6170.81487555374;6369.840753981095;6373.203349581302;6375.362463753588;6825.795226143125;6898.655067246617;6957.82605434858;6963;6965.82585435358;1793.3723196880987;1840.0191689463156;1872.700367941123;1891.1678861300984;1954.0815816566192;835.1564919431418;864.4424346296604;873.5108339329995;877.899041610223;892.4868200784445;17072.573185670208;17139.74290385645;17184.82815171857;17649;17976.730349044774;858.6908712863365;862.2024627219797;862.5773371048267;875.4922145155795;891.8038031633031;9047;9358.485283309346;9699.563519641491;9754.609815607297;9907.851382229272;344532;346569;347732;374351;381898;78719.21280787118;80324;80949;82516;82996.58501707453;1053.8629978102952;1063.7553362726462;1101.3722178358419;1104.2987702808775;1107.1253709569512;16928.32286708518;17188.914055429643;17310.74033889518;17936.461906142835;18566.535836604195;38589.80705096456;38816;38977.41533876937;39574;39918;47219.52780472151;47422.52577474319;47849;47981;50357.74821125871;7903.3677305816545;8046.476978996347;8048.235417635316;8262.14101827084;8438.70464533763;11814.232074915446;13638.908887288795;13746.243956582484;13897.16617002983;14162.787558186841;10949;10963;11066.889331106586;11438.885611143782;11576.710582235512;10411.895881041093;10462.424566648908;10498.632547860789;10518.211134164816;10548.314359566604;10776.191785616267;10972.396518191576;10986;11385.943070284595;11425.257358271685;8141;8199.508029518249;8357.620992536407;8380.832383352421;8695.347848911484;11365.147613928822;11400.828987565359;11451.198416110792;11827.349495777815;11974.820377694168 14:56:57 INFO - PID 26552 | |3;mootools.html;966.2801213096244;1195.4919159357273;1241.3793103448277;1253.9937300313497;1257.8490581130266;7883.093444253906;8259;9072.773180670487;9254.259659227262;9271.814563708738;9063.048379920112;9113.362064655477;9198.632054717804;9202.677906273266;9209.125133112344;1836.237961246088;2167.100653228912;2205.44863784054;2208.933731988035;2210.7126073610407;1939.5732938753451;2194.9341519754353;2266.1048885690225;2275.1127060446356;2277.52172043871;2148.140743702516;2161.373201771484;2176.52116534363;2181.890905454729;2183.268605017321;1822.5261432027635;1900.9714854277197;1981.6234915366106;1988.363723608453;1989.6319180951425;2121.99205377446;2198.483356411242;2200.9009594568283;2205.426589086833;2205.514786746913;8855.114488551159;8934.195922366953;8939.73180804577;8943.373963822534;8946.776330591787;5447.237386765856;5668.291463567054;5669.291338582677;5669.518090962273;5674.233978412903;3164.620245570546;3367.0908854609365;3367.7474189435648;3368.5452463917304;3392.694657480814;1022.9079382855579;1038.2783965144229;1081.5241293830688;1084.414416215243;1094.6332978452149;13085.86914130856;13087.541936032289;13087.672808179777;13088.280144592043;13122.212667239995;4890.579163314183;4910.8772280693265;5114.181730923035;5122.667026643257;5135.897282054338;11230.66308010761;11310.208285420105;11317.038051765527;11319.660410187707;11328.603498877499;5451.291332126798;5586.329640443173;5668.801591944262;5670.262865827416;5674.773009079673;4941.802327906916;5013.874653133701;5018.698878067327;5031;5091.210862316347;3689.8339574719203;3780.905477363088;3801.4107813288983;3824.2542704172974;3832.405977073558;1099.6810924831868;1101.4547798839626;1107.8449017137607;1118.1557923767502;1142.6800495861173;689.4966674327769;711.850511392603;720.672094197139;728.1080676171753;744.4416687484387;5406.8918621627345;5419.83740487786;5511.366192887869;5581.776728930879;5598.600349912522;518.7717404342153;532.7975369359696;537.1861629631112;537.8413368056433;538.6014349381508;3571.0715214044535;3598.6221446748236;3614.4216925292353;3643.9453408198897;3652.2695460907394;11681.182317237712;12126.211796233392;12310.50757969689;12329.691757706129;12340.444679989421;11603.941980290214;12141.878581214074;12147.392630368622;12183.45174467151;12315.4458049388;6826.214985276657;7096.077509923677;7119.679614417364;7130.821729456805;7192.92807071933;6149.84625384369;6235.657038862906;6291.245050593958;6352.650604216812;6419;10705.518251678848;10711.143108551141;10848.945755271488;11070.889291106985;11078.612248571262;11070.833937491105;11291.774164516828;11352.375619341015;11388.37363944991;11413.657590272305;7584.658690358837;7773.1060927994;7775.844483110193;7778.533288002738;7783.805404864924;8833;9265.53672316395;9353.812923741623;9368.203702685349;9368.57841397125;7682.539047657158;7685.8462830741955;7728.45900786962;7866.173157708117;7942.841143177219;7485;7577.696892124473;7579;7673.079230492377;7799.844003119792;7071.893921591078;7079.079719636415;7131.536450130725;7140.143182818095;7143.749968751069;4359.542248063907;5088.821891233789;5230.63385563007;5307.548858347083;5396.0556902542685;5157;5420.295361602966;5446.494612478305;5457.645253058538;5468.945310546844 14:56:57 INFO - PID 26552 | |4;prototype.html;362.3188405797101;382.38817891373805;383.4038070799906;385.95368555773314;391.6768665850674;5207.890804224286;5214.487798538419;5237.973810130953;5248.606354523412;5287.524122828944;5035.597152227822;5150.896982060366;5153.30430391897;5179.326687530625;5190.818321358754;4069.776162311072;4093.8362465501345;4096.877093687194;4103.035786590164;4110.424540564309;4077.8980525486804;4104.179164167163;4104.179164167163;4104.774237416941;4108.198901214264;3988.3618621020496;4035.737677050997;4051.898702532431;4057.8579749708765;4073.5926407359325;4034.717569770132;4054.5201001634487;4058.452108965311;4061.756294622332;4068.593140685937;3672.7612705174347;3682.797446140461;3685.0787303174206;3687.1888184599347;3699.5190625218547;5058;5059.721715305656;5065.949340506585;5097.337346144977;5100.1074811907765;4721.929171062437;4800.3759511263315;4862.6839255448285;4894.926576101361;4900.656954013185;5517.724113794295;5533.78256783507;5537.944620553783;5545.833624991256;5553.028220061473;4251.086016506466;4282.42187304713;4292.678049146295;4293.592108749664;4299.484061912591;5509.614326997112;5634.774609015634;5742.28221472316;5815.476607105338;5894.027485464893;4202.096549241927;4252.808623611945;4272.230998420252;4272.380504826782;4346.565343465628;4431.091626216617;4436.223660859337;4438.223310920576;4444;4444.555544445529;4773.9497310592305;4871.488493708181;4903.5586797188425;4908.920037591724;4917.901641967141;5487.890242195133;5535.197396377503;5537.723113844372;5564.4991950724625;5576.693281869536;1534.2788889222047;1557.7351850185496;1560.9151639610361;1564.6557757293376;1567.3417164790815;1043.12377602814;1094.600470828158;1097.9066779323687;1105.6014142110237;1130.0789856267115;4836.177849765478;4836.927446088312;4842.322074909515;4849.369581954324;4852.296417019513;5718.370979192286;5737.381407966627;5742.712864356849;5745.339285982165;5753.59724819267;4622;4841.733704646208;4843.660943733905;4844.4186697596515;4859.392575928009;2994.1766014345794;3002.2944608017096;3005.1885990782803;3010.66025618602;3021.6827233140643;5344.171653393652;5369.114096174166;5377.381601115843;5394.271773310631;5396;5651.491365777099;5860.970695146497;5888.617239879394;5905.291365036223;5918;5348.973255133699;5389.059938422165;5392.597924539569;5402.648827826179;5402.91895621566;5592.598849284103;5711.485966263056;5738.426157384228;5749.923790771917;5752.597318187687;5669.829905102853;5679.488846003879;5687.118496633028;5690.5163061140265;5710;5113.51421614946;5165.66423182492;5262.447443018581;5345.1714984177515;5345.65253258537;3947.131631041166;3993.482476658851;4002.69979751514;4003.139325045129;4005.5794141615875;5509.531689806411;5748.597598168255;5750.338711048283;5759.884802304015;5771.826845194651;5530.474604912527;5531.861703457445;5548.5031735719895;5549.500544950974;5568.16477528374;5542.473465020817;5546.916796247979;5559.805406810742;5572.136318870582;5578.77684892616;5274.156135018378;5453.727313634223;5472.50747432733;5484.588655850907;5496.285482887199;5579.46995035471;5597.216389705526;5597.992361374992;5600.215969764155;5612.382637909745;5364.356277246599;5456.236126942311;5456.236126942311;5457.235986961908;5457.645253058538 14:56:57 INFO - PID 26552 | |5;yui.html;729.2598013016785;729.7591794707747;741.3216906530524;758.9051368578928;759.5556599389357;13840.100393474417;14357;14373.281335933214;14396.712065758678;14440.494582689607;13532.188068715885;14637;15117;15294.694106117871;15403.152826594533;895.6014573514789;904.5477261369315;905.6060613633058;908.5366463103832;910.2490445382552;919.3610440743686;920.9217216536603;921.2123634292684;921.2860033474044;922.349743430883;975.0201047946804;975.0882924465648;975.4829940131741;975.5853762151092;976.3946353260952;914.085914085914;941.7316064921533;954.5895265036032;966.2994329111408;969.5443141723414;695.210935588106;695.5687473766246;696.8083776961377;696.8153439338579;697.7348607529157;13806.378712957941;14135.15189088658;14246.358913848799;14351.497697580638;14359.569212923629;14847.851521484756;14859.479918202918;15262.618434539114;15290.388384464608;15296.388144474207;11679.591214307458;11969.102317326235;11974.101942354271;12035.638930832089;12143.635690929286;2889.2921234297523;2906.5058939980254;2909.156344660046;2914.2714321419644;2930.882764689431;70930;71090.64454677694;72038;72761.27238727598;73997;11676.94161529187;11692;11794.05647548194;11820.88179118215;11838.171328007129;23268.3019509415;23295.53408931812;23390.18134365289;23939.880300598386;24022.27933162008;5518.33779946401;5537.446255374431;5543.556515478752;5557.694326811983;5559.8888022239325;2737.20621019902;2899.4780939431107;2946.7789915756402;2950.3361743607516;2957.3937342845097;3511.17487390463;3571.196480791801;3574.070741607201;3603.3153700796765;3605.080704420356;710.72637034742;721.8375865430236;722.3895808042196;725.760499035317;728.0826159039542;575.9481646651822;583.9036558967807;585.2070444547662;588.808637192914;605.5639939243738;9658.517074146264;10592.491904209768;10682.611260536236;11289.604863829727;11604.825927611093;612.6660969771485;615.722924683894;623.2147494157394;626.7902947311732;635.3614617309574;4459.10817836434;4611.723296602215;4678.274867395559;4678.906421871544;4773.665843390999;61501.69249153726;61604;62567.13800285001;63453.36546634567;64234;55102.72448637731;55326.72336638372;55657.44342556604;55891.161632575546;56062;38576.8071159648;48584.27123593149;49117.75441122772;49225.753871230416;49435.75282123566;10017.69946901594;10250.231232657432;10597.152227821602;10659.147268218368;10787.892121078688;25449;25717.614235786103;25857.482850342512;27041.459170816866;27061;31419.528707068956;31689.524657130623;31776.523352150198;31841.203969900936;32574.674253257162;13322.200667959953;13532.526361577298;13752.243626600633;13831.377588008765;13955;14247.715045699235;14660.70678586401;14672.486462973744;14733.189674568002;14991.17548534841;12909.741805164032;12923.806142908052;12927.288999104763;13067.673308166992;13268.800967985295;12653.430595623035;12813.679658008625;12845.165064270792;12921.483140674643;12936.741265174833;13630.727385452434;13688.110272832235;13761.31193440304;13813.24027178515;13935.372908218951;9536.952315238379;9669.43759903612;9685.370450920667;10602;10705.197110216921;11437.142214333791;12442.191257568229;12447.93776031114;12562;12595.811062833882 14:56:57 INFO - PID 26552 | __end_tp_report 14:56:57 INFO - PID 26552 | __start_cc_report 14:56:57 INFO - PID 26552 | _x_x_mozilla_cycle_collect,1622 14:56:57 INFO - PID 26552 | __end_cc_report 14:56:57 INFO - PID 26552 | __startTimestamp1494021417141__endTimestamp 14:56:57 INFO - PID 26552 | 14:56:57 INFO - PID 26552 | ------- Summary: start ------- 14:56:57 INFO - PID 26552 | Number of tests: 6 14:56:57 INFO - PID 26552 | 14:56:57 INFO - PID 26552 | [#0] dojo.html Cycles:165 Average:5094.49 Median:5246.03 stddev:596.04 (11.4%) stddev-sans-first:566.03 14:56:57 INFO - PID 26552 | Values: 2644.3 2676.3 2693.7 2716.3 2727.5 5052.6 5182.7 5212.0 5234.9 5281.2 5124.1 5137.3 5199.3 5235.4 5246.0 4245.8 4499.3 4596.7 4626.5 4638.4 4615.4 4630.1 4635.6 4669.7 4686.1 4509.5 4558.4 4567.5 4601.7 4651.3 4633.4 4635.5 4636.7 4689.1 4707.6 4575.9 4611.8 4628.7 4647.8 4675.6 5076.3 5130.3 5137.2 5173.4 5185.4 5519.4 5559.8 5608.9 5611.2 5616.0 5471.3 5480.4 5498.9 5501.0 5507.5 5092.1 5126.7 5179.2 5195.8 5228.3 5633.9 5667.5 5698.1 5730.9 5740.2 5509.5 5560.9 5561.2 5569.5 5593.6 5616.2 5622.1 5663.0 5673.1 5675.6 5407.0 5448.5 5492.5 5500.7 5618.9 5613.4 5626.7 5628.7 5630.3 5631.2 4733.7 4738.1 4743.0 4746.5 4747.2 4042.8 4079.4 4083.5 4118.2 4137.7 4704.2 4715.6 4762.2 4766.2 4810.9 5499.4 5563.0 5625.8 5637.3 5638.4 4661.3 4666.7 4667.9 4679.2 4691.7 4943.7 4944.5 4945.0 4946.7 4947.2 5111.6 5151.4 5152.3 5152.3 5161.7 5506.0 5512.0 5516.7 5516.8 5519.7 4508.0 5165.5 5291.8 5292.4 5297.7 5505.9 5506.9 5515.0 5515.4 5516.6 5615.0 5623.8 5626.8 5629.6 5676.8 5205.5 5265.0 5270.7 5270.8 5375.6 5443.3 5448.3 5457.5 5457.9 5497.8 5372.9 5376.5 5380.7 5382.5 5383.4 5320.9 5412.5 5489.7 5495.1 5547.8 5245.9 5279.2 5345.9 5363.4 5377.0 14:56:57 INFO - PID 26552 | 14:56:57 INFO - PID 26552 | [#1] ext.html Cycles:180 Average:29195.57 Median:30011.05 stddev:38935.81 (129.7%) stddev-sans-first:38986.12 14:56:57 INFO - PID 26552 | Values: 671.3 737.0 756.7 1051.6 1067.2 25867.2 32263.2 32781.8 32793.3 32842.3 34236.8 34628.8 34630.8 34681.8 34748.8 5232.0 6955.7 7109.6 7124.0 7125.6 5423.4 5525.5 5526.2 5526.6 6384.5 7079.0 7132.7 7133.7 7142.3 7149.8 7001.5 7102.3 7104.8 7106.0 7106.7 5294.9 5435.6 6899.9 6941.0 6942.0 29549.6 30218.2 30249.1 30250.0 30302.4 3021.7 3066.1 3069.6 3070.6 3071.0 24248.3 24281.4 24330.0 24343.0 24344.9 2741.4 2757.4 2762.3 2766.3 2773.6 142299.0 142353.0 142862.0 143151.3 143358.0 40642.0 40782.4 40783.8 40818.6 40859.8 43575.6 43596.3 43630.8 43639.6 43722.3 10799.7 10912.7 10946.8 10961.7 10967.3 8526.3 8531.1 8531.3 8536.3 8564.3 10486.3 10671.8 11835.3 12139.7 12312.6 5013.3 5094.5 5143.3 5162.9 5165.9 870.2 907.5 909.5 914.2 939.8 20114.3 21289.4 21297.0 21437.1 21438.1 932.6 956.6 975.4 980.9 992.0 10853.1 11086.2 11215.3 11332.4 11343.2 158745.2 159157.0 159518.0 159521.0 159528.0 39897.2 40379.2 40382.2 40385.2 40492.8 1165.7 1209.9 1213.4 1215.1 1219.3 19675.6 19794.3 20056.4 21114.6 21283.9 29995.6 30026.2 30247.7 30315.0 30426.7 149291.0 149677.0 149694.3 150219.0 150719.0 28454.9 28506.7 28995.9 29168.1 29257.2 29995.9 30299.8 30613.1 34276.8 35450.6 25644.2 26236.2 26938.9 27323.7 27502.6 25635.4 26091.3 26683.3 26767.3 26998.3 29266.6 29305.0 29369.6 29369.7 29383.9 25621.7 25777.6 25846.6 27539.9 27840.4 21617.4 22387.3 22533.0 22601.3 22692.3 14:56:57 INFO - PID 26552 | 14:56:57 INFO - PID 26552 | [#2] jquery.html Cycles:180 Average:24521.23 Median:19488.38 stddev:59814.35 (306.9%) stddev-sans-first:59954.70 14:56:57 INFO - PID 26552 | Values: 387.0 399.3 426.6 431.9 433.4 16249.3 17099.5 17575.6 17724.6 17738.2 18691.6 18787.6 19089.8 19153.8 19284.4 5327.5 5370.8 5451.0 5457.9 5509.0 5433.7 5527.3 5531.4 5536.1 5542.8 5214.8 5419.2 5461.5 5500.7 5502.7 5384.0 5426.2 5428.6 5439.9 5446.6 4725.2 4872.3 4912.7 4919.3 4938.8 21228.5 21493.9 21804.8 21953.0 22118.4 1609.2 1641.9 1642.2 1642.6 1643.2 14530.6 14734.9 14934.6 15054.6 15158.2 2085.9 2103.1 2158.5 2167.5 2175.2 80715.6 80936.2 81032.0 82196.0 82274.6 10580.8 10828.2 11116.4 11198.8 11206.8 15452.0 15455.8 15460.1 15466.5 15497.2 6664.9 6859.2 6888.9 7033.6 7053.4 6150.2 6170.8 6369.8 6373.2 6375.4 6825.8 6898.7 6957.8 6963.0 6965.8 1793.4 1840.0 1872.7 1891.2 1954.1 835.2 864.4 873.5 877.9 892.5 17072.6 17139.7 17184.8 17649.0 17976.7 858.7 862.2 862.6 875.5 891.8 9047.0 9358.5 9699.6 9754.6 9907.9 344532.0 346569.0 347732.0 374351.0 381898.0 78719.2 80324.0 80949.0 82516.0 82996.6 1053.9 1063.8 1101.4 1104.3 1107.1 16928.3 17188.9 17310.7 17936.5 18566.5 38589.8 38816.0 38977.4 39574.0 39918.0 47219.5 47422.5 47849.0 47981.0 50357.7 7903.4 8046.5 8048.2 8262.1 8438.7 11814.2 13638.9 13746.2 13897.2 14162.8 10949.0 10963.0 11066.9 11438.9 11576.7 10411.9 10462.4 10498.6 10518.2 10548.3 10776.2 10972.4 10986.0 11385.9 11425.3 8141.0 8199.5 8357.6 8380.8 8695.3 11365.1 11400.8 11451.2 11827.3 11974.8 14:56:57 INFO - PID 26552 | 14:56:57 INFO - PID 26552 | [#3] mootools.html Cycles:180 Average:5936.72 Median:5059.91 stddev:3660.33 (72.3%) stddev-sans-first:3651.53 14:56:57 INFO - PID 26552 | Values: 966.3 1195.5 1241.4 1254.0 1257.8 7883.1 8259.0 9072.8 9254.3 9271.8 9063.0 9113.4 9198.6 9202.7 9209.1 1836.2 2167.1 2205.4 2208.9 2210.7 1939.6 2194.9 2266.1 2275.1 2277.5 2148.1 2161.4 2176.5 2181.9 2183.3 1822.5 1901.0 1981.6 1988.4 1989.6 2122.0 2198.5 2200.9 2205.4 2205.5 8855.1 8934.2 8939.7 8943.4 8946.8 5447.2 5668.3 5669.3 5669.5 5674.2 3164.6 3367.1 3367.7 3368.5 3392.7 1022.9 1038.3 1081.5 1084.4 1094.6 13085.9 13087.5 13087.7 13088.3 13122.2 4890.6 4910.9 5114.2 5122.7 5135.9 11230.7 11310.2 11317.0 11319.7 11328.6 5451.3 5586.3 5668.8 5670.3 5674.8 4941.8 5013.9 5018.7 5031.0 5091.2 3689.8 3780.9 3801.4 3824.3 3832.4 1099.7 1101.5 1107.8 1118.2 1142.7 689.5 711.9 720.7 728.1 744.4 5406.9 5419.8 5511.4 5581.8 5598.6 518.8 532.8 537.2 537.8 538.6 3571.1 3598.6 3614.4 3643.9 3652.3 11681.2 12126.2 12310.5 12329.7 12340.4 11603.9 12141.9 12147.4 12183.5 12315.4 6826.2 7096.1 7119.7 7130.8 7192.9 6149.8 6235.7 6291.2 6352.7 6419.0 10705.5 10711.1 10848.9 11070.9 11078.6 11070.8 11291.8 11352.4 11388.4 11413.7 7584.7 7773.1 7775.8 7778.5 7783.8 8833.0 9265.5 9353.8 9368.2 9368.6 7682.5 7685.8 7728.5 7866.2 7942.8 7485.0 7577.7 7579.0 7673.1 7799.8 7071.9 7079.1 7131.5 7140.1 7143.7 4359.5 5088.8 5230.6 5307.5 5396.1 5157.0 5420.3 5446.5 5457.6 5468.9 14:56:57 INFO - PID 26552 | 14:56:57 INFO - PID 26552 | [#4] prototype.html Cycles:180 Average:4635.75 Median:5106.81 stddev:1305.37 (25.6%) stddev-sans-first:1269.01 14:56:57 INFO - PID 26552 | Values: 362.3 382.4 383.4 386.0 391.7 5207.9 5214.5 5238.0 5248.6 5287.5 5035.6 5150.9 5153.3 5179.3 5190.8 4069.8 4093.8 4096.9 4103.0 4110.4 4077.9 4104.2 4104.2 4104.8 4108.2 3988.4 4035.7 4051.9 4057.9 4073.6 4034.7 4054.5 4058.5 4061.8 4068.6 3672.8 3682.8 3685.1 3687.2 3699.5 5058.0 5059.7 5065.9 5097.3 5100.1 4721.9 4800.4 4862.7 4894.9 4900.7 5517.7 5533.8 5537.9 5545.8 5553.0 4251.1 4282.4 4292.7 4293.6 4299.5 5509.6 5634.8 5742.3 5815.5 5894.0 4202.1 4252.8 4272.2 4272.4 4346.6 4431.1 4436.2 4438.2 4444.0 4444.6 4773.9 4871.5 4903.6 4908.9 4917.9 5487.9 5535.2 5537.7 5564.5 5576.7 1534.3 1557.7 1560.9 1564.7 1567.3 1043.1 1094.6 1097.9 1105.6 1130.1 4836.2 4836.9 4842.3 4849.4 4852.3 5718.4 5737.4 5742.7 5745.3 5753.6 4622.0 4841.7 4843.7 4844.4 4859.4 2994.2 3002.3 3005.2 3010.7 3021.7 5344.2 5369.1 5377.4 5394.3 5396.0 5651.5 5861.0 5888.6 5905.3 5918.0 5349.0 5389.1 5392.6 5402.6 5402.9 5592.6 5711.5 5738.4 5749.9 5752.6 5669.8 5679.5 5687.1 5690.5 5710.0 5113.5 5165.7 5262.4 5345.2 5345.7 3947.1 3993.5 4002.7 4003.1 4005.6 5509.5 5748.6 5750.3 5759.9 5771.8 5530.5 5531.9 5548.5 5549.5 5568.2 5542.5 5546.9 5559.8 5572.1 5578.8 5274.2 5453.7 5472.5 5484.6 5496.3 5579.5 5597.2 5598.0 5600.2 5612.4 5364.4 5456.2 5456.2 5457.2 5457.6 14:56:57 INFO - PID 26552 | 14:56:57 INFO - PID 26552 | [#5] yui.html Cycles:180 Average:14983.52 Median:17188.46 stddev:17734.61 (103.2%) stddev-sans-first:17752.06 14:56:57 INFO - PID 26552 | Values: 729.3 729.8 741.3 758.9 759.6 13840.1 14357.0 14373.3 14396.7 14440.5 13532.2 14637.0 15117.0 15294.7 15403.2 895.6 904.5 905.6 908.5 910.2 919.4 920.9 921.2 921.3 922.3 975.0 975.1 975.5 975.6 976.4 914.1 941.7 954.6 966.3 969.5 695.2 695.6 696.8 696.8 697.7 13806.4 14135.2 14246.4 14351.5 14359.6 14847.9 14859.5 15262.6 15290.4 15296.4 11679.6 11969.1 11974.1 12035.6 12143.6 2889.3 2906.5 2909.2 2914.3 2930.9 70930.0 71090.6 72038.0 72761.3 73997.0 11676.9 11692.0 11794.1 11820.9 11838.2 23268.3 23295.5 23390.2 23939.9 24022.3 5518.3 5537.4 5543.6 5557.7 5559.9 2737.2 2899.5 2946.8 2950.3 2957.4 3511.2 3571.2 3574.1 3603.3 3605.1 710.7 721.8 722.4 725.8 728.1 575.9 583.9 585.2 588.8 605.6 9658.5 10592.5 10682.6 11289.6 11604.8 612.7 615.7 623.2 626.8 635.4 4459.1 4611.7 4678.3 4678.9 4773.7 61501.7 61604.0 62567.1 63453.4 64234.0 55102.7 55326.7 55657.4 55891.2 56062.0 38576.8 48584.3 49117.8 49225.8 49435.8 10017.7 10250.2 10597.2 10659.1 10787.9 25449.0 25717.6 25857.5 27041.5 27061.0 31419.5 31689.5 31776.5 31841.2 32574.7 13322.2 13532.5 13752.2 13831.4 13955.0 14247.7 14660.7 14672.5 14733.2 14991.2 12909.7 12923.8 12927.3 13067.7 13268.8 12653.4 12813.7 12845.2 12921.5 12936.7 13630.7 13688.1 13761.3 13813.2 13935.4 9537.0 9669.4 9685.4 10602.0 10705.2 11437.1 12442.2 12447.9 12562.0 12595.8 14:56:57 INFO - PID 26552 | -------- Summary: end -------- 14:56:57 INFO - PID 26552 | 14:56:57 INFO - TEST-INFO | 26552: exit 0 14:56:58 INFO - TEST-OK | dromaeo_css | took 1122594ms 14:56:58 INFO - TEST-START | kraken 14:56:58 INFO - operating with platform_type : linux_ 14:56:58 INFO - Initialising browser for kraken test... 14:56:58 INFO - TEST-INFO | started process 26879 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpolMCVE/profile http://localhost:54733/getInfo.html) 14:57:02 INFO - PID 26879 | __metrics Screen width/height:1600/1200 14:57:02 INFO - PID 26879 | colorDepth:24 14:57:02 INFO - PID 26879 | Browser inner width/height: 1024/695 14:57:02 INFO - PID 26879 | __metrics 14:57:02 INFO - PID 26879 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:57:02 INFO - PID 26879 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:57:04 INFO - TEST-INFO | 26879: exit 0 14:57:04 INFO - Browser initialized. 14:57:04 INFO - Running cycle 1/1 for kraken test... 14:57:04 INFO - TEST-INFO | started process 26976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpolMCVE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:16 INFO - PID 26976 | RSS: Main: 170733568 14:57:16 INFO - PID 26976 | 14:57:19 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54733/tests/kraken/driver.html?testName=audio-beat-detection) 14:57:20 INFO - PID 26976 | RSS: Main: 237817856 14:57:20 INFO - PID 26976 | 14:57:22 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54733/tests/kraken/driver.html?testName=audio-dft) 14:57:23 INFO - PID 26976 | RSS: Main: 199532544 14:57:23 INFO - PID 26976 | 14:57:26 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54733/tests/kraken/driver.html?testName=audio-fft) 14:57:27 INFO - PID 26976 | RSS: Main: 279769088 14:57:27 INFO - PID 26976 | 14:57:29 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54733/tests/kraken/driver.html?testName=audio-oscillator) 14:57:30 INFO - PID 26976 | RSS: Main: 191336448 14:57:30 INFO - PID 26976 | 14:57:32 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54733/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:57:32 INFO - PID 26976 | RSS: Main: 193339392 14:57:32 INFO - PID 26976 | 14:57:36 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54733/tests/kraken/driver.html?testName=imaging-darkroom) 14:57:36 INFO - PID 26976 | RSS: Main: 254066688 14:57:36 INFO - PID 26976 | 14:57:40 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54733/tests/kraken/driver.html?testName=imaging-desaturate) 14:57:41 INFO - PID 26976 | RSS: Main: 252399616 14:57:41 INFO - PID 26976 | 14:57:43 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54733/tests/kraken/driver.html?testName=json-parse-financial) 14:57:44 INFO - PID 26976 | RSS: Main: 250290176 14:57:44 INFO - PID 26976 | 14:57:46 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54733/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:57:46 INFO - PID 26976 | RSS: Main: 215728128 14:57:46 INFO - PID 26976 | 14:57:48 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54733/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:57:49 INFO - PID 26976 | RSS: Main: 219684864 14:57:49 INFO - PID 26976 | 14:57:51 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54733/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:57:52 INFO - PID 26976 | RSS: Main: 229531648 14:57:52 INFO - PID 26976 | 14:57:54 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:57:55 INFO - PID 26976 | RSS: Main: 238309376 14:57:55 INFO - PID 26976 | 14:57:58 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:57:59 INFO - PID 26976 | RSS: Main: 234274816 14:57:59 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | Cycle 1(1): loaded http://localhost:54733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54733/tests/kraken/driver.html?testName=ai-astar) 14:58:01 INFO - PID 26976 | RSS: Main: 284037120 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | __start_tp_report 14:58:01 INFO - PID 26976 | _x_x_mozilla_page_load 14:58:01 INFO - PID 26976 | _x_x_mozilla_page_load_details 14:58:01 INFO - PID 26976 | |i|pagename|runs| 14:58:01 INFO - PID 26976 | |0;ai-astar;111;111;112;110;112;111;111;111;111;111 14:58:01 INFO - PID 26976 | |1;audio-beat-detection;158;127;130;179;128;127;122;122;146;123 14:58:01 INFO - PID 26976 | |2;audio-dft;163;164;163;164;166;164;164;162;162;160 14:58:01 INFO - PID 26976 | |3;audio-fft;74;75;77;103;76;75;76;75;97;75 14:58:01 INFO - PID 26976 | |4;audio-oscillator;85;83;114;84;83;84;99;84;84;116 14:58:01 INFO - PID 26976 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;114;113;113 14:58:01 INFO - PID 26976 | |6;imaging-darkroom;149;149;149;151;149;150;148;148;149;148 14:58:01 INFO - PID 26976 | |7;imaging-desaturate;93;94;94;93;94;93;94;94;94;94 14:58:01 INFO - PID 26976 | |8;json-parse-financial;54;53;53;53;55;54;54;55;54;53 14:58:01 INFO - PID 26976 | |9;json-stringify-tinderbox;55;56;54;55;55;55;55;55;55;55 14:58:01 INFO - PID 26976 | |10;stanford-crypto-aes;82;80;82;80;81;80;80;82;82;81 14:58:01 INFO - PID 26976 | |11;stanford-crypto-ccm;140;133;133;132;148;138;142;131;189;129 14:58:01 INFO - PID 26976 | |12;stanford-crypto-pbkdf2;184;195;188;202;193;211;199;194;197;188 14:58:01 INFO - PID 26976 | |13;stanford-crypto-sha256-iterative;71;71;73;75;70;71;69;70;73;70 14:58:01 INFO - PID 26976 | __end_tp_report 14:58:01 INFO - PID 26976 | __start_cc_report 14:58:01 INFO - PID 26976 | _x_x_mozilla_cycle_collect,2237 14:58:01 INFO - PID 26976 | __end_cc_report 14:58:01 INFO - PID 26976 | __startTimestamp1494021481570__endTimestamp 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | ------- Summary: start ------- 14:58:01 INFO - PID 26976 | Number of tests: 14 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 14:58:01 INFO - PID 26976 | Values: 111.0 111.0 112.0 110.0 112.0 111.0 111.0 111.0 111.0 111.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:129.00 stddev:19.02 (14.7%) stddev-sans-first:18.46 14:58:01 INFO - PID 26976 | Values: 158.0 127.0 130.0 179.0 128.0 127.0 122.0 122.0 146.0 123.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#2] audio-dft Cycles:10 Average:163.20 Median:164.00 stddev:1.62 (1.0%) stddev-sans-first:1.72 14:58:01 INFO - PID 26976 | Values: 163.0 164.0 163.0 164.0 166.0 164.0 164.0 162.0 162.0 160.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.50 stddev:10.51 (13.9%) stddev-sans-first:10.90 14:58:01 INFO - PID 26976 | Values: 74.0 75.0 77.0 103.0 76.0 75.0 76.0 75.0 97.0 75.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:84.00 stddev:13.23 (15.7%) stddev-sans-first:13.81 14:58:01 INFO - PID 26976 | Values: 85.0 83.0 114.0 84.0 83.0 84.0 99.0 84.0 84.0 116.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:58:01 INFO - PID 26976 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 113.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 14:58:01 INFO - PID 26976 | Values: 149.0 149.0 149.0 151.0 149.0 150.0 148.0 148.0 149.0 148.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:58:01 INFO - PID 26976 | Values: 93.0 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 94.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 14:58:01 INFO - PID 26976 | Values: 54.0 53.0 53.0 53.0 55.0 54.0 54.0 55.0 54.0 53.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 14:58:01 INFO - PID 26976 | Values: 55.0 56.0 54.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.50 stddev:0.94 (1.2%) stddev-sans-first:0.93 14:58:01 INFO - PID 26976 | Values: 82.0 80.0 82.0 80.0 81.0 80.0 80.0 82.0 82.0 81.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:139.00 stddev:17.68 (12.7%) stddev-sans-first:18.75 14:58:01 INFO - PID 26976 | Values: 140.0 133.0 133.0 132.0 148.0 138.0 142.0 131.0 189.0 129.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.10 Median:196.00 stddev:7.81 (4.0%) stddev-sans-first:7.18 14:58:01 INFO - PID 26976 | Values: 184.0 195.0 188.0 202.0 193.0 211.0 199.0 194.0 197.0 188.0 14:58:01 INFO - PID 26976 | 14:58:01 INFO - PID 26976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:1.83 (2.6%) stddev-sans-first:1.94 14:58:01 INFO - PID 26976 | Values: 71.0 71.0 73.0 75.0 70.0 71.0 69.0 70.0 73.0 70.0 14:58:01 INFO - PID 26976 | -------- Summary: end -------- 14:58:01 INFO - PID 26976 | 14:58:02 INFO - TEST-INFO | 26976: exit 0 14:58:02 INFO - TEST-OK | kraken | took 64987ms 14:58:02 INFO - SUITE-END | took 1187s 14:58:03 INFO - Completed test suite (00:19:47) 14:58:03 INFO - javascript benchmark 14:58:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6565.6917364853, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.2860427684527, 2676.330917270682, 2693.690225624053, 2716.3344980479774, 2727.509048371294, 5052.570531504817, 5182.714950677711, 5211.973940130299, 5234.895302093956, 5281.181416880385, 5124.0776660201145, 5137.255098010786, 5199.324087868572, 5235.424103348629, 5246.029484545362, 4245.787710614472, 4499.280115181572, 4596.7012144210685, 4626.491085980556, 4638.4433867935895, 4615.446146462429, 4630.120277147348, 4635.605973492257, 4669.6731228814, 4686.133065382898, 4509.4814096379005, 4558.361829343895, 4567.543245675406, 4601.700889442175, 4651.279051746985, 4633.4208223972, 4635.46692130406, 4636.698614590075, 4689.085628302482, 4707.623390128816, 4575.931361029588, 4611.7694115294435, 4628.675992680513, 4647.767611619405, 4675.579197872174, 5076.340075790161, 5130.3074084998425, 5137.17805151174, 5173.379194496647, 5185.377754669426, 5519.365272993577, 5559.833205003856, 5608.943910560883, 5611.186377975171, 5616.017196990551, 5471.343438787371, 5480.369757477902, 5498.917516237259, 5501.0, 5507.476789704971, 5092.134337162691, 5126.6667666601925, 5179.249008893689, 5195.818146364934, 5228.346456692913, 5633.887322253532, 5667.518260947783, 5698.116791897262, 5730.942690573124, 5740.167675687086, 5509.5041446270025, 5560.86097847549, 5561.165825126263, 5569.498745112959, 5593.608447408642, 5616.157576363578, 5622.072358060956, 5663.0, 5673.063944449203, 5675.602707810413, 5406.999705054499, 5448.536874365644, 5492.47821456961, 5500.669959802424, 5618.887622247532, 5613.382527921925, 5626.662400255997, 5628.662280263197, 5630.296212973379, 5631.211630371751, 4733.739644319527, 4738.07607516531, 4742.976285118552, 4746.501617330199, 4747.192977193886, 4042.8180731867137, 4079.3880917862557, 4083.509978802503, 4118.155778065489, 4137.668986481134, 4704.2473204287835, 4715.646326525524, 4762.190427627312, 4766.213574760126, 4810.855674329776, 5499.367572729107, 5563.0, 5625.803096891589, 5637.267155269788, 5638.351589567253, 4661.254199328091, 4666.743329116864, 4667.8599642010795, 4679.204535229019, 4691.695039822401, 4943.703377797344, 4944.505549445099, 4945.035718034948, 4946.703197808143, 4947.208446648591, 5111.642185047085, 5151.407588127264, 5152.27868098459, 5152.27868098474, 5161.716105614228, 5506.008918394567, 5511.972440137773, 5516.724163791875, 5516.779328826802, 5519.696416696959, 4507.954920450754, 5165.457626949116, 5291.76187071575, 5292.4442933492965, 5297.682139071668, 5505.9174112387545, 5506.862328441821, 5514.972425137848, 5515.420880807618, 5516.613837031369, 5615.045442274904, 5623.831285061455, 5626.831195064155, 5629.634073785191, 5676.829695109153, 5205.505476979681, 5265.0259701955265, 5270.683758974474, 5270.8155214567305, 5375.623706340675, 5443.346798384219, 5448.291722076105, 5457.454254574511, 5457.863553411196, 5497.835064948058, 5372.919406208832, 5376.489233522809, 5380.677159370451, 5382.515573598395, 5383.353997520166, 5320.946790532045, 5412.539934105645, 5489.725513724218, 5495.065838807493, 5547.805826796042, 5245.895082098413, 5279.234510995807, 5345.930813837171, 5363.356397232357, 5377.032134215879], "value": 5051.738904951793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.2817285504512, 737.0308044920929, 756.7086671631422, 1051.5951358726888, 1067.1782727299983, 25867.22398328051, 32263.19342016451, 32781.83609081951, 32793.34413311732, 32842.343153136986, 34236.82881585595, 34628.82685586575, 34630.8268458658, 34681.82659086707, 34748.82625586875, 5232.0, 6955.686994085266, 7109.573425594481, 7124.038254835583, 7125.608091554963, 5423.403425623178, 5525.530329921961, 5526.226328314039, 5526.640768350045, 6384.457321127709, 7079.0, 7132.714691412337, 7133.714651413938, 7142.285771422842, 7149.821254468654, 7001.509894307401, 7102.289771022908, 7104.751333703295, 7106.040684507629, 7106.680199391039, 5294.947050529522, 5435.646682965634, 6899.896501552481, 6941.028256044158, 6942.0, 29549.556756648668, 30218.244543886358, 30249.09252722422, 30250.0, 30302.393952120834, 3021.6525099613605, 3066.095501826944, 3069.6162979627547, 3070.6468756093113, 3071.01727447217, 24248.272551823473, 24281.392965175834, 24330.0, 24343.0, 24344.878275608684, 2741.424300896814, 2757.352022274764, 2762.337039110599, 2766.349907771672, 2773.5978283149034, 142299.0, 142353.0, 142862.0, 143151.2842435802, 143358.0, 40642.0, 40782.388264176065, 40783.796081019405, 40818.59181408207, 40859.79570102131, 43575.56424435778, 43596.346054809204, 43630.78184609057, 43639.563604364186, 43722.34416483755, 10799.67600971972, 10912.727181820517, 10946.781064378667, 10961.725956851142, 10967.341959482457, 8526.31789456842, 8531.146885311544, 8531.274841638531, 8536.274416674529, 8564.272036876935, 10486.26596138263, 10671.839922401015, 11835.349055802013, 12139.696507587381, 12312.569060083033, 5013.323201367769, 5094.49055094495, 5143.331366922351, 5162.92255616166, 5165.948340516622, 870.2298465857762, 907.4600612635471, 909.5437338115136, 914.1589737441569, 939.7744541310036, 20114.2674337813, 21289.36131916045, 21297.0, 21437.142514299252, 21438.142474301167, 932.6222879733718, 956.6316967967383, 975.380633297861, 980.8970058143935, 991.9752006199758, 10853.084589777689, 11086.22396432242, 11215.327080375204, 11332.376719280353, 11343.205975581795, 158745.2062739679, 159157.0, 159518.0, 159521.01197470157, 159528.0, 39897.20205595872, 40379.19241615151, 40382.192356152715, 40385.19229615391, 40492.797536012724, 1165.7260543772206, 1209.8608660004213, 1213.375111817397, 1215.0801733261426, 1219.3171823778712, 19675.606487869874, 19794.307199247956, 20056.398308050782, 21114.57770844544, 21283.893580532, 29995.55006674858, 30026.249343765707, 30247.69752302449, 30315.0, 30426.695733042387, 149291.0, 149677.0, 149694.251528746, 150219.0, 150719.0, 28454.857725711237, 28506.714932850406, 28995.85502072476, 29168.124956251348, 29257.22056404638, 29995.850020749756, 30299.848500757354, 30613.08160755181, 34276.828615856764, 35450.64549354473, 25644.230673079837, 26236.21291361262, 26938.865305673346, 27323.72676273212, 27502.587461188497, 25635.35911602225, 26091.347716306485, 26683.332916676463, 26767.330816729736, 26998.32504187411, 29266.561001584567, 29305.0, 29369.55945660774, 29369.7063029367, 29383.853080734458, 25621.743782561934, 25777.613335800354, 25846.566003408996, 27539.862300688368, 27840.44319113647, 21617.351479455643, 22387.32838014862, 22533.0, 22601.321960341214, 22692.319230423112], "value": 13959.191329311056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.95743468218507, 399.3483271080027, 426.5563813633821, 431.8574870292804, 433.42571093301376, 16249.268782904768, 17099.487015389528, 17575.560610984732, 17724.556886077855, 17738.20178091986, 18691.626167476643, 18787.624247515043, 19089.80910190901, 19153.808461915378, 19284.421467356, 5327.467253274671, 5370.838874833761, 5450.972745136269, 5457.918131228034, 5508.9724551377185, 5433.701146436944, 5527.309086364205, 5531.419200983899, 5536.114221724525, 5542.75057622406, 5214.817481388152, 5419.241306217133, 5461.508464238218, 5500.724963751816, 5502.697351645658, 5384.0, 5426.186072089218, 5428.61999660022, 5439.918401223965, 5446.645968012067, 4725.22033864412, 4872.269159626049, 4912.673578133884, 4919.311296418504, 4938.827141050082, 21228.469288267763, 21493.892530537247, 21804.781952180434, 21953.0, 22118.447038824157, 1609.1712767924528, 1641.9261133249033, 1642.2117383655793, 1642.581141808843, 1643.2112585958687, 14530.636734081627, 14734.926325368411, 14934.626634334229, 15054.623634409118, 15158.166300853449, 2085.8644188127873, 2103.074647155247, 2158.4819643285655, 2167.5231449081175, 2175.2060497918305, 80715.5964220181, 80936.19063809345, 81032.0, 82196.0, 82274.58862705708, 10580.841287380696, 10828.187885908588, 11116.388598627153, 11198.776024479464, 11206.831897521544, 15452.0, 15455.768163477333, 15460.149691766836, 15466.458673946358, 15497.225138743242, 6664.900026499607, 6859.176898772179, 6888.931110688929, 7033.6483175841, 7053.365197132282, 6150.169727086875, 6170.81487555374, 6369.840753981095, 6373.203349581302, 6375.362463753588, 6825.795226143125, 6898.655067246617, 6957.82605434858, 6963.0, 6965.82585435358, 1793.3723196880987, 1840.0191689463156, 1872.700367941123, 1891.1678861300984, 1954.0815816566192, 835.1564919431418, 864.4424346296604, 873.5108339329995, 877.899041610223, 892.4868200784445, 17072.573185670208, 17139.74290385645, 17184.82815171857, 17649.0, 17976.730349044774, 858.6908712863365, 862.2024627219797, 862.5773371048267, 875.4922145155795, 891.8038031633031, 9047.0, 9358.485283309346, 9699.563519641491, 9754.609815607297, 9907.851382229272, 344532.0, 346569.0, 347732.0, 374351.0, 381898.0, 78719.21280787118, 80324.0, 80949.0, 82516.0, 82996.58501707453, 1053.8629978102952, 1063.7553362726462, 1101.3722178358419, 1104.2987702808775, 1107.1253709569512, 16928.32286708518, 17188.914055429643, 17310.74033889518, 17936.461906142835, 18566.535836604195, 38589.80705096456, 38816.0, 38977.41533876937, 39574.0, 39918.0, 47219.52780472151, 47422.52577474319, 47849.0, 47981.0, 50357.74821125871, 7903.3677305816545, 8046.476978996347, 8048.235417635316, 8262.14101827084, 8438.70464533763, 11814.232074915446, 13638.908887288795, 13746.243956582484, 13897.16617002983, 14162.787558186841, 10949.0, 10963.0, 11066.889331106586, 11438.885611143782, 11576.710582235512, 10411.895881041093, 10462.424566648908, 10498.632547860789, 10518.211134164816, 10548.314359566604, 10776.191785616267, 10972.396518191576, 10986.0, 11385.943070284595, 11425.257358271685, 8141.0, 8199.508029518249, 8357.620992536407, 8380.832383352421, 8695.347848911484, 11365.147613928822, 11400.828987565359, 11451.198416110792, 11827.349495777815, 11974.820377694168], "value": 8785.17800251893, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [966.2801213096244, 1195.4919159357273, 1241.3793103448277, 1253.9937300313497, 1257.8490581130266, 7883.093444253906, 8259.0, 9072.773180670487, 9254.259659227262, 9271.814563708738, 9063.048379920112, 9113.362064655477, 9198.632054717804, 9202.677906273266, 9209.125133112344, 1836.237961246088, 2167.100653228912, 2205.44863784054, 2208.933731988035, 2210.7126073610407, 1939.5732938753451, 2194.9341519754353, 2266.1048885690225, 2275.1127060446356, 2277.52172043871, 2148.140743702516, 2161.373201771484, 2176.52116534363, 2181.890905454729, 2183.268605017321, 1822.5261432027635, 1900.9714854277197, 1981.6234915366106, 1988.363723608453, 1989.6319180951425, 2121.99205377446, 2198.483356411242, 2200.9009594568283, 2205.426589086833, 2205.514786746913, 8855.114488551159, 8934.195922366953, 8939.73180804577, 8943.373963822534, 8946.776330591787, 5447.237386765856, 5668.291463567054, 5669.291338582677, 5669.518090962273, 5674.233978412903, 3164.620245570546, 3367.0908854609365, 3367.7474189435648, 3368.5452463917304, 3392.694657480814, 1022.9079382855579, 1038.2783965144229, 1081.5241293830688, 1084.414416215243, 1094.6332978452149, 13085.86914130856, 13087.541936032289, 13087.672808179777, 13088.280144592043, 13122.212667239995, 4890.579163314183, 4910.8772280693265, 5114.181730923035, 5122.667026643257, 5135.897282054338, 11230.66308010761, 11310.208285420105, 11317.038051765527, 11319.660410187707, 11328.603498877499, 5451.291332126798, 5586.329640443173, 5668.801591944262, 5670.262865827416, 5674.773009079673, 4941.802327906916, 5013.874653133701, 5018.698878067327, 5031.0, 5091.210862316347, 3689.8339574719203, 3780.905477363088, 3801.4107813288983, 3824.2542704172974, 3832.405977073558, 1099.6810924831868, 1101.4547798839626, 1107.8449017137607, 1118.1557923767502, 1142.6800495861173, 689.4966674327769, 711.850511392603, 720.672094197139, 728.1080676171753, 744.4416687484387, 5406.8918621627345, 5419.83740487786, 5511.366192887869, 5581.776728930879, 5598.600349912522, 518.7717404342153, 532.7975369359696, 537.1861629631112, 537.8413368056433, 538.6014349381508, 3571.0715214044535, 3598.6221446748236, 3614.4216925292353, 3643.9453408198897, 3652.2695460907394, 11681.182317237712, 12126.211796233392, 12310.50757969689, 12329.691757706129, 12340.444679989421, 11603.941980290214, 12141.878581214074, 12147.392630368622, 12183.45174467151, 12315.4458049388, 6826.214985276657, 7096.077509923677, 7119.679614417364, 7130.821729456805, 7192.92807071933, 6149.84625384369, 6235.657038862906, 6291.245050593958, 6352.650604216812, 6419.0, 10705.518251678848, 10711.143108551141, 10848.945755271488, 11070.889291106985, 11078.612248571262, 11070.833937491105, 11291.774164516828, 11352.375619341015, 11388.37363944991, 11413.657590272305, 7584.658690358837, 7773.1060927994, 7775.844483110193, 7778.533288002738, 7783.805404864924, 8833.0, 9265.53672316395, 9353.812923741623, 9368.203702685349, 9368.57841397125, 7682.539047657158, 7685.8462830741955, 7728.45900786962, 7866.173157708117, 7942.841143177219, 7485.0, 7577.696892124473, 7579.0, 7673.079230492377, 7799.844003119792, 7071.893921591078, 7079.079719636415, 7131.536450130725, 7140.143182818095, 7143.749968751069, 4359.542248063907, 5088.821891233789, 5230.63385563007, 5307.548858347083, 5396.0556902542685, 5157.0, 5420.295361602966, 5446.494612478305, 5457.645253058538, 5468.945310546844], "value": 4498.753564332243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.3188405797101, 382.38817891373805, 383.4038070799906, 385.95368555773314, 391.6768665850674, 5207.890804224286, 5214.487798538419, 5237.973810130953, 5248.606354523412, 5287.524122828944, 5035.597152227822, 5150.896982060366, 5153.30430391897, 5179.326687530625, 5190.818321358754, 4069.776162311072, 4093.8362465501345, 4096.877093687194, 4103.035786590164, 4110.424540564309, 4077.8980525486804, 4104.179164167163, 4104.179164167163, 4104.774237416941, 4108.198901214264, 3988.3618621020496, 4035.737677050997, 4051.898702532431, 4057.8579749708765, 4073.5926407359325, 4034.717569770132, 4054.5201001634487, 4058.452108965311, 4061.756294622332, 4068.593140685937, 3672.7612705174347, 3682.797446140461, 3685.0787303174206, 3687.1888184599347, 3699.5190625218547, 5058.0, 5059.721715305656, 5065.949340506585, 5097.337346144977, 5100.1074811907765, 4721.929171062437, 4800.3759511263315, 4862.6839255448285, 4894.926576101361, 4900.656954013185, 5517.724113794295, 5533.78256783507, 5537.944620553783, 5545.833624991256, 5553.028220061473, 4251.086016506466, 4282.42187304713, 4292.678049146295, 4293.592108749664, 4299.484061912591, 5509.614326997112, 5634.774609015634, 5742.28221472316, 5815.476607105338, 5894.027485464893, 4202.096549241927, 4252.808623611945, 4272.230998420252, 4272.380504826782, 4346.565343465628, 4431.091626216617, 4436.223660859337, 4438.223310920576, 4444.0, 4444.555544445529, 4773.9497310592305, 4871.488493708181, 4903.5586797188425, 4908.920037591724, 4917.901641967141, 5487.890242195133, 5535.197396377503, 5537.723113844372, 5564.4991950724625, 5576.693281869536, 1534.2788889222047, 1557.7351850185496, 1560.9151639610361, 1564.6557757293376, 1567.3417164790815, 1043.12377602814, 1094.600470828158, 1097.9066779323687, 1105.6014142110237, 1130.0789856267115, 4836.177849765478, 4836.927446088312, 4842.322074909515, 4849.369581954324, 4852.296417019513, 5718.370979192286, 5737.381407966627, 5742.712864356849, 5745.339285982165, 5753.59724819267, 4622.0, 4841.733704646208, 4843.660943733905, 4844.4186697596515, 4859.392575928009, 2994.1766014345794, 3002.2944608017096, 3005.1885990782803, 3010.66025618602, 3021.6827233140643, 5344.171653393652, 5369.114096174166, 5377.381601115843, 5394.271773310631, 5396.0, 5651.491365777099, 5860.970695146497, 5888.617239879394, 5905.291365036223, 5918.0, 5348.973255133699, 5389.059938422165, 5392.597924539569, 5402.648827826179, 5402.91895621566, 5592.598849284103, 5711.485966263056, 5738.426157384228, 5749.923790771917, 5752.597318187687, 5669.829905102853, 5679.488846003879, 5687.118496633028, 5690.5163061140265, 5710.0, 5113.51421614946, 5165.66423182492, 5262.447443018581, 5345.1714984177515, 5345.65253258537, 3947.131631041166, 3993.482476658851, 4002.69979751514, 4003.139325045129, 4005.5794141615875, 5509.531689806411, 5748.597598168255, 5750.338711048283, 5759.884802304015, 5771.826845194651, 5530.474604912527, 5531.861703457445, 5548.5031735719895, 5549.500544950974, 5568.16477528374, 5542.473465020817, 5546.916796247979, 5559.805406810742, 5572.136318870582, 5578.77684892616, 5274.156135018378, 5453.727313634223, 5472.50747432733, 5484.588655850907, 5496.285482887199, 5579.46995035471, 5597.216389705526, 5597.992361374992, 5600.215969764155, 5612.382637909745, 5364.356277246599, 5456.236126942311, 5456.236126942311, 5457.235986961908, 5457.645253058538], "value": 4246.899803348846, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.2598013016785, 729.7591794707747, 741.3216906530524, 758.9051368578928, 759.5556599389357, 13840.100393474417, 14357.0, 14373.281335933214, 14396.712065758678, 14440.494582689607, 13532.188068715885, 14637.0, 15117.0, 15294.694106117871, 15403.152826594533, 895.6014573514789, 904.5477261369315, 905.6060613633058, 908.5366463103832, 910.2490445382552, 919.3610440743686, 920.9217216536603, 921.2123634292684, 921.2860033474044, 922.349743430883, 975.0201047946804, 975.0882924465648, 975.4829940131741, 975.5853762151092, 976.3946353260952, 914.085914085914, 941.7316064921533, 954.5895265036032, 966.2994329111408, 969.5443141723414, 695.210935588106, 695.5687473766246, 696.8083776961377, 696.8153439338579, 697.7348607529157, 13806.378712957941, 14135.15189088658, 14246.358913848799, 14351.497697580638, 14359.569212923629, 14847.851521484756, 14859.479918202918, 15262.618434539114, 15290.388384464608, 15296.388144474207, 11679.591214307458, 11969.102317326235, 11974.101942354271, 12035.638930832089, 12143.635690929286, 2889.2921234297523, 2906.5058939980254, 2909.156344660046, 2914.2714321419644, 2930.882764689431, 70930.0, 71090.64454677694, 72038.0, 72761.27238727598, 73997.0, 11676.94161529187, 11692.0, 11794.05647548194, 11820.88179118215, 11838.171328007129, 23268.3019509415, 23295.53408931812, 23390.18134365289, 23939.880300598386, 24022.27933162008, 5518.33779946401, 5537.446255374431, 5543.556515478752, 5557.694326811983, 5559.8888022239325, 2737.20621019902, 2899.4780939431107, 2946.7789915756402, 2950.3361743607516, 2957.3937342845097, 3511.17487390463, 3571.196480791801, 3574.070741607201, 3603.3153700796765, 3605.080704420356, 710.72637034742, 721.8375865430236, 722.3895808042196, 725.760499035317, 728.0826159039542, 575.9481646651822, 583.9036558967807, 585.2070444547662, 588.808637192914, 605.5639939243738, 9658.517074146264, 10592.491904209768, 10682.611260536236, 11289.604863829727, 11604.825927611093, 612.6660969771485, 615.722924683894, 623.2147494157394, 626.7902947311732, 635.3614617309574, 4459.10817836434, 4611.723296602215, 4678.274867395559, 4678.906421871544, 4773.665843390999, 61501.69249153726, 61604.0, 62567.13800285001, 63453.36546634567, 64234.0, 55102.72448637731, 55326.72336638372, 55657.44342556604, 55891.161632575546, 56062.0, 38576.8071159648, 48584.27123593149, 49117.75441122772, 49225.753871230416, 49435.75282123566, 10017.69946901594, 10250.231232657432, 10597.152227821602, 10659.147268218368, 10787.892121078688, 25449.0, 25717.614235786103, 25857.482850342512, 27041.459170816866, 27061.0, 31419.528707068956, 31689.524657130623, 31776.523352150198, 31841.203969900936, 32574.674253257162, 13322.200667959953, 13532.526361577298, 13752.243626600633, 13831.377588008765, 13955.0, 14247.715045699235, 14660.70678586401, 14672.486462973744, 14733.189674568002, 14991.17548534841, 12909.741805164032, 12923.806142908052, 12927.288999104763, 13067.673308166992, 13268.800967985295, 12653.430595623035, 12813.679658008625, 12845.165064270792, 12921.483140674643, 12936.741265174833, 13630.727385452434, 13688.110272832235, 13761.31193440304, 13813.24027178515, 13935.372908218951, 9536.952315238379, 9669.43759903612, 9685.370450920667, 10602.0, 10705.197110216921, 11437.142214333791, 12442.191257568229, 12447.93776031114, 12562.0, 12595.811062833882], "value": 6767.595449577272, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 112.0, 110.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 130.0, 179.0, 128.0, 127.0, 122.0, 122.0, 146.0, 123.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 164.0, 166.0, 164.0, 164.0, 162.0, 162.0, 160.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 103.0, 76.0, 75.0, 76.0, 75.0, 97.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 114.0, 84.0, 83.0, 84.0, 99.0, 84.0, 84.0, 116.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 151.0, 149.0, 150.0, 148.0, 148.0, 149.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 55.0, 54.0, 54.0, 55.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 82.0, 80.0, 81.0, 80.0, 80.0, 82.0, 82.0, 81.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 133.0, 132.0, 148.0, 138.0, 142.0, 131.0, 189.0, 129.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 195.0, 188.0, 202.0, 193.0, 211.0, 199.0, 194.0, 197.0, 188.0], "value": 195.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 75.0, 70.0, 71.0, 69.0, 70.0, 73.0, 70.0], "value": 71.3, "unit": "score"}]}]} 14:58:03 INFO - Return code: 0 14:58:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:58:03 INFO - # TBPL SUCCESS # 14:58:03 INFO - Running post-action listener: _resource_record_post_action 14:58:03 INFO - [mozharness: 2017-05-05 21:58:03.378123Z] Finished run-tests step (success) 14:58:03 INFO - Running post-run listener: _resource_record_post_run 14:58:03 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 345669632; Read time: 0; Write time: 230080 14:58:03 INFO - TinderboxPrint: CPU usage
12.9% 14:58:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:58:03 INFO - TinderboxPrint: I/O write bytes / time
345,669,632 / 230,080 14:58:03 INFO - TinderboxPrint: CPU idle
8,360.3 (87.1%) 14:58:03 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 14:58:03 INFO - TinderboxPrint: Swap in / out
0 / 0 14:58:03 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 55549952; Read time: 0; Write time: 20720 14:58:03 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 243961856; Read time: 0; Write time: 132676 14:58:04 INFO - Running post-run listener: _upload_blobber_files 14:58:04 INFO - Blob upload gear active. 14:58:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:58:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:58:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:58:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:58:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:58:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:58:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:58:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:05 INFO - (blobuploader) - INFO - Done attempting. 14:58:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:58:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:58:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:08 INFO - (blobuploader) - INFO - Done attempting. 14:58:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:58:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:58:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:09 INFO - (blobuploader) - INFO - Done attempting. 14:58:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:58:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:10 INFO - (blobuploader) - INFO - Done attempting. 14:58:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:58:10 INFO - Return code: 0 14:58:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:58:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:58:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/026f3106be72f3c3788a8abbd5dfbdd2c7b45c451c3be11c5e115ec5b29eb93772233a68ca65a3d289cbcca158aaf946040574f6e0654acbcde5166797638819", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70424e8f9ff0e4bf6870484017c0de3ea3b5d64bc8dd7f3f72d01f52c313b5ab32fb8364fae7ff4b78366c3f14902337d66a5e42c76799885d0f787c54dbd99a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e945dd007df909504c992f39214ee4eedcbb47e4cef5b9b904711e53d79e385880d908c5a1f1291400f9a97ed7a7455676b60c9e9adcf98a6a3c1a6c1fcb791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3593f1a38e2c3b6bf77e1716a41764ed7a38de1ae2bfe72192258c5603b082198713a4cc46073f999fcc6dbded548c20ffddbee2e8a9c534b646ab3812473b4f"} 14:58:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:58:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:58:10 INFO - Contents: 14:58:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/026f3106be72f3c3788a8abbd5dfbdd2c7b45c451c3be11c5e115ec5b29eb93772233a68ca65a3d289cbcca158aaf946040574f6e0654acbcde5166797638819", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70424e8f9ff0e4bf6870484017c0de3ea3b5d64bc8dd7f3f72d01f52c313b5ab32fb8364fae7ff4b78366c3f14902337d66a5e42c76799885d0f787c54dbd99a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e945dd007df909504c992f39214ee4eedcbb47e4cef5b9b904711e53d79e385880d908c5a1f1291400f9a97ed7a7455676b60c9e9adcf98a6a3c1a6c1fcb791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3593f1a38e2c3b6bf77e1716a41764ed7a38de1ae2bfe72192258c5603b082198713a4cc46073f999fcc6dbded548c20ffddbee2e8a9c534b646ab3812473b4f"} 14:58:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:58:10 INFO - Copying logs to upload dir... 14:58:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:58:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.928810 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-05 14:58:10.131069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:10.136038) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1494020032.761234-736481675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/026f3106be72f3c3788a8abbd5dfbdd2c7b45c451c3be11c5e115ec5b29eb93772233a68ca65a3d289cbcca158aaf946040574f6e0654acbcde5166797638819", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70424e8f9ff0e4bf6870484017c0de3ea3b5d64bc8dd7f3f72d01f52c313b5ab32fb8364fae7ff4b78366c3f14902337d66a5e42c76799885d0f787c54dbd99a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e945dd007df909504c992f39214ee4eedcbb47e4cef5b9b904711e53d79e385880d908c5a1f1291400f9a97ed7a7455676b60c9e9adcf98a6a3c1a6c1fcb791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3593f1a38e2c3b6bf77e1716a41764ed7a38de1ae2bfe72192258c5603b082198713a4cc46073f999fcc6dbded548c20ffddbee2e8a9c534b646ab3812473b4f"} build_url:https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/WnUDgc1lSIy5CIwmv0vY0g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/026f3106be72f3c3788a8abbd5dfbdd2c7b45c451c3be11c5e115ec5b29eb93772233a68ca65a3d289cbcca158aaf946040574f6e0654acbcde5166797638819", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/70424e8f9ff0e4bf6870484017c0de3ea3b5d64bc8dd7f3f72d01f52c313b5ab32fb8364fae7ff4b78366c3f14902337d66a5e42c76799885d0f787c54dbd99a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1e945dd007df909504c992f39214ee4eedcbb47e4cef5b9b904711e53d79e385880d908c5a1f1291400f9a97ed7a7455676b60c9e9adcf98a6a3c1a6c1fcb791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3593f1a38e2c3b6bf77e1716a41764ed7a38de1ae2bfe72192258c5603b082198713a4cc46073f999fcc6dbded548c20ffddbee2e8a9c534b646ab3812473b4f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:10.164088) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:10.164388) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1494020032.761234-736481675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:10.247430) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 14:58:10.250819) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 14:58:10.251117) ========= ========= Total master_lag: 0.20 =========