builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1477014151.94 results: success (0) buildid: 20161020153022 builduid: 2f5a59bc02c84ee5be6ffd67bff0b271 revision: ba6fc133264d8e7aa8adf43d9d88f48b6dc2ffac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:31.940122) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:31.940641) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:31.940988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:31.957094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:31.957730) ========= 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=6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 18:42:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.3M=0s 2016-10-20 18:42:32 (88.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.067986) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.068783) ========= 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=6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020471 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.122439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.122855) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba6fc133264d8e7aa8adf43d9d88f48b6dc2ffac --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 ba6fc133264d8e7aa8adf43d9d88f48b6dc2ffac --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=6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 18:42:32,323 truncating revision to first 12 chars 2016-10-20 18:42:32,323 Setting DEBUG logging. 2016-10-20 18:42:32,323 attempt 1/10 2016-10-20 18:42:32,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba6fc133264d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 18:42:32,635 unpacking tar archive at: fx-team-ba6fc133264d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.618531 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.758010) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.758607) ========= script_repo_revision: ba6fc133264d8e7aa8adf43d9d88f48b6dc2ffac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.759077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.759376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 18:42:32.769189) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-20 18:42:32.769490) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:42:33 INFO - MultiFileLogger online at 20161020 18:42:33 in /builds/slave/test 18:42:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:42:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:42:33 INFO - {'append_to_log': False, 18:42:33 INFO - 'base_work_dir': '/builds/slave/test', 18:42:33 INFO - 'blob_upload_branch': 'Fx-Team', 18:42:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:42:33 INFO - 'branch': 'Fx-Team', 18:42:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:42:33 INFO - 'config_files': ('talos/linux_config.py',), 18:42:33 INFO - 'default_actions': ('clobber', 18:42:33 INFO - 'read-buildbot-config', 18:42:33 INFO - 'download-and-extract', 18:42:33 INFO - 'populate-webroot', 18:42:33 INFO - 'create-virtualenv', 18:42:33 INFO - 'install', 18:42:33 INFO - 'run-tests'), 18:42:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:42:33 INFO - 'download_minidump_stackwalk': True, 18:42:33 INFO - 'download_symbols': 'ondemand', 18:42:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:42:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:42:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:42:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:42:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:42:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:42:33 INFO - 'installer_path': 'installer.exe', 18:42:33 INFO - 'log_level': 'info', 18:42:33 INFO - 'log_name': 'talos', 18:42:33 INFO - 'log_to_console': True, 18:42:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:42:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:42:33 INFO - 'opt_config_files': (), 18:42:33 INFO - 'pip_index': False, 18:42:33 INFO - 'sps_profile': False, 18:42:33 INFO - 'sps_profile_interval': 0, 18:42:33 INFO - 'suite': 'dromaeojs', 18:42:33 INFO - 'system_bits': '32', 18:42:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:42:33 INFO - 'title': 'talos-linux64-ix-023', 18:42:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:42:33 INFO - 'use_talos_json': True, 18:42:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:42:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:42:33 INFO - 'work_dir': 'build'} 18:42:33 INFO - [mozharness: 2016-10-21 01:42:33.070320Z] Running clobber step. 18:42:33 INFO - Running pre-action listener: _resource_record_pre_action 18:42:33 INFO - Running main action method: clobber 18:42:33 INFO - rmtree: /builds/slave/test/build 18:42:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:42:33 INFO - Running post-action listener: _resource_record_post_action 18:42:33 INFO - [mozharness: 2016-10-21 01:42:33.560910Z] Finished clobber step (success) 18:42:33 INFO - [mozharness: 2016-10-21 01:42:33.561013Z] Running read-buildbot-config step. 18:42:33 INFO - Running pre-action listener: _resource_record_pre_action 18:42:33 INFO - Running main action method: read_buildbot_config 18:42:33 INFO - Using buildbot properties: 18:42:33 INFO - { 18:42:33 INFO - "project": "", 18:42:33 INFO - "product": "firefox", 18:42:33 INFO - "script_repo_revision": "production", 18:42:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:42:33 INFO - "repository": "", 18:42:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:42:33 INFO - "buildid": "20161020153022", 18:42:33 INFO - "pgo_build": "True", 18:42:33 INFO - "basedir": "/builds/slave/test", 18:42:33 INFO - "buildnumber": 1157, 18:42:33 INFO - "slavename": "talos-linux64-ix-023", 18:42:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:42:33 INFO - "platform": "ubuntu64_hw", 18:42:33 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:42:33 INFO - "branch": "fx-team", 18:42:33 INFO - "repo_path": "integration/fx-team", 18:42:33 INFO - "revision": "ba6fc133264d8e7aa8adf43d9d88f48b6dc2ffac", 18:42:33 INFO - "stage_platform": "linux64-pgo", 18:42:33 INFO - "builduid": "2f5a59bc02c84ee5be6ffd67bff0b271", 18:42:33 INFO - "slavebuilddir": "test" 18:42:33 INFO - } 18:42:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:42:33 INFO - Running post-action listener: _resource_record_post_action 18:42:33 INFO - [mozharness: 2016-10-21 01:42:33.563485Z] Finished read-buildbot-config step (success) 18:42:33 INFO - [mozharness: 2016-10-21 01:42:33.563574Z] Running download-and-extract step. 18:42:33 INFO - Running pre-action listener: _resource_record_pre_action 18:42:33 INFO - Running main action method: download_and_extract 18:42:33 INFO - mkdir: /builds/slave/test/build/tests 18:42: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')]} 18:42:33 INFO - trying https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:42:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/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 18:42:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/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 18:42:34 INFO - Downloaded 1361 bytes. 18:42:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:42:34 INFO - Using the following test package requirements: 18:42:34 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:42:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:42:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:42:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:34 INFO - u'jsshell-linux-x86_64.zip'], 18:42:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:42:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:42:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:42:34 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:42:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:42:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:42:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:42:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:42:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:42:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:42:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:42:34 INFO - Http code: 200 18:42:34 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 18:42:34 INFO - x-amz-cf-id: 40yQioWWvuRpO6YQ945R7pswQHgQCSrD-G6cs-9URS4wXYSecQ3D6g== 18:42:34 INFO - x-amz-version-id: qKpeYRZlMOKsl.mv7kOQ7bFCVXl9lmXj 18:42:35 INFO - Expected file size: 22118215 18:42:35 INFO - Obtained file size: 22118215 18:42:39 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 18:42:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:42:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:42:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:42:39 INFO - Http code: 200 18:42:39 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 18:42:39 INFO - x-amz-cf-id: cuCYkVEuIzuQYSH4gTfUXr9TDK21a6Hiypo0FG0-qOxNUp2P4MsSSQ== 18:42:39 INFO - x-amz-version-id: qKpeYRZlMOKsl.mv7kOQ7bFCVXl9lmXj 18:42:40 INFO - Expected file size: 22118215 18:42:40 INFO - Obtained file size: 22118215 18:42:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:42:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:42:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:42:45 INFO - Http code: 200 18:42:45 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 18:42:45 INFO - x-amz-cf-id: RgqKN-gwgBypzvEBa58UpLbLJCfu46aDtPTgZsMJdiwuxfFdUcx4zg== 18:42:45 INFO - x-amz-version-id: gkdVb6yJAWkMvT2_pXeI_OE6OjhAHp8q 18:42:45 INFO - Expected file size: 14409028 18:42:45 INFO - Obtained file size: 14409028 18:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:45 INFO - trying https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:42:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/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 18:42:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/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 18:42:46 INFO - Downloaded 59500231 bytes. 18:42:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:42:46 INFO - mkdir: /builds/slave/test/properties 18:42:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:42:46 INFO - Writing to file /builds/slave/test/properties/build_url 18:42:46 INFO - Contents: 18:42:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:42:47 INFO - Running post-action listener: _resource_record_post_action 18:42:47 INFO - Running post-action listener: set_extra_try_arguments 18:42:47 INFO - [mozharness: 2016-10-21 01:42:47.466930Z] Finished download-and-extract step (success) 18:42:47 INFO - [mozharness: 2016-10-21 01:42:47.467160Z] Running populate-webroot step. 18:42:47 INFO - Running pre-action listener: _resource_record_pre_action 18:42:47 INFO - Running main action method: populate_webroot 18:42:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:42:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:42:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:42:47 INFO - '--tppagecycles', 18:42:47 INFO - '7'], 18:42:47 INFO - 'tests': ['tsvgm']}}, 18:42:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:42:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:42:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:42:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:42:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:47 INFO - 'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:42:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:47 INFO - 'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['damp', 'tps']}, 18:42:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:47 INFO - 'tests': ['damp', 'tps']}, 18:42:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['dromaeo_dom']}, 18:42:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:42:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['basic_compositor_video']}, 18:42:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:42:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['a11yr', 18:42:47 INFO - 'ts_paint', 18:42:47 INFO - 'tpaint', 18:42:47 INFO - 'sessionrestore', 18:42:47 INFO - 'sessionrestore_no_auto_restore', 18:42:47 INFO - 'tabpaint']}, 18:42:47 INFO - 'other-e10s': {'tests': ['a11yr', 18:42:47 INFO - 'ts_paint', 18:42:47 INFO - 'tpaint', 18:42:47 INFO - 'sessionrestore', 18:42:47 INFO - 'sessionrestore_no_auto_restore', 18:42:47 INFO - 'tabpaint']}, 18:42:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:42:47 INFO - 'ts_paint', 18:42:47 INFO - 'tpaint', 18:42:47 INFO - 'sessionrestore', 18:42:47 INFO - 'sessionrestore_no_auto_restore', 18:42:47 INFO - 'tabpaint']}, 18:42:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:42:47 INFO - 'ts_paint', 18:42:47 INFO - 'tpaint', 18:42:47 INFO - 'sessionrestore', 18:42:47 INFO - 'sessionrestore_no_auto_restore', 18:42:47 INFO - 'tabpaint']}, 18:42:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['a11yr', 18:42:47 INFO - 'ts_paint', 18:42:47 INFO - 'tpaint', 18:42:47 INFO - 'sessionrestore', 18:42:47 INFO - 'sessionrestore_no_auto_restore', 18:42:47 INFO - 'tabpaint']}, 18:42:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['a11yr', 18:42:47 INFO - 'ts_paint', 18:42:47 INFO - 'tpaint', 18:42:47 INFO - 'sessionrestore', 18:42:47 INFO - 'sessionrestore_no_auto_restore', 18:42:47 INFO - 'tabpaint']}, 18:42:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['tsvgx', 18:42:47 INFO - 'tsvgr_opacity', 18:42:47 INFO - 'tart', 18:42:47 INFO - 'tscrollx', 18:42:47 INFO - 'cart']}, 18:42:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:42:47 INFO - 'tsvgr_opacity', 18:42:47 INFO - 'tart', 18:42:47 INFO - 'tscrollx', 18:42:47 INFO - 'cart']}, 18:42:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:47 INFO - 'talos_options': ['--disable-e10s'], 18:42:47 INFO - 'tests': ['tp5o']}, 18:42:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:47 INFO - 'tests': ['tp5o']}, 18:42:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:47 INFO - 'talos_options': ['--disable-e10s', 18:42:47 INFO - '--xperf_path', 18:42:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:47 INFO - 'tests': ['tp5n']}, 18:42:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:42:47 INFO - 'talos_options': ['--xperf_path', 18:42:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:42:47 INFO - 'tests': ['tp5n']}}, 18:42:47 INFO - 'talos.zip': {'path': '', 18:42:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:42:47 INFO - Running post-action listener: _resource_record_post_action 18:42:47 INFO - [mozharness: 2016-10-21 01:42:47.487879Z] Finished populate-webroot step (success) 18:42:47 INFO - [mozharness: 2016-10-21 01:42:47.487967Z] Running create-virtualenv step. 18:42:47 INFO - Running pre-action listener: _resource_record_pre_action 18:42:47 INFO - Running main action method: create_virtualenv 18:42:47 INFO - Creating virtualenv /builds/slave/test/build/venv 18:42:47 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 18:42:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:42:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:42:47 INFO - Using real prefix '/usr' 18:42:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:42:48 INFO - Installing distribute.............................................................................................................................................................................................done. 18:42:50 INFO - Installing pip.................done. 18:42:50 INFO - Return code: 0 18:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:42:50 INFO - Reading from file tmpfile_stdout 18:42:50 INFO - Output received: 18:42:50 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) 18:42:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:42: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')]} 18:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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')]} 18:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:42:50 INFO - Using env: {'DISPLAY': ':0', 18:42:50 INFO - 'HOME': '/home/cltbld', 18:42:50 INFO - 'LANG': 'en_US.UTF-8', 18:42:50 INFO - 'LANGUAGE': 'en_US:en', 18:42:50 INFO - 'LOGNAME': 'cltbld', 18:42:50 INFO - 'MAIL': '/var/mail/cltbld', 18:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:50 INFO - 'MOZ_NO_REMOTE': '1', 18:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:50 INFO - 'NO_EM_RESTART': '1', 18:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:50 INFO - 'PWD': '/builds/slave/test', 18:42:50 INFO - 'SHELL': '/bin/bash', 18:42:50 INFO - 'SHLVL': '1', 18:42:50 INFO - 'TERM': 'linux', 18:42:50 INFO - 'TMOUT': '86400', 18:42:50 INFO - 'USER': 'cltbld', 18:42:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:50 INFO - '_': '/tools/buildbot/bin/python'} 18:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:50 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 18:42:50 INFO - Cleaning up... 18:42:50 INFO - Return code: 0 18:42:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:42: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')]} 18:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42: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')]} 18:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:42:50 INFO - Using env: {'DISPLAY': ':0', 18:42:50 INFO - 'HOME': '/home/cltbld', 18:42:50 INFO - 'LANG': 'en_US.UTF-8', 18:42:50 INFO - 'LANGUAGE': 'en_US:en', 18:42:50 INFO - 'LOGNAME': 'cltbld', 18:42:50 INFO - 'MAIL': '/var/mail/cltbld', 18:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:50 INFO - 'MOZ_NO_REMOTE': '1', 18:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:50 INFO - 'NO_EM_RESTART': '1', 18:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:50 INFO - 'PWD': '/builds/slave/test', 18:42:50 INFO - 'SHELL': '/bin/bash', 18:42:50 INFO - 'SHLVL': '1', 18:42:50 INFO - 'TERM': 'linux', 18:42:50 INFO - 'TMOUT': '86400', 18:42:50 INFO - 'USER': 'cltbld', 18:42:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:50 INFO - '_': '/tools/buildbot/bin/python'} 18:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:50 INFO - Downloading/unpacking psutil>=3.1.1 18:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:42:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:52 INFO - Installing collected packages: psutil 18:42:52 INFO - Running setup.py install for psutil 18:42:52 INFO - building 'psutil._psutil_linux' extension 18:42:52 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 18:42:52 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 18:42:53 INFO - building 'psutil._psutil_posix' extension 18:42:53 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 18:42:53 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 18:42:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:42:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:42:53 INFO - Successfully installed psutil 18:42:53 INFO - Cleaning up... 18:42:53 INFO - Return code: 0 18:42:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:53 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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:42:53 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 18:42:53 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 18:42:53 INFO - Using env: {'DISPLAY': ':0', 18:42:53 INFO - 'HOME': '/home/cltbld', 18:42:53 INFO - 'LANG': 'en_US.UTF-8', 18:42:53 INFO - 'LANGUAGE': 'en_US:en', 18:42:53 INFO - 'LOGNAME': 'cltbld', 18:42:53 INFO - 'MAIL': '/var/mail/cltbld', 18:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:53 INFO - 'MOZ_NO_REMOTE': '1', 18:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:53 INFO - 'NO_EM_RESTART': '1', 18:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:53 INFO - 'PWD': '/builds/slave/test', 18:42:53 INFO - 'SHELL': '/bin/bash', 18:42:53 INFO - 'SHLVL': '1', 18:42:53 INFO - 'TERM': 'linux', 18:42:53 INFO - 'TMOUT': '86400', 18:42:53 INFO - 'USER': 'cltbld', 18:42:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:53 INFO - '_': '/tools/buildbot/bin/python'} 18:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:42:53 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 18:42:53 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 18:42:53 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 18:42:53 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 18:42:53 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 18:42:53 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 18:42:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:42:55 INFO - Installing collected packages: mozsystemmonitor 18:42:55 INFO - Running setup.py install for mozsystemmonitor 18:42:55 INFO - Successfully installed mozsystemmonitor 18:42:55 INFO - Cleaning up... 18:42:55 INFO - Return code: 0 18:42:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:42:55 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')]} 18:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:55 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')]} 18:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:55 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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:42:55 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 18:42:55 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 18:42:55 INFO - Using env: {'DISPLAY': ':0', 18:42:55 INFO - 'HOME': '/home/cltbld', 18:42:55 INFO - 'LANG': 'en_US.UTF-8', 18:42:55 INFO - 'LANGUAGE': 'en_US:en', 18:42:55 INFO - 'LOGNAME': 'cltbld', 18:42:55 INFO - 'MAIL': '/var/mail/cltbld', 18:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:55 INFO - 'MOZ_NO_REMOTE': '1', 18:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:55 INFO - 'NO_EM_RESTART': '1', 18:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:55 INFO - 'PWD': '/builds/slave/test', 18:42:55 INFO - 'SHELL': '/bin/bash', 18:42:55 INFO - 'SHLVL': '1', 18:42:55 INFO - 'TERM': 'linux', 18:42:55 INFO - 'TMOUT': '86400', 18:42:55 INFO - 'USER': 'cltbld', 18:42:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:55 INFO - '_': '/tools/buildbot/bin/python'} 18:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:55 INFO - Downloading/unpacking jsonschema==2.5.1 18:42:55 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 18:42:55 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 18:42:55 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 18:42:55 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 18:42:55 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 18:42:55 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 18:42:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:42:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:42:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:42:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:42:58 INFO - warning: no files found matching '*.txt' 18:42:58 INFO - no previously-included directories found matching 'build' 18:42:58 INFO - no previously-included directories found matching 'dist' 18:42:58 INFO - no previously-included directories found matching '.git*' 18:42:58 INFO - Installing collected packages: jsonschema, functools32 18:42:58 INFO - Running setup.py install for functools32 18:42:58 INFO - warning: no files found matching '*.txt' 18:42:58 INFO - no previously-included directories found matching 'build' 18:42:58 INFO - no previously-included directories found matching 'dist' 18:42:58 INFO - no previously-included directories found matching '.git*' 18:42:58 INFO - Successfully installed jsonschema functools32 18:42:58 INFO - Cleaning up... 18:42:58 INFO - Return code: 0 18:42:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:42:58 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')]} 18:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:58 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')]} 18:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:58 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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:42:58 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 18:42:58 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 18:42:58 INFO - Using env: {'DISPLAY': ':0', 18:42:58 INFO - 'HOME': '/home/cltbld', 18:42:58 INFO - 'LANG': 'en_US.UTF-8', 18:42:58 INFO - 'LANGUAGE': 'en_US:en', 18:42:58 INFO - 'LOGNAME': 'cltbld', 18:42:58 INFO - 'MAIL': '/var/mail/cltbld', 18:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:58 INFO - 'MOZ_NO_REMOTE': '1', 18:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:58 INFO - 'NO_EM_RESTART': '1', 18:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:58 INFO - 'PWD': '/builds/slave/test', 18:42:58 INFO - 'SHELL': '/bin/bash', 18:42:58 INFO - 'SHLVL': '1', 18:42:58 INFO - 'TERM': 'linux', 18:42:58 INFO - 'TMOUT': '86400', 18:42:58 INFO - 'USER': 'cltbld', 18:42:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:58 INFO - '_': '/tools/buildbot/bin/python'} 18:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:42:58 INFO - Cleaning up... 18:42:58 INFO - Return code: 0 18:42:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:42:58 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')]} 18:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:58 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')]} 18:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:42:58 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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:42:58 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 18:42:58 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 18:42:58 INFO - Using env: {'DISPLAY': ':0', 18:42:58 INFO - 'HOME': '/home/cltbld', 18:42:58 INFO - 'LANG': 'en_US.UTF-8', 18:42:58 INFO - 'LANGUAGE': 'en_US:en', 18:42:58 INFO - 'LOGNAME': 'cltbld', 18:42:58 INFO - 'MAIL': '/var/mail/cltbld', 18:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:58 INFO - 'MOZ_NO_REMOTE': '1', 18:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:42:58 INFO - 'NO_EM_RESTART': '1', 18:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:58 INFO - 'PWD': '/builds/slave/test', 18:42:58 INFO - 'SHELL': '/bin/bash', 18:42:58 INFO - 'SHLVL': '1', 18:42:58 INFO - 'TERM': 'linux', 18:42:58 INFO - 'TMOUT': '86400', 18:42:58 INFO - 'USER': 'cltbld', 18:42:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:58 INFO - '_': '/tools/buildbot/bin/python'} 18:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:42:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:42:58 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 18:42:58 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 18:42:58 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 18:42:58 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 18:42:58 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 18:42:58 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 18:43:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:43:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:43:00 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 18:43:00 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 18:43:00 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 18:43:00 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 18:43:00 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 18:43:00 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 18:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:43:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:43:01 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 18:43:01 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 18:43:01 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 18:43:01 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 18:43:01 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 18:43:01 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 18:43:01 INFO - Downloading docopt-0.6.1.tar.gz 18:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:43:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:43:01 INFO - Running setup.py install for blobuploader 18:43:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:43:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:43:01 INFO - Running setup.py install for requests 18:43:01 INFO - Running setup.py install for docopt 18:43:01 INFO - Successfully installed blobuploader requests docopt 18:43:01 INFO - Cleaning up... 18:43:02 INFO - Return code: 0 18:43:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:02 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')]} 18:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:02 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')]} 18:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:02 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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:43:02 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 18:43:02 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 18:43:02 INFO - Using env: {'DISPLAY': ':0', 18:43:02 INFO - 'HOME': '/home/cltbld', 18:43:02 INFO - 'LANG': 'en_US.UTF-8', 18:43:02 INFO - 'LANGUAGE': 'en_US:en', 18:43:02 INFO - 'LOGNAME': 'cltbld', 18:43:02 INFO - 'MAIL': '/var/mail/cltbld', 18:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:02 INFO - 'MOZ_NO_REMOTE': '1', 18:43:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:02 INFO - 'NO_EM_RESTART': '1', 18:43:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:02 INFO - 'PWD': '/builds/slave/test', 18:43:02 INFO - 'SHELL': '/bin/bash', 18:43:02 INFO - 'SHLVL': '1', 18:43:02 INFO - 'TERM': 'linux', 18:43:02 INFO - 'TMOUT': '86400', 18:43:02 INFO - 'USER': 'cltbld', 18:43:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:02 INFO - '_': '/tools/buildbot/bin/python'} 18:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:02 INFO - Running setup.py (path:/tmp/pip-RneEZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:02 INFO - Running setup.py (path:/tmp/pip-q4oJ_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:02 INFO - Running setup.py (path:/tmp/pip-jvjRMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:02 INFO - Running setup.py (path:/tmp/pip-QM4QNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:02 INFO - Running setup.py (path:/tmp/pip-y0Yrsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:02 INFO - Running setup.py (path:/tmp/pip-__XG8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:02 INFO - Running setup.py (path:/tmp/pip-AoIjwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:02 INFO - Running setup.py (path:/tmp/pip-ad0QKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:02 INFO - Running setup.py (path:/tmp/pip-fHv1qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:02 INFO - Running setup.py (path:/tmp/pip-faGLjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:03 INFO - Running setup.py (path:/tmp/pip-K8immo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:03 INFO - Running setup.py (path:/tmp/pip-X_m44a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:03 INFO - Running setup.py (path:/tmp/pip-I3WIF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:03 INFO - Running setup.py (path:/tmp/pip-HWPS3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:03 INFO - Running setup.py (path:/tmp/pip-5iraAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:03 INFO - Running setup.py (path:/tmp/pip-OkP0ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:03 INFO - Running setup.py (path:/tmp/pip-VZVYUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:43:03 INFO - Running setup.py install for manifestparser 18:43:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:43:03 INFO - Running setup.py install for mozcrash 18:43:03 INFO - Running setup.py install for mozdebug 18:43:03 INFO - Running setup.py install for mozdevice 18:43:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:43:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:43:03 INFO - Running setup.py install for mozfile 18:43:04 INFO - Running setup.py install for mozhttpd 18:43:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Running setup.py install for mozinfo 18:43:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Running setup.py install for mozInstall 18:43:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Running setup.py install for mozleak 18:43:04 INFO - Running setup.py install for mozlog 18:43:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Running setup.py install for moznetwork 18:43:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Running setup.py install for mozprocess 18:43:04 INFO - Running setup.py install for mozprofile 18:43:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:43:04 INFO - Running setup.py install for mozrunner 18:43:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:43:05 INFO - Running setup.py install for mozscreenshot 18:43:05 INFO - Running setup.py install for moztest 18:43:05 INFO - Running setup.py install for mozversion 18:43:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:43:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:43:05 INFO - Cleaning up... 18:43:05 INFO - Return code: 0 18:43:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:05 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')]} 18:43:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:05 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')]} 18:43:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:05 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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:43:05 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 18:43:05 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 18:43:05 INFO - Using env: {'DISPLAY': ':0', 18:43:05 INFO - 'HOME': '/home/cltbld', 18:43:05 INFO - 'LANG': 'en_US.UTF-8', 18:43:05 INFO - 'LANGUAGE': 'en_US:en', 18:43:05 INFO - 'LOGNAME': 'cltbld', 18:43:05 INFO - 'MAIL': '/var/mail/cltbld', 18:43:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:05 INFO - 'MOZ_NO_REMOTE': '1', 18:43:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:05 INFO - 'NO_EM_RESTART': '1', 18:43:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:05 INFO - 'PWD': '/builds/slave/test', 18:43:05 INFO - 'SHELL': '/bin/bash', 18:43:05 INFO - 'SHLVL': '1', 18:43:05 INFO - 'TERM': 'linux', 18:43:05 INFO - 'TMOUT': '86400', 18:43:05 INFO - 'USER': 'cltbld', 18:43:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:43:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:05 INFO - '_': '/tools/buildbot/bin/python'} 18:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:05 INFO - Running setup.py (path:/tmp/pip-zEf2Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:05 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)) 18:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:05 INFO - Running setup.py (path:/tmp/pip-mIo4AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:05 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)) 18:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:05 INFO - Running setup.py (path:/tmp/pip-14_585-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:05 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)) 18:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:05 INFO - Running setup.py (path:/tmp/pip-wxCc4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:05 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)) 18:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:05 INFO - Running setup.py (path:/tmp/pip-8xh5ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:05 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)) 18:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:05 INFO - Running setup.py (path:/tmp/pip-n3rchi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:06 INFO - Running setup.py (path:/tmp/pip-5ZR_fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:06 INFO - Running setup.py (path:/tmp/pip-uQGBUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:06 INFO - Running setup.py (path:/tmp/pip-VDmyYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:06 INFO - Running setup.py (path:/tmp/pip-ai5sV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:06 INFO - Running setup.py (path:/tmp/pip-2r0A1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:06 INFO - Running setup.py (path:/tmp/pip-MCh4sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:06 INFO - Running setup.py (path:/tmp/pip-zqfJOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:06 INFO - Running setup.py (path:/tmp/pip-GdYlck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:06 INFO - Running setup.py (path:/tmp/pip-2M9Lsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:06 INFO - Running setup.py (path:/tmp/pip-Boguuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:06 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)) 18:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:06 INFO - Running setup.py (path:/tmp/pip-Z93F2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:06 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)) 18:43:06 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)) 18:43:06 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)) 18:43:06 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)) 18:43:06 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)) 18:43:06 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)) 18:43:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:43:06 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 18:43:06 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 18:43:06 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 18:43:06 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 18:43:06 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 18:43:06 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 18:43:08 INFO - Downloading blessings-1.6.tar.gz 18:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:43:08 INFO - Installing collected packages: blessings 18:43:08 INFO - Running setup.py install for blessings 18:43:08 INFO - Successfully installed blessings 18:43:08 INFO - Cleaning up... 18:43:09 INFO - Return code: 0 18:43:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:43:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:09 INFO - Reading from file tmpfile_stdout 18:43:09 INFO - Current package versions: 18:43:09 INFO - argparse == 1.2.1 18:43:09 INFO - blessings == 1.6 18:43:09 INFO - blobuploader == 1.2.4 18:43:09 INFO - docopt == 0.6.1 18:43:09 INFO - functools32 == 3.2.3-2 18:43:09 INFO - jsonschema == 2.5.1 18:43:09 INFO - manifestparser == 1.1 18:43:09 INFO - mozInstall == 1.12 18:43:09 INFO - mozcrash == 0.17 18:43:09 INFO - mozdebug == 0.1 18:43:09 INFO - mozdevice == 0.48 18:43:09 INFO - mozfile == 1.2 18:43:09 INFO - mozhttpd == 0.7 18:43:09 INFO - mozinfo == 0.9 18:43:09 INFO - mozleak == 0.1 18:43:09 INFO - mozlog == 3.4 18:43:09 INFO - moznetwork == 0.27 18:43:09 INFO - mozprocess == 0.23 18:43:09 INFO - mozprofile == 0.28 18:43:09 INFO - mozrunner == 6.12 18:43:09 INFO - mozscreenshot == 0.1 18:43:09 INFO - mozsystemmonitor == 0.3 18:43:09 INFO - moztest == 0.7 18:43:09 INFO - mozversion == 1.4 18:43:09 INFO - psutil == 3.1.1 18:43:09 INFO - requests == 1.2.3 18:43:09 INFO - wsgiref == 0.1.2 18:43:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:09 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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:43:09 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 18:43:09 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 18:43:09 INFO - Using env: {'DISPLAY': ':0', 18:43:09 INFO - 'HOME': '/home/cltbld', 18:43:09 INFO - 'LANG': 'en_US.UTF-8', 18:43:09 INFO - 'LANGUAGE': 'en_US:en', 18:43:09 INFO - 'LOGNAME': 'cltbld', 18:43:09 INFO - 'MAIL': '/var/mail/cltbld', 18:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:09 INFO - 'MOZ_NO_REMOTE': '1', 18:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:09 INFO - 'NO_EM_RESTART': '1', 18:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:09 INFO - 'PWD': '/builds/slave/test', 18:43:09 INFO - 'SHELL': '/bin/bash', 18:43:09 INFO - 'SHLVL': '1', 18:43:09 INFO - 'TERM': 'linux', 18:43:09 INFO - 'TMOUT': '86400', 18:43:09 INFO - 'USER': 'cltbld', 18:43:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:09 INFO - '_': '/tools/buildbot/bin/python'} 18:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 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)) 18:43:09 INFO - Cleaning up... 18:43:09 INFO - Return code: 0 18:43:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:09 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 0x7fabf0404f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', '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 18:43:09 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 18:43:09 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 18:43:09 INFO - Using env: {'DISPLAY': ':0', 18:43:09 INFO - 'HOME': '/home/cltbld', 18:43:09 INFO - 'LANG': 'en_US.UTF-8', 18:43:09 INFO - 'LANGUAGE': 'en_US:en', 18:43:09 INFO - 'LOGNAME': 'cltbld', 18:43:09 INFO - 'MAIL': '/var/mail/cltbld', 18:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:09 INFO - 'MOZ_NO_REMOTE': '1', 18:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:09 INFO - 'NO_EM_RESTART': '1', 18:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:09 INFO - 'PWD': '/builds/slave/test', 18:43:09 INFO - 'SHELL': '/bin/bash', 18:43:09 INFO - 'SHLVL': '1', 18:43:09 INFO - 'TERM': 'linux', 18:43:09 INFO - 'TMOUT': '86400', 18:43:09 INFO - 'USER': 'cltbld', 18:43:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:09 INFO - '_': '/tools/buildbot/bin/python'} 18:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:43:09 INFO - Cleaning up... 18:43:09 INFO - Return code: 0 18:43:09 INFO - Running post-action listener: _resource_record_post_action 18:43:09 INFO - Running post-action listener: _start_resource_monitoring 18:43:09 INFO - Starting resource monitoring. 18:43:09 INFO - [mozharness: 2016-10-21 01:43:09.719411Z] Finished create-virtualenv step (success) 18:43:09 INFO - [mozharness: 2016-10-21 01:43:09.719888Z] Running install step. 18:43:09 INFO - Running pre-action listener: _resource_record_pre_action 18:43:09 INFO - Running main action method: install 18:43:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:09 INFO - Reading from file tmpfile_stdout 18:43:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:43:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:43:09 INFO - Reading from file tmpfile_stdout 18:43:09 INFO - Output received: 18:43:09 INFO - Usage: mozinstall [options] installer 18:43:09 INFO - Options: 18:43:09 INFO - -h, --help show this help message and exit 18:43:09 INFO - -d DEST, --destination=DEST 18:43:10 INFO - Directory to install application into. [default: 18:43:10 INFO - "/builds/slave/test"] 18:43:10 INFO - --app=APP Application being installed. [default: firefox] 18:43:10 INFO - mkdir: /builds/slave/test/build/application 18:43:10 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'] 18:43:10 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 18:43:26 INFO - Reading from file tmpfile_stdout 18:43:26 INFO - Output received: 18:43:26 INFO - /builds/slave/test/build/application/firefox/firefox 18:43:26 INFO - Running post-action listener: _resource_record_post_action 18:43:26 INFO - [mozharness: 2016-10-21 01:43:26.955403Z] Finished install step (success) 18:43:26 INFO - [mozharness: 2016-10-21 01:43:26.955649Z] Running run-tests step. 18:43:26 INFO - Running pre-action listener: _resource_record_pre_action 18:43:26 INFO - Running main action method: run_tests 18:43:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:43:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:43:26 INFO - Python 2.7.3 18:43:26 INFO - Return code: 0 18:43:26 INFO - grabbing minidump binary from tooltool 18:43:26 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')]} 18:43:26 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 0x121c930>, '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 0x121d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121dcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:43:26 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 18:43:26 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 18:43:26 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 18:43:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:43:27 INFO - Return code: 0 18:43:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:43:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:43:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:43:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:43:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 18:43:27 INFO - Using env: {'DISPLAY': ':0', 18:43:27 INFO - 'HOME': '/home/cltbld', 18:43:27 INFO - 'LANG': 'en_US.UTF-8', 18:43:27 INFO - 'LANGUAGE': 'en_US:en', 18:43:27 INFO - 'LOGNAME': 'cltbld', 18:43:27 INFO - 'MAIL': '/var/mail/cltbld', 18:43:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:43:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:27 INFO - 'MOZ_NO_REMOTE': '1', 18:43:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:27 INFO - 'NO_EM_RESTART': '1', 18:43:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:27 INFO - 'PWD': '/builds/slave/test', 18:43:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:43:27 INFO - 'SHELL': '/bin/bash', 18:43:27 INFO - 'SHLVL': '1', 18:43:27 INFO - 'TERM': 'linux', 18:43:27 INFO - 'TMOUT': '86400', 18:43:27 INFO - 'USER': 'cltbld', 18:43:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479', 18:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:27 INFO - '_': '/tools/buildbot/bin/python'} 18:43:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:43:27 INFO - mozversion application_buildid: 20161020153022 18:43:27 INFO - mozversion application_changeset: ba6fc133264d8e7aa8adf43d9d88f48b6dc2ffac 18:43:27 INFO - mozversion application_display_name: Nightly 18:43:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:43:27 INFO - mozversion application_name: Firefox 18:43:27 INFO - mozversion application_remotingname: firefox 18:43:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:43:27 INFO - mozversion application_vendor: Mozilla 18:43:27 INFO - mozversion application_version: 52.0a1 18:43:27 INFO - mozversion platform_buildid: 20161020153022 18:43:27 INFO - mozversion platform_changeset: ba6fc133264d8e7aa8adf43d9d88f48b6dc2ffac 18:43:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:43:27 INFO - mozversion platform_version: 52.0a1 18:43:27 INFO - using testdate: 1477014207 18:43:27 INFO - actual date: 1477014207 18:43:27 INFO - starting webserver on 'localhost:40637' 18:43:27 INFO - SUITE-START | Running 2 tests 18:43:27 INFO - TEST-START | dromaeo_css 18:43:27 INFO - operating with platform_type : linux_ 18:43:27 INFO - Initialising browser for dromaeo_css test... 18:43:27 INFO - TEST-INFO | started process 4566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi11OhV/profile http://localhost:40637/getInfo.html) 18:43:31 INFO - PROCESS | 4566 | __metrics Screen width/height:1600/1200 18:43:31 INFO - PROCESS | 4566 | colorDepth:24 18:43:31 INFO - PROCESS | 4566 | Browser inner width/height: 1024/697 18:43:31 INFO - PROCESS | 4566 | __metrics 18:43:31 INFO - PROCESS | 4566 | 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" 18:43:31 INFO - PROCESS | 4566 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:43:32 INFO - PROCESS | 4566 | console.error: PushService: 18:43:32 INFO - PROCESS | 4566 | stateChangeProcessEnqueue: Error transitioning state 18:43:32 INFO - PROCESS | 4566 | UnknownError 18:43:33 INFO - TEST-INFO | 4566: exit 0 18:43:33 INFO - Browser initialized. 18:43:33 INFO - Running cycle 1/1 for dromaeo_css test... 18:43:33 INFO - TEST-INFO | started process 4651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi11OhV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:43:45 INFO - PROCESS | 4651 | RSS: Main: 172032000 18:43:45 INFO - PROCESS | 4651 | 18:44:36 INFO - PROCESS | 4651 | 1477014276910 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] 18:46:46 INFO - PROCESS | 4651 | Cycle 1(1): loaded http://localhost:40637/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40637/tests/dromaeo/cssquery-ext.html) 18:46:49 INFO - PROCESS | 4651 | RSS: Main: 392224768 18:46:49 INFO - PROCESS | 4651 | 18:49:51 INFO - PROCESS | 4651 | Cycle 1(1): loaded http://localhost:40637/tests/dromaeo/cssquery-ext.html (next: http://localhost:40637/tests/dromaeo/cssquery-jquery.html) 18:49:52 INFO - PROCESS | 4651 | RSS: Main: 277385216 18:49:52 INFO - PROCESS | 4651 | 18:52:54 INFO - PROCESS | 4651 | Cycle 1(1): loaded http://localhost:40637/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40637/tests/dromaeo/cssquery-mootools.html) 18:52:55 INFO - PROCESS | 4651 | RSS: Main: 218185728 18:52:55 INFO - PROCESS | 4651 | 18:55:57 INFO - PROCESS | 4651 | Cycle 1(1): loaded http://localhost:40637/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40637/tests/dromaeo/cssquery-prototype.html) 18:55:57 INFO - PROCESS | 4651 | RSS: Main: 249798656 18:55:57 INFO - PROCESS | 4651 | 18:59:00 INFO - PROCESS | 4651 | Cycle 1(1): loaded http://localhost:40637/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40637/tests/dromaeo/cssquery-yui.html) 18:59:01 INFO - PROCESS | 4651 | RSS: Main: 220037120 18:59:01 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | Cycle 1(1): loaded http://localhost:40637/tests/dromaeo/cssquery-yui.html (next: http://localhost:40637/tests/dromaeo/cssquery-dojo.html) 19:02:04 INFO - PROCESS | 4651 | RSS: Main: 306565120 19:02:04 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | __start_tp_report 19:02:04 INFO - PROCESS | 4651 | _x_x_mozilla_page_load 19:02:04 INFO - PROCESS | 4651 | _x_x_mozilla_page_load_details 19:02:04 INFO - PROCESS | 4651 | |i|pagename|runs| 19:02:04 INFO - PROCESS | 4651 | |0;dojo.html;3022.0782661288304;3038.7568994480444;3050.8779648814048;3069.693030696932;3096.860641271144;5128.640995130338;5147.330846989886;5194.662346947446;5225.137852254378;5231.319928409302;5328.786848526054;5335.226392173142;5446.509814116729;5457.072297709389;5487.2317875497365;4747.311639812225;4753.144434001878;4794.736289504076;4833.734144622062;4833.854984350458;4871.926921096187;4880.463149053619;4942.654014219006;4944.826931057396;4998.475160108191;4750.382450281441;4872.78072486739;4892.192788189945;4936.654434189608;4968.428630707461;4759.262314341283;4791.928121078186;4793.640476964207;4837.782299796518;4840.15297322967;4793.233082706785;4802.975985120052;4812.951870481285;4826.058918510892;4861.659683822134;5302.125149350352;5307.416184219771;5317.787288508455;5325.973370133163;5327.786888524454;5514.310711161105;5570.721463926788;5638.069718496443;5660.2075709400715;5700.087985922232;5772;5779;5779.422057794229;5795.362510123883;5847.56143289255;5375.354957405137;5378;5379.757910894019;5381.48875856793;5385.21914322425;5620.9437905621235;5661.943380566224;5762.078067509178;5820.621659592113;5827.096799996008;5569.582281328917;5572.164175373645;5578.442155784389;5665.2635157430095;5671.829845104653;5607.43925607436;5639.125935480007;5639.802606908738;5657.858553536113;5700.800471983461;5447.210154527571;5486.835394938158;5673.8297851064535;5686.459786320293;5687.857803554862;5600.467955544217;5650.604457687922;5652.123920792284;5670.5463562914865;5684.317881854204;4294.89262768427;4303.397524346594;4358.411614432074;4360.629346505582;4411.426514553087;3856.2865869814173;3896.532416110085;3899.883003509899;3950.7234493585747;3976.1053762903693;5321.574274058066;5349.063913815066;5349.491798279158;5350.0904846176245;5357.491038351351;5592.804251851166;5603.299587551556;5622.381538030813;5625.296837895263;5642;5216.7913283469;5374.435684253097;5394.136938089887;5394.568434525228;5458.426865179178;4640.83757068501;4676.602488788423;4726.550977657117;4735.857924262277;4781.187198176319;5821.243238378984;5825.300963884361;5833.095870140135;5837.09525023622;5839.124131380242;5628.071368224197;5664.603477756682;5670.177824215548;5674.233978412862;5692.51613612831;5720.427957204246;5779.36426993022;5807.912881306699;5847.356790753099;5869.4717475427415;5574.804881829116;5576.191452239322;5582.911332290165;5593;5647.887042259214;5614;5657.575681823962;5690.374058853606;5705.400932902152;5742.942570574241;5469.617126801086;5501.614886958035;5502.504774570308;5560.138178582326;5569.498745112959;5544.473275038865;5553.500184983371;5557.249771280825;5559.63862348946;5562.388137304974;5495.258140151029;5504.669719816824;5507.421720719427;5510.91733624004;5513.2005859151;5521.0853398641575;5542.251796007487;5573.832785016456;5574.414686457863;5589.413111623221;5469.753861076181;5486.533644640251;5487.643303185439;5496.038193316073;5505.091659876076 19:02:04 INFO - PROCESS | 4651 | |1;ext.html;592.2419303291787;612.2683393344953;626.2141013028648;630.3696303696304;630.8107567729683;31218.219544511398;42602.78698606507;44424.555754442445;44482.33276500855;47208.291875621806;45543.544564554344;45786.771066144625;45888.3116753249;45890.77054614722;45918;8857.867131993009;8984.96672882617;8997.95501022494;9006.414583052081;9008.729738107868;8076.9192308077045;8355.83288334233;10486.475676216196;10741.194410419212;10742.462876856165;10991.61529346473;11064.0595549378;11070.944645276762;11073.224874258805;11073.889261107406;10733.141348692086;10770.676879693583;10795.514201860935;10802.297850639761;10874;10586.629467968583;10637.202209834293;10644.520996555097;10674.73313167177;10678.466076696212;40722.38916416256;41254;41344.1731165375;41365.1726965462;41492.1701565967;3437.845296961643;3463.515107884873;3567.7680950738377;3605.6574625410544;3996.620321069523;31518.212044698837;31614;31660.36679266425;31693.52459713106;31784.682153178404;4271.829126834923;4370.7159034662645;4495.617872480843;4556.453225612914;4566.885827854297;227314;227425;227627;303273;305240.4737976318;33161.3367732644;34482.655173448446;57288.42711572831;57678.7116064417;57722.4227757717;35909.64090359115;36028;36046.63953360433;36160.09599760027;36261.27477450436;13318.467261309439;13431;13441.865581344256;13450.192988420726;13485.797713034312;8590.699325523577;8747.781305467413;10456.215783816244;10465;10480.895191048145;7715.768526944088;7759.72840950564;7891.329237014918;8209.220124088202;8262.504249745034;3195.2650890295363;3200.759943004284;3227.3383956288903;3248.6751324867796;3291.259466619991;913.5934509143367;957.2007373842919;1000.4097582426404;1006.4514839412537;1024.9801447559726;30561.23596910095;30758.692413075583;31014.379712405625;31179.53230701541;31525.842370788;1013.4172850610928;1018.0226982097122;1050.7163065972145;1093.8523299354486;1145.4330106597122;16317.67364652724;16453.83546164547;16507;16604.169791510376;16769.72323842853;153403;154233.2288338551;154651;154683;154918;56753;57217.713911430175;57458.42541574614;57484.71257643685;57499.13751293734;1186.4127257007665;1224.9142560020714;1226.7730469863282;1303.6154334471353;1309.5874799438147;28036.71963280341;31132.53301200529;31737;32805.507917381736;33111;53254.46745532495;53805.50264232812;53878;53932;54013.459865400844;419616;420982;421107;422638;422663;26223.21330360092;27024.459510810066;27368.178954631392;27526.587101193098;27930.441391171655;42246.366304506075;42670.57329426666;43097.35353969756;43284.78357608192;43589.34615980699;35988.82005589955;36546;36633.816830915675;36862.262754745294;37027.81486092552;36271.274574507835;36325.69505370638;36550.26899462049;37261;37492;36196.4044228783;36551.45172822357;36741;36880.07799805026;37459.250814984094;30834.38331233318;33784.1553961153;33925.83037084799;33937.66062339345;34033.65966340404;24869.50260994806;25263.36841578975;25718;25787.613185801853;26092.34769130711 19:02:04 INFO - PROCESS | 4651 | |2;jquery.html;352.6825856728945;364.855881926639;384.53471299727335;388.10348095898473;408.6914379643369;14194.36125374358;17824.37614683488;17859.464216073524;18405;19571.315003974865;16768.580785480368;17727.911360443213;18125.365612203575;18469.53826154347;18496;5050.671706339085;5291.6031297652635;5301;5310.893782124355;5312.335958005249;3812.046988252937;4100.056986893016;5226.5818734501145;5246.632735708502;5287.788488460457;4083.97958010211;6229.90655140171;6258.374162583751;6316.210473690789;6337.746490140412;6188.4739797116845;6236.8440788980415;6279.560430769848;6322.39937205967;6327.683615819214;5640.379558248589;5656.547476201894;5664.291963504562;5665.405132461115;5665.971670141664;21917.780822191733;22482.77517224823;22535.211267605555;23073.884630576908;23326;2214.446388402899;2217.623004089309;2256.808171305441;2288.2448791898632;2320.953580928372;9411.529423528864;9601.231901447938;10018.3488073275;10406.739831504197;10661.626843060532;1873.2226126157627;1930.1700268884374;1985.2158397432934;1987.8807271563753;1993.531520092777;74324;77785.61107194428;77910;79534.20465795326;80806.19193808046;10703.735360714902;10705.892941070646;10729.83905241422;10936.945315273373;10973.561057557608;14857;14982.850171498363;15028.62428439276;15130.470433534774;15139.697206055816;7143.42852571793;7301.160366557808;7458.888116678254;7573.507721998052;7615.733449329357;6991.23096459389;7008.5094043416475;7035.788926332219;7172.246914073947;7219.169795473587;4582.175208462509;4585.312203169485;4617.191991401492;4626.306054091913;4705.788239529229;1852.2035524724497;1909.8376637985648;1948.3473036532637;1964.145596665455;1977.5945931084093;950.5316322425957;960.3469640644429;971.7327734872966;984.675057231112;997.1922742578535;17898.284068637367;18671.626567468575;18883.62232755337;19018;19185.32851350196;933.3186773655269;934.0566028311455;943.094629156018;945.2626950978248;946.4415994563241;10249.180065594735;10284.691459256233;10607.41659208751;10718.517666705016;10730.087942524817;454670;463544;465405;466498;466806;89769;91746;92033.53983230174;92329;92833.53583232041;998.6654470752234;1070.1278458056815;1109.8501702270253;1111.7887601355717;1114.9665510034713;16424.343026278813;16931.492055238363;17145.742813857552;17163.91418042902;17363.565910851823;37950.62049379581;39095.6090439092;39349;41672.79163604163;41763.7911810439;52665.47334526606;55262.17106743321;56181;56659.15011274752;57343.71328143332;6351.237851457855;7727.459077864721;7866;8486.40595158333;8831.116888311117;11313.604023859125;12787.744245115231;13169.53906613264;13572.457101715821;13657.38541765603;10748.89251107479;11170.664880053611;11396.715082122682;11719.941400292944;12085.214461060355;10653.840192396965;11013.339199648046;11283.153763467937;11347.148963827582;11536.884631153582;11542.13433992437;11662.70843228926;11779;11957.820632690691;12030.578929737418;7365.226651201547;7454.366378857858;8437.325013998743;8594.742157735278;8858.734237972614;10506.422146782;11156.832647510131;11278.323300601991;11485.540578376771;11776.234544754563 19:02:04 INFO - PROCESS | 4651 | |3;mootools.html;1286.2604002698451;1483.1397789282216;1504.105057490793;1599.9920000399995;1757.0775342944953;7645.464817462773;8568.186022327876;8824.161704638049;8848.380613357067;9156.8626470603;8977.102289771019;9076.591553380098;9084.727458176249;9086.591103400346;9090.318226133033;2231.933042008738;2252.718410198725;2258.841881068326;2259.2770313499686;2259.6158653029024;2211.4581927427803;2239.2386588559966;2273.715785526809;2274.7611500792427;2275.9886200568976;2232.1071571371417;2234.1398561553838;2236.507968246983;2237.3735354100877;2275.112706044644;2148.355493351988;2173.3045425463856;2178.564287142578;2183.7270341207427;2184.945376365588;2130.744310682728;2133.0721136305756;2138.8182004529635;2139.4009677290383;2140.989295053515;8763.167499087576;8907.02022777494;8933.731988040368;8936.508492032935;8936.910630893737;4954.529319714621;5088.643794934356;5089.872753181163;5156.871078223037;5161.483851614846;3110.8690546975395;3281.8359082045804;3303.5705358303508;3366.5791776027995;3396.541466901986;1004.8542961270575;1042.468341146021;1048.496721573649;1065.9893401065967;1069.7913906788178;12334.074944379117;12410.069244806675;12464.065195110403;12491.437885295183;12507.249565026128;4065.1463192729857;4196.769177695195;4331.826726930887;4343;4353.608175264241;9836.917939026702;9838.9016109838;9841.60633574649;9935.701928942144;9949.452780097019;5068.569171620454;5074.543291103744;5079.212722028092;5085.211792172219;5085.923711144335;4176.9582304177175;4194.161167766459;4644.465886423037;4792.592629626451;4824.734639594786;3560.4481305397703;3656.177360094011;3707.1288247261873;3719.4048952168064;3724.646158614927;1040.152275895143;1069.994650026745;1079.1205167788228;1088.7006073329899;1094.7919895219882;867.319154463743;897.9551022448851;906.9162350990503;920.9907900921039;987.782687808681;5935.970320148372;5979.970100149471;6033.7586496540525;6078.817635470943;6265.154204182468;934.6822080492665;953.8855337359561;967.4147140979746;980.1129977370491;1005.1657124586576;4024.7987600619854;4129.29801933666;4240.681948853849;4268.843331054932;4319.935200971988;11235.325880447199;11573.652790416301;11574.826377604175;11587;11597.420128993517;11342.262752921033;11445.54217831294;11454.541818327174;11460.828087578526;11529.192956492965;7684.577348245788;8102.675892964333;8211.34309255258;8213.589320533949;8218.63016164274;6174.8147555573405;6214.130021797043;6236.251649801871;6279.623222606659;6305.306416294296;10305.74235644085;10310.123639490726;10330.845037324296;10391.792164156826;10408.271421000458;10384.948075259877;10754.408507531847;10894.182936279969;10932.781344373227;10946.835797463204;6908.5509441886115;7115.5730656160795;7984.84030319402;8097.716579919675;8129.75610731679;7860.174681658344;8266.628001739817;8266.917330826614;8402.621882015446;8684.04475507681;7715.92284077152;7809;7840.686372545034;8161.469504482189;8273.83452330962;7233.132024157135;7469.514481558681;7476.289752473506;7539.811504712426;7718.459707820623;7035.401990830836;7113.715451381887;7117.8576428470105;7133.322334378226;7136;5052.418971818288;5218.791248350175;5228.58171346299;5273.182656688219;5500.367457742411;5253.264542964064;5265.815696450606;5285.68285902847;5304.681719096712;5513.558915286687 19:02:04 INFO - PROCESS | 4651 | |4;prototype.html;322.6966651347733;329.79223089453643;332.8302565691498;335;340.8670618458803;5303.840884773458;5352.545033672132;5365.785368585257;5371.033214021474;5378.6503877248;5067.84796456106;5132.692038477694;5195.194594918739;5255.216244304104;5352.973235133829;4136.379543068534;4146.771927543984;4165.708400411972;4174.394712766647;4184.581541845821;4110.8972275693195;4135.565765594614;4171.165766846628;4176.310908700061;4195.433616461769;3695.7597756145897;3922.5881282465357;3985.960140398588;4114.8148333324925;4179.707420480552;4077.5718549552166;4087.2234275487563;4091.243120022805;4099.934017155531;4102.856400025999;3614.204874927538;3617.801020943847;3628.183658676803;3631.273745250934;3635.5092062571744;5059.848204553869;5179.715115668637;5193.948060519422;5195.740212989335;5197.298364720752;4749.7387643679585;4751.809927602892;4752.405949256343;4763.809447622091;4764.880877978044;5480.205370221335;5546.77812887484;5580.19087232349;5589.636673616243;5596.188552659883;3854.95687285739;3947.4276229946786;4001.379786133154;4011.237864805707;4018.7294178789184;5684.488396044335;5706;5717.885642287131;5728.799492017801;5748.540116790688;4073.246449406869;4074.4295798587627;4087.6525495332635;4087.6729861611;4144.461220041436;4062.370332598452;4142.1301526679135;4186.497620285524;4188.204241194163;4191.664666826647;4687.554682305244;4707.8587642370785;4717.858464246078;4730.479647238801;4766.737829419346;5533.944660553343;5555.50000499957;5557.861053473695;5564.27664403633;5582.581306402036;1325.9535916242885;1332.6468485851258;1425.6792221750022;1436.7844823276591;1437.7771445425976;907.0747837206145;935.0789472369711;940;940.6049459227141;943.9569275950114;4777.208546794952;4781.928271075936;4800.4479484859685;4830.6135509159185;4937.876553086202;4667.766611669403;5012.8496145115705;5051.257316225896;5051.444341122474;5079.120725331651;4731.384919960383;4757.621189405298;4771.618270538349;4777.593904518086;4807.807687692523;2681.3028612560875;2691.6366290550527;2695.786895896815;2700.7839372850126;2707.294404525176;5172.456867046086;5423.430539793344;5904.940950590439;5993.160957465958;6006.249218847644;5863.882722345529;5875.20684707559;5884.558658100659;5892.908017653671;5898.4101589840675;5750.30996280449;5928.496077833346;5931.881362372642;5957.761689532457;5970.194023806817;5763.538916886723;5774.855628609318;5776.7111644418455;5784.392638772868;5787.305523337058;5657.32112146545;5667.319921609434;5674.375818659862;5678.290213723285;5699.715014249354;5600.747966341606;5894.440028197314;5925.703714814328;5971.761129554943;5990.550708696778;4059.4925634295714;4074.4499492568125;4080.5924504542463;4090.1410703752545;4096.344584866407;5729.3984131665575;5818.185454036523;5835.008048631658;5855.180274761452;5883.676397798162;5607.523360514402;5634.183043458757;5634.211210430625;5689;5708.315002199763;5331.5611430627805;5401.2168235606405;5473.75368108444;5583.78932114028;5587.323802859208;5548.805791797267;5570.220169176399;5593.8321850344555;5594.13290939905;5594.524465420485;5522.696251706195;5670.319561652628;5670.688112153706;5671.546276297804;5682.5453963681975;5487.2015272210665;5487.436080716977;5500.202470641654;5504.394516603091;5554.555635549227 19:02:04 INFO - PROCESS | 4651 | |5;yui.html;767.7005967672607;775.4881778026504;803.6222975201653;805.0661232969754;835.6323217784178;15082.849171508295;16448.095354755485;16499.75250371244;16534.090625015648;16582.66834663306;14366.138031718105;14717.264136793172;14867;14869.92565037176;15450.61373465664;778.1051790440996;807.858624740671;808.5108509351817;810.2424233341815;810.6959890041235;656.743869890743;670.2359310386164;811.2982270336175;815.3680897304577;816.302061737215;830.667732906836;850.1413572291967;854.5171977832536;861.0700443520982;861.315254372772;853.7225401744458;853.8078932240227;854.0903937306748;854.162920338066;854.5171977832536;501.6739119572307;511.66230288009734;626.3923993726079;626.3923993726079;626.9090981807612;13622.250776207306;14295.213763243017;14476.782848257284;14995.100293982396;15013.774793378108;14457.493987710379;14880.479183228643;15294.694106117815;15415.92292038544;15536.378544858193;11994.820077698841;12139.939300303531;12166.087543434278;12328.938355308255;13063.34683265833;3771.0068318954714;3920.0983773731914;3944.5069366329208;3992.201559688074;3992.740471869319;77770;78592;78826.6058669703;78943.68450523945;79010.60494697547;11561.132915031407;11740.295582265091;11785.587504437304;12330.691732706755;12436.626901192978;22994.540109197722;23003.079876805074;23038.193663222042;23055.423614409774;23068.4232894179;8194;8266.751997440086;8285.50286982771;8332.250097491255;8477.788055298666;4480.6658919118045;4651;4654.86035418938;4760.357351757538;4856.708597484162;3448.8448019839166;3526.0479670488826;3566.518519999767;3568.286342731464;3573.1781690211396;598.850287428143;613.5919613457002;616.8057062025538;627.8116565030473;639.4277121975806;569.0525275416385;636.7102968149574;675.4596322941627;686.9828254293583;687.4397366146575;9188.26493880488;9636.75908102303;10328.741781455374;10352.327098738559;10612.257141999986;599.5323647554915;605.5851741557047;630.5838146823074;699.5383047188831;715.6600614708076;4230.830766769356;4694.201985662446;4705.155235232777;4810.086083644096;4892.877678058077;102161;104521.47739261255;106165;107961;109701.45149274362;94635;96325.51837240769;97114.03390372804;97204.51397742965;98102.5094874521;80316.33831402821;81108;81522.59238703769;81740;82608;8844.867326990228;9153.775075263038;9223.677171298972;9236.214921731727;9444.197243234403;45301.546984529734;46501.3024804635;47312;47714.80712982203;47942.76028619835;64341.35658643354;66116.66941665261;72354.27645723686;72417.27582724106;73152.63423682848;11568.305901645928;11601.303921764722;11620.941895290469;12038.939805300917;12401.503939842305;13043.673863164831;13123.031545268286;13259.270740109387;13535.729285414434;13691.452341906212;12557.560485382968;12560.685982850502;12978.870211297766;13402.798958015443;13560.59318220455;12103.33431661267;12133;12543.372831358212;12672.809907851206;13045.608631741063;11555.768884622092;12181;12184.634460966185;12573.93713031429;12698.746025079261;9772.755681108029;9927.40435573868;10153.340032897839;10288.12550933179;10363.274570779973;9369.203617692572;9492.667756628485;9803.171702020963;10272.589096436059;10999.505022273857 19:02:04 INFO - PROCESS | 4651 | __end_tp_report 19:02:04 INFO - PROCESS | 4651 | __start_cc_report 19:02:04 INFO - PROCESS | 4651 | _x_x_mozilla_cycle_collect,2226 19:02:04 INFO - PROCESS | 4651 | __end_cc_report 19:02:04 INFO - PROCESS | 4651 | __startTimestamp1477015324734__endTimestamp 19:02:04 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | ------- Summary: start ------- 19:02:04 INFO - PROCESS | 4651 | Number of tests: 6 19:02:04 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | [#0] dojo.html Cycles:165 Average:5265.14 Median:5496.04 stddev:593.44 (10.8%) stddev-sans-first:568.57 19:02:04 INFO - PROCESS | 4651 | Values: 3022.1 3038.8 3050.9 3069.7 3096.9 5128.6 5147.3 5194.7 5225.1 5231.3 5328.8 5335.2 5446.5 5457.1 5487.2 4747.3 4753.1 4794.7 4833.7 4833.9 4871.9 4880.5 4942.7 4944.8 4998.5 4750.4 4872.8 4892.2 4936.7 4968.4 4759.3 4791.9 4793.6 4837.8 4840.2 4793.2 4803.0 4813.0 4826.1 4861.7 5302.1 5307.4 5317.8 5326.0 5327.8 5514.3 5570.7 5638.1 5660.2 5700.1 5772.0 5779.0 5779.4 5795.4 5847.6 5375.4 5378.0 5379.8 5381.5 5385.2 5620.9 5661.9 5762.1 5820.6 5827.1 5569.6 5572.2 5578.4 5665.3 5671.8 5607.4 5639.1 5639.8 5657.9 5700.8 5447.2 5486.8 5673.8 5686.5 5687.9 5600.5 5650.6 5652.1 5670.5 5684.3 4294.9 4303.4 4358.4 4360.6 4411.4 3856.3 3896.5 3899.9 3950.7 3976.1 5321.6 5349.1 5349.5 5350.1 5357.5 5592.8 5603.3 5622.4 5625.3 5642.0 5216.8 5374.4 5394.1 5394.6 5458.4 4640.8 4676.6 4726.6 4735.9 4781.2 5821.2 5825.3 5833.1 5837.1 5839.1 5628.1 5664.6 5670.2 5674.2 5692.5 5720.4 5779.4 5807.9 5847.4 5869.5 5574.8 5576.2 5582.9 5593.0 5647.9 5614.0 5657.6 5690.4 5705.4 5742.9 5469.6 5501.6 5502.5 5560.1 5569.5 5544.5 5553.5 5557.2 5559.6 5562.4 5495.3 5504.7 5507.4 5510.9 5513.2 5521.1 5542.3 5573.8 5574.4 5589.4 5469.8 5486.5 5487.6 5496.0 5505.1 19:02:04 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | [#1] ext.html Cycles:180 Average:44595.73 Median:18735.75 stddev:79442.43 (424.0%) stddev-sans-first:79596.59 19:02:04 INFO - PROCESS | 4651 | Values: 592.2 612.3 626.2 630.4 630.8 31218.2 42602.8 44424.6 44482.3 47208.3 45543.5 45786.8 45888.3 45890.8 45918.0 8857.9 8985.0 8998.0 9006.4 9008.7 8076.9 8355.8 10486.5 10741.2 10742.5 10991.6 11064.1 11070.9 11073.2 11073.9 10733.1 10770.7 10795.5 10802.3 10874.0 10586.6 10637.2 10644.5 10674.7 10678.5 40722.4 41254.0 41344.2 41365.2 41492.2 3437.8 3463.5 3567.8 3605.7 3996.6 31518.2 31614.0 31660.4 31693.5 31784.7 4271.8 4370.7 4495.6 4556.5 4566.9 227314.0 227425.0 227627.0 303273.0 305240.5 33161.3 34482.7 57288.4 57678.7 57722.4 35909.6 36028.0 36046.6 36160.1 36261.3 13318.5 13431.0 13441.9 13450.2 13485.8 8590.7 8747.8 10456.2 10465.0 10480.9 7715.8 7759.7 7891.3 8209.2 8262.5 3195.3 3200.8 3227.3 3248.7 3291.3 913.6 957.2 1000.4 1006.5 1025.0 30561.2 30758.7 31014.4 31179.5 31525.8 1013.4 1018.0 1050.7 1093.9 1145.4 16317.7 16453.8 16507.0 16604.2 16769.7 153403.0 154233.2 154651.0 154683.0 154918.0 56753.0 57217.7 57458.4 57484.7 57499.1 1186.4 1224.9 1226.8 1303.6 1309.6 28036.7 31132.5 31737.0 32805.5 33111.0 53254.5 53805.5 53878.0 53932.0 54013.5 419616.0 420982.0 421107.0 422638.0 422663.0 26223.2 27024.5 27368.2 27526.6 27930.4 42246.4 42670.6 43097.4 43284.8 43589.3 35988.8 36546.0 36633.8 36862.3 37027.8 36271.3 36325.7 36550.3 37261.0 37492.0 36196.4 36551.5 36741.0 36880.1 37459.3 30834.4 33784.2 33925.8 33937.7 34033.7 24869.5 25263.4 25718.0 25787.6 26092.3 19:02:04 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | [#2] jquery.html Cycles:180 Average:27777.36 Median:2098.29 stddev:76523.78 (3647.0%) stddev-sans-first:76710.75 19:02:04 INFO - PROCESS | 4651 | Values: 352.7 364.9 384.5 388.1 408.7 14194.4 17824.4 17859.5 18405.0 19571.3 16768.6 17727.9 18125.4 18469.5 18496.0 5050.7 5291.6 5301.0 5310.9 5312.3 3812.0 4100.1 5226.6 5246.6 5287.8 4084.0 6229.9 6258.4 6316.2 6337.7 6188.5 6236.8 6279.6 6322.4 6327.7 5640.4 5656.5 5664.3 5665.4 5666.0 21917.8 22482.8 22535.2 23073.9 23326.0 2214.4 2217.6 2256.8 2288.2 2321.0 9411.5 9601.2 10018.3 10406.7 10661.6 1873.2 1930.2 1985.2 1987.9 1993.5 74324.0 77785.6 77910.0 79534.2 80806.2 10703.7 10705.9 10729.8 10936.9 10973.6 14857.0 14982.9 15028.6 15130.5 15139.7 7143.4 7301.2 7458.9 7573.5 7615.7 6991.2 7008.5 7035.8 7172.2 7219.2 4582.2 4585.3 4617.2 4626.3 4705.8 1852.2 1909.8 1948.3 1964.1 1977.6 950.5 960.3 971.7 984.7 997.2 17898.3 18671.6 18883.6 19018.0 19185.3 933.3 934.1 943.1 945.3 946.4 10249.2 10284.7 10607.4 10718.5 10730.1 454670.0 463544.0 465405.0 466498.0 466806.0 89769.0 91746.0 92033.5 92329.0 92833.5 998.7 1070.1 1109.9 1111.8 1115.0 16424.3 16931.5 17145.7 17163.9 17363.6 37950.6 39095.6 39349.0 41672.8 41763.8 52665.5 55262.2 56181.0 56659.2 57343.7 6351.2 7727.5 7866.0 8486.4 8831.1 11313.6 12787.7 13169.5 13572.5 13657.4 10748.9 11170.7 11396.7 11719.9 12085.2 10653.8 11013.3 11283.2 11347.1 11536.9 11542.1 11662.7 11779.0 11957.8 12030.6 7365.2 7454.4 8437.3 8594.7 8858.7 10506.4 11156.8 11278.3 11485.5 11776.2 19:02:04 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | [#3] mootools.html Cycles:180 Average:5809.83 Median:4889.63 stddev:3416.93 (69.9%) stddev-sans-first:3409.61 19:02:04 INFO - PROCESS | 4651 | Values: 1286.3 1483.1 1504.1 1600.0 1757.1 7645.5 8568.2 8824.2 8848.4 9156.9 8977.1 9076.6 9084.7 9086.6 9090.3 2231.9 2252.7 2258.8 2259.3 2259.6 2211.5 2239.2 2273.7 2274.8 2276.0 2232.1 2234.1 2236.5 2237.4 2275.1 2148.4 2173.3 2178.6 2183.7 2184.9 2130.7 2133.1 2138.8 2139.4 2141.0 8763.2 8907.0 8933.7 8936.5 8936.9 4954.5 5088.6 5089.9 5156.9 5161.5 3110.9 3281.8 3303.6 3366.6 3396.5 1004.9 1042.5 1048.5 1066.0 1069.8 12334.1 12410.1 12464.1 12491.4 12507.2 4065.1 4196.8 4331.8 4343.0 4353.6 9836.9 9838.9 9841.6 9935.7 9949.5 5068.6 5074.5 5079.2 5085.2 5085.9 4177.0 4194.2 4644.5 4792.6 4824.7 3560.4 3656.2 3707.1 3719.4 3724.6 1040.2 1070.0 1079.1 1088.7 1094.8 867.3 898.0 906.9 921.0 987.8 5936.0 5980.0 6033.8 6078.8 6265.2 934.7 953.9 967.4 980.1 1005.2 4024.8 4129.3 4240.7 4268.8 4319.9 11235.3 11573.7 11574.8 11587.0 11597.4 11342.3 11445.5 11454.5 11460.8 11529.2 7684.6 8102.7 8211.3 8213.6 8218.6 6174.8 6214.1 6236.3 6279.6 6305.3 10305.7 10310.1 10330.8 10391.8 10408.3 10384.9 10754.4 10894.2 10932.8 10946.8 6908.6 7115.6 7984.8 8097.7 8129.8 7860.2 8266.6 8266.9 8402.6 8684.0 7715.9 7809.0 7840.7 8161.5 8273.8 7233.1 7469.5 7476.3 7539.8 7718.5 7035.4 7113.7 7117.9 7133.3 7136.0 5052.4 5218.8 5228.6 5273.2 5500.4 5253.3 5265.8 5285.7 5304.7 5513.6 19:02:04 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | [#4] prototype.html Cycles:180 Average:4632.50 Median:5194.57 stddev:1383.01 (26.6%) stddev-sans-first:1348.53 19:02:04 INFO - PROCESS | 4651 | Values: 322.7 329.8 332.8 335.0 340.9 5303.8 5352.5 5365.8 5371.0 5378.7 5067.8 5132.7 5195.2 5255.2 5353.0 4136.4 4146.8 4165.7 4174.4 4184.6 4110.9 4135.6 4171.2 4176.3 4195.4 3695.8 3922.6 3986.0 4114.8 4179.7 4077.6 4087.2 4091.2 4099.9 4102.9 3614.2 3617.8 3628.2 3631.3 3635.5 5059.8 5179.7 5193.9 5195.7 5197.3 4749.7 4751.8 4752.4 4763.8 4764.9 5480.2 5546.8 5580.2 5589.6 5596.2 3855.0 3947.4 4001.4 4011.2 4018.7 5684.5 5706.0 5717.9 5728.8 5748.5 4073.2 4074.4 4087.7 4087.7 4144.5 4062.4 4142.1 4186.5 4188.2 4191.7 4687.6 4707.9 4717.9 4730.5 4766.7 5533.9 5555.5 5557.9 5564.3 5582.6 1326.0 1332.6 1425.7 1436.8 1437.8 907.1 935.1 940.0 940.6 944.0 4777.2 4781.9 4800.4 4830.6 4937.9 4667.8 5012.8 5051.3 5051.4 5079.1 4731.4 4757.6 4771.6 4777.6 4807.8 2681.3 2691.6 2695.8 2700.8 2707.3 5172.5 5423.4 5904.9 5993.2 6006.2 5863.9 5875.2 5884.6 5892.9 5898.4 5750.3 5928.5 5931.9 5957.8 5970.2 5763.5 5774.9 5776.7 5784.4 5787.3 5657.3 5667.3 5674.4 5678.3 5699.7 5600.7 5894.4 5925.7 5971.8 5990.6 4059.5 4074.4 4080.6 4090.1 4096.3 5729.4 5818.2 5835.0 5855.2 5883.7 5607.5 5634.2 5634.2 5689.0 5708.3 5331.6 5401.2 5473.8 5583.8 5587.3 5548.8 5570.2 5593.8 5594.1 5594.5 5522.7 5670.3 5670.7 5671.5 5682.5 5487.2 5487.4 5500.2 5504.4 5554.6 19:02:04 INFO - PROCESS | 4651 | 19:02:04 INFO - PROCESS | 4651 | [#5] yui.html Cycles:180 Average:20039.39 Median:26008.58 stddev:28522.53 (109.7%) stddev-sans-first:28565.83 19:02:04 INFO - PROCESS | 4651 | Values: 767.7 775.5 803.6 805.1 835.6 15082.8 16448.1 16499.8 16534.1 16582.7 14366.1 14717.3 14867.0 14869.9 15450.6 778.1 807.9 808.5 810.2 810.7 656.7 670.2 811.3 815.4 816.3 830.7 850.1 854.5 861.1 861.3 853.7 853.8 854.1 854.2 854.5 501.7 511.7 626.4 626.4 626.9 13622.3 14295.2 14476.8 14995.1 15013.8 14457.5 14880.5 15294.7 15415.9 15536.4 11994.8 12139.9 12166.1 12328.9 13063.3 3771.0 3920.1 3944.5 3992.2 3992.7 77770.0 78592.0 78826.6 78943.7 79010.6 11561.1 11740.3 11785.6 12330.7 12436.6 22994.5 23003.1 23038.2 23055.4 23068.4 8194.0 8266.8 8285.5 8332.3 8477.8 4480.7 4651.0 4654.9 4760.4 4856.7 3448.8 3526.0 3566.5 3568.3 3573.2 598.9 613.6 616.8 627.8 639.4 569.1 636.7 675.5 687.0 687.4 9188.3 9636.8 10328.7 10352.3 10612.3 599.5 605.6 630.6 699.5 715.7 4230.8 4694.2 4705.2 4810.1 4892.9 102161.0 104521.5 106165.0 107961.0 109701.5 94635.0 96325.5 97114.0 97204.5 98102.5 80316.3 81108.0 81522.6 81740.0 82608.0 8844.9 9153.8 9223.7 9236.2 9444.2 45301.5 46501.3 47312.0 47714.8 47942.8 64341.4 66116.7 72354.3 72417.3 73152.6 11568.3 11601.3 11620.9 12038.9 12401.5 13043.7 13123.0 13259.3 13535.7 13691.5 12557.6 12560.7 12978.9 13402.8 13560.6 12103.3 12133.0 12543.4 12672.8 13045.6 11555.8 12181.0 12184.6 12573.9 12698.7 9772.8 9927.4 10153.3 10288.1 10363.3 9369.2 9492.7 9803.2 10272.6 10999.5 19:02:04 INFO - PROCESS | 4651 | -------- Summary: end -------- 19:02:04 INFO - PROCESS | 4651 | 19:02:05 INFO - TEST-INFO | 4651: exit 0 19:02:05 INFO - TEST-OK | dromaeo_css | took 1118418ms 19:02:05 INFO - TEST-START | kraken 19:02:05 INFO - operating with platform_type : linux_ 19:02:05 INFO - Initialising browser for kraken test... 19:02:05 INFO - TEST-INFO | started process 4958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb24HJA/profile http://localhost:40637/getInfo.html) 19:02:09 INFO - PROCESS | 4958 | __metrics Screen width/height:1600/1200 19:02:09 INFO - PROCESS | 4958 | colorDepth:24 19:02:09 INFO - PROCESS | 4958 | Browser inner width/height: 1024/697 19:02:09 INFO - PROCESS | 4958 | __metrics 19:02:10 INFO - PROCESS | 4958 | 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" 19:02:10 INFO - PROCESS | 4958 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:02:10 INFO - PROCESS | 4958 | console.error: PushService: 19:02:10 INFO - PROCESS | 4958 | stateChangeProcessEnqueue: Error transitioning state 19:02:10 INFO - PROCESS | 4958 | UnknownError 19:02:11 INFO - TEST-INFO | 4958: exit 0 19:02:11 INFO - Browser initialized. 19:02:11 INFO - Running cycle 1/1 for kraken test... 19:02:11 INFO - TEST-INFO | started process 5042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb24HJA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:02:23 INFO - PROCESS | 5042 | RSS: Main: 172253184 19:02:23 INFO - PROCESS | 5042 | 19:02:26 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40637/tests/kraken/driver.html?testName=audio-beat-detection) 19:02:27 INFO - PROCESS | 5042 | RSS: Main: 229335040 19:02:27 INFO - PROCESS | 5042 | 19:02:29 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40637/tests/kraken/driver.html?testName=audio-dft) 19:02:30 INFO - PROCESS | 5042 | RSS: Main: 215584768 19:02:30 INFO - PROCESS | 5042 | 19:02:33 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40637/tests/kraken/driver.html?testName=audio-fft) 19:02:34 INFO - PROCESS | 5042 | RSS: Main: 297156608 19:02:34 INFO - PROCESS | 5042 | 19:02:36 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40637/tests/kraken/driver.html?testName=audio-oscillator) 19:02:36 INFO - PROCESS | 5042 | RSS: Main: 206680064 19:02:36 INFO - PROCESS | 5042 | 19:02:38 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40637/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:02:39 INFO - PROCESS | 5042 | RSS: Main: 211345408 19:02:39 INFO - PROCESS | 5042 | 19:02:42 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40637/tests/kraken/driver.html?testName=imaging-darkroom) 19:02:43 INFO - PROCESS | 5042 | RSS: Main: 247848960 19:02:43 INFO - PROCESS | 5042 | 19:02:46 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40637/tests/kraken/driver.html?testName=imaging-desaturate) 19:02:46 INFO - PROCESS | 5042 | RSS: Main: 247107584 19:02:46 INFO - PROCESS | 5042 | 19:02:49 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40637/tests/kraken/driver.html?testName=json-parse-financial) 19:02:50 INFO - PROCESS | 5042 | RSS: Main: 246710272 19:02:50 INFO - PROCESS | 5042 | 19:02:51 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40637/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:02:52 INFO - PROCESS | 5042 | RSS: Main: 208658432 19:02:52 INFO - PROCESS | 5042 | 19:02:54 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40637/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:02:54 INFO - PROCESS | 5042 | RSS: Main: 216211456 19:02:54 INFO - PROCESS | 5042 | 19:02:56 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40637/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:02:57 INFO - PROCESS | 5042 | RSS: Main: 225972224 19:02:57 INFO - PROCESS | 5042 | 19:02:59 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:03:00 INFO - PROCESS | 5042 | RSS: Main: 228651008 19:03:00 INFO - PROCESS | 5042 | 19:03:03 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:03:04 INFO - PROCESS | 5042 | RSS: Main: 231432192 19:03:04 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | Cycle 1(1): loaded http://localhost:40637/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40637/tests/kraken/driver.html?testName=ai-astar) 19:03:05 INFO - PROCESS | 5042 | RSS: Main: 281939968 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | __start_tp_report 19:03:05 INFO - PROCESS | 5042 | _x_x_mozilla_page_load 19:03:05 INFO - PROCESS | 5042 | _x_x_mozilla_page_load_details 19:03:05 INFO - PROCESS | 5042 | |i|pagename|runs| 19:03:05 INFO - PROCESS | 5042 | |0;ai-astar;105;110;111;110;111;114;111;110;111;109 19:03:05 INFO - PROCESS | 5042 | |1;audio-beat-detection;151;121;122;158;125;122;130;123;161;121 19:03:05 INFO - PROCESS | 5042 | |2;audio-dft;160;160;160;160;160;163;161;162;161;162 19:03:05 INFO - PROCESS | 5042 | |3;audio-fft;76;76;76;111;76;76;76;76;105;75 19:03:05 INFO - PROCESS | 5042 | |4;audio-oscillator;82;83;106;82;83;83;105;83;83;111 19:03:05 INFO - PROCESS | 5042 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;116;117 19:03:05 INFO - PROCESS | 5042 | |6;imaging-darkroom;147;145;146;146;145;147;145;147;146;146 19:03:05 INFO - PROCESS | 5042 | |7;imaging-desaturate;84;84;86;85;86;85;84;84;85;85 19:03:05 INFO - PROCESS | 5042 | |8;json-parse-financial;54;52;52;53;52;55;54;53;53;53 19:03:05 INFO - PROCESS | 5042 | |9;json-stringify-tinderbox;59;60;59;59;60;59;60;59;59;60 19:03:05 INFO - PROCESS | 5042 | |10;stanford-crypto-aes;80;80;80;81;88;83;80;79;79;88 19:03:05 INFO - PROCESS | 5042 | |11;stanford-crypto-ccm;133;132;130;133;146;132;130;143;185;134 19:03:05 INFO - PROCESS | 5042 | |12;stanford-crypto-pbkdf2;167;165;165;163;164;167;165;163;163;164 19:03:05 INFO - PROCESS | 5042 | |13;stanford-crypto-sha256-iterative;66;68;67;66;65;66;64;68;65;65 19:03:05 INFO - PROCESS | 5042 | __end_tp_report 19:03:05 INFO - PROCESS | 5042 | __start_cc_report 19:03:05 INFO - PROCESS | 5042 | _x_x_mozilla_cycle_collect,1677 19:03:05 INFO - PROCESS | 5042 | __end_cc_report 19:03:05 INFO - PROCESS | 5042 | __startTimestamp1477015385962__endTimestamp 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | ------- Summary: start ------- 19:03:05 INFO - PROCESS | 5042 | Number of tests: 14 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.25 (2.0%) stddev-sans-first:1.39 19:03:05 INFO - PROCESS | 5042 | Values: 105.0 110.0 111.0 110.0 111.0 114.0 111.0 110.0 111.0 109.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:127.50 stddev:16.45 (12.9%) stddev-sans-first:16.16 19:03:05 INFO - PROCESS | 5042 | Values: 151.0 121.0 122.0 158.0 125.0 122.0 130.0 123.0 161.0 121.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 19:03:05 INFO - PROCESS | 5042 | Values: 160.0 160.0 160.0 160.0 160.0 163.0 161.0 162.0 161.0 162.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.62 (17.9%) stddev-sans-first:14.26 19:03:05 INFO - PROCESS | 5042 | Values: 76.0 76.0 76.0 111.0 76.0 76.0 76.0 76.0 105.0 75.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:83.00 stddev:11.99 (14.5%) stddev-sans-first:12.36 19:03:05 INFO - PROCESS | 5042 | Values: 82.0 83.0 106.0 82.0 83.0 83.0 105.0 83.0 83.0 111.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:03:05 INFO - PROCESS | 5042 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 19:03:05 INFO - PROCESS | 5042 | Values: 147.0 145.0 146.0 146.0 145.0 147.0 145.0 147.0 146.0 146.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 19:03:05 INFO - PROCESS | 5042 | Values: 84.0 84.0 86.0 85.0 86.0 85.0 84.0 84.0 85.0 85.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:1.00 19:03:05 INFO - PROCESS | 5042 | Values: 54.0 52.0 52.0 53.0 52.0 55.0 54.0 53.0 53.0 53.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 19:03:05 INFO - PROCESS | 5042 | Values: 59.0 60.0 59.0 59.0 60.0 59.0 60.0 59.0 59.0 60.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.50 stddev:3.46 (4.3%) stddev-sans-first:3.61 19:03:05 INFO - PROCESS | 5042 | Values: 80.0 80.0 80.0 81.0 88.0 83.0 80.0 79.0 79.0 88.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:133.50 stddev:16.77 (12.6%) stddev-sans-first:17.61 19:03:05 INFO - PROCESS | 5042 | Values: 133.0 132.0 130.0 133.0 146.0 132.0 130.0 143.0 185.0 134.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:1.51 (0.9%) stddev-sans-first:1.32 19:03:05 INFO - PROCESS | 5042 | Values: 167.0 165.0 165.0 163.0 164.0 167.0 165.0 163.0 163.0 164.0 19:03:05 INFO - PROCESS | 5042 | 19:03:05 INFO - PROCESS | 5042 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.33 (2.0%) stddev-sans-first:1.41 19:03:05 INFO - PROCESS | 5042 | Values: 66.0 68.0 67.0 66.0 65.0 66.0 64.0 68.0 65.0 65.0 19:03:05 INFO - PROCESS | 5042 | -------- Summary: end -------- 19:03:05 INFO - PROCESS | 5042 | 19:03:07 INFO - TEST-INFO | 5042: exit 0 19:03:07 INFO - TEST-OK | kraken | took 61438ms 19:03:07 INFO - SUITE-END | took 1179s 19:03:07 INFO - Completed test suite (00:19:39) 19:03:07 INFO - javascript benchmark 19:03:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3022.0782661288304, 3038.7568994480444, 3050.8779648814048, 3069.693030696932, 3096.860641271144, 5128.640995130338, 5147.330846989886, 5194.662346947446, 5225.137852254378, 5231.319928409302, 5328.786848526054, 5335.226392173142, 5446.509814116729, 5457.072297709389, 5487.2317875497365, 4747.311639812225, 4753.144434001878, 4794.736289504076, 4833.734144622062, 4833.854984350458, 4871.926921096187, 4880.463149053619, 4942.654014219006, 4944.826931057396, 4998.475160108191, 4750.382450281441, 4872.78072486739, 4892.192788189945, 4936.654434189608, 4968.428630707461, 4759.262314341283, 4791.928121078186, 4793.640476964207, 4837.782299796518, 4840.15297322967, 4793.233082706785, 4802.975985120052, 4812.951870481285, 4826.058918510892, 4861.659683822134, 5302.125149350352, 5307.416184219771, 5317.787288508455, 5325.973370133163, 5327.786888524454, 5514.310711161105, 5570.721463926788, 5638.069718496443, 5660.2075709400715, 5700.087985922232, 5772.0, 5779.0, 5779.422057794229, 5795.362510123883, 5847.56143289255, 5375.354957405137, 5378.0, 5379.757910894019, 5381.48875856793, 5385.21914322425, 5620.9437905621235, 5661.943380566224, 5762.078067509178, 5820.621659592113, 5827.096799996008, 5569.582281328917, 5572.164175373645, 5578.442155784389, 5665.2635157430095, 5671.829845104653, 5607.43925607436, 5639.125935480007, 5639.802606908738, 5657.858553536113, 5700.800471983461, 5447.210154527571, 5486.835394938158, 5673.8297851064535, 5686.459786320293, 5687.857803554862, 5600.467955544217, 5650.604457687922, 5652.123920792284, 5670.5463562914865, 5684.317881854204, 4294.89262768427, 4303.397524346594, 4358.411614432074, 4360.629346505582, 4411.426514553087, 3856.2865869814173, 3896.532416110085, 3899.883003509899, 3950.7234493585747, 3976.1053762903693, 5321.574274058066, 5349.063913815066, 5349.491798279158, 5350.0904846176245, 5357.491038351351, 5592.804251851166, 5603.299587551556, 5622.381538030813, 5625.296837895263, 5642.0, 5216.7913283469, 5374.435684253097, 5394.136938089887, 5394.568434525228, 5458.426865179178, 4640.83757068501, 4676.602488788423, 4726.550977657117, 4735.857924262277, 4781.187198176319, 5821.243238378984, 5825.300963884361, 5833.095870140135, 5837.09525023622, 5839.124131380242, 5628.071368224197, 5664.603477756682, 5670.177824215548, 5674.233978412862, 5692.51613612831, 5720.427957204246, 5779.36426993022, 5807.912881306699, 5847.356790753099, 5869.4717475427415, 5574.804881829116, 5576.191452239322, 5582.911332290165, 5593.0, 5647.887042259214, 5614.0, 5657.575681823962, 5690.374058853606, 5705.400932902152, 5742.942570574241, 5469.617126801086, 5501.614886958035, 5502.504774570308, 5560.138178582326, 5569.498745112959, 5544.473275038865, 5553.500184983371, 5557.249771280825, 5559.63862348946, 5562.388137304974, 5495.258140151029, 5504.669719816824, 5507.421720719427, 5510.91733624004, 5513.2005859151, 5521.0853398641575, 5542.251796007487, 5573.832785016456, 5574.414686457863, 5589.413111623221, 5469.753861076181, 5486.533644640251, 5487.643303185439, 5496.038193316073, 5505.091659876076], "value": 5225.180667624167, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2419303291787, 612.2683393344953, 626.2141013028648, 630.3696303696304, 630.8107567729683, 31218.219544511398, 42602.78698606507, 44424.555754442445, 44482.33276500855, 47208.291875621806, 45543.544564554344, 45786.771066144625, 45888.3116753249, 45890.77054614722, 45918.0, 8857.867131993009, 8984.96672882617, 8997.95501022494, 9006.414583052081, 9008.729738107868, 8076.9192308077045, 8355.83288334233, 10486.475676216196, 10741.194410419212, 10742.462876856165, 10991.61529346473, 11064.0595549378, 11070.944645276762, 11073.224874258805, 11073.889261107406, 10733.141348692086, 10770.676879693583, 10795.514201860935, 10802.297850639761, 10874.0, 10586.629467968583, 10637.202209834293, 10644.520996555097, 10674.73313167177, 10678.466076696212, 40722.38916416256, 41254.0, 41344.1731165375, 41365.1726965462, 41492.1701565967, 3437.845296961643, 3463.515107884873, 3567.7680950738377, 3605.6574625410544, 3996.620321069523, 31518.212044698837, 31614.0, 31660.36679266425, 31693.52459713106, 31784.682153178404, 4271.829126834923, 4370.7159034662645, 4495.617872480843, 4556.453225612914, 4566.885827854297, 227314.0, 227425.0, 227627.0, 303273.0, 305240.4737976318, 33161.3367732644, 34482.655173448446, 57288.42711572831, 57678.7116064417, 57722.4227757717, 35909.64090359115, 36028.0, 36046.63953360433, 36160.09599760027, 36261.27477450436, 13318.467261309439, 13431.0, 13441.865581344256, 13450.192988420726, 13485.797713034312, 8590.699325523577, 8747.781305467413, 10456.215783816244, 10465.0, 10480.895191048145, 7715.768526944088, 7759.72840950564, 7891.329237014918, 8209.220124088202, 8262.504249745034, 3195.2650890295363, 3200.759943004284, 3227.3383956288903, 3248.6751324867796, 3291.259466619991, 913.5934509143367, 957.2007373842919, 1000.4097582426404, 1006.4514839412537, 1024.9801447559726, 30561.23596910095, 30758.692413075583, 31014.379712405625, 31179.53230701541, 31525.842370788, 1013.4172850610928, 1018.0226982097122, 1050.7163065972145, 1093.8523299354486, 1145.4330106597122, 16317.67364652724, 16453.83546164547, 16507.0, 16604.169791510376, 16769.72323842853, 153403.0, 154233.2288338551, 154651.0, 154683.0, 154918.0, 56753.0, 57217.713911430175, 57458.42541574614, 57484.71257643685, 57499.13751293734, 1186.4127257007665, 1224.9142560020714, 1226.7730469863282, 1303.6154334471353, 1309.5874799438147, 28036.71963280341, 31132.53301200529, 31737.0, 32805.507917381736, 33111.0, 53254.46745532495, 53805.50264232812, 53878.0, 53932.0, 54013.459865400844, 419616.0, 420982.0, 421107.0, 422638.0, 422663.0, 26223.21330360092, 27024.459510810066, 27368.178954631392, 27526.587101193098, 27930.441391171655, 42246.366304506075, 42670.57329426666, 43097.35353969756, 43284.78357608192, 43589.34615980699, 35988.82005589955, 36546.0, 36633.816830915675, 36862.262754745294, 37027.81486092552, 36271.274574507835, 36325.69505370638, 36550.26899462049, 37261.0, 37492.0, 36196.4044228783, 36551.45172822357, 36741.0, 36880.07799805026, 37459.250814984094, 30834.38331233318, 33784.1553961153, 33925.83037084799, 33937.66062339345, 34033.65966340404, 24869.50260994806, 25263.36841578975, 25718.0, 25787.613185801853, 26092.34769130711], "value": 17711.41694154457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.6825856728945, 364.855881926639, 384.53471299727335, 388.10348095898473, 408.6914379643369, 14194.36125374358, 17824.37614683488, 17859.464216073524, 18405.0, 19571.315003974865, 16768.580785480368, 17727.911360443213, 18125.365612203575, 18469.53826154347, 18496.0, 5050.671706339085, 5291.6031297652635, 5301.0, 5310.893782124355, 5312.335958005249, 3812.046988252937, 4100.056986893016, 5226.5818734501145, 5246.632735708502, 5287.788488460457, 4083.97958010211, 6229.90655140171, 6258.374162583751, 6316.210473690789, 6337.746490140412, 6188.4739797116845, 6236.8440788980415, 6279.560430769848, 6322.39937205967, 6327.683615819214, 5640.379558248589, 5656.547476201894, 5664.291963504562, 5665.405132461115, 5665.971670141664, 21917.780822191733, 22482.77517224823, 22535.211267605555, 23073.884630576908, 23326.0, 2214.446388402899, 2217.623004089309, 2256.808171305441, 2288.2448791898632, 2320.953580928372, 9411.529423528864, 9601.231901447938, 10018.3488073275, 10406.739831504197, 10661.626843060532, 1873.2226126157627, 1930.1700268884374, 1985.2158397432934, 1987.8807271563753, 1993.531520092777, 74324.0, 77785.61107194428, 77910.0, 79534.20465795326, 80806.19193808046, 10703.735360714902, 10705.892941070646, 10729.83905241422, 10936.945315273373, 10973.561057557608, 14857.0, 14982.850171498363, 15028.62428439276, 15130.470433534774, 15139.697206055816, 7143.42852571793, 7301.160366557808, 7458.888116678254, 7573.507721998052, 7615.733449329357, 6991.23096459389, 7008.5094043416475, 7035.788926332219, 7172.246914073947, 7219.169795473587, 4582.175208462509, 4585.312203169485, 4617.191991401492, 4626.306054091913, 4705.788239529229, 1852.2035524724497, 1909.8376637985648, 1948.3473036532637, 1964.145596665455, 1977.5945931084093, 950.5316322425957, 960.3469640644429, 971.7327734872966, 984.675057231112, 997.1922742578535, 17898.284068637367, 18671.626567468575, 18883.62232755337, 19018.0, 19185.32851350196, 933.3186773655269, 934.0566028311455, 943.094629156018, 945.2626950978248, 946.4415994563241, 10249.180065594735, 10284.691459256233, 10607.41659208751, 10718.517666705016, 10730.087942524817, 454670.0, 463544.0, 465405.0, 466498.0, 466806.0, 89769.0, 91746.0, 92033.53983230174, 92329.0, 92833.53583232041, 998.6654470752234, 1070.1278458056815, 1109.8501702270253, 1111.7887601355717, 1114.9665510034713, 16424.343026278813, 16931.492055238363, 17145.742813857552, 17163.91418042902, 17363.565910851823, 37950.62049379581, 39095.6090439092, 39349.0, 41672.79163604163, 41763.7911810439, 52665.47334526606, 55262.17106743321, 56181.0, 56659.15011274752, 57343.71328143332, 6351.237851457855, 7727.459077864721, 7866.0, 8486.40595158333, 8831.116888311117, 11313.604023859125, 12787.744245115231, 13169.53906613264, 13572.457101715821, 13657.38541765603, 10748.89251107479, 11170.664880053611, 11396.715082122682, 11719.941400292944, 12085.214461060355, 10653.840192396965, 11013.339199648046, 11283.153763467937, 11347.148963827582, 11536.884631153582, 11542.13433992437, 11662.70843228926, 11779.0, 11957.820632690691, 12030.578929737418, 7365.226651201547, 7454.366378857858, 8437.325013998743, 8594.742157735278, 8858.734237972614, 10506.422146782, 11156.832647510131, 11278.323300601991, 11485.540578376771, 11776.234544754563], "value": 8917.523897984542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.2604002698451, 1483.1397789282216, 1504.105057490793, 1599.9920000399995, 1757.0775342944953, 7645.464817462773, 8568.186022327876, 8824.161704638049, 8848.380613357067, 9156.8626470603, 8977.102289771019, 9076.591553380098, 9084.727458176249, 9086.591103400346, 9090.318226133033, 2231.933042008738, 2252.718410198725, 2258.841881068326, 2259.2770313499686, 2259.6158653029024, 2211.4581927427803, 2239.2386588559966, 2273.715785526809, 2274.7611500792427, 2275.9886200568976, 2232.1071571371417, 2234.1398561553838, 2236.507968246983, 2237.3735354100877, 2275.112706044644, 2148.355493351988, 2173.3045425463856, 2178.564287142578, 2183.7270341207427, 2184.945376365588, 2130.744310682728, 2133.0721136305756, 2138.8182004529635, 2139.4009677290383, 2140.989295053515, 8763.167499087576, 8907.02022777494, 8933.731988040368, 8936.508492032935, 8936.910630893737, 4954.529319714621, 5088.643794934356, 5089.872753181163, 5156.871078223037, 5161.483851614846, 3110.8690546975395, 3281.8359082045804, 3303.5705358303508, 3366.5791776027995, 3396.541466901986, 1004.8542961270575, 1042.468341146021, 1048.496721573649, 1065.9893401065967, 1069.7913906788178, 12334.074944379117, 12410.069244806675, 12464.065195110403, 12491.437885295183, 12507.249565026128, 4065.1463192729857, 4196.769177695195, 4331.826726930887, 4343.0, 4353.608175264241, 9836.917939026702, 9838.9016109838, 9841.60633574649, 9935.701928942144, 9949.452780097019, 5068.569171620454, 5074.543291103744, 5079.212722028092, 5085.211792172219, 5085.923711144335, 4176.9582304177175, 4194.161167766459, 4644.465886423037, 4792.592629626451, 4824.734639594786, 3560.4481305397703, 3656.177360094011, 3707.1288247261873, 3719.4048952168064, 3724.646158614927, 1040.152275895143, 1069.994650026745, 1079.1205167788228, 1088.7006073329899, 1094.7919895219882, 867.319154463743, 897.9551022448851, 906.9162350990503, 920.9907900921039, 987.782687808681, 5935.970320148372, 5979.970100149471, 6033.7586496540525, 6078.817635470943, 6265.154204182468, 934.6822080492665, 953.8855337359561, 967.4147140979746, 980.1129977370491, 1005.1657124586576, 4024.7987600619854, 4129.29801933666, 4240.681948853849, 4268.843331054932, 4319.935200971988, 11235.325880447199, 11573.652790416301, 11574.826377604175, 11587.0, 11597.420128993517, 11342.262752921033, 11445.54217831294, 11454.541818327174, 11460.828087578526, 11529.192956492965, 7684.577348245788, 8102.675892964333, 8211.34309255258, 8213.589320533949, 8218.63016164274, 6174.8147555573405, 6214.130021797043, 6236.251649801871, 6279.623222606659, 6305.306416294296, 10305.74235644085, 10310.123639490726, 10330.845037324296, 10391.792164156826, 10408.271421000458, 10384.948075259877, 10754.408507531847, 10894.182936279969, 10932.781344373227, 10946.835797463204, 6908.5509441886115, 7115.5730656160795, 7984.84030319402, 8097.716579919675, 8129.75610731679, 7860.174681658344, 8266.628001739817, 8266.917330826614, 8402.621882015446, 8684.04475507681, 7715.92284077152, 7809.0, 7840.686372545034, 8161.469504482189, 8273.83452330962, 7233.132024157135, 7469.514481558681, 7476.289752473506, 7539.811504712426, 7718.459707820623, 7035.401990830836, 7113.715451381887, 7117.8576428470105, 7133.322334378226, 7136.0, 5052.418971818288, 5218.791248350175, 5228.58171346299, 5273.182656688219, 5500.367457742411, 5253.264542964064, 5265.815696450606, 5285.68285902847, 5304.681719096712, 5513.558915286687], "value": 4573.943817888106, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.6966651347733, 329.79223089453643, 332.8302565691498, 335.0, 340.8670618458803, 5303.840884773458, 5352.545033672132, 5365.785368585257, 5371.033214021474, 5378.6503877248, 5067.84796456106, 5132.692038477694, 5195.194594918739, 5255.216244304104, 5352.973235133829, 4136.379543068534, 4146.771927543984, 4165.708400411972, 4174.394712766647, 4184.581541845821, 4110.8972275693195, 4135.565765594614, 4171.165766846628, 4176.310908700061, 4195.433616461769, 3695.7597756145897, 3922.5881282465357, 3985.960140398588, 4114.8148333324925, 4179.707420480552, 4077.5718549552166, 4087.2234275487563, 4091.243120022805, 4099.934017155531, 4102.856400025999, 3614.204874927538, 3617.801020943847, 3628.183658676803, 3631.273745250934, 3635.5092062571744, 5059.848204553869, 5179.715115668637, 5193.948060519422, 5195.740212989335, 5197.298364720752, 4749.7387643679585, 4751.809927602892, 4752.405949256343, 4763.809447622091, 4764.880877978044, 5480.205370221335, 5546.77812887484, 5580.19087232349, 5589.636673616243, 5596.188552659883, 3854.95687285739, 3947.4276229946786, 4001.379786133154, 4011.237864805707, 4018.7294178789184, 5684.488396044335, 5706.0, 5717.885642287131, 5728.799492017801, 5748.540116790688, 4073.246449406869, 4074.4295798587627, 4087.6525495332635, 4087.6729861611, 4144.461220041436, 4062.370332598452, 4142.1301526679135, 4186.497620285524, 4188.204241194163, 4191.664666826647, 4687.554682305244, 4707.8587642370785, 4717.858464246078, 4730.479647238801, 4766.737829419346, 5533.944660553343, 5555.50000499957, 5557.861053473695, 5564.27664403633, 5582.581306402036, 1325.9535916242885, 1332.6468485851258, 1425.6792221750022, 1436.7844823276591, 1437.7771445425976, 907.0747837206145, 935.0789472369711, 940.0, 940.6049459227141, 943.9569275950114, 4777.208546794952, 4781.928271075936, 4800.4479484859685, 4830.6135509159185, 4937.876553086202, 4667.766611669403, 5012.8496145115705, 5051.257316225896, 5051.444341122474, 5079.120725331651, 4731.384919960383, 4757.621189405298, 4771.618270538349, 4777.593904518086, 4807.807687692523, 2681.3028612560875, 2691.6366290550527, 2695.786895896815, 2700.7839372850126, 2707.294404525176, 5172.456867046086, 5423.430539793344, 5904.940950590439, 5993.160957465958, 6006.249218847644, 5863.882722345529, 5875.20684707559, 5884.558658100659, 5892.908017653671, 5898.4101589840675, 5750.30996280449, 5928.496077833346, 5931.881362372642, 5957.761689532457, 5970.194023806817, 5763.538916886723, 5774.855628609318, 5776.7111644418455, 5784.392638772868, 5787.305523337058, 5657.32112146545, 5667.319921609434, 5674.375818659862, 5678.290213723285, 5699.715014249354, 5600.747966341606, 5894.440028197314, 5925.703714814328, 5971.761129554943, 5990.550708696778, 4059.4925634295714, 4074.4499492568125, 4080.5924504542463, 4090.1410703752545, 4096.344584866407, 5729.3984131665575, 5818.185454036523, 5835.008048631658, 5855.180274761452, 5883.676397798162, 5607.523360514402, 5634.183043458757, 5634.211210430625, 5689.0, 5708.315002199763, 5331.5611430627805, 5401.2168235606405, 5473.75368108444, 5583.78932114028, 5587.323802859208, 5548.805791797267, 5570.220169176399, 5593.8321850344555, 5594.13290939905, 5594.524465420485, 5522.696251706195, 5670.319561652628, 5670.688112153706, 5671.546276297804, 5682.5453963681975, 5487.2015272210665, 5487.436080716977, 5500.202470641654, 5504.394516603091, 5554.555635549227], "value": 4192.19264121415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.7005967672607, 775.4881778026504, 803.6222975201653, 805.0661232969754, 835.6323217784178, 15082.849171508295, 16448.095354755485, 16499.75250371244, 16534.090625015648, 16582.66834663306, 14366.138031718105, 14717.264136793172, 14867.0, 14869.92565037176, 15450.61373465664, 778.1051790440996, 807.858624740671, 808.5108509351817, 810.2424233341815, 810.6959890041235, 656.743869890743, 670.2359310386164, 811.2982270336175, 815.3680897304577, 816.302061737215, 830.667732906836, 850.1413572291967, 854.5171977832536, 861.0700443520982, 861.315254372772, 853.7225401744458, 853.8078932240227, 854.0903937306748, 854.162920338066, 854.5171977832536, 501.6739119572307, 511.66230288009734, 626.3923993726079, 626.3923993726079, 626.9090981807612, 13622.250776207306, 14295.213763243017, 14476.782848257284, 14995.100293982396, 15013.774793378108, 14457.493987710379, 14880.479183228643, 15294.694106117815, 15415.92292038544, 15536.378544858193, 11994.820077698841, 12139.939300303531, 12166.087543434278, 12328.938355308255, 13063.34683265833, 3771.0068318954714, 3920.0983773731914, 3944.5069366329208, 3992.201559688074, 3992.740471869319, 77770.0, 78592.0, 78826.6058669703, 78943.68450523945, 79010.60494697547, 11561.132915031407, 11740.295582265091, 11785.587504437304, 12330.691732706755, 12436.626901192978, 22994.540109197722, 23003.079876805074, 23038.193663222042, 23055.423614409774, 23068.4232894179, 8194.0, 8266.751997440086, 8285.50286982771, 8332.250097491255, 8477.788055298666, 4480.6658919118045, 4651.0, 4654.86035418938, 4760.357351757538, 4856.708597484162, 3448.8448019839166, 3526.0479670488826, 3566.518519999767, 3568.286342731464, 3573.1781690211396, 598.850287428143, 613.5919613457002, 616.8057062025538, 627.8116565030473, 639.4277121975806, 569.0525275416385, 636.7102968149574, 675.4596322941627, 686.9828254293583, 687.4397366146575, 9188.26493880488, 9636.75908102303, 10328.741781455374, 10352.327098738559, 10612.257141999986, 599.5323647554915, 605.5851741557047, 630.5838146823074, 699.5383047188831, 715.6600614708076, 4230.830766769356, 4694.201985662446, 4705.155235232777, 4810.086083644096, 4892.877678058077, 102161.0, 104521.47739261255, 106165.0, 107961.0, 109701.45149274362, 94635.0, 96325.51837240769, 97114.03390372804, 97204.51397742965, 98102.5094874521, 80316.33831402821, 81108.0, 81522.59238703769, 81740.0, 82608.0, 8844.867326990228, 9153.775075263038, 9223.677171298972, 9236.214921731727, 9444.197243234403, 45301.546984529734, 46501.3024804635, 47312.0, 47714.80712982203, 47942.76028619835, 64341.35658643354, 66116.66941665261, 72354.27645723686, 72417.27582724106, 73152.63423682848, 11568.305901645928, 11601.303921764722, 11620.941895290469, 12038.939805300917, 12401.503939842305, 13043.673863164831, 13123.031545268286, 13259.270740109387, 13535.729285414434, 13691.452341906212, 12557.560485382968, 12560.685982850502, 12978.870211297766, 13402.798958015443, 13560.59318220455, 12103.33431661267, 12133.0, 12543.372831358212, 12672.809907851206, 13045.608631741063, 11555.768884622092, 12181.0, 12184.634460966185, 12573.93713031429, 12698.746025079261, 9772.755681108029, 9927.40435573868, 10153.340032897839, 10288.12550933179, 10363.274570779973, 9369.203617692572, 9492.667756628485, 9803.171702020963, 10272.589096436059, 10999.505022273857], "value": 7348.813490889118, "unit": "score"}], "name": "dromaeo_css", "value": 6986.583663557045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 111.0, 110.0, 111.0, 114.0, 111.0, 110.0, 111.0, 109.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 122.0, 158.0, 125.0, 122.0, 130.0, 123.0, 161.0, 121.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 163.0, 161.0, 162.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 111.0, 76.0, 76.0, 76.0, 76.0, 105.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 106.0, 82.0, 83.0, 83.0, 105.0, 83.0, 83.0, 111.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 146.0, 146.0, 145.0, 147.0, 145.0, 147.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 85.0, 86.0, 85.0, 84.0, 84.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 53.0, 52.0, 55.0, 54.0, 53.0, 53.0, 53.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 81.0, 88.0, 83.0, 80.0, 79.0, 79.0, 88.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 130.0, 133.0, 146.0, 132.0, 130.0, 143.0, 185.0, 134.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 165.0, 163.0, 164.0, 167.0, 165.0, 163.0, 163.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 65.0, 66.0, 64.0, 68.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1489.1, "alertThreshold": 2.0}]} 19:03:07 INFO - Return code: 0 19:03:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:03:07 INFO - # TBPL SUCCESS # 19:03:07 INFO - Running post-action listener: _resource_record_post_action 19:03:07 INFO - [mozharness: 2016-10-21 02:03:07.260827Z] Finished run-tests step (success) 19:03:07 INFO - Running post-run listener: _resource_record_post_run 19:03:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398741504; Read time: 20; Write time: 434276 19:03:07 INFO - TinderboxPrint: CPU usage
13.1% 19:03:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 19:03:07 INFO - TinderboxPrint: I/O write bytes / time
398,741,504 / 434,276 19:03:07 INFO - TinderboxPrint: CPU idle
8,301.0 (86.9%) 19:03:07 INFO - TinderboxPrint: CPU user
1,199.9 (12.6%) 19:03:07 INFO - TinderboxPrint: Swap in / out
0 / 0 19:03:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110096384; Read time: 0; Write time: 114696 19:03:07 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287690752; Read time: 0; Write time: 319580 19:03:07 INFO - Running post-run listener: _upload_blobber_files 19:03:07 INFO - Blob upload gear active. 19:03:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:03:07 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 19:03:07 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:03:07 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:03:08 INFO - (blobuploader) - INFO - Open directory for files ... 19:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:03:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:09 INFO - (blobuploader) - INFO - Done attempting. 19:03:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:03:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:03:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:09 INFO - (blobuploader) - INFO - Done attempting. 19:03:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:03:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:03:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:13 INFO - (blobuploader) - INFO - Done attempting. 19:03:13 INFO - (blobuploader) - INFO - Iteration through files over. 19:03:13 INFO - Return code: 0 19:03:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:03:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:03:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d68bb02a13565dbf531857b68bdd9501430f42c8aad46d0383c1b68908c2bd7280942fba7d8c62fbaa3a001e746ffd6e52abc12b40a3f2ec049607f743ec3392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bd3a4862a1330619a397ff2b8b93136af4aa1520c9de87d76ede9d787256b841f524ed5904c0187a34a07bfa356ee54b2371f446f0acefe20774839b03af280", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e65ebc003b606c3ac944ac507929629ff6899140f49b2698f5a68450c17f945d2d4bd1691ab791be41d04d4099e92d385fa57996529407a2b1e703c9d830709c"} 19:03:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:03:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:03:13 INFO - Contents: 19:03:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d68bb02a13565dbf531857b68bdd9501430f42c8aad46d0383c1b68908c2bd7280942fba7d8c62fbaa3a001e746ffd6e52abc12b40a3f2ec049607f743ec3392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bd3a4862a1330619a397ff2b8b93136af4aa1520c9de87d76ede9d787256b841f524ed5904c0187a34a07bfa356ee54b2371f446f0acefe20774839b03af280", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e65ebc003b606c3ac944ac507929629ff6899140f49b2698f5a68450c17f945d2d4bd1691ab791be41d04d4099e92d385fa57996529407a2b1e703c9d830709c"} 19:03:13 INFO - Running post-run listener: copy_logs_to_upload_dir 19:03:13 INFO - Copying logs to upload dir... 19:03:13 INFO - mkdir: /builds/slave/test/build/upload/logs 19:03:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.881555 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-20 19:03:13.660129) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 19:03:13.664118) ========= 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=6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479 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/sha512/d68bb02a13565dbf531857b68bdd9501430f42c8aad46d0383c1b68908c2bd7280942fba7d8c62fbaa3a001e746ffd6e52abc12b40a3f2ec049607f743ec3392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bd3a4862a1330619a397ff2b8b93136af4aa1520c9de87d76ede9d787256b841f524ed5904c0187a34a07bfa356ee54b2371f446f0acefe20774839b03af280", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e65ebc003b606c3ac944ac507929629ff6899140f49b2698f5a68450c17f945d2d4bd1691ab791be41d04d4099e92d385fa57996529407a2b1e703c9d830709c"} build_url:https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/Rsb1gsJJTTiYNaRRsYaigg/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/sha512/d68bb02a13565dbf531857b68bdd9501430f42c8aad46d0383c1b68908c2bd7280942fba7d8c62fbaa3a001e746ffd6e52abc12b40a3f2ec049607f743ec3392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bd3a4862a1330619a397ff2b8b93136af4aa1520c9de87d76ede9d787256b841f524ed5904c0187a34a07bfa356ee54b2371f446f0acefe20774839b03af280", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e65ebc003b606c3ac944ac507929629ff6899140f49b2698f5a68450c17f945d2d4bd1691ab791be41d04d4099e92d385fa57996529407a2b1e703c9d830709c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 19:03:13.693781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:03:13.694502) ========= 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=6d15e502d8e29d5d2676d664000001c3-1477014151.337674-444987479 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:03:13.777155) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 19:03:13.777822) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 19:03:13.778405) ========= ========= Total master_lag: 0.18 =========