builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1477328333.75 results: success (0) buildid: 20161024091322 builduid: 472d8bb340574b17a79eb04eed84c1d1 revision: 047185d03891ffa44e54e5e6f421f04d20fd643c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.746144) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.746692) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.747003) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.761996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.762384) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 09:58:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-10-24 09:58:54 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089898 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.866757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.867310) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020275 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.917672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:53.918063) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 047185d03891ffa44e54e5e6f421f04d20fd643c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 047185d03891ffa44e54e5e6f421f04d20fd643c --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=56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 09:58:54,604 truncating revision to first 12 chars 2016-10-24 09:58:54,604 Setting DEBUG logging. 2016-10-24 09:58:54,604 attempt 1/10 2016-10-24 09:58:54,604 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/047185d03891?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 09:58:54,976 unpacking tar archive at: fx-team-047185d03891/testing/mozharness/ program finished with exit code 0 elapsedTime=0.768193 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:54.700296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:54.700675) ========= script_repo_revision: 047185d03891ffa44e54e5e6f421f04d20fd643c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:54.701119) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:54.701421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 09:58:54.711569) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-24 09:58:54.711990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:58:55 INFO - MultiFileLogger online at 20161024 09:58:55 in /builds/slave/test 09:58:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:58:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:55 INFO - {'append_to_log': False, 09:58:55 INFO - 'base_work_dir': '/builds/slave/test', 09:58:55 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:58:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:55 INFO - 'branch': 'Fx-Team-Non-PGO', 09:58:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:55 INFO - 'config_files': ('talos/linux_config.py',), 09:58:55 INFO - 'default_actions': ('clobber', 09:58:55 INFO - 'read-buildbot-config', 09:58:55 INFO - 'download-and-extract', 09:58:55 INFO - 'populate-webroot', 09:58:55 INFO - 'create-virtualenv', 09:58:55 INFO - 'install', 09:58:55 INFO - 'run-tests'), 09:58:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:55 INFO - 'download_minidump_stackwalk': True, 09:58:55 INFO - 'download_symbols': 'ondemand', 09:58:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:55 INFO - 'installer_path': 'installer.exe', 09:58:55 INFO - 'log_level': 'info', 09:58:55 INFO - 'log_name': 'talos', 09:58:55 INFO - 'log_to_console': True, 09:58:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:58:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:58:55 INFO - 'opt_config_files': (), 09:58:55 INFO - 'pip_index': False, 09:58:55 INFO - 'sps_profile': False, 09:58:55 INFO - 'sps_profile_interval': 0, 09:58:55 INFO - 'suite': 'dromaeojs', 09:58:55 INFO - 'system_bits': '32', 09:58:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:55 INFO - 'title': 'talos-linux64-ix-037', 09:58:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:55 INFO - 'use_talos_json': True, 09:58:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:55 INFO - 'work_dir': 'build'} 09:58:55 INFO - [mozharness: 2016-10-24 16:58:55.499174Z] Running clobber step. 09:58:55 INFO - Running pre-action listener: _resource_record_pre_action 09:58:55 INFO - Running main action method: clobber 09:58:55 INFO - rmtree: /builds/slave/test/build 09:58:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:56 INFO - Running post-action listener: _resource_record_post_action 09:58:56 INFO - [mozharness: 2016-10-24 16:58:56.469670Z] Finished clobber step (success) 09:58:56 INFO - [mozharness: 2016-10-24 16:58:56.469776Z] Running read-buildbot-config step. 09:58:56 INFO - Running pre-action listener: _resource_record_pre_action 09:58:56 INFO - Running main action method: read_buildbot_config 09:58:56 INFO - Using buildbot properties: 09:58:56 INFO - { 09:58:56 INFO - "project": "", 09:58:56 INFO - "product": "firefox", 09:58:56 INFO - "script_repo_revision": "production", 09:58:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:58:56 INFO - "repository": "", 09:58:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:58:56 INFO - "buildid": "20161024091322", 09:58:56 INFO - "pgo_build": "False", 09:58:56 INFO - "basedir": "/builds/slave/test", 09:58:56 INFO - "buildnumber": 1986, 09:58:56 INFO - "slavename": "talos-linux64-ix-037", 09:58:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:58:56 INFO - "platform": "ubuntu64_hw", 09:58:56 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:58:56 INFO - "branch": "fx-team", 09:58:56 INFO - "repo_path": "integration/fx-team", 09:58:56 INFO - "revision": "047185d03891ffa44e54e5e6f421f04d20fd643c", 09:58:56 INFO - "stage_platform": "linux64", 09:58:56 INFO - "builduid": "472d8bb340574b17a79eb04eed84c1d1", 09:58:56 INFO - "slavebuilddir": "test" 09:58:56 INFO - } 09:58:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:58:56 INFO - Running post-action listener: _resource_record_post_action 09:58:56 INFO - [mozharness: 2016-10-24 16:58:56.472204Z] Finished read-buildbot-config step (success) 09:58:56 INFO - [mozharness: 2016-10-24 16:58:56.472291Z] Running download-and-extract step. 09:58:56 INFO - Running pre-action listener: _resource_record_pre_action 09:58:56 INFO - Running main action method: download_and_extract 09:58:56 INFO - mkdir: /builds/slave/test/build/tests 09:58: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')]} 09:58:56 INFO - trying https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:58:56 INFO - Downloading https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:58:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:58:58 INFO - Downloaded 1361 bytes. 09:58:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:58:58 INFO - Using the following test package requirements: 09:58:58 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:58:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:58:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:58 INFO - u'jsshell-linux-x86_64.zip'], 09:58:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:58:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:58:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:58:58 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:58:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:58:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:58:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:58:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:58:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:58:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:58 INFO - Fetch https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:58:58 INFO - Http code: 200 09:58:58 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 09:58:58 INFO - x-amz-cf-id: 7lTMAfCrP4YDxc0srd6fDI_Botof2oaWG3uWnPxbJnWJdjt2El70og== 09:58:58 INFO - x-amz-version-id: FXKOgyKhqqCaApMgLDOwGj91yo2QECTB 09:58:58 INFO - Expected file size: 20454154 09:58:58 INFO - Obtained file size: 20454154 09:59:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:59:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:59:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:02 INFO - Fetch https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:59:03 INFO - Http code: 200 09:59:03 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:59:03 INFO - x-amz-cf-id: YSO7rq_z_2TeSmnh8cOINAWMWcLZshBYe0qDrstUFWAMpeHcJhx16w== 09:59:03 INFO - x-amz-version-id: FXKOgyKhqqCaApMgLDOwGj91yo2QECTB 09:59:03 INFO - Expected file size: 20454154 09:59:03 INFO - Obtained file size: 20454154 09:59:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:59:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:59:08 INFO - Fetch https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:59:08 INFO - Http code: 200 09:59:08 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 09:59:08 INFO - x-amz-cf-id: _CRSxgKANbx3tZ_Usx6II2df8gcJ_8jP5F7il0V1wazJIq9_KySOkg== 09:59:08 INFO - x-amz-version-id: 3LauHAh1nFUg2yHO9svgH.onfujMomKv 09:59:09 INFO - Expected file size: 14409028 09:59:09 INFO - Obtained file size: 14409028 09:59:09 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')]} 09:59:09 INFO - trying https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:59:09 INFO - Downloading https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:59:10 INFO - Downloaded 55580730 bytes. 09:59:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:59:10 INFO - mkdir: /builds/slave/test/properties 09:59:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:10 INFO - Contents: 09:59:10 INFO - build_url:https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:59:11 INFO - Running post-action listener: _resource_record_post_action 09:59:11 INFO - Running post-action listener: set_extra_try_arguments 09:59:11 INFO - [mozharness: 2016-10-24 16:59:11.028728Z] Finished download-and-extract step (success) 09:59:11 INFO - [mozharness: 2016-10-24 16:59:11.028974Z] Running populate-webroot step. 09:59:11 INFO - Running pre-action listener: _resource_record_pre_action 09:59:11 INFO - Running main action method: populate_webroot 09:59:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:11 INFO - '--tppagecycles', 09:59:11 INFO - '7'], 09:59:11 INFO - 'tests': ['tsvgm']}}, 09:59:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:59:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:59:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:11 INFO - 'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:11 INFO - 'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['damp', 'tps']}, 09:59:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:11 INFO - 'tests': ['damp', 'tps']}, 09:59:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['dromaeo_dom']}, 09:59:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['basic_compositor_video']}, 09:59:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:59:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['a11yr', 09:59:11 INFO - 'ts_paint', 09:59:11 INFO - 'tpaint', 09:59:11 INFO - 'sessionrestore', 09:59:11 INFO - 'sessionrestore_no_auto_restore', 09:59:11 INFO - 'tabpaint']}, 09:59:11 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:11 INFO - 'ts_paint', 09:59:11 INFO - 'tpaint', 09:59:11 INFO - 'sessionrestore', 09:59:11 INFO - 'sessionrestore_no_auto_restore', 09:59:11 INFO - 'tabpaint']}, 09:59:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:59:11 INFO - 'ts_paint', 09:59:11 INFO - 'tpaint', 09:59:11 INFO - 'sessionrestore', 09:59:11 INFO - 'sessionrestore_no_auto_restore', 09:59:11 INFO - 'tabpaint']}, 09:59:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:59:11 INFO - 'ts_paint', 09:59:11 INFO - 'tpaint', 09:59:11 INFO - 'sessionrestore', 09:59:11 INFO - 'sessionrestore_no_auto_restore', 09:59:11 INFO - 'tabpaint']}, 09:59:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['a11yr', 09:59:11 INFO - 'ts_paint', 09:59:11 INFO - 'tpaint', 09:59:11 INFO - 'sessionrestore', 09:59:11 INFO - 'sessionrestore_no_auto_restore', 09:59:11 INFO - 'tabpaint']}, 09:59:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['a11yr', 09:59:11 INFO - 'ts_paint', 09:59:11 INFO - 'tpaint', 09:59:11 INFO - 'sessionrestore', 09:59:11 INFO - 'sessionrestore_no_auto_restore', 09:59:11 INFO - 'tabpaint']}, 09:59:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['tsvgx', 09:59:11 INFO - 'tsvgr_opacity', 09:59:11 INFO - 'tart', 09:59:11 INFO - 'tscrollx', 09:59:11 INFO - 'cart']}, 09:59:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:11 INFO - 'tsvgr_opacity', 09:59:11 INFO - 'tart', 09:59:11 INFO - 'tscrollx', 09:59:11 INFO - 'cart']}, 09:59:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:11 INFO - 'talos_options': ['--disable-e10s'], 09:59:11 INFO - 'tests': ['tp5o']}, 09:59:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:11 INFO - 'tests': ['tp5o']}, 09:59:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:11 INFO - 'talos_options': ['--disable-e10s', 09:59:11 INFO - '--xperf_path', 09:59:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:11 INFO - 'tests': ['tp5n']}, 09:59:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:11 INFO - 'talos_options': ['--xperf_path', 09:59:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:11 INFO - 'tests': ['tp5n']}}, 09:59:11 INFO - 'talos.zip': {'path': '', 09:59:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:11 INFO - Running post-action listener: _resource_record_post_action 09:59:11 INFO - [mozharness: 2016-10-24 16:59:11.045098Z] Finished populate-webroot step (success) 09:59:11 INFO - [mozharness: 2016-10-24 16:59:11.045215Z] Running create-virtualenv step. 09:59:11 INFO - Running pre-action listener: _resource_record_pre_action 09:59:11 INFO - Running main action method: create_virtualenv 09:59:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:11 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 09:59:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:59:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:11 INFO - Using real prefix '/usr' 09:59:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:11 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:13 INFO - Installing pip.................done. 09:59:13 INFO - Return code: 0 09:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:59:13 INFO - Reading from file tmpfile_stdout 09:59:13 INFO - Output received: 09:59:13 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) 09:59:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59:13 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')]} 09:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:13 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')]} 09:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:13 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:13 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 09:59:13 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 09:59:13 INFO - Using env: {'DISPLAY': ':0', 09:59:13 INFO - 'HOME': '/home/cltbld', 09:59:13 INFO - 'LANG': 'en_US.UTF-8', 09:59:13 INFO - 'LANGUAGE': 'en_US:en', 09:59:13 INFO - 'LOGNAME': 'cltbld', 09:59:13 INFO - 'MAIL': '/var/mail/cltbld', 09:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:13 INFO - 'MOZ_NO_REMOTE': '1', 09:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:13 INFO - 'NO_EM_RESTART': '1', 09:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:13 INFO - 'PWD': '/builds/slave/test', 09:59:13 INFO - 'SHELL': '/bin/bash', 09:59:13 INFO - 'SHLVL': '1', 09:59:13 INFO - 'TERM': 'linux', 09:59:13 INFO - 'TMOUT': '86400', 09:59:13 INFO - 'USER': 'cltbld', 09:59:13 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:13 INFO - '_': '/tools/buildbot/bin/python'} 09:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:14 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 09:59:14 INFO - Cleaning up... 09:59:14 INFO - Return code: 0 09:59:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59:14 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')]} 09:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:14 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')]} 09:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:14 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:14 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 09:59:14 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 09:59:14 INFO - Using env: {'DISPLAY': ':0', 09:59:14 INFO - 'HOME': '/home/cltbld', 09:59:14 INFO - 'LANG': 'en_US.UTF-8', 09:59:14 INFO - 'LANGUAGE': 'en_US:en', 09:59:14 INFO - 'LOGNAME': 'cltbld', 09:59:14 INFO - 'MAIL': '/var/mail/cltbld', 09:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:14 INFO - 'MOZ_NO_REMOTE': '1', 09:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:14 INFO - 'NO_EM_RESTART': '1', 09:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:14 INFO - 'PWD': '/builds/slave/test', 09:59:14 INFO - 'SHELL': '/bin/bash', 09:59:14 INFO - 'SHLVL': '1', 09:59:14 INFO - 'TERM': 'linux', 09:59:14 INFO - 'TMOUT': '86400', 09:59:14 INFO - 'USER': 'cltbld', 09:59:14 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:14 INFO - '_': '/tools/buildbot/bin/python'} 09:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:14 INFO - Downloading/unpacking psutil>=3.1.1 09:59:14 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 09:59:14 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 09:59:14 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 09:59:14 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 09:59:14 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 09:59:14 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 09:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:16 INFO - Installing collected packages: psutil 09:59:16 INFO - Running setup.py install for psutil 09:59:16 INFO - building 'psutil._psutil_linux' extension 09:59:16 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 09:59:16 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 09:59:16 INFO - building 'psutil._psutil_posix' extension 09:59:16 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 09:59:16 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 09:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:16 INFO - Successfully installed psutil 09:59:16 INFO - Cleaning up... 09:59:16 INFO - Return code: 0 09:59:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:16 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')]} 09:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:16 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')]} 09:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:16 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:16 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 09:59:16 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 09:59:16 INFO - Using env: {'DISPLAY': ':0', 09:59:16 INFO - 'HOME': '/home/cltbld', 09:59:16 INFO - 'LANG': 'en_US.UTF-8', 09:59:16 INFO - 'LANGUAGE': 'en_US:en', 09:59:16 INFO - 'LOGNAME': 'cltbld', 09:59:16 INFO - 'MAIL': '/var/mail/cltbld', 09:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:16 INFO - 'MOZ_NO_REMOTE': '1', 09:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:16 INFO - 'NO_EM_RESTART': '1', 09:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:16 INFO - 'PWD': '/builds/slave/test', 09:59:16 INFO - 'SHELL': '/bin/bash', 09:59:16 INFO - 'SHLVL': '1', 09:59:16 INFO - 'TERM': 'linux', 09:59:16 INFO - 'TMOUT': '86400', 09:59:16 INFO - 'USER': 'cltbld', 09:59:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:16 INFO - '_': '/tools/buildbot/bin/python'} 09:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59:17 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 09:59:17 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 09:59:17 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 09:59:17 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 09:59:17 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 09:59:17 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 09:59:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:19 INFO - Installing collected packages: mozsystemmonitor 09:59:19 INFO - Running setup.py install for mozsystemmonitor 09:59:19 INFO - Successfully installed mozsystemmonitor 09:59:19 INFO - Cleaning up... 09:59:19 INFO - Return code: 0 09:59:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:19 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')]} 09:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 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')]} 09:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:19 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:19 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 09:59:19 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 09:59:19 INFO - Using env: {'DISPLAY': ':0', 09:59:19 INFO - 'HOME': '/home/cltbld', 09:59:19 INFO - 'LANG': 'en_US.UTF-8', 09:59:19 INFO - 'LANGUAGE': 'en_US:en', 09:59:19 INFO - 'LOGNAME': 'cltbld', 09:59:19 INFO - 'MAIL': '/var/mail/cltbld', 09:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:19 INFO - 'MOZ_NO_REMOTE': '1', 09:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:19 INFO - 'NO_EM_RESTART': '1', 09:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:19 INFO - 'PWD': '/builds/slave/test', 09:59:19 INFO - 'SHELL': '/bin/bash', 09:59:19 INFO - 'SHLVL': '1', 09:59:19 INFO - 'TERM': 'linux', 09:59:19 INFO - 'TMOUT': '86400', 09:59:19 INFO - 'USER': 'cltbld', 09:59:19 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:19 INFO - '_': '/tools/buildbot/bin/python'} 09:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:19 INFO - Downloading/unpacking jsonschema==2.5.1 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:19 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 09:59:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:59:21 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 09:59:21 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 09:59:21 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 09:59:21 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 09:59:21 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 09:59:21 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 09:59:21 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:21 INFO - warning: no files found matching '*.txt' 09:59:21 INFO - no previously-included directories found matching 'build' 09:59:21 INFO - no previously-included directories found matching 'dist' 09:59:21 INFO - no previously-included directories found matching '.git*' 09:59:21 INFO - Installing collected packages: jsonschema, functools32 09:59:21 INFO - Running setup.py install for functools32 09:59:21 INFO - warning: no files found matching '*.txt' 09:59:21 INFO - no previously-included directories found matching 'build' 09:59:21 INFO - no previously-included directories found matching 'dist' 09:59:21 INFO - no previously-included directories found matching '.git*' 09:59:21 INFO - Successfully installed jsonschema functools32 09:59:21 INFO - Cleaning up... 09:59:21 INFO - Return code: 0 09:59:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:59:21 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')]} 09:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:21 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')]} 09:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:21 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:21 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 09:59:21 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 09:59:21 INFO - Using env: {'DISPLAY': ':0', 09:59:21 INFO - 'HOME': '/home/cltbld', 09:59:21 INFO - 'LANG': 'en_US.UTF-8', 09:59:21 INFO - 'LANGUAGE': 'en_US:en', 09:59:21 INFO - 'LOGNAME': 'cltbld', 09:59:21 INFO - 'MAIL': '/var/mail/cltbld', 09:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:21 INFO - 'MOZ_NO_REMOTE': '1', 09:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:21 INFO - 'NO_EM_RESTART': '1', 09:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:21 INFO - 'PWD': '/builds/slave/test', 09:59:21 INFO - 'SHELL': '/bin/bash', 09:59:21 INFO - 'SHLVL': '1', 09:59:21 INFO - 'TERM': 'linux', 09:59:21 INFO - 'TMOUT': '86400', 09:59:21 INFO - 'USER': 'cltbld', 09:59:21 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:21 INFO - '_': '/tools/buildbot/bin/python'} 09:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:59:22 INFO - Cleaning up... 09:59:22 INFO - Return code: 0 09:59:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59:22 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')]} 09:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:22 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')]} 09:59:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:22 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:22 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 09:59:22 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 09:59:22 INFO - Using env: {'DISPLAY': ':0', 09:59:22 INFO - 'HOME': '/home/cltbld', 09:59:22 INFO - 'LANG': 'en_US.UTF-8', 09:59:22 INFO - 'LANGUAGE': 'en_US:en', 09:59:22 INFO - 'LOGNAME': 'cltbld', 09:59:22 INFO - 'MAIL': '/var/mail/cltbld', 09:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:22 INFO - 'MOZ_NO_REMOTE': '1', 09:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:22 INFO - 'NO_EM_RESTART': '1', 09:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:22 INFO - 'PWD': '/builds/slave/test', 09:59:22 INFO - 'SHELL': '/bin/bash', 09:59:22 INFO - 'SHLVL': '1', 09:59:22 INFO - 'TERM': 'linux', 09:59:22 INFO - 'TMOUT': '86400', 09:59:22 INFO - 'USER': 'cltbld', 09:59:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:22 INFO - '_': '/tools/buildbot/bin/python'} 09:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:22 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:22 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 09:59:22 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 09:59:22 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 09:59:22 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 09:59:22 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 09:59:22 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 09:59:24 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 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 09:59:24 INFO - Downloading docopt-0.6.1.tar.gz 09:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:25 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:25 INFO - Running setup.py install for blobuploader 09:59:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:25 INFO - Running setup.py install for requests 09:59:25 INFO - Running setup.py install for docopt 09:59:25 INFO - Successfully installed blobuploader requests docopt 09:59:25 INFO - Cleaning up... 09:59:25 INFO - Return code: 0 09:59:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:25 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')]} 09:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:25 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')]} 09:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:25 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:25 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 09:59:25 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 09:59:25 INFO - Using env: {'DISPLAY': ':0', 09:59:25 INFO - 'HOME': '/home/cltbld', 09:59:25 INFO - 'LANG': 'en_US.UTF-8', 09:59:25 INFO - 'LANGUAGE': 'en_US:en', 09:59:25 INFO - 'LOGNAME': 'cltbld', 09:59:25 INFO - 'MAIL': '/var/mail/cltbld', 09:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:25 INFO - 'MOZ_NO_REMOTE': '1', 09:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:25 INFO - 'NO_EM_RESTART': '1', 09:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:25 INFO - 'PWD': '/builds/slave/test', 09:59:25 INFO - 'SHELL': '/bin/bash', 09:59:25 INFO - 'SHLVL': '1', 09:59:25 INFO - 'TERM': 'linux', 09:59:25 INFO - 'TMOUT': '86400', 09:59:25 INFO - 'USER': 'cltbld', 09:59:25 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:25 INFO - '_': '/tools/buildbot/bin/python'} 09:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:25 INFO - Running setup.py (path:/tmp/pip-Va1kYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:25 INFO - Running setup.py (path:/tmp/pip-BcN9ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:26 INFO - Running setup.py (path:/tmp/pip-VFftNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:26 INFO - Running setup.py (path:/tmp/pip-XqY0M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:26 INFO - Running setup.py (path:/tmp/pip-7q6no0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:26 INFO - Running setup.py (path:/tmp/pip-GA206r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:26 INFO - Running setup.py (path:/tmp/pip-AwvybL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:26 INFO - Running setup.py (path:/tmp/pip-uQNl50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:26 INFO - Running setup.py (path:/tmp/pip-SHLVq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:26 INFO - Running setup.py (path:/tmp/pip-8f3SOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:26 INFO - Running setup.py (path:/tmp/pip-yx90gP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:26 INFO - Running setup.py (path:/tmp/pip-dfriZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:26 INFO - Running setup.py (path:/tmp/pip-OgTvtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:26 INFO - Running setup.py (path:/tmp/pip-go6abS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:26 INFO - Running setup.py (path:/tmp/pip-eK4U62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:26 INFO - Running setup.py (path:/tmp/pip-sF0q5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:27 INFO - Running setup.py (path:/tmp/pip-sbGBEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:27 INFO - Running setup.py install for manifestparser 09:59:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Running setup.py install for mozcrash 09:59:27 INFO - Running setup.py install for mozdebug 09:59:27 INFO - Running setup.py install for mozdevice 09:59:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Running setup.py install for mozfile 09:59:27 INFO - Running setup.py install for mozhttpd 09:59:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Running setup.py install for mozinfo 09:59:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Running setup.py install for mozInstall 09:59:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:27 INFO - Running setup.py install for mozleak 09:59:28 INFO - Running setup.py install for mozlog 09:59:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:28 INFO - Running setup.py install for moznetwork 09:59:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:28 INFO - Running setup.py install for mozprocess 09:59:28 INFO - Running setup.py install for mozprofile 09:59:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:28 INFO - Running setup.py install for mozrunner 09:59:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:28 INFO - Running setup.py install for mozscreenshot 09:59:28 INFO - Running setup.py install for moztest 09:59:28 INFO - Running setup.py install for mozversion 09:59:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:28 INFO - Cleaning up... 09:59:28 INFO - Return code: 0 09:59:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:28 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')]} 09:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:28 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')]} 09:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:28 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:28 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 09:59:28 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 09:59:28 INFO - Using env: {'DISPLAY': ':0', 09:59:28 INFO - 'HOME': '/home/cltbld', 09:59:28 INFO - 'LANG': 'en_US.UTF-8', 09:59:28 INFO - 'LANGUAGE': 'en_US:en', 09:59:28 INFO - 'LOGNAME': 'cltbld', 09:59:28 INFO - 'MAIL': '/var/mail/cltbld', 09:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:28 INFO - 'MOZ_NO_REMOTE': '1', 09:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:28 INFO - 'NO_EM_RESTART': '1', 09:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:28 INFO - 'PWD': '/builds/slave/test', 09:59:28 INFO - 'SHELL': '/bin/bash', 09:59:28 INFO - 'SHLVL': '1', 09:59:28 INFO - 'TERM': 'linux', 09:59:28 INFO - 'TMOUT': '86400', 09:59:28 INFO - 'USER': 'cltbld', 09:59:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:28 INFO - '_': '/tools/buildbot/bin/python'} 09:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:29 INFO - Running setup.py (path:/tmp/pip-_JKask-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:29 INFO - Running setup.py (path:/tmp/pip-lWejGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:29 INFO - Running setup.py (path:/tmp/pip-9inbJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:29 INFO - Running setup.py (path:/tmp/pip-etEAdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:29 INFO - Running setup.py (path:/tmp/pip-JIrzxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:29 INFO - Running setup.py (path:/tmp/pip-oBOTmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:29 INFO - Running setup.py (path:/tmp/pip-kmI4Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:29 INFO - Running setup.py (path:/tmp/pip-FYxV_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:29 INFO - Running setup.py (path:/tmp/pip-mHNLGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:29 INFO - Running setup.py (path:/tmp/pip-wifcDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:29 INFO - Running setup.py (path:/tmp/pip-HvTSaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:29 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:29 INFO - Running setup.py (path:/tmp/pip-1lEtgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 09:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:30 INFO - Running setup.py (path:/tmp/pip-fYtYDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:30 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)) 09:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:30 INFO - Running setup.py (path:/tmp/pip-I5_LAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:30 INFO - Running setup.py (path:/tmp/pip-Hm_KyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:30 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)) 09:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:30 INFO - Running setup.py (path:/tmp/pip-hP0xvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 09:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:30 INFO - Running setup.py (path:/tmp/pip-_4HxAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:30 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)) 09:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:30 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)) 09:59:30 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:59:30 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:59:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:30 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 09:59:30 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 09:59:30 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 09:59:30 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 09:59:30 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 09:59:30 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 09:59:33 INFO - Downloading blessings-1.6.tar.gz 09:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:33 INFO - Installing collected packages: blessings 09:59:33 INFO - Running setup.py install for blessings 09:59:33 INFO - Successfully installed blessings 09:59:33 INFO - Cleaning up... 09:59:33 INFO - Return code: 0 09:59:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:33 INFO - Reading from file tmpfile_stdout 09:59:33 INFO - Current package versions: 09:59:33 INFO - argparse == 1.2.1 09:59:33 INFO - blessings == 1.6 09:59:33 INFO - blobuploader == 1.2.4 09:59:33 INFO - docopt == 0.6.1 09:59:33 INFO - functools32 == 3.2.3-2 09:59:33 INFO - jsonschema == 2.5.1 09:59:33 INFO - manifestparser == 1.1 09:59:33 INFO - mozInstall == 1.12 09:59:33 INFO - mozcrash == 0.17 09:59:33 INFO - mozdebug == 0.1 09:59:33 INFO - mozdevice == 0.48 09:59:33 INFO - mozfile == 1.2 09:59:33 INFO - mozhttpd == 0.7 09:59:33 INFO - mozinfo == 0.9 09:59:33 INFO - mozleak == 0.1 09:59:33 INFO - mozlog == 3.4 09:59:33 INFO - moznetwork == 0.27 09:59:33 INFO - mozprocess == 0.23 09:59:33 INFO - mozprofile == 0.28 09:59:33 INFO - mozrunner == 6.12 09:59:33 INFO - mozscreenshot == 0.1 09:59:33 INFO - mozsystemmonitor == 0.3 09:59:33 INFO - moztest == 0.7 09:59:33 INFO - mozversion == 1.4 09:59:33 INFO - psutil == 3.1.1 09:59:33 INFO - requests == 1.2.3 09:59:33 INFO - wsgiref == 0.1.2 09:59:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:33 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')]} 09:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:33 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')]} 09:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:33 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:33 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 09:59:33 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 09:59:33 INFO - Using env: {'DISPLAY': ':0', 09:59:33 INFO - 'HOME': '/home/cltbld', 09:59:33 INFO - 'LANG': 'en_US.UTF-8', 09:59:33 INFO - 'LANGUAGE': 'en_US:en', 09:59:33 INFO - 'LOGNAME': 'cltbld', 09:59:33 INFO - 'MAIL': '/var/mail/cltbld', 09:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:33 INFO - 'MOZ_NO_REMOTE': '1', 09:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:33 INFO - 'NO_EM_RESTART': '1', 09:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:33 INFO - 'PWD': '/builds/slave/test', 09:59:33 INFO - 'SHELL': '/bin/bash', 09:59:33 INFO - 'SHLVL': '1', 09:59:33 INFO - 'TERM': 'linux', 09:59:33 INFO - 'TMOUT': '86400', 09:59:33 INFO - 'USER': 'cltbld', 09:59:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:33 INFO - '_': '/tools/buildbot/bin/python'} 09:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 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)) 09:59:33 INFO - Cleaning up... 09:59:34 INFO - Return code: 0 09:59:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:34 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')]} 09:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:34 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')]} 09:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:34 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 0x7f6ee9b71f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', '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 09:59:34 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 09:59:34 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 09:59:34 INFO - Using env: {'DISPLAY': ':0', 09:59:34 INFO - 'HOME': '/home/cltbld', 09:59:34 INFO - 'LANG': 'en_US.UTF-8', 09:59:34 INFO - 'LANGUAGE': 'en_US:en', 09:59:34 INFO - 'LOGNAME': 'cltbld', 09:59:34 INFO - 'MAIL': '/var/mail/cltbld', 09:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:34 INFO - 'MOZ_NO_REMOTE': '1', 09:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:34 INFO - 'NO_EM_RESTART': '1', 09:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:34 INFO - 'PWD': '/builds/slave/test', 09:59:34 INFO - 'SHELL': '/bin/bash', 09:59:34 INFO - 'SHLVL': '1', 09:59:34 INFO - 'TERM': 'linux', 09:59:34 INFO - 'TMOUT': '86400', 09:59:34 INFO - 'USER': 'cltbld', 09:59:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:34 INFO - '_': '/tools/buildbot/bin/python'} 09:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:59:34 INFO - Cleaning up... 09:59:34 INFO - Return code: 0 09:59:34 INFO - Running post-action listener: _resource_record_post_action 09:59:34 INFO - Running post-action listener: _start_resource_monitoring 09:59:34 INFO - Starting resource monitoring. 09:59:34 INFO - [mozharness: 2016-10-24 16:59:34.260540Z] Finished create-virtualenv step (success) 09:59:34 INFO - [mozharness: 2016-10-24 16:59:34.261043Z] Running install step. 09:59:34 INFO - Running pre-action listener: _resource_record_pre_action 09:59:34 INFO - Running main action method: install 09:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:34 INFO - Reading from file tmpfile_stdout 09:59:34 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:34 INFO - Reading from file tmpfile_stdout 09:59:34 INFO - Output received: 09:59:34 INFO - Usage: mozinstall [options] installer 09:59:34 INFO - Options: 09:59:34 INFO - -h, --help show this help message and exit 09:59:34 INFO - -d DEST, --destination=DEST 09:59:34 INFO - Directory to install application into. [default: 09:59:34 INFO - "/builds/slave/test"] 09:59:34 INFO - --app=APP Application being installed. [default: firefox] 09:59:34 INFO - mkdir: /builds/slave/test/build/application 09:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:59:50 INFO - Reading from file tmpfile_stdout 09:59:50 INFO - Output received: 09:59:50 INFO - /builds/slave/test/build/application/firefox/firefox 09:59:50 INFO - Running post-action listener: _resource_record_post_action 09:59:50 INFO - [mozharness: 2016-10-24 16:59:50.604816Z] Finished install step (success) 09:59:50 INFO - [mozharness: 2016-10-24 16:59:50.605063Z] Running run-tests step. 09:59:50 INFO - Running pre-action listener: _resource_record_pre_action 09:59:50 INFO - Running main action method: run_tests 09:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:50 INFO - Python 2.7.3 09:59:50 INFO - Return code: 0 09:59:50 INFO - grabbing minidump binary from tooltool 09:59: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')]} 09:59:50 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 0x21fef60>, '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 0x21ffd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22001d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:50 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 09:59:50 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 09:59:50 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 09:59:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:50 INFO - Return code: 0 09:59:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:59:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:59:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 09:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 09:59:50 INFO - Using env: {'DISPLAY': ':0', 09:59:50 INFO - 'HOME': '/home/cltbld', 09:59:50 INFO - 'LANG': 'en_US.UTF-8', 09:59:50 INFO - 'LANGUAGE': 'en_US:en', 09:59:50 INFO - 'LOGNAME': 'cltbld', 09:59:50 INFO - 'MAIL': '/var/mail/cltbld', 09:59:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:50 INFO - 'MOZ_NO_REMOTE': '1', 09:59:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:50 INFO - 'NO_EM_RESTART': '1', 09:59:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:50 INFO - 'PWD': '/builds/slave/test', 09:59:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:50 INFO - 'SHELL': '/bin/bash', 09:59:50 INFO - 'SHLVL': '1', 09:59:50 INFO - 'TERM': 'linux', 09:59:50 INFO - 'TMOUT': '86400', 09:59:50 INFO - 'USER': 'cltbld', 09:59:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227', 09:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:50 INFO - '_': '/tools/buildbot/bin/python'} 09:59:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 09:59:50 INFO - mozversion application_buildid: 20161024091322 09:59:50 INFO - mozversion application_changeset: 047185d03891ffa44e54e5e6f421f04d20fd643c 09:59:50 INFO - mozversion application_display_name: Nightly 09:59:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:50 INFO - mozversion application_name: Firefox 09:59:50 INFO - mozversion application_remotingname: firefox 09:59:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:59:50 INFO - mozversion application_vendor: Mozilla 09:59:50 INFO - mozversion application_version: 52.0a1 09:59:50 INFO - mozversion platform_buildid: 20161024091322 09:59:50 INFO - mozversion platform_changeset: 047185d03891ffa44e54e5e6f421f04d20fd643c 09:59:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:59:50 INFO - mozversion platform_version: 52.0a1 09:59:50 INFO - using testdate: 1477328390 09:59:50 INFO - actual date: 1477328390 09:59:50 INFO - starting webserver on 'localhost:43969' 09:59:50 INFO - SUITE-START | Running 2 tests 09:59:50 INFO - TEST-START | dromaeo_css 09:59:50 INFO - operating with platform_type : linux_ 09:59:50 INFO - Initialising browser for dromaeo_css test... 09:59:50 INFO - TEST-INFO | started process 23568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXeB7gP/profile http://localhost:43969/getInfo.html) 09:59:55 INFO - PROCESS | 23568 | __metrics Screen width/height:1600/1200 09:59:55 INFO - PROCESS | 23568 | colorDepth:24 09:59:55 INFO - PROCESS | 23568 | Browser inner width/height: 1024/697 09:59:55 INFO - PROCESS | 23568 | __metrics 09:59:55 INFO - PROCESS | 23568 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:59:55 INFO - PROCESS | 23568 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:56 INFO - PROCESS | 23568 | console.error: PushService: 09:59:56 INFO - PROCESS | 23568 | stateChangeProcessEnqueue: Error transitioning state 09:59:56 INFO - PROCESS | 23568 | UnknownError 09:59:57 INFO - TEST-INFO | 23568: exit 0 09:59:57 INFO - Browser initialized. 09:59:57 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:57 INFO - TEST-INFO | started process 23647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXeB7gP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:09 INFO - PROCESS | 23647 | RSS: Main: 173563904 10:00:09 INFO - PROCESS | 23647 | 10:01:01 INFO - PROCESS | 23647 | 1477328461100 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:03:14 INFO - PROCESS | 23647 | Cycle 1(1): loaded http://localhost:43969/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43969/tests/dromaeo/cssquery-ext.html) 10:03:16 INFO - PROCESS | 23647 | RSS: Main: 376303616 10:03:16 INFO - PROCESS | 23647 | 10:06:19 INFO - PROCESS | 23647 | Cycle 1(1): loaded http://localhost:43969/tests/dromaeo/cssquery-ext.html (next: http://localhost:43969/tests/dromaeo/cssquery-jquery.html) 10:06:20 INFO - PROCESS | 23647 | RSS: Main: 282677248 10:06:20 INFO - PROCESS | 23647 | 10:09:22 INFO - PROCESS | 23647 | Cycle 1(1): loaded http://localhost:43969/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43969/tests/dromaeo/cssquery-mootools.html) 10:09:23 INFO - PROCESS | 23647 | RSS: Main: 218865664 10:09:23 INFO - PROCESS | 23647 | 10:12:25 INFO - PROCESS | 23647 | Cycle 1(1): loaded http://localhost:43969/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43969/tests/dromaeo/cssquery-prototype.html) 10:12:25 INFO - PROCESS | 23647 | RSS: Main: 243195904 10:12:25 INFO - PROCESS | 23647 | 10:15:29 INFO - PROCESS | 23647 | Cycle 1(1): loaded http://localhost:43969/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43969/tests/dromaeo/cssquery-yui.html) 10:15:29 INFO - PROCESS | 23647 | RSS: Main: 220409856 10:15:29 INFO - PROCESS | 23647 | 10:18:32 INFO - PROCESS | 23647 | Cycle 1(1): loaded http://localhost:43969/tests/dromaeo/cssquery-yui.html (next: http://localhost:43969/tests/dromaeo/cssquery-dojo.html) 10:18:33 INFO - PROCESS | 23647 | RSS: Main: 295649280 10:18:33 INFO - PROCESS | 23647 | 10:18:33 INFO - PROCESS | 23647 | __start_tp_report 10:18:33 INFO - PROCESS | 23647 | _x_x_mozilla_page_load 10:18:33 INFO - PROCESS | 23647 | _x_x_mozilla_page_load_details 10:18:33 INFO - PROCESS | 23647 | |i|pagename|runs| 10:18:33 INFO - PROCESS | 23647 | |0;dojo.html;2616.123598594471;2638.4854953284116;2670.172246603553;2672.9599056014163;2683.0072873036966;4565.817367305303;4661.487236403993;4682.344471773954;4707.552782485663;4730.739809310491;4663;4678.53214678532;4688.578027977482;4693.342931989524;4701.811927522904;4294.334378171388;4319.870403887889;4332.263515202408;4357.825686972533;4379.649628029766;4350.695451318409;4359.215341238576;4385.912281754363;4386.385905973167;4392.450943632046;4308.633766129883;4314.546972567882;4333.133373325331;4359.476862776455;4366.868993930188;4390.27560452525;4392.868213953587;4393.538678438782;4409.9118017639785;4420.403245561856;4172.4784401949755;4215.114825886568;4262.722923009995;4291.957080429187;4318.093200427914;4636.35091087248;4653.185692503798;4655.51117132703;4668.5798278155125;4743.620510359163;4945.530174633404;4988.152014157602;5002.399712034543;5007.724575148365;5040;4863.902721945577;4907.533784290523;4911.312416261762;5039.269305950616;5093.363329583802;4648.0703859227615;4652.32541281519;4666.626669866402;4676.836310729176;4736.644751643572;5111.5655169310285;5119.180931051014;5120.667156634881;5121.129408000575;5176.870578235575;4757.904841903142;4910.950890491121;4911.484294149134;4918.631102667314;4981.103401387785;4863.197572400514;4927.482614325516;4988.925166122511;5032.370953630796;5039.017391608674;4967.428745694219;4969.950300496948;4970.304157417964;5022.096022715873;5053.140966035783;4970.90058198834;4978.32792572998;4978.4025916890205;4985.252212168204;5034.244863270539;4214.4099826024385;4215.283401821697;4253.8723838284905;4294.184105020036;4329.134173165379;3670.3576874046935;3751.362268414376;3773.471713960048;3787.8295476703615;3803.9239215216094;4330;4339.956600433955;4346.456692913386;4366.083122544302;4390.517043125254;5054.671446355975;5064.645474816727;5065.189569668835;5073.543381095646;5101.795928162832;4179.6029377209115;4221.957780422218;4328.458942632171;4332.870013899588;4367.978160109243;4580.129775342741;4617.445906491243;4617.953820461819;4623.237165867594;4682.204025315705;4783.1390349737385;4792.496787837227;4799.424069111729;4800.73595952226;4858.05267972742;4880.658353915192;5020.47285035066;5060.0132974071175;5062.417821950376;5122.667026643257;4674.5325467452985;4714.104320179155;4721.339012538178;4741.075490279362;4745.952540474689;4919.458859525378;4922.286268490977;4922.581580565692;4923.753812309442;4924.778384972613;4984.152694041949;4996.775145118406;4998.225275082368;5003.649744517995;5011.799528018839;4864.36763220779;4873.829415970424;4874.122657921466;4878.268259760922;4882.194437917704;4783.904321913612;4806.255030470283;4835.153848076502;4855.320255164209;4895;4829.782659780389;4832.106060378841;4834.854954351375;4886.633502487257;4892.92660610084;4921.827736029221;4922.483139270468;4925.581325587365;4930.161872481615;4967.205247160437;4695.859124226278;4731;4746.644001699818;4816.614670826255;4874.488178741181 10:18:33 INFO - PROCESS | 23647 | |1;ext.html;569.6382796923954;575.1832397994847;582.4845012164236;582.5863636817858;588.7497813429294;28939.27651808706;31397.84301078494;31538.36923261536;38757;39508.40737388934;40689;41388.79305603475;41470.37794433086;41502.96242593937;41581.16837663245;7649.770506884788;7802.570858602775;7802.882956755653;7808.336291415237;7809.219078092174;7531.2468753124795;7636.961815190944;7639.961800190991;7643.968064311302;7647.847043059135;7636.3890888728765;7688.423368247376;7690.115636701795;7692.961535192344;7698.345640620554;7628.313451789338;7665.501742386755;7667.654955527015;7670.923290767077;7676.1172465166665;7690.769276921701;7743.10954240264;7751.612419379008;7756.340711039568;7760.495567788075;38912.61087389118;39246.803765981276;39336.60663393358;39337;39423.40864887029;3075.6309242890998;3093.7370323522528;3187.4421976154313;3267.068885367659;3393.5588373511287;29012.27469313263;29412.41175176506;29772.255693607618;29917.25206869824;30742.46809531679;3371.140359208386;3535.381308271068;3565.964340356589;3618.0412190769202;3677.8161091945294;199794;249434;250770;250989;251800;28783.71216287852;29288.853555732087;55477.445225548036;56123.43876561182;56192.71903640455;32281.838590806896;32448.83775581107;32594.185145371557;32605.67394326074;32647.347053058806;12911.289879056554;13114.278714670785;13130;13134;13138.671533211555;10266.538005789758;10345.120664743581;10345.844812327821;10350.948245258876;10352.275340726077;7644.732434364771;7739.845203095907;7785.3771698264;7788.415868809862;7834.804129896798;2968.584398184256;3033.833139177322;3046.2688954650725;3061.8315992620173;3072.2472994116583;847.7753395350237;857.438377862501;871.5163084488044;913.196387179278;951.296040929707;27373.863130684218;27935.860320698266;30298.545521817192;30698.693013069584;32727;881.7487016200353;943.0475220027821;959.4866746290701;961.8220629183623;1017.6489111256604;14112.929435352962;14761.261936903113;14933.178675172752;15259.542213733606;15307.540773776804;369118;377587;377656;378049;378779;50899.49100509022;51583.226251606255;51666.741666291426;51727;51806.74096629568;1080.0981180714034;1114.0307932099126;1161.4076820821274;1196.300164403816;1206.6983254186453;26038;28961.7103828959;29598.55602165926;29635.40729185361;29766.553501697927;42644.78677606592;43308;43326.56673433226;43353.783231083646;43493.565064350216;300892;302623;303079;303434;303864;31180.844095779375;31633.841830790698;32466.675333246367;32483.18792030218;37962.21774536269;35576.64423355733;36754.448683270304;41972.580274196866;42826;42957.14085718331;35278.82360588181;35295.29409411746;35605.28789424249;35721.64278357287;35952.46071308985;35217.295654086265;35634.46548301829;35822.641773581934;35855.46216806802;36142;34377.65622343744;34714.47928281027;34954;35225;35786.10534736652;30228.395432090794;32442.35115297728;32472.51291230586;32621.673783261864;32698.509522356708;24532.877335613208;25074.49851002933;25088.74911250864;25197.74802251954;25558 10:18:33 INFO - PROCESS | 23647 | |2;jquery.html;357.8461261657486;361.56431500042453;366.6406921217207;376.0617259936459;384.91339448624063;15520.611984700388;16546.172691365442;17277;17356.004059533156;17360.13199340031;16429;17132.82867171328;17197.484075477725;17320.56698582536;17324.913375433138;4810.927836082462;5067.543921047105;5070.2394640803805;5070.518300761421;5072.289879416885;3644.216493453907;3794.2790869734663;5041.59667226621;5651.350094739117;5945.16767652529;6021.277446706401;6024.909626355608;6025.758969641209;6030.457258846703;6035.69821508925;5815.82552523425;5965.642061476326;5979.820605381846;5986.820395388146;5987.072003839412;5065.493450654905;5228.08508511009;5248.842534723926;5252.1596544552685;5259.237410575445;20136.79863201364;20449.693254601192;20471.897640511852;20514.794852051436;20527.5894482111;1841.8250266224686;2027.6046170996663;2056.270024141423;2202.1631779923687;2358.375030616871;12824.487020519262;12898.09713320068;13259.602211933658;13321.933390332986;13551.39018744159;1712.76877621522;1755.262789628359;1786.3747688308988;1847.5196448923377;1856.2841611290246;67260;69116.17676464676;69379.3062069383;69790;70180.29819701788;9680.757981050388;9682.949870790679;9996.650117245861;10027.649032283834;10118.190544756402;13587.388567514485;13699.931500342434;13704.52034178799;13712.314384280946;13716.519921802688;6862.3823855852215;6984.895226571605;7134.643267836587;7191.964040179766;7204.423646108299;6681.398674119353;6753.628550429676;6871.6564171791215;6921.8961715574305;6930.06444130036;4254.659782168607;4325.199838029975;4329.978350108229;4424.734515929054;4437.8224871004795;1582.4936020473567;1671.6155284284682;1673.8577220936356;1703.8807283490037;1740.8694347923704;755.5315704263392;773.3697036915008;799.2167675677869;832.6919039955134;874.2612492443875;15450.6137346565;16086.597835053983;16178;16565.834341656428;16589;856.9742907712779;866.8526350520426;919.8252332056887;928.2759447630858;936.4100616611491;9053.148258298746;9232.169104780602;9526.428414295026;9633.662821801203;9706.563204655808;375583;377622;381436;387745;393623;74441;75273.62363188149;75576;76828.61585692035;76911.23088769152;869.1786261982493;879.0550158579553;884.2748945864458;887.174927317588;887.3566664168555;14683.926580367457;14777.556673299818;14873.553793386216;15235.466758663393;15423.460178893685;35238.647613523535;35525.467117993765;35984.92045238647;37408.43887341637;37541.81229093837;51568;51956.74021629868;52654;52747;54699.45300547103;6897.689603967733;7266.1280646322775;7402.29678180572;7484.251574842472;7714.421418393756;8803.515806630698;10777.89222107769;11663.708407289885;11706.648800535997;11879.46542405611;9163.679271225476;9244.537773111451;9398.859017114886;9610.366237739461;9846.310758246855;9525.809483810424;9685.467299298607;9685.757856053655;9699.224062075158;9815.705528834147;9070.319726020443;9395.671151509665;9562.282828788007;9637;10016.499175041365;6190.380961903954;6401.519886008661;6673.599584024974;7000.929990700028;7269.818254543467;8640.524771137647;9371.156595906128;9448.716538503855;9718.9028109718;10111.54498047575 10:18:33 INFO - PROCESS | 23647 | |3;mootools.html;1331.4740677432414;1394.7350003499337;1449.8115245018146;1652.5868532866784;1687.190148728611;7493.625318734069;8099.0686071101845;8106.635201415936;8114.959425202873;8122.065962414309;6847.828804279896;7114.075170227863;7572.7349542766015;7820.1788812174755;7822;2179.1283486605366;2189.3650841256017;2194.484296190394;2203.647416413366;2206.79035491628;2166.360923527563;2200.0979598364675;2223.8665680059166;2224.354937068248;2225.2879078694823;1862.1806405181744;1943.067327682713;2107.92622258221;2156.0513374115417;2163.5348400093976;2160.2763074370027;2167.642339014061;2169.143188440565;2180.8255339572956;2186.6719992001167;2175.6518956966966;2177.8584392014627;2181.0839447432118;2181.683655869906;2182.7162468878946;7935.682572697086;8032.357411407132;8057.315128214109;8064.274215320649;8079.636416361278;4434.379186913835;4627.051454451829;4646.767661616906;4658.720476771405;4660.487346391894;2831.546952487592;3012.834294113823;3013.171377871081;3032.6209223847018;3032.848357582112;897.7172190759956;923.1783712495884;933.8645896344992;958.2717134977397;960.9567569459322;10886.129109671207;10896.128309735202;10903.454827258605;10909.618163364323;10931.56273749049;3956.3669812829808;4139.503259608866;4268.167707297047;4309.41822853917;4335.609795118455;9119.452832830051;9298.90701092994;9308.627654893728;9320.487373194539;9336.859947100798;4542.568455996675;4550.13547425988;4550.954490455119;4553.317002449593;4557.703749256354;4066.9796651016554;4136.875893723193;4157.708960372805;4161.3549899765585;4163.354680024601;3557.2885422915;3663.9816800915823;3749.343864823645;3752.6810221130963;3906.7265291429894;1170.3329102411544;1172.9296242225323;1176.1237877781107;1227.766724322376;1234.7283597608512;636.4144986612328;701.4668851672664;778.5951305321202;792.9643166057426;818.2431251092715;4823.131836269506;4979.253112033224;5161.3032240647035;5195.740212989411;5266.210068489757;725.7630965892075;823.7281697039963;827.4745536584312;829.3116713128089;892.3441270666056;3454.5509083818943;3471.9652803472145;3491.9825400872833;3499.1077275295147;3561.4385614385615;9539.90460095404;9980.351277166961;9991.950040249752;10000.999900010087;10005.849912251322;9874.061964113398;9889.06053924876;9895.752606184758;9908.306418550632;9937.155341795884;7153.320434558708;7297.4891757577525;7393.223711510214;7399.81500462482;7409.481336306515;5013.753003029212;5031.496850314939;5051;5080.923786143137;5193.558547523352;8545.188207120314;8911.643534258557;8923.553822308728;8998.550072496218;9001.594928228376;8989.190972812477;9008.639654414012;9135.680251191176;9199.816003680024;9285.396449230779;6883.380495755406;6948.305169483011;7021.122359705037;7042;7045.682944267623;7522.172561018393;7560.3573696236435;7569.924300756922;7605.771826845204;7622;6357.96821015892;6440.871182576416;6810.965945170243;6831.316868313129;6858.348456896587;6400.583962042452;6416.582922110048;6448.193975753031;6630.668466576555;6675.198976122896;6148.985417406257;6241.812745617639;6245.406686364788;6248.781292654735;6280.403361680633;4049.8987525312104;4100.159467309135;4111.424400583861;4138.903190654419;4238.131183107517;4388.890277743082;4462.531434199363;4468.597826195658;4575.702579332333;4626.1210370029585 10:18:33 INFO - PROCESS | 23647 | |4;prototype.html;294.6081711323938;300.37821709062234;303.1768747849588;306.9923251918702;307.32848725534694;4532.365468834358;4700.952990470094;4756.38167038285;4779.498152693969;4802.807887684493;4558.54414558544;4631.379017343928;4655.813767449306;4659.603933665634;4737.620990320775;3770.396736522157;3797.9430308545393;3807.200487897545;3810.2760475509563;3810.618938106181;3543.94684079739;3773.2642984227286;3786.8106594670294;3795.070207799079;3832.712546559005;3483.9477407838904;3722.7952462614544;3747;3750.4186851038135;3782.7162962777766;3756.1924186299802;3761.567419746737;3763.2849758546063;3772.358699021173;3777.6788972937334;3357.143928298293;3358.244395011103;3369.0061431877657;3374.8143852088124;3380.509826075205;4531.886702832423;4593.40285762852;4617.191991401492;4690.742009189493;4704.176769065434;4257.76582287974;4266.87199384019;4267.167902259061;4275.957240427618;4290.270653988799;4876.414830220397;4927.6550641455115;4946.01079784041;4949.604031677493;4972.105021096201;3511.455724362728;3645.54430696163;3656.542932133483;3658.2134841009047;3668.137987572918;5107.948920510785;5111.616628752859;5131.640785145079;5137.33214682089;5144.459831717653;3657.396529572644;3698.6116457771545;3709.573399059143;3714.60996595359;3719.6652301293016;3733.4773131761576;3740.1958578905665;3746.0822098586023;3774.339490589136;3785.1861849702445;4151.501819781645;4167.868330764246;4212.873613791591;4233.153369326147;4284.807183676742;4889.217725164028;4894.632902532324;4907.803687852446;4908.288298196741;4919.7540122993705;1189.1794661683412;1224.865264820869;1287.7553264879643;1311.4360824845407;1312.6324629103867;878.83302172587;914.7621618379269;919.4667093085994;922.2898368256405;924.9676261330821;4330.242207613655;4345.326474396474;4382.189294980439;4400.625946794558;4405.691601587922;5084.593232541388;5090.847274581768;5091.745412729349;5101.51535604117;5109.948900511022;4205.936910946339;4408.933865992013;4430.379746835446;4434.7560884151035;4478.865634030984;2695.460907818405;2697.9595306070423;2700.986495067512;2710.6069619905;2722.2513808702765;4757.881052973703;4777.8088876445245;4814.7833347499445;4817.349657796152;4838.540338667821;5056.064628043824;5153.458886816905;5159.458256883048;5193.454687257859;5237.816676416307;4817.349657796222;4822.156122678587;4825.094087835356;4826.155422801066;4848.12733707936;5046.410380730058;5082.364704411949;5093.974530127326;5108.719020453911;5114.5652619527755;4773.331733557374;4935.851924442272;4967.850964471072;4968.105740966661;4982.626303027215;4796.6882152661365;4799.1841386965;4800.4479484859685;4817.13291607514;4828.95171048285;3587.372209863211;3603.891883243507;3611.223586928823;3613.9819300903328;3620.5474315710535;4868.342773725643;5071.163258062378;5103;5117.61617878668;5123.769430375716;4921.532454416824;4926.630502712239;4928.408590969107;4928.827491037797;4935.827246046371;4924.310596516419;4926.433460152129;4933.383327084114;4938.802447902188;4973.980334031443;4631.166390049823;4644.074233233042;4769.546893045155;4847.491013443538;4864.659473836798;4826.155422800925;4959.60323174138;4960.429550601727;4974.303597496426;4978.47725988766;4857.611391088775;4858.562729354375;4865.197242455097;4899.387576552931;4909.656324057281 10:18:33 INFO - PROCESS | 23647 | |5;yui.html;675.2369822101026;716.9596152415895;749.2544917806783;757.0427768804686;764.7208768799389;12613.558525451599;13273.665955707933;13944.860551394482;13959.511417100392;13989.790153147685;13100.47598096075;13434.5297914573;13438.5296514622;13444.3950022249;13454;775.0815283888581;775.2363921537282;775.3409601838449;775.5153029356652;780.8243145292321;624.7782037376734;642.2678146912524;776.7825008997489;787.0280203948148;795.9124496305402;830.6013113705425;836.4270474724802;839.7061028639988;843.0136740014168;844.3582877013483;833.7415401225579;833.7998880268722;834.6285902773268;835.4861760017607;835.6364981233183;476.56870532168443;485.5581420906993;587.1457030021352;600.6276108812564;608.7047781825811;12327.50689972409;12340.5063797448;12352.505899763999;12354.567590134302;12360.752784944341;12059.397030148457;12533.498660053587;12652.746945061048;12752.426140823593;13189.934050329686;11382;11467.36929468879;11902.34537100459;12160.574379896661;12602.46361699689;4064.8780536583654;4068.471098757172;4117.07365842686;4293.184294983943;4293.355996600504;62194;62884.37115628831;62917;62946.68526657383;62963.425914352505;10000.14998725102;10333.121684656888;10363.497292892489;10382.42896640692;10880.67357979262;19343.226270949006;19352.612947740967;19363.90318048401;19364;19377.612447750966;6672.232693240339;6813.897791533131;6884.552504087218;6926.965365173141;7037.437005039585;3546.2907418515883;3591.174029973121;3653.9817300913323;3659.7621154624862;3680.5215322007966;2839.2192147159285;2925.473414785359;2940.4413161499674;2941.7499512541244;2943.3377490064563;505.66373361714784;506.2810808651723;509.99021936565805;514.3210961530743;516.9302144210559;451.8441137807451;457.4373520569718;561.926949496571;562.8198976327536;592.6266452135127;7536.359409450149;7713.305802477804;7719.536827790351;7748.915151878741;8421.789455263544;502.83155143027494;558.2714557502417;604.5224272824507;611.39471922797;620.227816368624;3501.1072176594807;3571.3571557119967;3740.8503659853845;3886.1644746379097;4020.19596080785;94741;98588;101105.49447252716;101482.49258753807;101548;83518.58240708758;83995.58002210072;84926;85169;85664;74365;75914.62042689751;77145.2285477138;77152;77843.04217635372;6878.415334696607;7398.186199517941;7463.664135113824;7507.099148102045;7574.848503029798;45340;45955.54044459513;47829.521704782506;48044;48779.512204877494;62900;66660;69585;69612.65193673999;69994;10093.343932644355;10294.845577316497;10314.535845886803;10385.948070259601;10398.376097434179;10989.725256868322;11082.445877706245;11182.440877955907;11784.410779461165;11882.108841836724;9876.654317098866;10094.697159084946;10296.639617613348;10629.89370106289;10724.946375268073;10187.134093602126;10234.33476824004;10263.486825658836;10332.53503592325;10488.842667359842;9964.202863770735;10007.949960250153;10119.848202277119;10191.541380638037;10660.147188225079;8533.615987280711;8937.419067760575;9019.774505637411;9153.954230228806;9196.402233854778;8162.510249385056;8517.318614510948;8535.445196062235;8554.486730795923;8837.64649414042 10:18:33 INFO - PROCESS | 23647 | __end_tp_report 10:18:33 INFO - PROCESS | 23647 | __start_cc_report 10:18:33 INFO - PROCESS | 23647 | _x_x_mozilla_cycle_collect,2414 10:18:33 INFO - PROCESS | 23647 | __end_cc_report 10:18:33 INFO - PROCESS | 23647 | __startTimestamp1477329513103__endTimestamp 10:18:33 INFO - PROCESS | 23647 | 10:18:33 INFO - PROCESS | 23647 | ------- Summary: start ------- 10:18:33 INFO - PROCESS | 23647 | Number of tests: 6 10:18:33 INFO - PROCESS | 23647 | 10:18:33 INFO - PROCESS | 23647 | [#0] dojo.html Cycles:165 Average:4639.57 Median:4746.64 stddev:472.06 (9.9%) stddev-sans-first:446.03 10:18:33 INFO - PROCESS | 23647 | Values: 2616.1 2638.5 2670.2 2673.0 2683.0 4565.8 4661.5 4682.3 4707.6 4730.7 4663.0 4678.5 4688.6 4693.3 4701.8 4294.3 4319.9 4332.3 4357.8 4379.6 4350.7 4359.2 4385.9 4386.4 4392.5 4308.6 4314.5 4333.1 4359.5 4366.9 4390.3 4392.9 4393.5 4409.9 4420.4 4172.5 4215.1 4262.7 4292.0 4318.1 4636.4 4653.2 4655.5 4668.6 4743.6 4945.5 4988.2 5002.4 5007.7 5040.0 4863.9 4907.5 4911.3 5039.3 5093.4 4648.1 4652.3 4666.6 4676.8 4736.6 5111.6 5119.2 5120.7 5121.1 5176.9 4757.9 4911.0 4911.5 4918.6 4981.1 4863.2 4927.5 4988.9 5032.4 5039.0 4967.4 4970.0 4970.3 5022.1 5053.1 4970.9 4978.3 4978.4 4985.3 5034.2 4214.4 4215.3 4253.9 4294.2 4329.1 3670.4 3751.4 3773.5 3787.8 3803.9 4330.0 4340.0 4346.5 4366.1 4390.5 5054.7 5064.6 5065.2 5073.5 5101.8 4179.6 4222.0 4328.5 4332.9 4368.0 4580.1 4617.4 4618.0 4623.2 4682.2 4783.1 4792.5 4799.4 4800.7 4858.1 4880.7 5020.5 5060.0 5062.4 5122.7 4674.5 4714.1 4721.3 4741.1 4746.0 4919.5 4922.3 4922.6 4923.8 4924.8 4984.2 4996.8 4998.2 5003.6 5011.8 4864.4 4873.8 4874.1 4878.3 4882.2 4783.9 4806.3 4835.2 4855.3 4895.0 4829.8 4832.1 4834.9 4886.6 4892.9 4921.8 4922.5 4925.6 4930.2 4967.2 4695.9 4731.0 4746.6 4816.6 4874.5 10:18:33 INFO - PROCESS | 23647 | 10:18:33 INFO - PROCESS | 23647 | [#1] ext.html Cycles:180 Average:45265.73 Median:35619.88 stddev:82155.27 (230.6%) stddev-sans-first:82317.20 10:18:33 INFO - PROCESS | 23647 | Values: 569.6 575.2 582.5 582.6 588.7 28939.3 31397.8 31538.4 38757.0 39508.4 40689.0 41388.8 41470.4 41503.0 41581.2 7649.8 7802.6 7802.9 7808.3 7809.2 7531.2 7637.0 7640.0 7644.0 7647.8 7636.4 7688.4 7690.1 7693.0 7698.3 7628.3 7665.5 7667.7 7670.9 7676.1 7690.8 7743.1 7751.6 7756.3 7760.5 38912.6 39246.8 39336.6 39337.0 39423.4 3075.6 3093.7 3187.4 3267.1 3393.6 29012.3 29412.4 29772.3 29917.3 30742.5 3371.1 3535.4 3566.0 3618.0 3677.8 199794.0 249434.0 250770.0 250989.0 251800.0 28783.7 29288.9 55477.4 56123.4 56192.7 32281.8 32448.8 32594.2 32605.7 32647.3 12911.3 13114.3 13130.0 13134.0 13138.7 10266.5 10345.1 10345.8 10350.9 10352.3 7644.7 7739.8 7785.4 7788.4 7834.8 2968.6 3033.8 3046.3 3061.8 3072.2 847.8 857.4 871.5 913.2 951.3 27373.9 27935.9 30298.5 30698.7 32727.0 881.7 943.0 959.5 961.8 1017.6 14112.9 14761.3 14933.2 15259.5 15307.5 369118.0 377587.0 377656.0 378049.0 378779.0 50899.5 51583.2 51666.7 51727.0 51806.7 1080.1 1114.0 1161.4 1196.3 1206.7 26038.0 28961.7 29598.6 29635.4 29766.6 42644.8 43308.0 43326.6 43353.8 43493.6 300892.0 302623.0 303079.0 303434.0 303864.0 31180.8 31633.8 32466.7 32483.2 37962.2 35576.6 36754.4 41972.6 42826.0 42957.1 35278.8 35295.3 35605.3 35721.6 35952.5 35217.3 35634.5 35822.6 35855.5 36142.0 34377.7 34714.5 34954.0 35225.0 35786.1 30228.4 32442.4 32472.5 32621.7 32698.5 24532.9 25074.5 25088.7 25197.7 25558.0 10:18:33 INFO - PROCESS | 23647 | 10:18:33 INFO - PROCESS | 23647 | [#2] jquery.html Cycles:180 Average:24051.41 Median:5250.50 stddev:63330.14 (1206.2%) stddev-sans-first:63482.81 10:18:33 INFO - PROCESS | 23647 | Values: 357.8 361.6 366.6 376.1 384.9 15520.6 16546.2 17277.0 17356.0 17360.1 16429.0 17132.8 17197.5 17320.6 17324.9 4810.9 5067.5 5070.2 5070.5 5072.3 3644.2 3794.3 5041.6 5651.4 5945.2 6021.3 6024.9 6025.8 6030.5 6035.7 5815.8 5965.6 5979.8 5986.8 5987.1 5065.5 5228.1 5248.8 5252.2 5259.2 20136.8 20449.7 20471.9 20514.8 20527.6 1841.8 2027.6 2056.3 2202.2 2358.4 12824.5 12898.1 13259.6 13321.9 13551.4 1712.8 1755.3 1786.4 1847.5 1856.3 67260.0 69116.2 69379.3 69790.0 70180.3 9680.8 9682.9 9996.7 10027.6 10118.2 13587.4 13699.9 13704.5 13712.3 13716.5 6862.4 6984.9 7134.6 7192.0 7204.4 6681.4 6753.6 6871.7 6921.9 6930.1 4254.7 4325.2 4330.0 4424.7 4437.8 1582.5 1671.6 1673.9 1703.9 1740.9 755.5 773.4 799.2 832.7 874.3 15450.6 16086.6 16178.0 16565.8 16589.0 857.0 866.9 919.8 928.3 936.4 9053.1 9232.2 9526.4 9633.7 9706.6 375583.0 377622.0 381436.0 387745.0 393623.0 74441.0 75273.6 75576.0 76828.6 76911.2 869.2 879.1 884.3 887.2 887.4 14683.9 14777.6 14873.6 15235.5 15423.5 35238.6 35525.5 35984.9 37408.4 37541.8 51568.0 51956.7 52654.0 52747.0 54699.5 6897.7 7266.1 7402.3 7484.3 7714.4 8803.5 10777.9 11663.7 11706.6 11879.5 9163.7 9244.5 9398.9 9610.4 9846.3 9525.8 9685.5 9685.8 9699.2 9815.7 9070.3 9395.7 9562.3 9637.0 10016.5 6190.4 6401.5 6673.6 7000.9 7269.8 8640.5 9371.2 9448.7 9718.9 10111.5 10:18:33 INFO - PROCESS | 23647 | 10:18:33 INFO - PROCESS | 23647 | [#3] mootools.html Cycles:180 Average:5145.56 Median:5041.25 stddev:2940.24 (58.3%) stddev-sans-first:2934.51 10:18:33 INFO - PROCESS | 23647 | Values: 1331.5 1394.7 1449.8 1652.6 1687.2 7493.6 8099.1 8106.6 8115.0 8122.1 6847.8 7114.1 7572.7 7820.2 7822.0 2179.1 2189.4 2194.5 2203.6 2206.8 2166.4 2200.1 2223.9 2224.4 2225.3 1862.2 1943.1 2107.9 2156.1 2163.5 2160.3 2167.6 2169.1 2180.8 2186.7 2175.7 2177.9 2181.1 2181.7 2182.7 7935.7 8032.4 8057.3 8064.3 8079.6 4434.4 4627.1 4646.8 4658.7 4660.5 2831.5 3012.8 3013.2 3032.6 3032.8 897.7 923.2 933.9 958.3 961.0 10886.1 10896.1 10903.5 10909.6 10931.6 3956.4 4139.5 4268.2 4309.4 4335.6 9119.5 9298.9 9308.6 9320.5 9336.9 4542.6 4550.1 4551.0 4553.3 4557.7 4067.0 4136.9 4157.7 4161.4 4163.4 3557.3 3664.0 3749.3 3752.7 3906.7 1170.3 1172.9 1176.1 1227.8 1234.7 636.4 701.5 778.6 793.0 818.2 4823.1 4979.3 5161.3 5195.7 5266.2 725.8 823.7 827.5 829.3 892.3 3454.6 3472.0 3492.0 3499.1 3561.4 9539.9 9980.4 9992.0 10001.0 10005.8 9874.1 9889.1 9895.8 9908.3 9937.2 7153.3 7297.5 7393.2 7399.8 7409.5 5013.8 5031.5 5051.0 5080.9 5193.6 8545.2 8911.6 8923.6 8998.6 9001.6 8989.2 9008.6 9135.7 9199.8 9285.4 6883.4 6948.3 7021.1 7042.0 7045.7 7522.2 7560.4 7569.9 7605.8 7622.0 6358.0 6440.9 6811.0 6831.3 6858.3 6400.6 6416.6 6448.2 6630.7 6675.2 6149.0 6241.8 6245.4 6248.8 6280.4 4049.9 4100.2 4111.4 4138.9 4238.1 4388.9 4462.5 4468.6 4575.7 4626.1 10:18:33 INFO - PROCESS | 23647 | 10:18:33 INFO - PROCESS | 23647 | [#4] prototype.html Cycles:180 Average:4129.36 Median:4695.85 stddev:1173.40 (25.0%) stddev-sans-first:1140.84 10:18:33 INFO - PROCESS | 23647 | Values: 294.6 300.4 303.2 307.0 307.3 4532.4 4701.0 4756.4 4779.5 4802.8 4558.5 4631.4 4655.8 4659.6 4737.6 3770.4 3797.9 3807.2 3810.3 3810.6 3543.9 3773.3 3786.8 3795.1 3832.7 3483.9 3722.8 3747.0 3750.4 3782.7 3756.2 3761.6 3763.3 3772.4 3777.7 3357.1 3358.2 3369.0 3374.8 3380.5 4531.9 4593.4 4617.2 4690.7 4704.2 4257.8 4266.9 4267.2 4276.0 4290.3 4876.4 4927.7 4946.0 4949.6 4972.1 3511.5 3645.5 3656.5 3658.2 3668.1 5107.9 5111.6 5131.6 5137.3 5144.5 3657.4 3698.6 3709.6 3714.6 3719.7 3733.5 3740.2 3746.1 3774.3 3785.2 4151.5 4167.9 4212.9 4233.2 4284.8 4889.2 4894.6 4907.8 4908.3 4919.8 1189.2 1224.9 1287.8 1311.4 1312.6 878.8 914.8 919.5 922.3 925.0 4330.2 4345.3 4382.2 4400.6 4405.7 5084.6 5090.8 5091.7 5101.5 5109.9 4205.9 4408.9 4430.4 4434.8 4478.9 2695.5 2698.0 2701.0 2710.6 2722.3 4757.9 4777.8 4814.8 4817.3 4838.5 5056.1 5153.5 5159.5 5193.5 5237.8 4817.3 4822.2 4825.1 4826.2 4848.1 5046.4 5082.4 5094.0 5108.7 5114.6 4773.3 4935.9 4967.9 4968.1 4982.6 4796.7 4799.2 4800.4 4817.1 4829.0 3587.4 3603.9 3611.2 3614.0 3620.5 4868.3 5071.2 5103.0 5117.6 5123.8 4921.5 4926.6 4928.4 4928.8 4935.8 4924.3 4926.4 4933.4 4938.8 4974.0 4631.2 4644.1 4769.5 4847.5 4864.7 4826.2 4959.6 4960.4 4974.3 4978.5 4857.6 4858.6 4865.2 4899.4 4909.7 10:18:33 INFO - PROCESS | 23647 | 10:18:33 INFO - PROCESS | 23647 | [#5] yui.html Cycles:180 Average:17902.76 Median:504.25 stddev:26095.62 (5175.2%) stddev-sans-first:26136.76 10:18:33 INFO - PROCESS | 23647 | Values: 675.2 717.0 749.3 757.0 764.7 12613.6 13273.7 13944.9 13959.5 13989.8 13100.5 13434.5 13438.5 13444.4 13454.0 775.1 775.2 775.3 775.5 780.8 624.8 642.3 776.8 787.0 795.9 830.6 836.4 839.7 843.0 844.4 833.7 833.8 834.6 835.5 835.6 476.6 485.6 587.1 600.6 608.7 12327.5 12340.5 12352.5 12354.6 12360.8 12059.4 12533.5 12652.7 12752.4 13189.9 11382.0 11467.4 11902.3 12160.6 12602.5 4064.9 4068.5 4117.1 4293.2 4293.4 62194.0 62884.4 62917.0 62946.7 62963.4 10000.1 10333.1 10363.5 10382.4 10880.7 19343.2 19352.6 19363.9 19364.0 19377.6 6672.2 6813.9 6884.6 6927.0 7037.4 3546.3 3591.2 3654.0 3659.8 3680.5 2839.2 2925.5 2940.4 2941.7 2943.3 505.7 506.3 510.0 514.3 516.9 451.8 457.4 561.9 562.8 592.6 7536.4 7713.3 7719.5 7748.9 8421.8 502.8 558.3 604.5 611.4 620.2 3501.1 3571.4 3740.9 3886.2 4020.2 94741.0 98588.0 101105.5 101482.5 101548.0 83518.6 83995.6 84926.0 85169.0 85664.0 74365.0 75914.6 77145.2 77152.0 77843.0 6878.4 7398.2 7463.7 7507.1 7574.8 45340.0 45955.5 47829.5 48044.0 48779.5 62900.0 66660.0 69585.0 69612.7 69994.0 10093.3 10294.8 10314.5 10385.9 10398.4 10989.7 11082.4 11182.4 11784.4 11882.1 9876.7 10094.7 10296.6 10629.9 10724.9 10187.1 10234.3 10263.5 10332.5 10488.8 9964.2 10007.9 10119.8 10191.5 10660.1 8533.6 8937.4 9019.8 9154.0 9196.4 8162.5 8517.3 8535.4 8554.5 8837.6 10:18:33 INFO - PROCESS | 23647 | -------- Summary: end -------- 10:18:33 INFO - PROCESS | 23647 | 10:18:34 INFO - TEST-INFO | 23647: exit 0 10:18:34 INFO - TEST-OK | dromaeo_css | took 1123205ms 10:18:34 INFO - TEST-START | kraken 10:18:34 INFO - operating with platform_type : linux_ 10:18:34 INFO - Initialising browser for kraken test... 10:18:34 INFO - TEST-INFO | started process 23959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzUQKJ/profile http://localhost:43969/getInfo.html) 10:18:38 INFO - PROCESS | 23959 | __metrics Screen width/height:1600/1200 10:18:38 INFO - PROCESS | 23959 | colorDepth:24 10:18:38 INFO - PROCESS | 23959 | Browser inner width/height: 1024/697 10:18:38 INFO - PROCESS | 23959 | __metrics 10:18:38 INFO - PROCESS | 23959 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:18:38 INFO - PROCESS | 23959 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:18:39 INFO - PROCESS | 23959 | console.error: PushService: 10:18:39 INFO - PROCESS | 23959 | stateChangeProcessEnqueue: Error transitioning state 10:18:39 INFO - PROCESS | 23959 | UnknownError 10:18:40 INFO - TEST-INFO | 23959: exit 0 10:18:40 INFO - Browser initialized. 10:18:40 INFO - Running cycle 1/1 for kraken test... 10:18:40 INFO - TEST-INFO | started process 24039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzUQKJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:52 INFO - PROCESS | 24039 | RSS: Main: 174026752 10:18:52 INFO - PROCESS | 24039 | 10:18:55 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43969/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:56 INFO - PROCESS | 24039 | RSS: Main: 230002688 10:18:56 INFO - PROCESS | 24039 | 10:18:58 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43969/tests/kraken/driver.html?testName=audio-dft) 10:18:59 INFO - PROCESS | 24039 | RSS: Main: 217292800 10:18:59 INFO - PROCESS | 24039 | 10:19:02 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43969/tests/kraken/driver.html?testName=audio-fft) 10:19:03 INFO - PROCESS | 24039 | RSS: Main: 298172416 10:19:03 INFO - PROCESS | 24039 | 10:19:05 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43969/tests/kraken/driver.html?testName=audio-oscillator) 10:19:06 INFO - PROCESS | 24039 | RSS: Main: 207921152 10:19:06 INFO - PROCESS | 24039 | 10:19:08 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43969/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:08 INFO - PROCESS | 24039 | RSS: Main: 212250624 10:19:08 INFO - PROCESS | 24039 | 10:19:11 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43969/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:12 INFO - PROCESS | 24039 | RSS: Main: 248770560 10:19:12 INFO - PROCESS | 24039 | 10:19:16 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43969/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:16 INFO - PROCESS | 24039 | RSS: Main: 243613696 10:19:16 INFO - PROCESS | 24039 | 10:19:19 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43969/tests/kraken/driver.html?testName=json-parse-financial) 10:19:20 INFO - PROCESS | 24039 | RSS: Main: 245633024 10:19:20 INFO - PROCESS | 24039 | 10:19:21 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43969/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:22 INFO - PROCESS | 24039 | RSS: Main: 209412096 10:19:22 INFO - PROCESS | 24039 | 10:19:24 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43969/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:24 INFO - PROCESS | 24039 | RSS: Main: 217567232 10:19:24 INFO - PROCESS | 24039 | 10:19:27 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43969/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:27 INFO - PROCESS | 24039 | RSS: Main: 226021376 10:19:27 INFO - PROCESS | 24039 | 10:19:30 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:31 INFO - PROCESS | 24039 | RSS: Main: 229330944 10:19:31 INFO - PROCESS | 24039 | 10:19:34 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:19:34 INFO - PROCESS | 24039 | RSS: Main: 231055360 10:19:34 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | Cycle 1(1): loaded http://localhost:43969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43969/tests/kraken/driver.html?testName=ai-astar) 10:19:36 INFO - PROCESS | 24039 | RSS: Main: 281567232 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | __start_tp_report 10:19:36 INFO - PROCESS | 24039 | _x_x_mozilla_page_load 10:19:36 INFO - PROCESS | 24039 | _x_x_mozilla_page_load_details 10:19:36 INFO - PROCESS | 24039 | |i|pagename|runs| 10:19:36 INFO - PROCESS | 24039 | |0;ai-astar;106;117;114;114;115;115;113;114;115;114 10:19:36 INFO - PROCESS | 24039 | |1;audio-beat-detection;151;126;127;172;131;131;134;127;159;130 10:19:36 INFO - PROCESS | 24039 | |2;audio-dft;161;161;161;161;163;161;162;161;161;162 10:19:36 INFO - PROCESS | 24039 | |3;audio-fft;77;79;76;102;76;77;80;76;107;76 10:19:36 INFO - PROCESS | 24039 | |4;audio-oscillator;83;84;111;84;84;84;105;83;84;121 10:19:36 INFO - PROCESS | 24039 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;116 10:19:36 INFO - PROCESS | 24039 | |6;imaging-darkroom;148;147;146;147;147;147;147;147;147;146 10:19:36 INFO - PROCESS | 24039 | |7;imaging-desaturate;84;84;84;84;84;84;84;84;84;85 10:19:36 INFO - PROCESS | 24039 | |8;json-parse-financial;64;61;63;60;61;62;64;62;63;63 10:19:36 INFO - PROCESS | 24039 | |9;json-stringify-tinderbox;68;69;67;67;68;67;67;67;67;69 10:19:36 INFO - PROCESS | 24039 | |10;stanford-crypto-aes;83;83;84;85;83;83;83;84;84;83 10:19:36 INFO - PROCESS | 24039 | |11;stanford-crypto-ccm;147;142;144;150;141;141;152;140;191;141 10:19:36 INFO - PROCESS | 24039 | |12;stanford-crypto-pbkdf2;175;173;176;178;182;176;175;174;180;183 10:19:36 INFO - PROCESS | 24039 | |13;stanford-crypto-sha256-iterative;72;70;70;71;70;70;71;73;72;75 10:19:36 INFO - PROCESS | 24039 | __end_tp_report 10:19:36 INFO - PROCESS | 24039 | __start_cc_report 10:19:36 INFO - PROCESS | 24039 | _x_x_mozilla_cycle_collect,1964 10:19:36 INFO - PROCESS | 24039 | __end_cc_report 10:19:36 INFO - PROCESS | 24039 | __startTimestamp1477329576948__endTimestamp 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | ------- Summary: start ------- 10:19:36 INFO - PROCESS | 24039 | Number of tests: 14 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:2.91 (2.5%) stddev-sans-first:1.13 10:19:36 INFO - PROCESS | 24039 | Values: 106.0 117.0 114.0 114.0 115.0 115.0 113.0 114.0 115.0 114.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:132.50 stddev:16.07 (12.1%) stddev-sans-first:16.42 10:19:36 INFO - PROCESS | 24039 | Values: 151.0 126.0 127.0 172.0 131.0 131.0 134.0 127.0 159.0 130.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 10:19:36 INFO - PROCESS | 24039 | Values: 161.0 161.0 161.0 161.0 163.0 161.0 162.0 161.0 161.0 162.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.50 stddev:11.68 (15.3%) stddev-sans-first:12.21 10:19:36 INFO - PROCESS | 24039 | Values: 77.0 79.0 76.0 102.0 76.0 77.0 80.0 76.0 107.0 76.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:84.00 stddev:14.35 (17.1%) stddev-sans-first:14.82 10:19:36 INFO - PROCESS | 24039 | Values: 83.0 84.0 111.0 84.0 84.0 84.0 105.0 83.0 84.0 121.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:19:36 INFO - PROCESS | 24039 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 10:19:36 INFO - PROCESS | 24039 | Values: 148.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 10:19:36 INFO - PROCESS | 24039 | Values: 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 85.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:63.00 stddev:1.34 (2.1%) stddev-sans-first:1.27 10:19:36 INFO - PROCESS | 24039 | Values: 64.0 61.0 63.0 60.0 61.0 62.0 64.0 62.0 63.0 63.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 10:19:36 INFO - PROCESS | 24039 | Values: 68.0 69.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 69.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 10:19:36 INFO - PROCESS | 24039 | Values: 83.0 83.0 84.0 85.0 83.0 83.0 83.0 84.0 84.0 83.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:145.50 stddev:15.37 (10.6%) stddev-sans-first:16.28 10:19:36 INFO - PROCESS | 24039 | Values: 147.0 142.0 144.0 150.0 141.0 141.0 152.0 140.0 191.0 141.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:177.00 stddev:3.43 (1.9%) stddev-sans-first:3.54 10:19:36 INFO - PROCESS | 24039 | Values: 175.0 173.0 176.0 178.0 182.0 176.0 175.0 174.0 180.0 183.0 10:19:36 INFO - PROCESS | 24039 | 10:19:36 INFO - PROCESS | 24039 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.65 (2.3%) stddev-sans-first:1.73 10:19:36 INFO - PROCESS | 24039 | Values: 72.0 70.0 70.0 71.0 70.0 70.0 71.0 73.0 72.0 75.0 10:19:36 INFO - PROCESS | 24039 | -------- Summary: end -------- 10:19:36 INFO - PROCESS | 24039 | 10:19:38 INFO - TEST-INFO | 24039: exit 0 10:19:38 INFO - TEST-OK | kraken | took 64222ms 10:19:38 INFO - SUITE-END | took 1187s 10:19:38 INFO - Completed test suite (00:19:47) 10:19:38 INFO - javascript benchmark 10:19:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.123598594471, 2638.4854953284116, 2670.172246603553, 2672.9599056014163, 2683.0072873036966, 4565.817367305303, 4661.487236403993, 4682.344471773954, 4707.552782485663, 4730.739809310491, 4663.0, 4678.53214678532, 4688.578027977482, 4693.342931989524, 4701.811927522904, 4294.334378171388, 4319.870403887889, 4332.263515202408, 4357.825686972533, 4379.649628029766, 4350.695451318409, 4359.215341238576, 4385.912281754363, 4386.385905973167, 4392.450943632046, 4308.633766129883, 4314.546972567882, 4333.133373325331, 4359.476862776455, 4366.868993930188, 4390.27560452525, 4392.868213953587, 4393.538678438782, 4409.9118017639785, 4420.403245561856, 4172.4784401949755, 4215.114825886568, 4262.722923009995, 4291.957080429187, 4318.093200427914, 4636.35091087248, 4653.185692503798, 4655.51117132703, 4668.5798278155125, 4743.620510359163, 4945.530174633404, 4988.152014157602, 5002.399712034543, 5007.724575148365, 5040.0, 4863.902721945577, 4907.533784290523, 4911.312416261762, 5039.269305950616, 5093.363329583802, 4648.0703859227615, 4652.32541281519, 4666.626669866402, 4676.836310729176, 4736.644751643572, 5111.5655169310285, 5119.180931051014, 5120.667156634881, 5121.129408000575, 5176.870578235575, 4757.904841903142, 4910.950890491121, 4911.484294149134, 4918.631102667314, 4981.103401387785, 4863.197572400514, 4927.482614325516, 4988.925166122511, 5032.370953630796, 5039.017391608674, 4967.428745694219, 4969.950300496948, 4970.304157417964, 5022.096022715873, 5053.140966035783, 4970.90058198834, 4978.32792572998, 4978.4025916890205, 4985.252212168204, 5034.244863270539, 4214.4099826024385, 4215.283401821697, 4253.8723838284905, 4294.184105020036, 4329.134173165379, 3670.3576874046935, 3751.362268414376, 3773.471713960048, 3787.8295476703615, 3803.9239215216094, 4330.0, 4339.956600433955, 4346.456692913386, 4366.083122544302, 4390.517043125254, 5054.671446355975, 5064.645474816727, 5065.189569668835, 5073.543381095646, 5101.795928162832, 4179.6029377209115, 4221.957780422218, 4328.458942632171, 4332.870013899588, 4367.978160109243, 4580.129775342741, 4617.445906491243, 4617.953820461819, 4623.237165867594, 4682.204025315705, 4783.1390349737385, 4792.496787837227, 4799.424069111729, 4800.73595952226, 4858.05267972742, 4880.658353915192, 5020.47285035066, 5060.0132974071175, 5062.417821950376, 5122.667026643257, 4674.5325467452985, 4714.104320179155, 4721.339012538178, 4741.075490279362, 4745.952540474689, 4919.458859525378, 4922.286268490977, 4922.581580565692, 4923.753812309442, 4924.778384972613, 4984.152694041949, 4996.775145118406, 4998.225275082368, 5003.649744517995, 5011.799528018839, 4864.36763220779, 4873.829415970424, 4874.122657921466, 4878.268259760922, 4882.194437917704, 4783.904321913612, 4806.255030470283, 4835.153848076502, 4855.320255164209, 4895.0, 4829.782659780389, 4832.106060378841, 4834.854954351375, 4886.633502487257, 4892.92660610084, 4921.827736029221, 4922.483139270468, 4925.581325587365, 4930.161872481615, 4967.205247160437, 4695.859124226278, 4731.0, 4746.644001699818, 4816.614670826255, 4874.488178741181], "value": 4610.291373768404, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.6382796923954, 575.1832397994847, 582.4845012164236, 582.5863636817858, 588.7497813429294, 28939.27651808706, 31397.84301078494, 31538.36923261536, 38757.0, 39508.40737388934, 40689.0, 41388.79305603475, 41470.37794433086, 41502.96242593937, 41581.16837663245, 7649.770506884788, 7802.570858602775, 7802.882956755653, 7808.336291415237, 7809.219078092174, 7531.2468753124795, 7636.961815190944, 7639.961800190991, 7643.968064311302, 7647.847043059135, 7636.3890888728765, 7688.423368247376, 7690.115636701795, 7692.961535192344, 7698.345640620554, 7628.313451789338, 7665.501742386755, 7667.654955527015, 7670.923290767077, 7676.1172465166665, 7690.769276921701, 7743.10954240264, 7751.612419379008, 7756.340711039568, 7760.495567788075, 38912.61087389118, 39246.803765981276, 39336.60663393358, 39337.0, 39423.40864887029, 3075.6309242890998, 3093.7370323522528, 3187.4421976154313, 3267.068885367659, 3393.5588373511287, 29012.27469313263, 29412.41175176506, 29772.255693607618, 29917.25206869824, 30742.46809531679, 3371.140359208386, 3535.381308271068, 3565.964340356589, 3618.0412190769202, 3677.8161091945294, 199794.0, 249434.0, 250770.0, 250989.0, 251800.0, 28783.71216287852, 29288.853555732087, 55477.445225548036, 56123.43876561182, 56192.71903640455, 32281.838590806896, 32448.83775581107, 32594.185145371557, 32605.67394326074, 32647.347053058806, 12911.289879056554, 13114.278714670785, 13130.0, 13134.0, 13138.671533211555, 10266.538005789758, 10345.120664743581, 10345.844812327821, 10350.948245258876, 10352.275340726077, 7644.732434364771, 7739.845203095907, 7785.3771698264, 7788.415868809862, 7834.804129896798, 2968.584398184256, 3033.833139177322, 3046.2688954650725, 3061.8315992620173, 3072.2472994116583, 847.7753395350237, 857.438377862501, 871.5163084488044, 913.196387179278, 951.296040929707, 27373.863130684218, 27935.860320698266, 30298.545521817192, 30698.693013069584, 32727.0, 881.7487016200353, 943.0475220027821, 959.4866746290701, 961.8220629183623, 1017.6489111256604, 14112.929435352962, 14761.261936903113, 14933.178675172752, 15259.542213733606, 15307.540773776804, 369118.0, 377587.0, 377656.0, 378049.0, 378779.0, 50899.49100509022, 51583.226251606255, 51666.741666291426, 51727.0, 51806.74096629568, 1080.0981180714034, 1114.0307932099126, 1161.4076820821274, 1196.300164403816, 1206.6983254186453, 26038.0, 28961.7103828959, 29598.55602165926, 29635.40729185361, 29766.553501697927, 42644.78677606592, 43308.0, 43326.56673433226, 43353.783231083646, 43493.565064350216, 300892.0, 302623.0, 303079.0, 303434.0, 303864.0, 31180.844095779375, 31633.841830790698, 32466.675333246367, 32483.18792030218, 37962.21774536269, 35576.64423355733, 36754.448683270304, 41972.580274196866, 42826.0, 42957.14085718331, 35278.82360588181, 35295.29409411746, 35605.28789424249, 35721.64278357287, 35952.46071308985, 35217.295654086265, 35634.46548301829, 35822.641773581934, 35855.46216806802, 36142.0, 34377.65622343744, 34714.47928281027, 34954.0, 35225.0, 35786.10534736652, 30228.395432090794, 32442.35115297728, 32472.51291230586, 32621.673783261864, 32698.509522356708, 24532.877335613208, 25074.49851002933, 25088.74911250864, 25197.74802251954, 25558.0], "value": 16360.153709792594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.8461261657486, 361.56431500042453, 366.6406921217207, 376.0617259936459, 384.91339448624063, 15520.611984700388, 16546.172691365442, 17277.0, 17356.004059533156, 17360.13199340031, 16429.0, 17132.82867171328, 17197.484075477725, 17320.56698582536, 17324.913375433138, 4810.927836082462, 5067.543921047105, 5070.2394640803805, 5070.518300761421, 5072.289879416885, 3644.216493453907, 3794.2790869734663, 5041.59667226621, 5651.350094739117, 5945.16767652529, 6021.277446706401, 6024.909626355608, 6025.758969641209, 6030.457258846703, 6035.69821508925, 5815.82552523425, 5965.642061476326, 5979.820605381846, 5986.820395388146, 5987.072003839412, 5065.493450654905, 5228.08508511009, 5248.842534723926, 5252.1596544552685, 5259.237410575445, 20136.79863201364, 20449.693254601192, 20471.897640511852, 20514.794852051436, 20527.5894482111, 1841.8250266224686, 2027.6046170996663, 2056.270024141423, 2202.1631779923687, 2358.375030616871, 12824.487020519262, 12898.09713320068, 13259.602211933658, 13321.933390332986, 13551.39018744159, 1712.76877621522, 1755.262789628359, 1786.3747688308988, 1847.5196448923377, 1856.2841611290246, 67260.0, 69116.17676464676, 69379.3062069383, 69790.0, 70180.29819701788, 9680.757981050388, 9682.949870790679, 9996.650117245861, 10027.649032283834, 10118.190544756402, 13587.388567514485, 13699.931500342434, 13704.52034178799, 13712.314384280946, 13716.519921802688, 6862.3823855852215, 6984.895226571605, 7134.643267836587, 7191.964040179766, 7204.423646108299, 6681.398674119353, 6753.628550429676, 6871.6564171791215, 6921.8961715574305, 6930.06444130036, 4254.659782168607, 4325.199838029975, 4329.978350108229, 4424.734515929054, 4437.8224871004795, 1582.4936020473567, 1671.6155284284682, 1673.8577220936356, 1703.8807283490037, 1740.8694347923704, 755.5315704263392, 773.3697036915008, 799.2167675677869, 832.6919039955134, 874.2612492443875, 15450.6137346565, 16086.597835053983, 16178.0, 16565.834341656428, 16589.0, 856.9742907712779, 866.8526350520426, 919.8252332056887, 928.2759447630858, 936.4100616611491, 9053.148258298746, 9232.169104780602, 9526.428414295026, 9633.662821801203, 9706.563204655808, 375583.0, 377622.0, 381436.0, 387745.0, 393623.0, 74441.0, 75273.62363188149, 75576.0, 76828.61585692035, 76911.23088769152, 869.1786261982493, 879.0550158579553, 884.2748945864458, 887.174927317588, 887.3566664168555, 14683.926580367457, 14777.556673299818, 14873.553793386216, 15235.466758663393, 15423.460178893685, 35238.647613523535, 35525.467117993765, 35984.92045238647, 37408.43887341637, 37541.81229093837, 51568.0, 51956.74021629868, 52654.0, 52747.0, 54699.45300547103, 6897.689603967733, 7266.1280646322775, 7402.29678180572, 7484.251574842472, 7714.421418393756, 8803.515806630698, 10777.89222107769, 11663.708407289885, 11706.648800535997, 11879.46542405611, 9163.679271225476, 9244.537773111451, 9398.859017114886, 9610.366237739461, 9846.310758246855, 9525.809483810424, 9685.467299298607, 9685.757856053655, 9699.224062075158, 9815.705528834147, 9070.319726020443, 9395.671151509665, 9562.282828788007, 9637.0, 10016.499175041365, 6190.380961903954, 6401.519886008661, 6673.599584024974, 7000.929990700028, 7269.818254543467, 8640.524771137647, 9371.156595906128, 9448.716538503855, 9718.9028109718, 10111.54498047575], "value": 8132.5404566016805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.4740677432414, 1394.7350003499337, 1449.8115245018146, 1652.5868532866784, 1687.190148728611, 7493.625318734069, 8099.0686071101845, 8106.635201415936, 8114.959425202873, 8122.065962414309, 6847.828804279896, 7114.075170227863, 7572.7349542766015, 7820.1788812174755, 7822.0, 2179.1283486605366, 2189.3650841256017, 2194.484296190394, 2203.647416413366, 2206.79035491628, 2166.360923527563, 2200.0979598364675, 2223.8665680059166, 2224.354937068248, 2225.2879078694823, 1862.1806405181744, 1943.067327682713, 2107.92622258221, 2156.0513374115417, 2163.5348400093976, 2160.2763074370027, 2167.642339014061, 2169.143188440565, 2180.8255339572956, 2186.6719992001167, 2175.6518956966966, 2177.8584392014627, 2181.0839447432118, 2181.683655869906, 2182.7162468878946, 7935.682572697086, 8032.357411407132, 8057.315128214109, 8064.274215320649, 8079.636416361278, 4434.379186913835, 4627.051454451829, 4646.767661616906, 4658.720476771405, 4660.487346391894, 2831.546952487592, 3012.834294113823, 3013.171377871081, 3032.6209223847018, 3032.848357582112, 897.7172190759956, 923.1783712495884, 933.8645896344992, 958.2717134977397, 960.9567569459322, 10886.129109671207, 10896.128309735202, 10903.454827258605, 10909.618163364323, 10931.56273749049, 3956.3669812829808, 4139.503259608866, 4268.167707297047, 4309.41822853917, 4335.609795118455, 9119.452832830051, 9298.90701092994, 9308.627654893728, 9320.487373194539, 9336.859947100798, 4542.568455996675, 4550.13547425988, 4550.954490455119, 4553.317002449593, 4557.703749256354, 4066.9796651016554, 4136.875893723193, 4157.708960372805, 4161.3549899765585, 4163.354680024601, 3557.2885422915, 3663.9816800915823, 3749.343864823645, 3752.6810221130963, 3906.7265291429894, 1170.3329102411544, 1172.9296242225323, 1176.1237877781107, 1227.766724322376, 1234.7283597608512, 636.4144986612328, 701.4668851672664, 778.5951305321202, 792.9643166057426, 818.2431251092715, 4823.131836269506, 4979.253112033224, 5161.3032240647035, 5195.740212989411, 5266.210068489757, 725.7630965892075, 823.7281697039963, 827.4745536584312, 829.3116713128089, 892.3441270666056, 3454.5509083818943, 3471.9652803472145, 3491.9825400872833, 3499.1077275295147, 3561.4385614385615, 9539.90460095404, 9980.351277166961, 9991.950040249752, 10000.999900010087, 10005.849912251322, 9874.061964113398, 9889.06053924876, 9895.752606184758, 9908.306418550632, 9937.155341795884, 7153.320434558708, 7297.4891757577525, 7393.223711510214, 7399.81500462482, 7409.481336306515, 5013.753003029212, 5031.496850314939, 5051.0, 5080.923786143137, 5193.558547523352, 8545.188207120314, 8911.643534258557, 8923.553822308728, 8998.550072496218, 9001.594928228376, 8989.190972812477, 9008.639654414012, 9135.680251191176, 9199.816003680024, 9285.396449230779, 6883.380495755406, 6948.305169483011, 7021.122359705037, 7042.0, 7045.682944267623, 7522.172561018393, 7560.3573696236435, 7569.924300756922, 7605.771826845204, 7622.0, 6357.96821015892, 6440.871182576416, 6810.965945170243, 6831.316868313129, 6858.348456896587, 6400.583962042452, 6416.582922110048, 6448.193975753031, 6630.668466576555, 6675.198976122896, 6148.985417406257, 6241.812745617639, 6245.406686364788, 6248.781292654735, 6280.403361680633, 4049.8987525312104, 4100.159467309135, 4111.424400583861, 4138.903190654419, 4238.131183107517, 4388.890277743082, 4462.531434199363, 4468.597826195658, 4575.702579332333, 4626.1210370029585], "value": 4116.15849270223, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.6081711323938, 300.37821709062234, 303.1768747849588, 306.9923251918702, 307.32848725534694, 4532.365468834358, 4700.952990470094, 4756.38167038285, 4779.498152693969, 4802.807887684493, 4558.54414558544, 4631.379017343928, 4655.813767449306, 4659.603933665634, 4737.620990320775, 3770.396736522157, 3797.9430308545393, 3807.200487897545, 3810.2760475509563, 3810.618938106181, 3543.94684079739, 3773.2642984227286, 3786.8106594670294, 3795.070207799079, 3832.712546559005, 3483.9477407838904, 3722.7952462614544, 3747.0, 3750.4186851038135, 3782.7162962777766, 3756.1924186299802, 3761.567419746737, 3763.2849758546063, 3772.358699021173, 3777.6788972937334, 3357.143928298293, 3358.244395011103, 3369.0061431877657, 3374.8143852088124, 3380.509826075205, 4531.886702832423, 4593.40285762852, 4617.191991401492, 4690.742009189493, 4704.176769065434, 4257.76582287974, 4266.87199384019, 4267.167902259061, 4275.957240427618, 4290.270653988799, 4876.414830220397, 4927.6550641455115, 4946.01079784041, 4949.604031677493, 4972.105021096201, 3511.455724362728, 3645.54430696163, 3656.542932133483, 3658.2134841009047, 3668.137987572918, 5107.948920510785, 5111.616628752859, 5131.640785145079, 5137.33214682089, 5144.459831717653, 3657.396529572644, 3698.6116457771545, 3709.573399059143, 3714.60996595359, 3719.6652301293016, 3733.4773131761576, 3740.1958578905665, 3746.0822098586023, 3774.339490589136, 3785.1861849702445, 4151.501819781645, 4167.868330764246, 4212.873613791591, 4233.153369326147, 4284.807183676742, 4889.217725164028, 4894.632902532324, 4907.803687852446, 4908.288298196741, 4919.7540122993705, 1189.1794661683412, 1224.865264820869, 1287.7553264879643, 1311.4360824845407, 1312.6324629103867, 878.83302172587, 914.7621618379269, 919.4667093085994, 922.2898368256405, 924.9676261330821, 4330.242207613655, 4345.326474396474, 4382.189294980439, 4400.625946794558, 4405.691601587922, 5084.593232541388, 5090.847274581768, 5091.745412729349, 5101.51535604117, 5109.948900511022, 4205.936910946339, 4408.933865992013, 4430.379746835446, 4434.7560884151035, 4478.865634030984, 2695.460907818405, 2697.9595306070423, 2700.986495067512, 2710.6069619905, 2722.2513808702765, 4757.881052973703, 4777.8088876445245, 4814.7833347499445, 4817.349657796152, 4838.540338667821, 5056.064628043824, 5153.458886816905, 5159.458256883048, 5193.454687257859, 5237.816676416307, 4817.349657796222, 4822.156122678587, 4825.094087835356, 4826.155422801066, 4848.12733707936, 5046.410380730058, 5082.364704411949, 5093.974530127326, 5108.719020453911, 5114.5652619527755, 4773.331733557374, 4935.851924442272, 4967.850964471072, 4968.105740966661, 4982.626303027215, 4796.6882152661365, 4799.1841386965, 4800.4479484859685, 4817.13291607514, 4828.95171048285, 3587.372209863211, 3603.891883243507, 3611.223586928823, 3613.9819300903328, 3620.5474315710535, 4868.342773725643, 5071.163258062378, 5103.0, 5117.61617878668, 5123.769430375716, 4921.532454416824, 4926.630502712239, 4928.408590969107, 4928.827491037797, 4935.827246046371, 4924.310596516419, 4926.433460152129, 4933.383327084114, 4938.802447902188, 4973.980334031443, 4631.166390049823, 4644.074233233042, 4769.546893045155, 4847.491013443538, 4864.659473836798, 4826.155422800925, 4959.60323174138, 4960.429550601727, 4974.303597496426, 4978.47725988766, 4857.611391088775, 4858.562729354375, 4865.197242455097, 4899.387576552931, 4909.656324057281], "value": 3761.706956364523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.2369822101026, 716.9596152415895, 749.2544917806783, 757.0427768804686, 764.7208768799389, 12613.558525451599, 13273.665955707933, 13944.860551394482, 13959.511417100392, 13989.790153147685, 13100.47598096075, 13434.5297914573, 13438.5296514622, 13444.3950022249, 13454.0, 775.0815283888581, 775.2363921537282, 775.3409601838449, 775.5153029356652, 780.8243145292321, 624.7782037376734, 642.2678146912524, 776.7825008997489, 787.0280203948148, 795.9124496305402, 830.6013113705425, 836.4270474724802, 839.7061028639988, 843.0136740014168, 844.3582877013483, 833.7415401225579, 833.7998880268722, 834.6285902773268, 835.4861760017607, 835.6364981233183, 476.56870532168443, 485.5581420906993, 587.1457030021352, 600.6276108812564, 608.7047781825811, 12327.50689972409, 12340.5063797448, 12352.505899763999, 12354.567590134302, 12360.752784944341, 12059.397030148457, 12533.498660053587, 12652.746945061048, 12752.426140823593, 13189.934050329686, 11382.0, 11467.36929468879, 11902.34537100459, 12160.574379896661, 12602.46361699689, 4064.8780536583654, 4068.471098757172, 4117.07365842686, 4293.184294983943, 4293.355996600504, 62194.0, 62884.37115628831, 62917.0, 62946.68526657383, 62963.425914352505, 10000.14998725102, 10333.121684656888, 10363.497292892489, 10382.42896640692, 10880.67357979262, 19343.226270949006, 19352.612947740967, 19363.90318048401, 19364.0, 19377.612447750966, 6672.232693240339, 6813.897791533131, 6884.552504087218, 6926.965365173141, 7037.437005039585, 3546.2907418515883, 3591.174029973121, 3653.9817300913323, 3659.7621154624862, 3680.5215322007966, 2839.2192147159285, 2925.473414785359, 2940.4413161499674, 2941.7499512541244, 2943.3377490064563, 505.66373361714784, 506.2810808651723, 509.99021936565805, 514.3210961530743, 516.9302144210559, 451.8441137807451, 457.4373520569718, 561.926949496571, 562.8198976327536, 592.6266452135127, 7536.359409450149, 7713.305802477804, 7719.536827790351, 7748.915151878741, 8421.789455263544, 502.83155143027494, 558.2714557502417, 604.5224272824507, 611.39471922797, 620.227816368624, 3501.1072176594807, 3571.3571557119967, 3740.8503659853845, 3886.1644746379097, 4020.19596080785, 94741.0, 98588.0, 101105.49447252716, 101482.49258753807, 101548.0, 83518.58240708758, 83995.58002210072, 84926.0, 85169.0, 85664.0, 74365.0, 75914.62042689751, 77145.2285477138, 77152.0, 77843.04217635372, 6878.415334696607, 7398.186199517941, 7463.664135113824, 7507.099148102045, 7574.848503029798, 45340.0, 45955.54044459513, 47829.521704782506, 48044.0, 48779.512204877494, 62900.0, 66660.0, 69585.0, 69612.65193673999, 69994.0, 10093.343932644355, 10294.845577316497, 10314.535845886803, 10385.948070259601, 10398.376097434179, 10989.725256868322, 11082.445877706245, 11182.440877955907, 11784.410779461165, 11882.108841836724, 9876.654317098866, 10094.697159084946, 10296.639617613348, 10629.89370106289, 10724.946375268073, 10187.134093602126, 10234.33476824004, 10263.486825658836, 10332.53503592325, 10488.842667359842, 9964.202863770735, 10007.949960250153, 10119.848202277119, 10191.541380638037, 10660.147188225079, 8533.615987280711, 8937.419067760575, 9019.774505637411, 9153.954230228806, 9196.402233854778, 8162.510249385056, 8517.318614510948, 8535.445196062235, 8554.486730795923, 8837.64649414042], "value": 6449.841696812121, "unit": "score"}], "name": "dromaeo_css", "value": 6278.693028722799, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 114.0, 114.0, 115.0, 115.0, 113.0, 114.0, 115.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 127.0, 172.0, 131.0, 131.0, 134.0, 127.0, 159.0, 130.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 163.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 76.0, 102.0, 76.0, 77.0, 80.0, 76.0, 107.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 111.0, 84.0, 84.0, 84.0, 105.0, 83.0, 84.0, 121.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 63.0, 60.0, 61.0, 62.0, 64.0, 62.0, 63.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 69.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 85.0, 83.0, 83.0, 83.0, 84.0, 84.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 142.0, 144.0, 150.0, 141.0, 141.0, 152.0, 140.0, 191.0, 141.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 176.0, 178.0, 182.0, 176.0, 175.0, 174.0, 180.0, 183.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 70.0, 71.0, 70.0, 70.0, 71.0, 73.0, 72.0, 75.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1547.5, "alertThreshold": 2.0}]} 10:19:38 INFO - Return code: 0 10:19:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:19:38 INFO - # TBPL SUCCESS # 10:19:38 INFO - Running post-action listener: _resource_record_post_action 10:19:38 INFO - [mozharness: 2016-10-24 17:19:38.746360Z] Finished run-tests step (success) 10:19:38 INFO - Running post-run listener: _resource_record_post_run 10:19:38 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393371648; Read time: 8; Write time: 301712 10:19:38 INFO - TinderboxPrint: CPU usage
13.0% 10:19:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:19:38 INFO - TinderboxPrint: I/O write bytes / time
393,371,648 / 301,712 10:19:38 INFO - TinderboxPrint: CPU idle
8,354.3 (87.0%) 10:19:38 INFO - TinderboxPrint: CPU user
1,205.0 (12.5%) 10:19:38 INFO - TinderboxPrint: Swap in / out
0 / 0 10:19:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99008512; Read time: 0; Write time: 83108 10:19:38 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 294363136; Read time: 0; Write time: 218604 10:19:39 INFO - Running post-run listener: _upload_blobber_files 10:19:39 INFO - Blob upload gear active. 10:19:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:39 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 10:19:39 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:19:39 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:19:39 INFO - (blobuploader) - INFO - Open directory for files ... 10:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:19:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:40 INFO - (blobuploader) - INFO - Done attempting. 10:19:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:19:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:19:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:41 INFO - (blobuploader) - INFO - Done attempting. 10:19:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:19:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:19:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:45 INFO - (blobuploader) - INFO - Done attempting. 10:19:45 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:45 INFO - Return code: 0 10:19:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5930348b4d729b24df7fb357c07c38926bb98526ad7bd263e2932a6658cf44d0a1d09bdbd05ce041c24158e1692dff9fa2db55eeb43ec426f65d2cc228de9761", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5421919c16d2813ed9582c6dc396129d928897f0c143a19c87f4fa10dd4fefad14acaef6149182562f5bd168371f12698d27fc333bb35ae247a55dcf53e628d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e6c3da809173def2dc9d00a0740337716a742a9ab6eac003919762ea7d10e95889b0ad57a812bcb931aa8e728602614aff4e6ef01096ac6b7420376e661f010b"} 10:19:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:45 INFO - Contents: 10:19:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5930348b4d729b24df7fb357c07c38926bb98526ad7bd263e2932a6658cf44d0a1d09bdbd05ce041c24158e1692dff9fa2db55eeb43ec426f65d2cc228de9761", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5421919c16d2813ed9582c6dc396129d928897f0c143a19c87f4fa10dd4fefad14acaef6149182562f5bd168371f12698d27fc333bb35ae247a55dcf53e628d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e6c3da809173def2dc9d00a0740337716a742a9ab6eac003919762ea7d10e95889b0ad57a812bcb931aa8e728602614aff4e6ef01096ac6b7420376e661f010b"} 10:19:45 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:45 INFO - Copying logs to upload dir... 10:19:45 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.700193 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-24 10:19:44.431975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 10:19:44.436034) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5930348b4d729b24df7fb357c07c38926bb98526ad7bd263e2932a6658cf44d0a1d09bdbd05ce041c24158e1692dff9fa2db55eeb43ec426f65d2cc228de9761", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5421919c16d2813ed9582c6dc396129d928897f0c143a19c87f4fa10dd4fefad14acaef6149182562f5bd168371f12698d27fc333bb35ae247a55dcf53e628d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e6c3da809173def2dc9d00a0740337716a742a9ab6eac003919762ea7d10e95889b0ad57a812bcb931aa8e728602614aff4e6ef01096ac6b7420376e661f010b"} build_url:https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/N1M-E0w2SMCpNEioVjXljg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5930348b4d729b24df7fb357c07c38926bb98526ad7bd263e2932a6658cf44d0a1d09bdbd05ce041c24158e1692dff9fa2db55eeb43ec426f65d2cc228de9761", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5421919c16d2813ed9582c6dc396129d928897f0c143a19c87f4fa10dd4fefad14acaef6149182562f5bd168371f12698d27fc333bb35ae247a55dcf53e628d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e6c3da809173def2dc9d00a0740337716a742a9ab6eac003919762ea7d10e95889b0ad57a812bcb931aa8e728602614aff4e6ef01096ac6b7420376e661f010b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 10:19:44.461165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:19:44.461507) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1477328333.646012-1761887227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 10:19:44.545608) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 10:19:44.545938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 10:19:44.546225) ========= ========= Total master_lag: 0.17 =========