builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1477479723.82 results: success (0) buildid: 20161026034546 builduid: 50fe45a570c34cf89a427362450008af revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.824190) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.824695) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.825092) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.839699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.840017) ========= 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=52faae308a556c440401f8e5000001e8-1477479724.131930-206509336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-26 04:02:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-10-26 04:02:04 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.064939 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.918785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.919096) ========= 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=52faae308a556c440401f8e5000001e8-1477479724.131930-206509336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017261 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.968313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:03.968693) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --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 f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 --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=52faae308a556c440401f8e5000001e8-1477479724.131930-206509336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-26 04:02:04,985 truncating revision to first 12 chars 2016-10-26 04:02:04,985 Setting DEBUG logging. 2016-10-26 04:02:04,985 attempt 1/10 2016-10-26 04:02:04,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f9f3cc95d728?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-26 04:02:05,296 unpacking tar archive at: fx-team-f9f3cc95d728/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620301 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:04.602533) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:04.602875) ========= script_repo_revision: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:04.603262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:04.603549) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-26 04:02:04.612947) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-26 04:02:04.613223) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=52faae308a556c440401f8e5000001e8-1477479724.131930-206509336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:02:05 INFO - MultiFileLogger online at 20161026 04:02:05 in /builds/slave/test 04:02:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:02:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:02:05 INFO - {'append_to_log': False, 04:02:05 INFO - 'base_work_dir': '/builds/slave/test', 04:02:05 INFO - 'blob_upload_branch': 'Fx-Team', 04:02:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:02:05 INFO - 'branch': 'Fx-Team', 04:02:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:02:05 INFO - 'config_files': ('talos/linux_config.py',), 04:02:05 INFO - 'default_actions': ('clobber', 04:02:05 INFO - 'read-buildbot-config', 04:02:05 INFO - 'download-and-extract', 04:02:05 INFO - 'populate-webroot', 04:02:05 INFO - 'create-virtualenv', 04:02:05 INFO - 'install', 04:02:05 INFO - 'run-tests'), 04:02:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:02:05 INFO - 'download_minidump_stackwalk': True, 04:02:05 INFO - 'download_symbols': 'ondemand', 04:02:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:02:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:02:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:02:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:02:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:02:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:02:05 INFO - 'installer_path': 'installer.exe', 04:02:05 INFO - 'log_level': 'info', 04:02:05 INFO - 'log_name': 'talos', 04:02:05 INFO - 'log_to_console': True, 04:02:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:02:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:02:05 INFO - 'opt_config_files': (), 04:02:05 INFO - 'pip_index': False, 04:02:05 INFO - 'sps_profile': False, 04:02:05 INFO - 'sps_profile_interval': 0, 04:02:05 INFO - 'suite': 'dromaeojs-e10s', 04:02:05 INFO - 'system_bits': '32', 04:02:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:02:05 INFO - 'title': 'talos-linux64-ix-056', 04:02:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:02:05 INFO - 'use_talos_json': True, 04:02:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:02:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:02:05 INFO - 'work_dir': 'build'} 04:02:05 INFO - [mozharness: 2016-10-26 11:02:05.724850Z] Running clobber step. 04:02:05 INFO - Running pre-action listener: _resource_record_pre_action 04:02:05 INFO - Running main action method: clobber 04:02:05 INFO - rmtree: /builds/slave/test/build 04:02:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:02:06 INFO - Running post-action listener: _resource_record_post_action 04:02:06 INFO - [mozharness: 2016-10-26 11:02:06.246825Z] Finished clobber step (success) 04:02:06 INFO - [mozharness: 2016-10-26 11:02:06.246926Z] Running read-buildbot-config step. 04:02:06 INFO - Running pre-action listener: _resource_record_pre_action 04:02:06 INFO - Running main action method: read_buildbot_config 04:02:06 INFO - Using buildbot properties: 04:02:06 INFO - { 04:02:06 INFO - "project": "", 04:02:06 INFO - "product": "firefox", 04:02:06 INFO - "script_repo_revision": "production", 04:02:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:02:06 INFO - "repository": "", 04:02:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:02:06 INFO - "buildid": "20161026034546", 04:02:06 INFO - "stage_platform": "linux64-pgo", 04:02:06 INFO - "basedir": "/builds/slave/test", 04:02:06 INFO - "buildnumber": 870, 04:02:06 INFO - "platform": "ubuntu64_hw", 04:02:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:02:06 INFO - "slavebuilddir": "test", 04:02:06 INFO - "branch": "fx-team", 04:02:06 INFO - "revision": "f9f3cc95d7282f1fd83f66dd74acbcdbfe821915", 04:02:06 INFO - "slavename": "talos-linux64-ix-056", 04:02:06 INFO - "builduid": "50fe45a570c34cf89a427362450008af", 04:02:06 INFO - "repo_path": "integration/fx-team" 04:02:06 INFO - } 04:02:06 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:02:06 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 04:02:06 INFO - Running post-action listener: _resource_record_post_action 04:02:06 INFO - [mozharness: 2016-10-26 11:02:06.249373Z] Finished read-buildbot-config step (success) 04:02:06 INFO - [mozharness: 2016-10-26 11:02:06.249460Z] Running download-and-extract step. 04:02:06 INFO - Running pre-action listener: _resource_record_pre_action 04:02:06 INFO - Running main action method: download_and_extract 04:02:06 INFO - mkdir: /builds/slave/test/build/tests 04:02:06 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')]} 04:02:06 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:02:06 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/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 04:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/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 04:02:06 INFO - Downloaded 1361 bytes. 04:02:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:02:06 INFO - Using the following test package requirements: 04:02:06 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:06 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:02:06 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:02:06 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:06 INFO - u'jsshell-linux-x86_64.zip'], 04:02:06 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:02:06 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:06 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:02:06 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:02:06 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:02:06 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:06 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:02:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:02:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:02:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:02:06 INFO - Http code: 200 04:02:06 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 04:02:06 INFO - x-amz-cf-id: VoVgPm-Lbdz-C2QYjrd_SrFOlx3tnlP3gRgkZXeUpMH_zOKBN2zrfA== 04:02:06 INFO - x-amz-replication-status: COMPLETED 04:02:06 INFO - x-amz-version-id: 5F50Omyga4paf3Kxpfjh2dVOZzd.xUvz 04:02:06 INFO - Expected file size: 22050788 04:02:06 INFO - Obtained file size: 22050788 04:02:10 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 04:02:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:02:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:10 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:02:10 INFO - Http code: 200 04:02:10 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 04:02:10 INFO - x-amz-cf-id: VgLb-erksr4AD1tk8PWPKGOh__SNmd7LowemjTciSQW4j3Oy9I9AwA== 04:02:10 INFO - x-amz-replication-status: COMPLETED 04:02:10 INFO - x-amz-version-id: 5F50Omyga4paf3Kxpfjh2dVOZzd.xUvz 04:02:10 INFO - Expected file size: 22050788 04:02:10 INFO - Obtained file size: 22050788 04:02:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:02:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:02:15 INFO - Http code: 200 04:02:15 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 04:02:15 INFO - x-amz-cf-id: QtMvopcL4jNatLUQyCwNnoWU9PPlKmjQdyX46H4lsAerowT2igAknQ== 04:02:15 INFO - x-amz-replication-status: COMPLETED 04:02:15 INFO - x-amz-version-id: tCB0klDszGR1xGb7m6e79MfbFA.4o3ec 04:02:15 INFO - Expected file size: 14409028 04:02:15 INFO - Obtained file size: 14409028 04:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:15 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:02:15 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/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 04:02:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/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 04:02:16 INFO - Downloaded 59470048 bytes. 04:02:16 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:02:16 INFO - mkdir: /builds/slave/test/properties 04:02:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:02:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:02:16 INFO - Contents: 04:02:16 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:02:16 INFO - Running post-action listener: _resource_record_post_action 04:02:16 INFO - Running post-action listener: set_extra_try_arguments 04:02:16 INFO - [mozharness: 2016-10-26 11:02:16.866964Z] Finished download-and-extract step (success) 04:02:16 INFO - [mozharness: 2016-10-26 11:02:16.867195Z] Running populate-webroot step. 04:02:16 INFO - Running pre-action listener: _resource_record_pre_action 04:02:16 INFO - Running main action method: populate_webroot 04:02:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:02:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:02:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:02:16 INFO - '--tppagecycles', 04:02:16 INFO - '7'], 04:02:16 INFO - 'tests': ['tsvgm']}}, 04:02:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:02:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:02:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:02:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:02:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:16 INFO - 'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:16 INFO - 'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['damp', 'tps']}, 04:02:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:16 INFO - 'tests': ['damp', 'tps']}, 04:02:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['dromaeo_dom']}, 04:02:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:02:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['basic_compositor_video']}, 04:02:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:02:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['a11yr', 04:02:16 INFO - 'ts_paint', 04:02:16 INFO - 'tpaint', 04:02:16 INFO - 'sessionrestore', 04:02:16 INFO - 'sessionrestore_no_auto_restore', 04:02:16 INFO - 'tabpaint']}, 04:02:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:02:16 INFO - 'ts_paint', 04:02:16 INFO - 'tpaint', 04:02:16 INFO - 'sessionrestore', 04:02:16 INFO - 'sessionrestore_no_auto_restore', 04:02:16 INFO - 'tabpaint']}, 04:02:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:02:16 INFO - 'ts_paint', 04:02:16 INFO - 'tpaint', 04:02:16 INFO - 'sessionrestore', 04:02:16 INFO - 'sessionrestore_no_auto_restore', 04:02:16 INFO - 'tabpaint']}, 04:02:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:02:16 INFO - 'ts_paint', 04:02:16 INFO - 'tpaint', 04:02:16 INFO - 'sessionrestore', 04:02:16 INFO - 'sessionrestore_no_auto_restore', 04:02:16 INFO - 'tabpaint']}, 04:02:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['a11yr', 04:02:16 INFO - 'ts_paint', 04:02:16 INFO - 'tpaint', 04:02:16 INFO - 'sessionrestore', 04:02:16 INFO - 'sessionrestore_no_auto_restore', 04:02:16 INFO - 'tabpaint']}, 04:02:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['a11yr', 04:02:16 INFO - 'ts_paint', 04:02:16 INFO - 'tpaint', 04:02:16 INFO - 'sessionrestore', 04:02:16 INFO - 'sessionrestore_no_auto_restore', 04:02:16 INFO - 'tabpaint']}, 04:02:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['tsvgx', 04:02:16 INFO - 'tsvgr_opacity', 04:02:16 INFO - 'tart', 04:02:16 INFO - 'tscrollx', 04:02:16 INFO - 'cart']}, 04:02:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:02:16 INFO - 'tsvgr_opacity', 04:02:16 INFO - 'tart', 04:02:16 INFO - 'tscrollx', 04:02:16 INFO - 'cart']}, 04:02:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:16 INFO - 'talos_options': ['--disable-e10s'], 04:02:16 INFO - 'tests': ['tp5o']}, 04:02:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:16 INFO - 'tests': ['tp5o']}, 04:02:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:16 INFO - 'talos_options': ['--disable-e10s', 04:02:16 INFO - '--xperf_path', 04:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:16 INFO - 'tests': ['tp5n']}, 04:02:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:16 INFO - 'talos_options': ['--xperf_path', 04:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:16 INFO - 'tests': ['tp5n']}}, 04:02:16 INFO - 'talos.zip': {'path': '', 04:02:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:02:16 INFO - Running post-action listener: _resource_record_post_action 04:02:16 INFO - [mozharness: 2016-10-26 11:02:16.889028Z] Finished populate-webroot step (success) 04:02:16 INFO - [mozharness: 2016-10-26 11:02:16.889115Z] Running create-virtualenv step. 04:02:16 INFO - Running pre-action listener: _resource_record_pre_action 04:02:16 INFO - Running main action method: create_virtualenv 04:02:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:02:16 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 04:02:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:02:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:02:16 INFO - Using real prefix '/usr' 04:02:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:02:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:02:19 INFO - Installing pip.................done. 04:02:19 INFO - Return code: 0 04:02:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:02:19 INFO - Reading from file tmpfile_stdout 04:02:19 INFO - Output received: 04:02:19 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) 04:02:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:02:19 INFO - Using env: {'DISPLAY': ':0', 04:02:19 INFO - 'HOME': '/home/cltbld', 04:02:19 INFO - 'LANG': 'en_US.UTF-8', 04:02:19 INFO - 'LANGUAGE': 'en_US:en', 04:02:19 INFO - 'LOGNAME': 'cltbld', 04:02:19 INFO - 'MAIL': '/var/mail/cltbld', 04:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:19 INFO - 'MOZ_NO_REMOTE': '1', 04:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:19 INFO - 'NO_EM_RESTART': '1', 04:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:19 INFO - 'PWD': '/builds/slave/test', 04:02:19 INFO - 'SHELL': '/bin/bash', 04:02:19 INFO - 'SHLVL': '1', 04:02:19 INFO - 'TERM': 'linux', 04:02:19 INFO - 'TMOUT': '86400', 04:02:19 INFO - 'USER': 'cltbld', 04:02:19 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:19 INFO - '_': '/tools/buildbot/bin/python'} 04:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:19 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 04:02:19 INFO - Cleaning up... 04:02:19 INFO - Return code: 0 04:02:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:02:19 INFO - Using env: {'DISPLAY': ':0', 04:02:19 INFO - 'HOME': '/home/cltbld', 04:02:19 INFO - 'LANG': 'en_US.UTF-8', 04:02:19 INFO - 'LANGUAGE': 'en_US:en', 04:02:19 INFO - 'LOGNAME': 'cltbld', 04:02:19 INFO - 'MAIL': '/var/mail/cltbld', 04:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:19 INFO - 'MOZ_NO_REMOTE': '1', 04:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:19 INFO - 'NO_EM_RESTART': '1', 04:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:19 INFO - 'PWD': '/builds/slave/test', 04:02:19 INFO - 'SHELL': '/bin/bash', 04:02:19 INFO - 'SHLVL': '1', 04:02:19 INFO - 'TERM': 'linux', 04:02:19 INFO - 'TMOUT': '86400', 04:02:19 INFO - 'USER': 'cltbld', 04:02:19 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:19 INFO - '_': '/tools/buildbot/bin/python'} 04:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:20 INFO - Downloading/unpacking psutil>=3.1.1 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:20 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 04:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:22 INFO - Installing collected packages: psutil 04:02:22 INFO - Running setup.py install for psutil 04:02:22 INFO - building 'psutil._psutil_linux' extension 04:02:22 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 04:02:22 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 04:02:22 INFO - building 'psutil._psutil_posix' extension 04:02:22 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 04:02:22 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 04:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:22 INFO - Successfully installed psutil 04:02:22 INFO - Cleaning up... 04:02:22 INFO - Return code: 0 04:02:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:02:22 INFO - Using env: {'DISPLAY': ':0', 04:02:22 INFO - 'HOME': '/home/cltbld', 04:02:22 INFO - 'LANG': 'en_US.UTF-8', 04:02:22 INFO - 'LANGUAGE': 'en_US:en', 04:02:22 INFO - 'LOGNAME': 'cltbld', 04:02:22 INFO - 'MAIL': '/var/mail/cltbld', 04:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:22 INFO - 'MOZ_NO_REMOTE': '1', 04:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:22 INFO - 'NO_EM_RESTART': '1', 04:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:22 INFO - 'PWD': '/builds/slave/test', 04:02:22 INFO - 'SHELL': '/bin/bash', 04:02:22 INFO - 'SHLVL': '1', 04:02:22 INFO - 'TERM': 'linux', 04:02:22 INFO - 'TMOUT': '86400', 04:02:22 INFO - 'USER': 'cltbld', 04:02:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:22 INFO - '_': '/tools/buildbot/bin/python'} 04:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:02:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:02:24 INFO - Installing collected packages: mozsystemmonitor 04:02:24 INFO - Running setup.py install for mozsystemmonitor 04:02:25 INFO - Successfully installed mozsystemmonitor 04:02:25 INFO - Cleaning up... 04:02:25 INFO - Return code: 0 04:02:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:25 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 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:25 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 04:02:25 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 04:02:25 INFO - Using env: {'DISPLAY': ':0', 04:02:25 INFO - 'HOME': '/home/cltbld', 04:02:25 INFO - 'LANG': 'en_US.UTF-8', 04:02:25 INFO - 'LANGUAGE': 'en_US:en', 04:02:25 INFO - 'LOGNAME': 'cltbld', 04:02:25 INFO - 'MAIL': '/var/mail/cltbld', 04:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:25 INFO - 'MOZ_NO_REMOTE': '1', 04:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:25 INFO - 'NO_EM_RESTART': '1', 04:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:25 INFO - 'PWD': '/builds/slave/test', 04:02:25 INFO - 'SHELL': '/bin/bash', 04:02:25 INFO - 'SHLVL': '1', 04:02:25 INFO - 'TERM': 'linux', 04:02:25 INFO - 'TMOUT': '86400', 04:02:25 INFO - 'USER': 'cltbld', 04:02:25 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:25 INFO - '_': '/tools/buildbot/bin/python'} 04:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:02:25 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 04:02:25 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 04:02:25 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 04:02:25 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 04:02:25 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 04:02:25 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 04:02:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:02:27 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 04:02:27 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 04:02:27 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 04:02:27 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 04:02:27 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 04:02:27 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 04:02:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:27 INFO - warning: no files found matching '*.txt' 04:02:27 INFO - no previously-included directories found matching 'build' 04:02:27 INFO - no previously-included directories found matching 'dist' 04:02:27 INFO - no previously-included directories found matching '.git*' 04:02:27 INFO - Installing collected packages: jsonschema, functools32 04:02:27 INFO - Running setup.py install for functools32 04:02:27 INFO - warning: no files found matching '*.txt' 04:02:27 INFO - no previously-included directories found matching 'build' 04:02:27 INFO - no previously-included directories found matching 'dist' 04:02:27 INFO - no previously-included directories found matching '.git*' 04:02:27 INFO - Successfully installed jsonschema functools32 04:02:27 INFO - Cleaning up... 04:02:27 INFO - Return code: 0 04:02:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:02:27 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')]} 04:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:27 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')]} 04:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:27 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 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:27 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 04:02:27 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 04:02:27 INFO - Using env: {'DISPLAY': ':0', 04:02:27 INFO - 'HOME': '/home/cltbld', 04:02:27 INFO - 'LANG': 'en_US.UTF-8', 04:02:27 INFO - 'LANGUAGE': 'en_US:en', 04:02:27 INFO - 'LOGNAME': 'cltbld', 04:02:27 INFO - 'MAIL': '/var/mail/cltbld', 04:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:27 INFO - 'MOZ_NO_REMOTE': '1', 04:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:27 INFO - 'NO_EM_RESTART': '1', 04:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:27 INFO - 'PWD': '/builds/slave/test', 04:02:27 INFO - 'SHELL': '/bin/bash', 04:02:27 INFO - 'SHLVL': '1', 04:02:27 INFO - 'TERM': 'linux', 04:02:27 INFO - 'TMOUT': '86400', 04:02:27 INFO - 'USER': 'cltbld', 04:02:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:27 INFO - '_': '/tools/buildbot/bin/python'} 04:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:02:27 INFO - Cleaning up... 04:02:27 INFO - Return code: 0 04:02:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02:27 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')]} 04:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:27 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')]} 04:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:27 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 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:27 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 04:02:27 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 04:02:27 INFO - Using env: {'DISPLAY': ':0', 04:02:27 INFO - 'HOME': '/home/cltbld', 04:02:27 INFO - 'LANG': 'en_US.UTF-8', 04:02:27 INFO - 'LANGUAGE': 'en_US:en', 04:02:27 INFO - 'LOGNAME': 'cltbld', 04:02:27 INFO - 'MAIL': '/var/mail/cltbld', 04:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:27 INFO - 'MOZ_NO_REMOTE': '1', 04:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:27 INFO - 'NO_EM_RESTART': '1', 04:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:27 INFO - 'PWD': '/builds/slave/test', 04:02:27 INFO - 'SHELL': '/bin/bash', 04:02:27 INFO - 'SHLVL': '1', 04:02:27 INFO - 'TERM': 'linux', 04:02:27 INFO - 'TMOUT': '86400', 04:02:27 INFO - 'USER': 'cltbld', 04:02:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:27 INFO - '_': '/tools/buildbot/bin/python'} 04:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:28 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:28 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 04:02:28 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 04:02:28 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 04:02:28 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 04:02:28 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 04:02:28 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 04:02:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:02:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:02:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:30 INFO - Downloading docopt-0.6.1.tar.gz 04:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:02:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:02:30 INFO - Running setup.py install for blobuploader 04:02:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:02:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:02:30 INFO - Running setup.py install for requests 04:02:31 INFO - Running setup.py install for docopt 04:02:31 INFO - Successfully installed blobuploader requests docopt 04:02:31 INFO - Cleaning up... 04:02:31 INFO - Return code: 0 04:02:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:31 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')]} 04:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:31 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')]} 04:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:31 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 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:31 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 04:02:31 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 04:02:31 INFO - Using env: {'DISPLAY': ':0', 04:02:31 INFO - 'HOME': '/home/cltbld', 04:02:31 INFO - 'LANG': 'en_US.UTF-8', 04:02:31 INFO - 'LANGUAGE': 'en_US:en', 04:02:31 INFO - 'LOGNAME': 'cltbld', 04:02:31 INFO - 'MAIL': '/var/mail/cltbld', 04:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:31 INFO - 'MOZ_NO_REMOTE': '1', 04:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:31 INFO - 'NO_EM_RESTART': '1', 04:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:31 INFO - 'PWD': '/builds/slave/test', 04:02:31 INFO - 'SHELL': '/bin/bash', 04:02:31 INFO - 'SHLVL': '1', 04:02:31 INFO - 'TERM': 'linux', 04:02:31 INFO - 'TMOUT': '86400', 04:02:31 INFO - 'USER': 'cltbld', 04:02:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:31 INFO - '_': '/tools/buildbot/bin/python'} 04:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:31 INFO - Running setup.py (path:/tmp/pip-YNPMs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:31 INFO - Running setup.py (path:/tmp/pip-1cWhjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:31 INFO - Running setup.py (path:/tmp/pip-aeMNbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:31 INFO - Running setup.py (path:/tmp/pip-1VzaxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:31 INFO - Running setup.py (path:/tmp/pip-b2s_yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:32 INFO - Running setup.py (path:/tmp/pip-XqGj2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:32 INFO - Running setup.py (path:/tmp/pip-cWPwSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:32 INFO - Running setup.py (path:/tmp/pip-yJyYCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:32 INFO - Running setup.py (path:/tmp/pip-HMLU6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:32 INFO - Running setup.py (path:/tmp/pip-4ZSe0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:32 INFO - Running setup.py (path:/tmp/pip-Hf9lOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:32 INFO - Running setup.py (path:/tmp/pip-2a6paj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:32 INFO - Running setup.py (path:/tmp/pip-kFdty3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:32 INFO - Running setup.py (path:/tmp/pip-pSf6od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:32 INFO - Running setup.py (path:/tmp/pip-Razfn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:32 INFO - Running setup.py (path:/tmp/pip-FgcUMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:32 INFO - Running setup.py (path:/tmp/pip-i3Awrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:02:32 INFO - Running setup.py install for manifestparser 04:02:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Running setup.py install for mozcrash 04:02:33 INFO - Running setup.py install for mozdebug 04:02:33 INFO - Running setup.py install for mozdevice 04:02:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Running setup.py install for mozfile 04:02:33 INFO - Running setup.py install for mozhttpd 04:02:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Running setup.py install for mozinfo 04:02:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Running setup.py install for mozInstall 04:02:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:02:33 INFO - Running setup.py install for mozleak 04:02:33 INFO - Running setup.py install for mozlog 04:02:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:02:34 INFO - Running setup.py install for moznetwork 04:02:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:02:34 INFO - Running setup.py install for mozprocess 04:02:34 INFO - Running setup.py install for mozprofile 04:02:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:02:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:02:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:02:34 INFO - Running setup.py install for mozrunner 04:02:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:02:34 INFO - Running setup.py install for mozscreenshot 04:02:34 INFO - Running setup.py install for moztest 04:02:34 INFO - Running setup.py install for mozversion 04:02:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:02:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:02:34 INFO - Cleaning up... 04:02:34 INFO - Return code: 0 04:02:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:34 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 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:34 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 04:02:34 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 04:02:34 INFO - Using env: {'DISPLAY': ':0', 04:02:34 INFO - 'HOME': '/home/cltbld', 04:02:34 INFO - 'LANG': 'en_US.UTF-8', 04:02:34 INFO - 'LANGUAGE': 'en_US:en', 04:02:34 INFO - 'LOGNAME': 'cltbld', 04:02:34 INFO - 'MAIL': '/var/mail/cltbld', 04:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:34 INFO - 'MOZ_NO_REMOTE': '1', 04:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:34 INFO - 'NO_EM_RESTART': '1', 04:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:34 INFO - 'PWD': '/builds/slave/test', 04:02:34 INFO - 'SHELL': '/bin/bash', 04:02:34 INFO - 'SHLVL': '1', 04:02:34 INFO - 'TERM': 'linux', 04:02:34 INFO - 'TMOUT': '86400', 04:02:34 INFO - 'USER': 'cltbld', 04:02:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:34 INFO - '_': '/tools/buildbot/bin/python'} 04:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:02:35 INFO - Running setup.py (path:/tmp/pip-_MztaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:02:35 INFO - Running setup.py (path:/tmp/pip-4gQkeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:02:35 INFO - Running setup.py (path:/tmp/pip-Qycg84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:02:35 INFO - Running setup.py (path:/tmp/pip-8I5pGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:02:35 INFO - Running setup.py (path:/tmp/pip-9cyzVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:02:35 INFO - Running setup.py (path:/tmp/pip-w2nJ22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:02:35 INFO - Running setup.py (path:/tmp/pip-urf_Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:02:35 INFO - Running setup.py (path:/tmp/pip-XGT5yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:02:35 INFO - Running setup.py (path:/tmp/pip-sq0cn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:02:35 INFO - Running setup.py (path:/tmp/pip-Bsj42N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:02:35 INFO - Running setup.py (path:/tmp/pip-qPZTLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:02:35 INFO - Running setup.py (path:/tmp/pip-MM_HPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:02:35 INFO - Running setup.py (path:/tmp/pip-KW66lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:02:35 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)) 04:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:02:35 INFO - Running setup.py (path:/tmp/pip-uhyD6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:02:36 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)) 04:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:36 INFO - Running setup.py (path:/tmp/pip-M1b_SB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:02:36 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)) 04:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:02:36 INFO - Running setup.py (path:/tmp/pip-kJ4c_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:02:36 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)) 04:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:02:36 INFO - Running setup.py (path:/tmp/pip-4wIPS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 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)) 04:02:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:02:36 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 04:02:36 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 04:02:36 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 04:02:36 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 04:02:36 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 04:02:36 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 04:02:38 INFO - Downloading blessings-1.6.tar.gz 04:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:02:38 INFO - Installing collected packages: blessings 04:02:38 INFO - Running setup.py install for blessings 04:02:38 INFO - Successfully installed blessings 04:02:38 INFO - Cleaning up... 04:02:38 INFO - Return code: 0 04:02:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:38 INFO - Reading from file tmpfile_stdout 04:02:38 INFO - Current package versions: 04:02:38 INFO - argparse == 1.2.1 04:02:38 INFO - blessings == 1.6 04:02:38 INFO - blobuploader == 1.2.4 04:02:38 INFO - docopt == 0.6.1 04:02:38 INFO - functools32 == 3.2.3-2 04:02:38 INFO - jsonschema == 2.5.1 04:02:38 INFO - manifestparser == 1.1 04:02:38 INFO - mozInstall == 1.12 04:02:38 INFO - mozcrash == 0.17 04:02:38 INFO - mozdebug == 0.1 04:02:38 INFO - mozdevice == 0.48 04:02:38 INFO - mozfile == 1.2 04:02:38 INFO - mozhttpd == 0.7 04:02:38 INFO - mozinfo == 0.9 04:02:38 INFO - mozleak == 0.1 04:02:38 INFO - mozlog == 3.4 04:02:38 INFO - moznetwork == 0.27 04:02:38 INFO - mozprocess == 0.23 04:02:38 INFO - mozprofile == 0.28 04:02:38 INFO - mozrunner == 6.12 04:02:38 INFO - mozscreenshot == 0.1 04:02:38 INFO - mozsystemmonitor == 0.3 04:02:38 INFO - moztest == 0.7 04:02:38 INFO - mozversion == 1.4 04:02:38 INFO - psutil == 3.1.1 04:02:38 INFO - requests == 1.2.3 04:02:38 INFO - wsgiref == 0.1.2 04:02:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:02:38 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')]} 04:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:38 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')]} 04:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:38 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 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:38 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 04:02:38 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 04:02:38 INFO - Using env: {'DISPLAY': ':0', 04:02:38 INFO - 'HOME': '/home/cltbld', 04:02:38 INFO - 'LANG': 'en_US.UTF-8', 04:02:38 INFO - 'LANGUAGE': 'en_US:en', 04:02:38 INFO - 'LOGNAME': 'cltbld', 04:02:38 INFO - 'MAIL': '/var/mail/cltbld', 04:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:38 INFO - 'MOZ_NO_REMOTE': '1', 04:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:38 INFO - 'NO_EM_RESTART': '1', 04:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:38 INFO - 'PWD': '/builds/slave/test', 04:02:38 INFO - 'SHELL': '/bin/bash', 04:02:38 INFO - 'SHLVL': '1', 04:02:38 INFO - 'TERM': 'linux', 04:02:38 INFO - 'TMOUT': '86400', 04:02:38 INFO - 'USER': 'cltbld', 04:02:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:38 INFO - '_': '/tools/buildbot/bin/python'} 04:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 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)) 04:02:38 INFO - Cleaning up... 04:02:38 INFO - Return code: 0 04:02:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:02:38 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')]} 04:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:38 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')]} 04:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:38 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 0x7f24dcbb2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xde18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, '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': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', '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 04:02:38 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 04:02:38 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 04:02:38 INFO - Using env: {'DISPLAY': ':0', 04:02:38 INFO - 'HOME': '/home/cltbld', 04:02:38 INFO - 'LANG': 'en_US.UTF-8', 04:02:38 INFO - 'LANGUAGE': 'en_US:en', 04:02:38 INFO - 'LOGNAME': 'cltbld', 04:02:38 INFO - 'MAIL': '/var/mail/cltbld', 04:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:38 INFO - 'MOZ_NO_REMOTE': '1', 04:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:38 INFO - 'NO_EM_RESTART': '1', 04:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:38 INFO - 'PWD': '/builds/slave/test', 04:02:38 INFO - 'SHELL': '/bin/bash', 04:02:38 INFO - 'SHLVL': '1', 04:02:38 INFO - 'TERM': 'linux', 04:02:38 INFO - 'TMOUT': '86400', 04:02:38 INFO - 'USER': 'cltbld', 04:02:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:38 INFO - '_': '/tools/buildbot/bin/python'} 04:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:02:39 INFO - Cleaning up... 04:02:39 INFO - Return code: 0 04:02:39 INFO - Running post-action listener: _resource_record_post_action 04:02:39 INFO - Running post-action listener: _start_resource_monitoring 04:02:39 INFO - Starting resource monitoring. 04:02:39 INFO - [mozharness: 2016-10-26 11:02:39.130565Z] Finished create-virtualenv step (success) 04:02:39 INFO - [mozharness: 2016-10-26 11:02:39.131024Z] Running install step. 04:02:39 INFO - Running pre-action listener: _resource_record_pre_action 04:02:39 INFO - Running main action method: install 04:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:02:39 INFO - Reading from file tmpfile_stdout 04:02:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:02:39 INFO - Reading from file tmpfile_stdout 04:02:39 INFO - Output received: 04:02:39 INFO - Usage: mozinstall [options] installer 04:02:39 INFO - Options: 04:02:39 INFO - -h, --help show this help message and exit 04:02:39 INFO - -d DEST, --destination=DEST 04:02:39 INFO - Directory to install application into. [default: 04:02:39 INFO - "/builds/slave/test"] 04:02:39 INFO - --app=APP Application being installed. [default: firefox] 04:02:39 INFO - mkdir: /builds/slave/test/build/application 04:02:39 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'] 04:02:39 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 04:02:56 INFO - Reading from file tmpfile_stdout 04:02:56 INFO - Output received: 04:02:56 INFO - /builds/slave/test/build/application/firefox/firefox 04:02:56 INFO - Running post-action listener: _resource_record_post_action 04:02:56 INFO - [mozharness: 2016-10-26 11:02:56.350613Z] Finished install step (success) 04:02:56 INFO - [mozharness: 2016-10-26 11:02:56.350886Z] Running run-tests step. 04:02:56 INFO - Running pre-action listener: _resource_record_pre_action 04:02:56 INFO - Running main action method: run_tests 04:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:02:56 INFO - Python 2.7.3 04:02:56 INFO - Return code: 0 04:02:56 INFO - grabbing minidump binary from tooltool 04:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:02:56 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 0xeab930>, '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 0xeac830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xeaccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:02:56 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 04:02:56 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 04:02:56 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 04:02:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:02:56 INFO - Return code: 0 04:02:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:02:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:02:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:02:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:02:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:02:56 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:02:56 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:02:56 INFO - Using env: {'DISPLAY': ':0', 04:02:56 INFO - 'HOME': '/home/cltbld', 04:02:56 INFO - 'LANG': 'en_US.UTF-8', 04:02:56 INFO - 'LANGUAGE': 'en_US:en', 04:02:56 INFO - 'LOGNAME': 'cltbld', 04:02:56 INFO - 'MAIL': '/var/mail/cltbld', 04:02:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:02:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:56 INFO - 'MOZ_NO_REMOTE': '1', 04:02:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:56 INFO - 'NO_EM_RESTART': '1', 04:02:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:56 INFO - 'PWD': '/builds/slave/test', 04:02:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:02:56 INFO - 'SHELL': '/bin/bash', 04:02:56 INFO - 'SHLVL': '1', 04:02:56 INFO - 'TERM': 'linux', 04:02:56 INFO - 'TMOUT': '86400', 04:02:56 INFO - 'USER': 'cltbld', 04:02:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1477479724.131930-206509336', 04:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:56 INFO - '_': '/tools/buildbot/bin/python'} 04:02:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:02:56 INFO - mozversion application_buildid: 20161026003021 04:02:56 INFO - mozversion application_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 04:02:56 INFO - mozversion application_display_name: Nightly 04:02:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:02:56 INFO - mozversion application_name: Firefox 04:02:56 INFO - mozversion application_remotingname: firefox 04:02:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:02:56 INFO - mozversion application_vendor: Mozilla 04:02:56 INFO - mozversion application_version: 52.0a1 04:02:56 INFO - mozversion platform_buildid: 20161026003021 04:02:56 INFO - mozversion platform_changeset: f9f3cc95d7282f1fd83f66dd74acbcdbfe821915 04:02:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:02:56 INFO - mozversion platform_version: 52.0a1 04:02:56 INFO - using testdate: 1477479776 04:02:56 INFO - actual date: 1477479776 04:02:56 INFO - starting webserver on 'localhost:44091' 04:02:56 INFO - SUITE-START | Running 2 tests 04:02:56 INFO - TEST-START | dromaeo_css 04:02:56 INFO - operating with platform_type : linux_ 04:02:56 INFO - Initialising browser for dromaeo_css test... 04:02:56 INFO - TEST-INFO | started process 13907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp419D8/profile http://localhost:44091/getInfo.html) 04:03:01 INFO - PROCESS | 13907 | __metrics Screen width/height:1600/1200 04:03:01 INFO - PROCESS | 13907 | colorDepth:24 04:03:01 INFO - PROCESS | 13907 | Browser inner width/height: 1024/697 04:03:01 INFO - PROCESS | 13907 | __metrics 04:03:02 ERROR - PROCESS | 13907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 04:03:03 INFO - TEST-INFO | 13907: exit 0 04:03:03 INFO - Browser initialized. 04:03:03 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:03 INFO - TEST-INFO | started process 14031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp419D8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:15 INFO - PROCESS | 14031 | RSS: Main: 182763520 04:03:15 INFO - PROCESS | 14031 | 04:04:04 INFO - PROCESS | 14031 | 1477479844899 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] 04:06:16 INFO - PROCESS | 14031 | Cycle 1(1): loaded http://localhost:44091/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44091/tests/dromaeo/cssquery-ext.html) 04:06:18 INFO - PROCESS | 14031 | RSS: Main: 196308992 04:06:18 INFO - PROCESS | 14031 | 04:09:20 INFO - PROCESS | 14031 | Cycle 1(1): loaded http://localhost:44091/tests/dromaeo/cssquery-ext.html (next: http://localhost:44091/tests/dromaeo/cssquery-jquery.html) 04:09:21 INFO - PROCESS | 14031 | RSS: Main: 194678784 04:09:21 INFO - PROCESS | 14031 | 04:12:23 INFO - PROCESS | 14031 | Cycle 1(1): loaded http://localhost:44091/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44091/tests/dromaeo/cssquery-mootools.html) 04:12:23 INFO - PROCESS | 14031 | RSS: Main: 197283840 04:12:23 INFO - PROCESS | 14031 | 04:15:25 INFO - PROCESS | 14031 | Cycle 1(1): loaded http://localhost:44091/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44091/tests/dromaeo/cssquery-prototype.html) 04:15:26 INFO - PROCESS | 14031 | RSS: Main: 193818624 04:15:26 INFO - PROCESS | 14031 | 04:18:28 INFO - PROCESS | 14031 | Cycle 1(1): loaded http://localhost:44091/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44091/tests/dromaeo/cssquery-yui.html) 04:18:29 INFO - PROCESS | 14031 | RSS: Main: 197275648 04:18:29 INFO - PROCESS | 14031 | 04:21:31 INFO - PROCESS | 14031 | Cycle 1(1): loaded http://localhost:44091/tests/dromaeo/cssquery-yui.html (next: http://localhost:44091/tests/dromaeo/cssquery-dojo.html) 04:21:32 INFO - PROCESS | 14031 | RSS: Main: 196481024 04:21:32 INFO - PROCESS | 14031 | 04:21:32 INFO - PROCESS | 14031 | __start_tp_report 04:21:32 INFO - PROCESS | 14031 | _x_x_mozilla_page_load 04:21:32 INFO - PROCESS | 14031 | _x_x_mozilla_page_load_details 04:21:32 INFO - PROCESS | 14031 | |i|pagename|runs| 04:21:32 INFO - PROCESS | 14031 | |0;dojo.html;3043.5130379139337;3044.771642126841;3063.1882551123954;3068.3863227354536;3091.922701932451;5344.545713614342;5345.198220266957;5355.464453554642;5403.945960540394;5489.4236105208975;5414.945850541493;5478.397376288605;5484.561235101192;5490.725463726808;5507.146392309199;4896.681715688469;4929.605631549467;4989.077020751154;5009.724465154415;5071.112555302826;4913.680610760307;4974.4081893794;5022.19644856823;5024.62315326352;5039.143345631252;4856.660033797635;4960.6527543072;5013;5059.342285502879;5100.41345245296;4953.851384458472;4974.179260422026;5054.519820617035;5072.467390923936;5073.137566613666;4814.085323788469;4830.710157390533;4842.927356089662;4868.342773725572;4884.755762211875;5308.522232999048;5360.919586206171;5366.9463305366835;5380.892382152374;5403.675779453206;5784.797532086399;5826.650400975955;5833.095870140092;5842.415758424166;5846.678432686201;5770.278715160605;5814.040683287252;5842.795502157446;5847.210626565445;5875;5401.675899446046;5419.674819510842;5437.265969094201;5449.3188351456065;5451.100568406168;5803.187553742479;5957.731902064417;5958.225430693982;5963.5527335450015;5963.73163207648;5630.4369563043365;5654.434556544395;5684.54523638108;5692.544596432275;5743.10981797822;5730.942690573041;5742.109972954198;5748.166515855178;5750.88498230033;5751.971240143773;5737.713114344266;5767.36558978512;5786.739596718074;5786.797462088806;5798.362180160263;5645;5713.342965558931;5747.597668163188;5748.770049198069;5815;4432.911341773147;4436.423264975532;4444.622207112432;4485.955140448619;4492.348609451611;3951.130751234724;3977.1846771411792;3980.3432433648704;4035.878923632296;4044.373122166069;5378.704171270618;5485.232067510552;5488.17677348401;5532.861678458071;5556.027695153332;5840.649561026352;5854.443827836349;5864.354920958691;5868.178455016301;5875.941240587625;5542.667439953616;5548.278723765965;5554.50009499147;5561.193626924073;5565.833025009256;5023.572996295283;5051.6716413433005;5052.5452709255605;5056.216286475602;5063.012712521023;5889.94110058894;5940.4653581177035;6007.939920600738;6017.368176341509;6039;5786.103154011135;5821.534277257894;5833.212516310414;5838.153467747238;5840.1531777892815;5958.821235362946;5969.04495280753;5976.073708575178;5987.31145918225;5991.490723288569;5602.803901863578;5626.5780066496;5632.436756324335;5669.20631111653;5677.3471050829685;5752.338481074563;5769.91345129815;5770.971145144247;5782.277215348082;5817.70911454434;5556.99974004683;5619.129034999582;5620.943790562042;5650.237217975685;5655.462731040545;5639.154126881001;5722.914156287742;5724.227229324155;5773.451522105393;5781.624194427349;5552.3892371839875;5647.3787883333625;5652.660840349592;5664.716764161693;5681.857953551194;5494.230807686847;5566.972165139148;5727.541796656341;5755.827325180251;5768.961586914395;5566.749496272597;5605.719714014202;5621.241132447068;5647.040003199384;5709.20071190042 04:21:32 INFO - PROCESS | 14031 | |1;ext.html;558.5447859994102;565.4515120333276;572.1932075773161;578.5429510686558;584.7719389438117;42703.572964270345;43843;44293.55706442935;46308.536914630844;46457.14171433147;41862.79068604653;41877.371839422434;41967.160656786924;42407.78796106023;42756.786216068955;8969.237614802749;9075.727728168165;9086.909130908705;9099.772505687377;9102.180803727662;8930.955345223265;8969.865452018224;9039.186473217409;9094.818103637923;9104.36269461138;9006;9019.503927283997;9043.457392556435;9087.727368178932;9110.681126160585;9055.501947392891;9114.58984345706;9130.908690913138;9134.08659134088;9160.129787670161;8852.690155844579;8906.242969347613;8919.598618062202;8921.464712117293;8922.910770892273;42199.156016879795;42766.358504622454;42810.35784463236;42898.356524652154;42938.78530607358;3238.627557830856;3296.241864371208;3306.404847127516;3508.8771892983877;3526.312369088029;29380;30771.384572308652;31285;31424.37151256985;32810.17974550631;4139.151473947833;4179.937300940488;4231.42875711778;4250.128723611683;4325.5025672047805;335114;335683;336229;337064;339602;57004.144937825964;57123.42876571181;57219.711211551905;57247;57743.71128144332;61245.38754612486;61479.38520614826;61775.691121545;61815;61995;15641.921790390976;15969.201539922957;16027.118508481912;16031.67936641284;16040.75938860918;11996.160268781276;12024.75950481003;12029.939850300867;12084.939575302067;12125.39373031345;17562.379133059712;18326.17532211027;18452.907735461504;18541.629167416577;18724.344647937258;6994.510384273052;7121.252268511732;7204.56772593646;7278.942844005531;7460.664270107858;859.4070091636751;1012.9290949633455;1086.1528008153653;1104.7845670094255;1139.6694958461953;32246.355072898412;32396.676033239837;32598;32637.836810815796;33139.83430082882;1059.782744537368;1065.1478816946412;1112.265904503024;1121.7251773315427;1126.695792136135;16366.754498682529;16950.40673576419;17398.65202695939;17457.822903291406;17554.648907021787;142706;144456;144540;144867.275663621;145486;38058.61941380606;38151.427728584094;38213.99999999945;38289;38528.8073559636;1227.1961864978452;1237.1216436330126;1275.7320962597773;1282.2883299768719;1296.1639742366121;28719.569206461503;30877;31316;31583.526247106773;32110.839445802623;44172.779136104116;44371.33442998422;45135;45344;45401.545984539734;426426;428221;429238;431901;432186;26554;27461.725382745917;27510.587341190298;27538.17385478439;27560.862195688893;46422.53577464182;46813.53186468092;47272.29091563698;47832.52167478281;48179.277310839665;39713.40429893496;40547;40896.38655420112;41160.79419603002;41902.37146442867;39635.80182099071;40594.59405405908;40898;41934.790326048176;42491;40606.59393406028;41291.7935410321;41848.095064314046;42491.57508424876;43206.35190472208;32270.515942260416;36811.26377472382;37289.813550933155;37397.439038413904;37439.62560374361;26637;27040.32399190036;27256.863715681295;27275.727242728113;27377.31556711098 04:21:32 INFO - PROCESS | 14031 | |2;jquery.html;388.98444062237513;390.3520156540144;394.80062568402946;398.960103989601;420.70971029989306;13877.69791364675;17802.28790848366;18058.72911906319;19299.807001929978;19332.323368682115;17973.460796176103;18342.358017469393;18608.906955465238;18677.159527821248;18698.906505467454;5135.8202462913805;5220.269162317288;5280.709560974145;5286.603504737141;5298.337707786527;5227.137522308814;5310.362756469229;5311.1502159654465;5312.760925758331;5314.707691076989;5275.49882761139;5324.467553244684;5560.916586251209;5667.319921609392;5695;5683.431656834304;5703.914441283384;5722.885542289173;5728.22668939692;5740.741666625012;4987.925181122286;5155.871103222412;5189.351331083614;5194.97402512985;5207.323048003773;22239.44401389978;22755.658665120038;22993.88503057474;23001.654975175385;23158.884205579034;2223.5219427823095;2230.9939919461203;2238.82089432845;2299.5515874404496;2678.933026674329;10230.590776368936;10279.074883260468;10801.243912926098;12438.502459901592;13999.300034998209;1877.6150889067708;1913.3877159309027;1938.5444420561157;1954.853385996056;1993.5240312159508;84068;85095.57452212762;86229.56885215596;87573;89279.55360223158;8234.917650823416;8790.516521591373;9306.906930930603;9401.34190606651;10981.364472526537;11796.938275555069;13044.152130111512;13049.151805132637;13076.019298552646;13123.803142952864;7025.89461158083;7209.567425954459;7228.76119940244;7390.889136662954;7417.740379086706;6994.2656021117045;7342.706291748377;7481.625918704043;7498.8765167024085;7663.808404789925;4020.3768415895584;4052.6555242804693;4092.570280120604;4122.587741225913;4169.791510424528;1957.4910523263768;1961.3527535913115;1979.5842872996543;2004.8596598238275;2011.2960463837833;893.8748575199477;920.9585568649427;987.950602469888;1031.9690409287584;1063.1176123817213;18638.44084677435;19184.520386990156;19446.902765486364;19671.803281966997;19947.700784488243;938.7183844846519;952.7760976170595;966.1546147121269;990.8513722941616;1027.9434631095212;10635.787284254271;10716.35701857891;10721.746344291398;10739.516721747541;10824.78350432987;447743;450703;452070;456533;456848;76758.61620691861;87376.563117184;88858.55570722105;89243;89854.55072724725;952.8808898887778;978.1099199728355;991.5686676295834;998.6604554451521;1005.5173516711873;16604.916975415046;16614.584635384213;16912.492625221264;17417.12914354252;17516.124193790514;31915.840420797747;36257.63742362648;41049.1790164201;41798.37302440405;42437.1512569753;45489;54411;54832.725836372156;54903.17645235245;56272.15591766045;7627.771166865003;7850.803729906798;7875.684972601031;8071.152528984607;8208;10057.899421005697;11493.988552003533;12130.211536250115;12493.126031095408;12958.935205323913;5730.5702072345575;6060.666663333559;11358.886411135783;11844.28934263947;11892.572891253105;7718.764997600357;10453.790924181625;10712.410817405118;10816.91830816912;11299.491522881655;11370.237613169971;11766.52933882635;11798.646040618794;11817.527298907948;11873.634532028927;8626;8634.78413039679;8656.523891185794;8771.254443372385;8953.731388058368;10790.406527641055;11368.715782105513;11383.804700506327;11612.76774464489;11997.880021200026 04:21:32 INFO - PROCESS | 14031 | |3;mootools.html;1448.6740483391236;1449.3333066789276;1595.0987691954044;1752.983269703572;1778.048743922002;7787.299143077122;8085.353171746261;8468.872966905494;9046.819063618723;9049.41178823376;8459.154084591537;8796.252318552915;8831.514266715329;9028.593713282902;9105.954470227656;2317.733460652021;2320.9767902321014;2333.684952531412;2347.3310106619615;2356.140008896749;2272.693186419837;2285.223024171781;2357.0925193800426;2364.73987861336;2366.0772298803395;2285.702858628384;2309.9884500577473;2334.428065124047;2334.6264597664376;2343.3438637181616;2276.3171048685326;2279.7606251343536;2308.4921317310163;2308.7229532456045;2314.2247347138727;2236.2285011670947;2238.250186187629;2275.4538910661486;2276.9544609107725;2284.554511870186;8967.237784788236;9051.773705657346;9068.410553314014;9074.727758167199;9075.727728168165;5223.660462069954;5265.710385928773;5358.598105142091;5378.489043540857;5380.139177731583;3099.1942095055224;3143.135637699628;3381.661833816623;3401.1327111586634;3444.569428821397;1075.591275315383;1084.8752393474772;1120.1318977792196;1141.4635121492886;1141.9086473082134;12626.621201363974;12627;12650.493980240779;12729.618111456672;12750.426230819636;4428.73427594339;4518.751468669255;4600.677952543357;4619.514950930171;4758.643101767381;10368.222383321281;10377.533011014522;10411.739706507398;10481.318714283547;10505.054545090978;5227.215917612389;5244.475552444725;5296.232046353334;5337.199420087018;5339.7063161526485;4229.978850105791;4232.597903199191;4706.552877476634;4765.118453086121;4844.467108618049;3831.482749828793;3853.3641949078647;3854.5952674969285;3879.3792993120965;3980.1840622672285;1196.946137423818;1205.5900993662196;1210.667066556704;1215.7933151364111;1218.9756204875853;867.4751775176054;871.6164887449502;884.1247165306429;901.3014913442134;910.3445519226146;5308.23030660552;5333.679979201261;5448.139726643464;5485.50630443262;5579.804706835242;410.69813686940074;434.6435922543547;441.6731618602211;443.8158164361754;444.4044979727181;3371.780834245815;3556.5732112146707;3683.2265224303196;3704.240630670706;3763.962360376361;10480.475976201313;10740.86282500769;10940.288881222696;11048.613298534674;11059.391733454577;10876.347419154876;10922.617708380169;10975.615853445252;10978.176636752276;11017.669469915916;8250.46371985819;8357.206065423776;8399.244068033906;8481.575921203792;8500.872486912702;5395.244665746877;5442.972785136049;5530.419305972815;5621.690807005654;5652.180433836988;9866.112049915542;9876.703698889045;9901;9979.251556133175;10068.44623545712;10119.190464762654;10120.190384769348;10308.484575771332;10309.48452577353;10350.585976560853;7587.430942679432;7867.488613240121;7872.72445464406;7917.168697286702;7991.680332786624;8589.957050214709;8720.040795512616;8792.208701216921;8796.604152813266;8810.735677929672;7441.181470038183;7570.621468926642;7723.266289702694;7832.530048197126;7998.360131189607;7416.7774966751085;7526.360259377795;7631;7722.845543089219;7831;6662.500312476487;6807.353301436356;6819.693113809792;6826.795196144124;6898.551594146365;4761.76191190446;4803.871090293848;4859.1496488113735;4881;5023.522765337287;4665.300204969146;4797.5682188601795;4887.315775791321;4905.77923993414;4975.900481990412 04:21:32 INFO - PROCESS | 14031 | |4;prototype.html;329.1540740297435;331.3373253493014;341.56962227593243;343.4864877008872;344.155099231387;5376.650517716345;5461.590380721447;5526.89462107578;5574.303212098488;5611.382747897733;5380.24676545283;5464.535514481274;5481.616286859921;5500.28496295481;5506.80726174584;4260;4270.295401258789;4299.204647140274;4317.956820431787;4364.585364390377;4218.725782824122;4251.426057482231;4296.419983302246;4320.1143765527995;4321.330193819963;4243.915121697564;4244.1140024783135;4256.6807489438415;4257.787110644471;4276.486821581415;4227.78861056949;4284.6786491013145;4285.807073730076;4286.935695964563;4313.82744690212;3770.7360484766077;3774.565924918642;3787.9242415151816;3789.1285004449132;3800.7909564973916;5099.464556221617;5334.306540149794;5352.090144675414;5352.474544754765;5352.812651557216;4874.8537543873745;4887.315775791392;4888.462269150391;4903.19097348937;4905.950940490585;5417.214503896952;5699.2590963174525;5750.894516960878;5773;5802.912956305659;4012.598740125993;4048.251073551373;4068.4304197412384;4078.775667338295;4090.263752524574;5871.178035075093;5910.222195568076;5927;5943.583949123563;5978.461938425563;3945.191235796655;4103.4870641169855;4116.0533077392365;4134.607212314825;4142.689298302639;4065.8780236592356;4091.734037287567;4097.672186225095;4128.8348466061625;4130.958690413117;4736.526347365236;4747.836779988925;4751.667383283206;4754;4779.665423420397;5583.827396246834;5710;5712.600117991784;5712.857178570569;5759;1429.4353730276482;1435.3397437179015;1437.525616546558;1441.9062760920506;1448.3844366144347;883.7437143228392;915.9084091590921;919.70569417787;932.6756006470692;938.558877327655;4791.7718261008795;4798.7840547175465;4833.492483289274;4847.491013443538;4862.294967229732;5104.642675012714;5131.461196574306;5136.948630513722;5148.562372198405;5152.536271735562;4608.769561521911;4829.372181616438;4830.6135509159185;4891.383110036114;4894;2671.7461841125064;2707.4314393977484;2726.2775364528416;2729.8089133760845;2733.8496382698745;5171.422716071635;5203.464977831549;5244.711540865289;5253.4221235664045;5254.660061684246;4981.8043669519775;5186.740662966837;5198.844034678966;5215.53060224574;5215.765290561933;5276.604254680914;5285.814996475182;5289.761960711778;5333.200019996954;5347.385050719062;5096.745162741922;5108.3103780989095;5146.845594632167;5165.354330708661;5185.714785686823;4784.617230621472;5091.338126043591;5103.617228707936;5123.231515272739;5143.6399452039495;5231.7705339246;5242.951409718148;5245.554127899171;5253.817890974653;5261.684298942076;3768.3593789055376;3769.095417099931;3981.2634662587516;4069.1658210066275;4078.2455245779624;5795.304563452412;5808.273965754281;5811.331696854747;5821.126830975388;5830.941690583039;5676.886462270649;5738.770449182153;5767.125684152751;5797.739101740347;5813.854653633693;5500.669959802424;5638.746256418389;5670.886582268414;5687.60186786921;5688.16049166819;5650;5700.743466544099;5705.459525927893;5715.742791574306;5762.366139724543;5521.254630624814;5730.226419433323;5740.712964351849;5769.913451298318;5824.475797178105;5623.834823592864;5626.578006649435;5643.463870932255;5670.716464176692;5680.289963754531 04:21:32 INFO - PROCESS | 14031 | |5;yui.html;694.8957656351547;732.6117157906305;735.8270806360506;814;821.1049955548455;12929.482820687173;13169.670758231048;13327.60017199483;13452.798208026887;13453.59639210824;13058.869411305885;13233.206007639525;13250.469981200764;13267.203967761941;13277.933610331935;760.1372442278013;784.4195295481331;784.6233807772272;785.3167744062673;789.2462698123308;776.9494982826127;777.4946284914794;782.679101568357;785.1520358013361;786.8977032985704;813.6419975210918;814.3810703865046;816.7835523586255;821.5768879027306;821.6056292979373;800.1238643685156;813.1340122769232;813.6826637611307;814.5804910471112;815.8735396013627;596.5466245653334;602.57518449493;602.8010756450404;603.8007457539002;605.8061420345491;12109.212901161396;12150.696232594168;12234.510619575207;12244.877551224463;12265.632031039084;12234.694132646666;12318.445669944875;12339.93830030844;12560.685982850411;12778.361081945959;10504.36973781568;10670.893291067068;10799.67600971972;10940.890591094067;11009.119270458345;3612.6567976042234;3632.291703117893;3679.5400574928135;3683.9447408288897;3733.253349330145;65348.34651653517;66739.3326066738;68357.9999999995;69115.65442172808;69254.3074569253;9119.407238529475;9370.250379969586;9517.5717092731;9620.711378658512;9662.227021838236;18998.41887013851;19471.90264048699;19609;19661.311854085037;19700.84786434164;7843.843123137505;8098.6637204860535;8180.100188979208;8221.848941148244;8253.752387428267;4355.80398882051;4549.567791059844;4593.839215627437;4596.241620132708;4633.4208223972;3317.4360358739073;3473.166440054419;3481.408160612702;3505.9298814023578;3509.420945543957;565.8104534980745;574.4341823304043;575.32686756495;595.6068994463719;598.6677394046259;679.5650783498564;699.4579201119174;722.140652623387;726.2483329753785;737.8897945161171;9208.815823683488;9325.601159826081;9409.388389754644;9492.240620750323;9492.525373731423;647.5790736021529;660.9074729537869;671.4225765841372;675;687.5530904911748;4478.596926276651;4530;4551.294549344857;4565.634749220055;4584.518625544337;86855.56572217225;89088;89389.55305223563;89604.551977241;90029.54985225032;48349.51650483521;75415;76366.61816690881;77103;77319.61340193376;68068.6596567024;71207;71649;74211.62894185494;74281.25718742743;8496.405251632574;8586.22723954847;8745.956270218863;8887.511186884783;9060.864087038832;47384.52615473939;47655.046899062516;47733.419993499934;48602;49078.5092149074;39632.60367396289;39721.40417893792;53966.19050714164;54117;62301.68849155906;11923.761524769283;11974.760504789681;12017.81973270419;12105.81841272364;12250.938745306217;13441.260730659907;13607.115537490032;13859.861401385857;13914.51299204523;14650.120992740469;12793.61619151427;13283.136596121607;13329.933350333185;13950.511732089328;14272.429102835771;12883.355832208164;12884.162529435556;13219.801702974271;13357.799633005317;13441.865581344453;12757.362131893182;12985.805212921625;12985.870141298845;13196.60410187696;13564;9439.716808495756;9640.42157470554;10284.588616455258;10531.94734026325;10678;8662.307015438624;8690.43512171732;9825.312228143961;10022.799544008933;10376.922962367416 04:21:32 INFO - PROCESS | 14031 | __end_tp_report 04:21:32 INFO - PROCESS | 14031 | __start_cc_report 04:21:32 INFO - PROCESS | 14031 | _x_x_mozilla_cycle_collect,313 04:21:32 INFO - PROCESS | 14031 | __end_cc_report 04:21:32 INFO - PROCESS | 14031 | __startTimestamp1477480892198__endTimestamp 04:21:32 INFO - PROCESS | 14031 | 04:21:32 INFO - PROCESS | 14031 | ------- Summary: start ------- 04:21:32 INFO - PROCESS | 14031 | Number of tests: 6 04:21:32 INFO - PROCESS | 14031 | 04:21:32 INFO - PROCESS | 14031 | [#0] dojo.html Cycles:165 Average:5393.28 Median:5619.13 stddev:609.49 (10.8%) stddev-sans-first:582.82 04:21:32 INFO - PROCESS | 14031 | Values: 3043.5 3044.8 3063.2 3068.4 3091.9 5344.5 5345.2 5355.5 5403.9 5489.4 5414.9 5478.4 5484.6 5490.7 5507.1 4896.7 4929.6 4989.1 5009.7 5071.1 4913.7 4974.4 5022.2 5024.6 5039.1 4856.7 4960.7 5013.0 5059.3 5100.4 4953.9 4974.2 5054.5 5072.5 5073.1 4814.1 4830.7 4842.9 4868.3 4884.8 5308.5 5360.9 5366.9 5380.9 5403.7 5784.8 5826.7 5833.1 5842.4 5846.7 5770.3 5814.0 5842.8 5847.2 5875.0 5401.7 5419.7 5437.3 5449.3 5451.1 5803.2 5957.7 5958.2 5963.6 5963.7 5630.4 5654.4 5684.5 5692.5 5743.1 5730.9 5742.1 5748.2 5750.9 5752.0 5737.7 5767.4 5786.7 5786.8 5798.4 5645.0 5713.3 5747.6 5748.8 5815.0 4432.9 4436.4 4444.6 4486.0 4492.3 3951.1 3977.2 3980.3 4035.9 4044.4 5378.7 5485.2 5488.2 5532.9 5556.0 5840.6 5854.4 5864.4 5868.2 5875.9 5542.7 5548.3 5554.5 5561.2 5565.8 5023.6 5051.7 5052.5 5056.2 5063.0 5889.9 5940.5 6007.9 6017.4 6039.0 5786.1 5821.5 5833.2 5838.2 5840.2 5958.8 5969.0 5976.1 5987.3 5991.5 5602.8 5626.6 5632.4 5669.2 5677.3 5752.3 5769.9 5771.0 5782.3 5817.7 5557.0 5619.1 5620.9 5650.2 5655.5 5639.2 5722.9 5724.2 5773.5 5781.6 5552.4 5647.4 5652.7 5664.7 5681.9 5494.2 5567.0 5727.5 5755.8 5769.0 5566.7 5605.7 5621.2 5647.0 5709.2 04:21:32 INFO - PROCESS | 14031 | 04:21:32 INFO - PROCESS | 14031 | [#1] ext.html Cycles:180 Average:47953.76 Median:41029.40 stddev:86336.99 (210.4%) stddev-sans-first:86505.85 04:21:32 INFO - PROCESS | 14031 | Values: 558.5 565.5 572.2 578.5 584.8 42703.6 43843.0 44293.6 46308.5 46457.1 41862.8 41877.4 41967.2 42407.8 42756.8 8969.2 9075.7 9086.9 9099.8 9102.2 8931.0 8969.9 9039.2 9094.8 9104.4 9006.0 9019.5 9043.5 9087.7 9110.7 9055.5 9114.6 9130.9 9134.1 9160.1 8852.7 8906.2 8919.6 8921.5 8922.9 42199.2 42766.4 42810.4 42898.4 42938.8 3238.6 3296.2 3306.4 3508.9 3526.3 29380.0 30771.4 31285.0 31424.4 32810.2 4139.2 4179.9 4231.4 4250.1 4325.5 335114.0 335683.0 336229.0 337064.0 339602.0 57004.1 57123.4 57219.7 57247.0 57743.7 61245.4 61479.4 61775.7 61815.0 61995.0 15641.9 15969.2 16027.1 16031.7 16040.8 11996.2 12024.8 12029.9 12084.9 12125.4 17562.4 18326.2 18452.9 18541.6 18724.3 6994.5 7121.3 7204.6 7278.9 7460.7 859.4 1012.9 1086.2 1104.8 1139.7 32246.4 32396.7 32598.0 32637.8 33139.8 1059.8 1065.1 1112.3 1121.7 1126.7 16366.8 16950.4 17398.7 17457.8 17554.6 142706.0 144456.0 144540.0 144867.3 145486.0 38058.6 38151.4 38214.0 38289.0 38528.8 1227.2 1237.1 1275.7 1282.3 1296.2 28719.6 30877.0 31316.0 31583.5 32110.8 44172.8 44371.3 45135.0 45344.0 45401.5 426426.0 428221.0 429238.0 431901.0 432186.0 26554.0 27461.7 27510.6 27538.2 27560.9 46422.5 46813.5 47272.3 47832.5 48179.3 39713.4 40547.0 40896.4 41160.8 41902.4 39635.8 40594.6 40898.0 41934.8 42491.0 40606.6 41291.8 41848.1 42491.6 43206.4 32270.5 36811.3 37289.8 37397.4 37439.6 26637.0 27040.3 27256.9 27275.7 27377.3 04:21:32 INFO - PROCESS | 14031 | 04:21:32 INFO - PROCESS | 14031 | [#2] jquery.html Cycles:180 Average:27326.96 Median:22570.87 stddev:74901.44 (331.8%) stddev-sans-first:75084.25 04:21:32 INFO - PROCESS | 14031 | Values: 389.0 390.4 394.8 399.0 420.7 13877.7 17802.3 18058.7 19299.8 19332.3 17973.5 18342.4 18608.9 18677.2 18698.9 5135.8 5220.3 5280.7 5286.6 5298.3 5227.1 5310.4 5311.2 5312.8 5314.7 5275.5 5324.5 5560.9 5667.3 5695.0 5683.4 5703.9 5722.9 5728.2 5740.7 4987.9 5155.9 5189.4 5195.0 5207.3 22239.4 22755.7 22993.9 23001.7 23158.9 2223.5 2231.0 2238.8 2299.6 2678.9 10230.6 10279.1 10801.2 12438.5 13999.3 1877.6 1913.4 1938.5 1954.9 1993.5 84068.0 85095.6 86229.6 87573.0 89279.6 8234.9 8790.5 9306.9 9401.3 10981.4 11796.9 13044.2 13049.2 13076.0 13123.8 7025.9 7209.6 7228.8 7390.9 7417.7 6994.3 7342.7 7481.6 7498.9 7663.8 4020.4 4052.7 4092.6 4122.6 4169.8 1957.5 1961.4 1979.6 2004.9 2011.3 893.9 921.0 988.0 1032.0 1063.1 18638.4 19184.5 19446.9 19671.8 19947.7 938.7 952.8 966.2 990.9 1027.9 10635.8 10716.4 10721.7 10739.5 10824.8 447743.0 450703.0 452070.0 456533.0 456848.0 76758.6 87376.6 88858.6 89243.0 89854.6 952.9 978.1 991.6 998.7 1005.5 16604.9 16614.6 16912.5 17417.1 17516.1 31915.8 36257.6 41049.2 41798.4 42437.2 45489.0 54411.0 54832.7 54903.2 56272.2 7627.8 7850.8 7875.7 8071.2 8208.0 10057.9 11494.0 12130.2 12493.1 12958.9 5730.6 6060.7 11358.9 11844.3 11892.6 7718.8 10453.8 10712.4 10816.9 11299.5 11370.2 11766.5 11798.6 11817.5 11873.6 8626.0 8634.8 8656.5 8771.3 8953.7 10790.4 11368.7 11383.8 11612.8 11997.9 04:21:32 INFO - PROCESS | 14031 | 04:21:32 INFO - PROCESS | 14031 | [#3] mootools.html Cycles:180 Average:5739.15 Median:4610.10 stddev:3374.20 (73.2%) stddev-sans-first:3368.26 04:21:32 INFO - PROCESS | 14031 | Values: 1448.7 1449.3 1595.1 1753.0 1778.0 7787.3 8085.4 8468.9 9046.8 9049.4 8459.2 8796.3 8831.5 9028.6 9106.0 2317.7 2321.0 2333.7 2347.3 2356.1 2272.7 2285.2 2357.1 2364.7 2366.1 2285.7 2310.0 2334.4 2334.6 2343.3 2276.3 2279.8 2308.5 2308.7 2314.2 2236.2 2238.3 2275.5 2277.0 2284.6 8967.2 9051.8 9068.4 9074.7 9075.7 5223.7 5265.7 5358.6 5378.5 5380.1 3099.2 3143.1 3381.7 3401.1 3444.6 1075.6 1084.9 1120.1 1141.5 1141.9 12626.6 12627.0 12650.5 12729.6 12750.4 4428.7 4518.8 4600.7 4619.5 4758.6 10368.2 10377.5 10411.7 10481.3 10505.1 5227.2 5244.5 5296.2 5337.2 5339.7 4230.0 4232.6 4706.6 4765.1 4844.5 3831.5 3853.4 3854.6 3879.4 3980.2 1196.9 1205.6 1210.7 1215.8 1219.0 867.5 871.6 884.1 901.3 910.3 5308.2 5333.7 5448.1 5485.5 5579.8 410.7 434.6 441.7 443.8 444.4 3371.8 3556.6 3683.2 3704.2 3764.0 10480.5 10740.9 10940.3 11048.6 11059.4 10876.3 10922.6 10975.6 10978.2 11017.7 8250.5 8357.2 8399.2 8481.6 8500.9 5395.2 5443.0 5530.4 5621.7 5652.2 9866.1 9876.7 9901.0 9979.3 10068.4 10119.2 10120.2 10308.5 10309.5 10350.6 7587.4 7867.5 7872.7 7917.2 7991.7 8590.0 8720.0 8792.2 8796.6 8810.7 7441.2 7570.6 7723.3 7832.5 7998.4 7416.8 7526.4 7631.0 7722.8 7831.0 6662.5 6807.4 6819.7 6826.8 6898.6 4761.8 4803.9 4859.1 4881.0 5023.5 4665.3 4797.6 4887.3 4905.8 4975.9 04:21:32 INFO - PROCESS | 14031 | 04:21:32 INFO - PROCESS | 14031 | [#4] prototype.html Cycles:180 Average:4608.67 Median:5140.29 stddev:1337.17 (26.0%) stddev-sans-first:1301.77 04:21:32 INFO - PROCESS | 14031 | Values: 329.2 331.3 341.6 343.5 344.2 5376.7 5461.6 5526.9 5574.3 5611.4 5380.2 5464.5 5481.6 5500.3 5506.8 4260.0 4270.3 4299.2 4318.0 4364.6 4218.7 4251.4 4296.4 4320.1 4321.3 4243.9 4244.1 4256.7 4257.8 4276.5 4227.8 4284.7 4285.8 4286.9 4313.8 3770.7 3774.6 3787.9 3789.1 3800.8 5099.5 5334.3 5352.1 5352.5 5352.8 4874.9 4887.3 4888.5 4903.2 4906.0 5417.2 5699.3 5750.9 5773.0 5802.9 4012.6 4048.3 4068.4 4078.8 4090.3 5871.2 5910.2 5927.0 5943.6 5978.5 3945.2 4103.5 4116.1 4134.6 4142.7 4065.9 4091.7 4097.7 4128.8 4131.0 4736.5 4747.8 4751.7 4754.0 4779.7 5583.8 5710.0 5712.6 5712.9 5759.0 1429.4 1435.3 1437.5 1441.9 1448.4 883.7 915.9 919.7 932.7 938.6 4791.8 4798.8 4833.5 4847.5 4862.3 5104.6 5131.5 5136.9 5148.6 5152.5 4608.8 4829.4 4830.6 4891.4 4894.0 2671.7 2707.4 2726.3 2729.8 2733.8 5171.4 5203.5 5244.7 5253.4 5254.7 4981.8 5186.7 5198.8 5215.5 5215.8 5276.6 5285.8 5289.8 5333.2 5347.4 5096.7 5108.3 5146.8 5165.4 5185.7 4784.6 5091.3 5103.6 5123.2 5143.6 5231.8 5243.0 5245.6 5253.8 5261.7 3768.4 3769.1 3981.3 4069.2 4078.2 5795.3 5808.3 5811.3 5821.1 5830.9 5676.9 5738.8 5767.1 5797.7 5813.9 5500.7 5638.7 5670.9 5687.6 5688.2 5650.0 5700.7 5705.5 5715.7 5762.4 5521.3 5730.2 5740.7 5769.9 5824.5 5623.8 5626.6 5643.5 5670.7 5680.3 04:21:32 INFO - PROCESS | 14031 | 04:21:32 INFO - PROCESS | 14031 | [#5] yui.html Cycles:180 Average:17300.13 Median:570.12 stddev:23374.01 (4099.8%) stddev-sans-first:23406.33 04:21:32 INFO - PROCESS | 14031 | Values: 694.9 732.6 735.8 814.0 821.1 12929.5 13169.7 13327.6 13452.8 13453.6 13058.9 13233.2 13250.5 13267.2 13277.9 760.1 784.4 784.6 785.3 789.2 776.9 777.5 782.7 785.2 786.9 813.6 814.4 816.8 821.6 821.6 800.1 813.1 813.7 814.6 815.9 596.5 602.6 602.8 603.8 605.8 12109.2 12150.7 12234.5 12244.9 12265.6 12234.7 12318.4 12339.9 12560.7 12778.4 10504.4 10670.9 10799.7 10940.9 11009.1 3612.7 3632.3 3679.5 3683.9 3733.3 65348.3 66739.3 68358.0 69115.7 69254.3 9119.4 9370.3 9517.6 9620.7 9662.2 18998.4 19471.9 19609.0 19661.3 19700.8 7843.8 8098.7 8180.1 8221.8 8253.8 4355.8 4549.6 4593.8 4596.2 4633.4 3317.4 3473.2 3481.4 3505.9 3509.4 565.8 574.4 575.3 595.6 598.7 679.6 699.5 722.1 726.2 737.9 9208.8 9325.6 9409.4 9492.2 9492.5 647.6 660.9 671.4 675.0 687.6 4478.6 4530.0 4551.3 4565.6 4584.5 86855.6 89088.0 89389.6 89604.6 90029.5 48349.5 75415.0 76366.6 77103.0 77319.6 68068.7 71207.0 71649.0 74211.6 74281.3 8496.4 8586.2 8746.0 8887.5 9060.9 47384.5 47655.0 47733.4 48602.0 49078.5 39632.6 39721.4 53966.2 54117.0 62301.7 11923.8 11974.8 12017.8 12105.8 12250.9 13441.3 13607.1 13859.9 13914.5 14650.1 12793.6 13283.1 13329.9 13950.5 14272.4 12883.4 12884.2 13219.8 13357.8 13441.9 12757.4 12985.8 12985.9 13196.6 13564.0 9439.7 9640.4 10284.6 10531.9 10678.0 8662.3 8690.4 9825.3 10022.8 10376.9 04:21:32 INFO - PROCESS | 14031 | -------- Summary: end -------- 04:21:32 INFO - PROCESS | 14031 | 04:21:33 INFO - TEST-INFO | 14031: exit 0 04:21:33 INFO - TEST-OK | dromaeo_css | took 1116612ms 04:21:33 INFO - TEST-START | kraken 04:21:33 INFO - operating with platform_type : linux_ 04:21:33 INFO - Initialising browser for kraken test... 04:21:33 INFO - TEST-INFO | started process 14393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg3d7wB/profile http://localhost:44091/getInfo.html) 04:21:37 INFO - PROCESS | 14393 | __metrics Screen width/height:1600/1200 04:21:37 INFO - PROCESS | 14393 | colorDepth:24 04:21:37 INFO - PROCESS | 14393 | Browser inner width/height: 1024/697 04:21:37 INFO - PROCESS | 14393 | __metrics 04:21:38 ERROR - PROCESS | 14393 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 04:21:39 INFO - TEST-INFO | 14393: exit 0 04:21:39 INFO - Browser initialized. 04:21:39 INFO - Running cycle 1/1 for kraken test... 04:21:39 INFO - TEST-INFO | started process 14515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg3d7wB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:51 INFO - PROCESS | 14515 | RSS: Main: 182308864 04:21:51 INFO - PROCESS | 14515 | 04:21:54 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44091/tests/kraken/driver.html?testName=audio-beat-detection) 04:21:55 INFO - PROCESS | 14515 | RSS: Main: 197095424 04:21:55 INFO - PROCESS | 14515 | 04:21:57 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44091/tests/kraken/driver.html?testName=audio-dft) 04:21:58 INFO - PROCESS | 14515 | RSS: Main: 195379200 04:21:58 INFO - PROCESS | 14515 | 04:22:01 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44091/tests/kraken/driver.html?testName=audio-fft) 04:22:01 INFO - PROCESS | 14515 | RSS: Main: 191508480 04:22:01 INFO - PROCESS | 14515 | 04:22:04 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44091/tests/kraken/driver.html?testName=audio-oscillator) 04:22:04 INFO - PROCESS | 14515 | RSS: Main: 192249856 04:22:04 INFO - PROCESS | 14515 | 04:22:06 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44091/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:07 INFO - PROCESS | 14515 | RSS: Main: 192495616 04:22:07 INFO - PROCESS | 14515 | 04:22:10 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44091/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:11 INFO - PROCESS | 14515 | RSS: Main: 192778240 04:22:11 INFO - PROCESS | 14515 | 04:22:14 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44091/tests/kraken/driver.html?testName=imaging-desaturate) 04:22:15 INFO - PROCESS | 14515 | RSS: Main: 192806912 04:22:15 INFO - PROCESS | 14515 | 04:22:17 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44091/tests/kraken/driver.html?testName=json-parse-financial) 04:22:18 INFO - PROCESS | 14515 | RSS: Main: 192155648 04:22:18 INFO - PROCESS | 14515 | 04:22:19 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44091/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:22:20 INFO - PROCESS | 14515 | RSS: Main: 192331776 04:22:20 INFO - PROCESS | 14515 | 04:22:22 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44091/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:22:23 INFO - PROCESS | 14515 | RSS: Main: 192794624 04:22:23 INFO - PROCESS | 14515 | 04:22:25 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44091/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:25 INFO - PROCESS | 14515 | RSS: Main: 192700416 04:22:25 INFO - PROCESS | 14515 | 04:22:28 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:22:29 INFO - PROCESS | 14515 | RSS: Main: 191963136 04:22:29 INFO - PROCESS | 14515 | 04:22:31 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:22:32 INFO - PROCESS | 14515 | RSS: Main: 192159744 04:22:32 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | Cycle 1(1): loaded http://localhost:44091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44091/tests/kraken/driver.html?testName=ai-astar) 04:22:34 INFO - PROCESS | 14515 | RSS: Main: 194256896 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | __start_tp_report 04:22:34 INFO - PROCESS | 14515 | _x_x_mozilla_page_load 04:22:34 INFO - PROCESS | 14515 | _x_x_mozilla_page_load_details 04:22:34 INFO - PROCESS | 14515 | |i|pagename|runs| 04:22:34 INFO - PROCESS | 14515 | |0;ai-astar;106;112;110;113;113;113;114;112;112;112 04:22:34 INFO - PROCESS | 14515 | |1;audio-beat-detection;156;123;124;175;124;129;128;126;160;123 04:22:34 INFO - PROCESS | 14515 | |2;audio-dft;162;167;166;174;164;163;161;164;162;165 04:22:34 INFO - PROCESS | 14515 | |3;audio-fft;76;76;74;119;79;77;77;76;100;77 04:22:34 INFO - PROCESS | 14515 | |4;audio-oscillator;82;82;107;82;82;81;107;82;82;112 04:22:34 INFO - PROCESS | 14515 | |5;imaging-gaussian-blur;118;120;120;118;120;117;118;118;119;118 04:22:34 INFO - PROCESS | 14515 | |6;imaging-darkroom;149;148;147;148;149;149;147;147;147;147 04:22:34 INFO - PROCESS | 14515 | |7;imaging-desaturate;85;87;86;86;85;88;86;85;88;86 04:22:34 INFO - PROCESS | 14515 | |8;json-parse-financial;58;57;55;54;55;56;59;55;56;55 04:22:34 INFO - PROCESS | 14515 | |9;json-stringify-tinderbox;61;62;62;62;63;62;62;63;62;63 04:22:34 INFO - PROCESS | 14515 | |10;stanford-crypto-aes;82;87;87;81;81;82;85;80;81;83 04:22:34 INFO - PROCESS | 14515 | |11;stanford-crypto-ccm;136;144;133;138;153;137;132;142;178;133 04:22:34 INFO - PROCESS | 14515 | |12;stanford-crypto-pbkdf2;171;171;164;169;166;170;165;163;170;167 04:22:34 INFO - PROCESS | 14515 | |13;stanford-crypto-sha256-iterative;67;69;73;67;69;71;68;66;65;71 04:22:34 INFO - PROCESS | 14515 | __end_tp_report 04:22:34 INFO - PROCESS | 14515 | __start_cc_report 04:22:34 INFO - PROCESS | 14515 | _x_x_mozilla_cycle_collect,792 04:22:34 INFO - PROCESS | 14515 | __end_cc_report 04:22:34 INFO - PROCESS | 14515 | __startTimestamp1477480954597__endTimestamp 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | ------- Summary: start ------- 04:22:34 INFO - PROCESS | 14515 | Number of tests: 14 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:2.26 (2.0%) stddev-sans-first:1.12 04:22:34 INFO - PROCESS | 14515 | Values: 106.0 112.0 110.0 113.0 113.0 113.0 114.0 112.0 112.0 112.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:128.50 stddev:19.23 (15.0%) stddev-sans-first:19.10 04:22:34 INFO - PROCESS | 14515 | Values: 156.0 123.0 124.0 175.0 124.0 129.0 128.0 126.0 160.0 123.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:3.74 (2.3%) stddev-sans-first:3.82 04:22:34 INFO - PROCESS | 14515 | Values: 162.0 167.0 166.0 174.0 164.0 163.0 161.0 164.0 162.0 165.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.50 stddev:14.67 (19.2%) stddev-sans-first:15.33 04:22:34 INFO - PROCESS | 14515 | Values: 76.0 76.0 74.0 119.0 79.0 77.0 77.0 76.0 100.0 77.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:13.03 (15.9%) stddev-sans-first:13.50 04:22:34 INFO - PROCESS | 14515 | Values: 82.0 82.0 107.0 82.0 82.0 81.0 107.0 82.0 82.0 112.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:1.07 (0.9%) stddev-sans-first:1.12 04:22:34 INFO - PROCESS | 14515 | Values: 118.0 120.0 120.0 118.0 120.0 117.0 118.0 118.0 119.0 118.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 04:22:34 INFO - PROCESS | 14515 | Values: 149.0 148.0 147.0 148.0 149.0 149.0 147.0 147.0 147.0 147.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:1.12 04:22:34 INFO - PROCESS | 14515 | Values: 85.0 87.0 86.0 86.0 85.0 88.0 86.0 85.0 88.0 86.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.56 (2.8%) stddev-sans-first:1.48 04:22:34 INFO - PROCESS | 14515 | Values: 58.0 57.0 55.0 54.0 55.0 56.0 59.0 55.0 56.0 55.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 04:22:34 INFO - PROCESS | 14515 | Values: 61.0 62.0 62.0 62.0 63.0 62.0 62.0 63.0 62.0 63.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:2.56 (3.1%) stddev-sans-first:2.69 04:22:34 INFO - PROCESS | 14515 | Values: 82.0 87.0 87.0 81.0 81.0 82.0 85.0 80.0 81.0 83.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:140.00 stddev:13.97 (10.0%) stddev-sans-first:14.61 04:22:34 INFO - PROCESS | 14515 | Values: 136.0 144.0 133.0 138.0 153.0 137.0 132.0 142.0 178.0 133.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:169.50 stddev:2.99 (1.8%) stddev-sans-first:2.91 04:22:34 INFO - PROCESS | 14515 | Values: 171.0 171.0 164.0 169.0 166.0 170.0 165.0 163.0 170.0 167.0 04:22:34 INFO - PROCESS | 14515 | 04:22:34 INFO - PROCESS | 14515 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:2.50 (3.6%) stddev-sans-first:2.59 04:22:34 INFO - PROCESS | 14515 | Values: 67.0 69.0 73.0 67.0 69.0 71.0 68.0 66.0 65.0 71.0 04:22:34 INFO - PROCESS | 14515 | -------- Summary: end -------- 04:22:34 INFO - PROCESS | 14515 | 04:22:35 INFO - TEST-INFO | 14515: exit 0 04:22:35 INFO - TEST-OK | kraken | took 62499ms 04:22:35 INFO - SUITE-END | took 1179s 04:22:35 INFO - Completed test suite (00:19:39) 04:22:35 INFO - javascript benchmark 04:22:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6963.210879309062, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.5130379139337, 3044.771642126841, 3063.1882551123954, 3068.3863227354536, 3091.922701932451, 5344.545713614342, 5345.198220266957, 5355.464453554642, 5403.945960540394, 5489.4236105208975, 5414.945850541493, 5478.397376288605, 5484.561235101192, 5490.725463726808, 5507.146392309199, 4896.681715688469, 4929.605631549467, 4989.077020751154, 5009.724465154415, 5071.112555302826, 4913.680610760307, 4974.4081893794, 5022.19644856823, 5024.62315326352, 5039.143345631252, 4856.660033797635, 4960.6527543072, 5013.0, 5059.342285502879, 5100.41345245296, 4953.851384458472, 4974.179260422026, 5054.519820617035, 5072.467390923936, 5073.137566613666, 4814.085323788469, 4830.710157390533, 4842.927356089662, 4868.342773725572, 4884.755762211875, 5308.522232999048, 5360.919586206171, 5366.9463305366835, 5380.892382152374, 5403.675779453206, 5784.797532086399, 5826.650400975955, 5833.095870140092, 5842.415758424166, 5846.678432686201, 5770.278715160605, 5814.040683287252, 5842.795502157446, 5847.210626565445, 5875.0, 5401.675899446046, 5419.674819510842, 5437.265969094201, 5449.3188351456065, 5451.100568406168, 5803.187553742479, 5957.731902064417, 5958.225430693982, 5963.5527335450015, 5963.73163207648, 5630.4369563043365, 5654.434556544395, 5684.54523638108, 5692.544596432275, 5743.10981797822, 5730.942690573041, 5742.109972954198, 5748.166515855178, 5750.88498230033, 5751.971240143773, 5737.713114344266, 5767.36558978512, 5786.739596718074, 5786.797462088806, 5798.362180160263, 5645.0, 5713.342965558931, 5747.597668163188, 5748.770049198069, 5815.0, 4432.911341773147, 4436.423264975532, 4444.622207112432, 4485.955140448619, 4492.348609451611, 3951.130751234724, 3977.1846771411792, 3980.3432433648704, 4035.878923632296, 4044.373122166069, 5378.704171270618, 5485.232067510552, 5488.17677348401, 5532.861678458071, 5556.027695153332, 5840.649561026352, 5854.443827836349, 5864.354920958691, 5868.178455016301, 5875.941240587625, 5542.667439953616, 5548.278723765965, 5554.50009499147, 5561.193626924073, 5565.833025009256, 5023.572996295283, 5051.6716413433005, 5052.5452709255605, 5056.216286475602, 5063.012712521023, 5889.94110058894, 5940.4653581177035, 6007.939920600738, 6017.368176341509, 6039.0, 5786.103154011135, 5821.534277257894, 5833.212516310414, 5838.153467747238, 5840.1531777892815, 5958.821235362946, 5969.04495280753, 5976.073708575178, 5987.31145918225, 5991.490723288569, 5602.803901863578, 5626.5780066496, 5632.436756324335, 5669.20631111653, 5677.3471050829685, 5752.338481074563, 5769.91345129815, 5770.971145144247, 5782.277215348082, 5817.70911454434, 5556.99974004683, 5619.129034999582, 5620.943790562042, 5650.237217975685, 5655.462731040545, 5639.154126881001, 5722.914156287742, 5724.227229324155, 5773.451522105393, 5781.624194427349, 5552.3892371839875, 5647.3787883333625, 5652.660840349592, 5664.716764161693, 5681.857953551194, 5494.230807686847, 5566.972165139148, 5727.541796656341, 5755.827325180251, 5768.961586914395, 5566.749496272597, 5605.719714014202, 5621.241132447068, 5647.040003199384, 5709.20071190042], "value": 5351.534925570963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.5447859994102, 565.4515120333276, 572.1932075773161, 578.5429510686558, 584.7719389438117, 42703.572964270345, 43843.0, 44293.55706442935, 46308.536914630844, 46457.14171433147, 41862.79068604653, 41877.371839422434, 41967.160656786924, 42407.78796106023, 42756.786216068955, 8969.237614802749, 9075.727728168165, 9086.909130908705, 9099.772505687377, 9102.180803727662, 8930.955345223265, 8969.865452018224, 9039.186473217409, 9094.818103637923, 9104.36269461138, 9006.0, 9019.503927283997, 9043.457392556435, 9087.727368178932, 9110.681126160585, 9055.501947392891, 9114.58984345706, 9130.908690913138, 9134.08659134088, 9160.129787670161, 8852.690155844579, 8906.242969347613, 8919.598618062202, 8921.464712117293, 8922.910770892273, 42199.156016879795, 42766.358504622454, 42810.35784463236, 42898.356524652154, 42938.78530607358, 3238.627557830856, 3296.241864371208, 3306.404847127516, 3508.8771892983877, 3526.312369088029, 29380.0, 30771.384572308652, 31285.0, 31424.37151256985, 32810.17974550631, 4139.151473947833, 4179.937300940488, 4231.42875711778, 4250.128723611683, 4325.5025672047805, 335114.0, 335683.0, 336229.0, 337064.0, 339602.0, 57004.144937825964, 57123.42876571181, 57219.711211551905, 57247.0, 57743.71128144332, 61245.38754612486, 61479.38520614826, 61775.691121545, 61815.0, 61995.0, 15641.921790390976, 15969.201539922957, 16027.118508481912, 16031.67936641284, 16040.75938860918, 11996.160268781276, 12024.75950481003, 12029.939850300867, 12084.939575302067, 12125.39373031345, 17562.379133059712, 18326.17532211027, 18452.907735461504, 18541.629167416577, 18724.344647937258, 6994.510384273052, 7121.252268511732, 7204.56772593646, 7278.942844005531, 7460.664270107858, 859.4070091636751, 1012.9290949633455, 1086.1528008153653, 1104.7845670094255, 1139.6694958461953, 32246.355072898412, 32396.676033239837, 32598.0, 32637.836810815796, 33139.83430082882, 1059.782744537368, 1065.1478816946412, 1112.265904503024, 1121.7251773315427, 1126.695792136135, 16366.754498682529, 16950.40673576419, 17398.65202695939, 17457.822903291406, 17554.648907021787, 142706.0, 144456.0, 144540.0, 144867.275663621, 145486.0, 38058.61941380606, 38151.427728584094, 38213.99999999945, 38289.0, 38528.8073559636, 1227.1961864978452, 1237.1216436330126, 1275.7320962597773, 1282.2883299768719, 1296.1639742366121, 28719.569206461503, 30877.0, 31316.0, 31583.526247106773, 32110.839445802623, 44172.779136104116, 44371.33442998422, 45135.0, 45344.0, 45401.545984539734, 426426.0, 428221.0, 429238.0, 431901.0, 432186.0, 26554.0, 27461.725382745917, 27510.587341190298, 27538.17385478439, 27560.862195688893, 46422.53577464182, 46813.53186468092, 47272.29091563698, 47832.52167478281, 48179.277310839665, 39713.40429893496, 40547.0, 40896.38655420112, 41160.79419603002, 41902.37146442867, 39635.80182099071, 40594.59405405908, 40898.0, 41934.790326048176, 42491.0, 40606.59393406028, 41291.7935410321, 41848.095064314046, 42491.57508424876, 43206.35190472208, 32270.515942260416, 36811.26377472382, 37289.813550933155, 37397.439038413904, 37439.62560374361, 26637.0, 27040.32399190036, 27256.863715681295, 27275.727242728113, 27377.31556711098], "value": 18893.763096512594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.98444062237513, 390.3520156540144, 394.80062568402946, 398.960103989601, 420.70971029989306, 13877.69791364675, 17802.28790848366, 18058.72911906319, 19299.807001929978, 19332.323368682115, 17973.460796176103, 18342.358017469393, 18608.906955465238, 18677.159527821248, 18698.906505467454, 5135.8202462913805, 5220.269162317288, 5280.709560974145, 5286.603504737141, 5298.337707786527, 5227.137522308814, 5310.362756469229, 5311.1502159654465, 5312.760925758331, 5314.707691076989, 5275.49882761139, 5324.467553244684, 5560.916586251209, 5667.319921609392, 5695.0, 5683.431656834304, 5703.914441283384, 5722.885542289173, 5728.22668939692, 5740.741666625012, 4987.925181122286, 5155.871103222412, 5189.351331083614, 5194.97402512985, 5207.323048003773, 22239.44401389978, 22755.658665120038, 22993.88503057474, 23001.654975175385, 23158.884205579034, 2223.5219427823095, 2230.9939919461203, 2238.82089432845, 2299.5515874404496, 2678.933026674329, 10230.590776368936, 10279.074883260468, 10801.243912926098, 12438.502459901592, 13999.300034998209, 1877.6150889067708, 1913.3877159309027, 1938.5444420561157, 1954.853385996056, 1993.5240312159508, 84068.0, 85095.57452212762, 86229.56885215596, 87573.0, 89279.55360223158, 8234.917650823416, 8790.516521591373, 9306.906930930603, 9401.34190606651, 10981.364472526537, 11796.938275555069, 13044.152130111512, 13049.151805132637, 13076.019298552646, 13123.803142952864, 7025.89461158083, 7209.567425954459, 7228.76119940244, 7390.889136662954, 7417.740379086706, 6994.2656021117045, 7342.706291748377, 7481.625918704043, 7498.8765167024085, 7663.808404789925, 4020.3768415895584, 4052.6555242804693, 4092.570280120604, 4122.587741225913, 4169.791510424528, 1957.4910523263768, 1961.3527535913115, 1979.5842872996543, 2004.8596598238275, 2011.2960463837833, 893.8748575199477, 920.9585568649427, 987.950602469888, 1031.9690409287584, 1063.1176123817213, 18638.44084677435, 19184.520386990156, 19446.902765486364, 19671.803281966997, 19947.700784488243, 938.7183844846519, 952.7760976170595, 966.1546147121269, 990.8513722941616, 1027.9434631095212, 10635.787284254271, 10716.35701857891, 10721.746344291398, 10739.516721747541, 10824.78350432987, 447743.0, 450703.0, 452070.0, 456533.0, 456848.0, 76758.61620691861, 87376.563117184, 88858.55570722105, 89243.0, 89854.55072724725, 952.8808898887778, 978.1099199728355, 991.5686676295834, 998.6604554451521, 1005.5173516711873, 16604.916975415046, 16614.584635384213, 16912.492625221264, 17417.12914354252, 17516.124193790514, 31915.840420797747, 36257.63742362648, 41049.1790164201, 41798.37302440405, 42437.1512569753, 45489.0, 54411.0, 54832.725836372156, 54903.17645235245, 56272.15591766045, 7627.771166865003, 7850.803729906798, 7875.684972601031, 8071.152528984607, 8208.0, 10057.899421005697, 11493.988552003533, 12130.211536250115, 12493.126031095408, 12958.935205323913, 5730.5702072345575, 6060.666663333559, 11358.886411135783, 11844.28934263947, 11892.572891253105, 7718.764997600357, 10453.790924181625, 10712.410817405118, 10816.91830816912, 11299.491522881655, 11370.237613169971, 11766.52933882635, 11798.646040618794, 11817.527298907948, 11873.634532028927, 8626.0, 8634.78413039679, 8656.523891185794, 8771.254443372385, 8953.731388058368, 10790.406527641055, 11368.715782105513, 11383.804700506327, 11612.76774464489, 11997.880021200026], "value": 8770.397578531316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.6740483391236, 1449.3333066789276, 1595.0987691954044, 1752.983269703572, 1778.048743922002, 7787.299143077122, 8085.353171746261, 8468.872966905494, 9046.819063618723, 9049.41178823376, 8459.154084591537, 8796.252318552915, 8831.514266715329, 9028.593713282902, 9105.954470227656, 2317.733460652021, 2320.9767902321014, 2333.684952531412, 2347.3310106619615, 2356.140008896749, 2272.693186419837, 2285.223024171781, 2357.0925193800426, 2364.73987861336, 2366.0772298803395, 2285.702858628384, 2309.9884500577473, 2334.428065124047, 2334.6264597664376, 2343.3438637181616, 2276.3171048685326, 2279.7606251343536, 2308.4921317310163, 2308.7229532456045, 2314.2247347138727, 2236.2285011670947, 2238.250186187629, 2275.4538910661486, 2276.9544609107725, 2284.554511870186, 8967.237784788236, 9051.773705657346, 9068.410553314014, 9074.727758167199, 9075.727728168165, 5223.660462069954, 5265.710385928773, 5358.598105142091, 5378.489043540857, 5380.139177731583, 3099.1942095055224, 3143.135637699628, 3381.661833816623, 3401.1327111586634, 3444.569428821397, 1075.591275315383, 1084.8752393474772, 1120.1318977792196, 1141.4635121492886, 1141.9086473082134, 12626.621201363974, 12627.0, 12650.493980240779, 12729.618111456672, 12750.426230819636, 4428.73427594339, 4518.751468669255, 4600.677952543357, 4619.514950930171, 4758.643101767381, 10368.222383321281, 10377.533011014522, 10411.739706507398, 10481.318714283547, 10505.054545090978, 5227.215917612389, 5244.475552444725, 5296.232046353334, 5337.199420087018, 5339.7063161526485, 4229.978850105791, 4232.597903199191, 4706.552877476634, 4765.118453086121, 4844.467108618049, 3831.482749828793, 3853.3641949078647, 3854.5952674969285, 3879.3792993120965, 3980.1840622672285, 1196.946137423818, 1205.5900993662196, 1210.667066556704, 1215.7933151364111, 1218.9756204875853, 867.4751775176054, 871.6164887449502, 884.1247165306429, 901.3014913442134, 910.3445519226146, 5308.23030660552, 5333.679979201261, 5448.139726643464, 5485.50630443262, 5579.804706835242, 410.69813686940074, 434.6435922543547, 441.6731618602211, 443.8158164361754, 444.4044979727181, 3371.780834245815, 3556.5732112146707, 3683.2265224303196, 3704.240630670706, 3763.962360376361, 10480.475976201313, 10740.86282500769, 10940.288881222696, 11048.613298534674, 11059.391733454577, 10876.347419154876, 10922.617708380169, 10975.615853445252, 10978.176636752276, 11017.669469915916, 8250.46371985819, 8357.206065423776, 8399.244068033906, 8481.575921203792, 8500.872486912702, 5395.244665746877, 5442.972785136049, 5530.419305972815, 5621.690807005654, 5652.180433836988, 9866.112049915542, 9876.703698889045, 9901.0, 9979.251556133175, 10068.44623545712, 10119.190464762654, 10120.190384769348, 10308.484575771332, 10309.48452577353, 10350.585976560853, 7587.430942679432, 7867.488613240121, 7872.72445464406, 7917.168697286702, 7991.680332786624, 8589.957050214709, 8720.040795512616, 8792.208701216921, 8796.604152813266, 8810.735677929672, 7441.181470038183, 7570.621468926642, 7723.266289702694, 7832.530048197126, 7998.360131189607, 7416.7774966751085, 7526.360259377795, 7631.0, 7722.845543089219, 7831.0, 6662.500312476487, 6807.353301436356, 6819.693113809792, 6826.795196144124, 6898.551594146365, 4761.76191190446, 4803.871090293848, 4859.1496488113735, 4881.0, 5023.522765337287, 4665.300204969146, 4797.5682188601795, 4887.315775791321, 4905.77923993414, 4975.900481990412], "value": 4473.318179312733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.1540740297435, 331.3373253493014, 341.56962227593243, 343.4864877008872, 344.155099231387, 5376.650517716345, 5461.590380721447, 5526.89462107578, 5574.303212098488, 5611.382747897733, 5380.24676545283, 5464.535514481274, 5481.616286859921, 5500.28496295481, 5506.80726174584, 4260.0, 4270.295401258789, 4299.204647140274, 4317.956820431787, 4364.585364390377, 4218.725782824122, 4251.426057482231, 4296.419983302246, 4320.1143765527995, 4321.330193819963, 4243.915121697564, 4244.1140024783135, 4256.6807489438415, 4257.787110644471, 4276.486821581415, 4227.78861056949, 4284.6786491013145, 4285.807073730076, 4286.935695964563, 4313.82744690212, 3770.7360484766077, 3774.565924918642, 3787.9242415151816, 3789.1285004449132, 3800.7909564973916, 5099.464556221617, 5334.306540149794, 5352.090144675414, 5352.474544754765, 5352.812651557216, 4874.8537543873745, 4887.315775791392, 4888.462269150391, 4903.19097348937, 4905.950940490585, 5417.214503896952, 5699.2590963174525, 5750.894516960878, 5773.0, 5802.912956305659, 4012.598740125993, 4048.251073551373, 4068.4304197412384, 4078.775667338295, 4090.263752524574, 5871.178035075093, 5910.222195568076, 5927.0, 5943.583949123563, 5978.461938425563, 3945.191235796655, 4103.4870641169855, 4116.0533077392365, 4134.607212314825, 4142.689298302639, 4065.8780236592356, 4091.734037287567, 4097.672186225095, 4128.8348466061625, 4130.958690413117, 4736.526347365236, 4747.836779988925, 4751.667383283206, 4754.0, 4779.665423420397, 5583.827396246834, 5710.0, 5712.600117991784, 5712.857178570569, 5759.0, 1429.4353730276482, 1435.3397437179015, 1437.525616546558, 1441.9062760920506, 1448.3844366144347, 883.7437143228392, 915.9084091590921, 919.70569417787, 932.6756006470692, 938.558877327655, 4791.7718261008795, 4798.7840547175465, 4833.492483289274, 4847.491013443538, 4862.294967229732, 5104.642675012714, 5131.461196574306, 5136.948630513722, 5148.562372198405, 5152.536271735562, 4608.769561521911, 4829.372181616438, 4830.6135509159185, 4891.383110036114, 4894.0, 2671.7461841125064, 2707.4314393977484, 2726.2775364528416, 2729.8089133760845, 2733.8496382698745, 5171.422716071635, 5203.464977831549, 5244.711540865289, 5253.4221235664045, 5254.660061684246, 4981.8043669519775, 5186.740662966837, 5198.844034678966, 5215.53060224574, 5215.765290561933, 5276.604254680914, 5285.814996475182, 5289.761960711778, 5333.200019996954, 5347.385050719062, 5096.745162741922, 5108.3103780989095, 5146.845594632167, 5165.354330708661, 5185.714785686823, 4784.617230621472, 5091.338126043591, 5103.617228707936, 5123.231515272739, 5143.6399452039495, 5231.7705339246, 5242.951409718148, 5245.554127899171, 5253.817890974653, 5261.684298942076, 3768.3593789055376, 3769.095417099931, 3981.2634662587516, 4069.1658210066275, 4078.2455245779624, 5795.304563452412, 5808.273965754281, 5811.331696854747, 5821.126830975388, 5830.941690583039, 5676.886462270649, 5738.770449182153, 5767.125684152751, 5797.739101740347, 5813.854653633693, 5500.669959802424, 5638.746256418389, 5670.886582268414, 5687.60186786921, 5688.16049166819, 5650.0, 5700.743466544099, 5705.459525927893, 5715.742791574306, 5762.366139724543, 5521.254630624814, 5730.226419433323, 5740.712964351849, 5769.913451298318, 5824.475797178105, 5623.834823592864, 5626.578006649435, 5643.463870932255, 5670.716464176692, 5680.289963754531], "value": 4183.809755605025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.8957656351547, 732.6117157906305, 735.8270806360506, 814.0, 821.1049955548455, 12929.482820687173, 13169.670758231048, 13327.60017199483, 13452.798208026887, 13453.59639210824, 13058.869411305885, 13233.206007639525, 13250.469981200764, 13267.203967761941, 13277.933610331935, 760.1372442278013, 784.4195295481331, 784.6233807772272, 785.3167744062673, 789.2462698123308, 776.9494982826127, 777.4946284914794, 782.679101568357, 785.1520358013361, 786.8977032985704, 813.6419975210918, 814.3810703865046, 816.7835523586255, 821.5768879027306, 821.6056292979373, 800.1238643685156, 813.1340122769232, 813.6826637611307, 814.5804910471112, 815.8735396013627, 596.5466245653334, 602.57518449493, 602.8010756450404, 603.8007457539002, 605.8061420345491, 12109.212901161396, 12150.696232594168, 12234.510619575207, 12244.877551224463, 12265.632031039084, 12234.694132646666, 12318.445669944875, 12339.93830030844, 12560.685982850411, 12778.361081945959, 10504.36973781568, 10670.893291067068, 10799.67600971972, 10940.890591094067, 11009.119270458345, 3612.6567976042234, 3632.291703117893, 3679.5400574928135, 3683.9447408288897, 3733.253349330145, 65348.34651653517, 66739.3326066738, 68357.9999999995, 69115.65442172808, 69254.3074569253, 9119.407238529475, 9370.250379969586, 9517.5717092731, 9620.711378658512, 9662.227021838236, 18998.41887013851, 19471.90264048699, 19609.0, 19661.311854085037, 19700.84786434164, 7843.843123137505, 8098.6637204860535, 8180.100188979208, 8221.848941148244, 8253.752387428267, 4355.80398882051, 4549.567791059844, 4593.839215627437, 4596.241620132708, 4633.4208223972, 3317.4360358739073, 3473.166440054419, 3481.408160612702, 3505.9298814023578, 3509.420945543957, 565.8104534980745, 574.4341823304043, 575.32686756495, 595.6068994463719, 598.6677394046259, 679.5650783498564, 699.4579201119174, 722.140652623387, 726.2483329753785, 737.8897945161171, 9208.815823683488, 9325.601159826081, 9409.388389754644, 9492.240620750323, 9492.525373731423, 647.5790736021529, 660.9074729537869, 671.4225765841372, 675.0, 687.5530904911748, 4478.596926276651, 4530.0, 4551.294549344857, 4565.634749220055, 4584.518625544337, 86855.56572217225, 89088.0, 89389.55305223563, 89604.551977241, 90029.54985225032, 48349.51650483521, 75415.0, 76366.61816690881, 77103.0, 77319.61340193376, 68068.6596567024, 71207.0, 71649.0, 74211.62894185494, 74281.25718742743, 8496.405251632574, 8586.22723954847, 8745.956270218863, 8887.511186884783, 9060.864087038832, 47384.52615473939, 47655.046899062516, 47733.419993499934, 48602.0, 49078.5092149074, 39632.60367396289, 39721.40417893792, 53966.19050714164, 54117.0, 62301.68849155906, 11923.761524769283, 11974.760504789681, 12017.81973270419, 12105.81841272364, 12250.938745306217, 13441.260730659907, 13607.115537490032, 13859.861401385857, 13914.51299204523, 14650.120992740469, 12793.61619151427, 13283.136596121607, 13329.933350333185, 13950.511732089328, 14272.429102835771, 12883.355832208164, 12884.162529435556, 13219.801702974271, 13357.799633005317, 13441.865581344453, 12757.362131893182, 12985.805212921625, 12985.870141298845, 13196.60410187696, 13564.0, 9439.716808495756, 9640.42157470554, 10284.588616455258, 10531.94734026325, 10678.0, 8662.307015438624, 8690.43512171732, 9825.312228143961, 10022.799544008933, 10376.922962367416], "value": 6867.456279947473, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 110.0, 113.0, 113.0, 113.0, 114.0, 112.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 124.0, 175.0, 124.0, 129.0, 128.0, 126.0, 160.0, 123.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 166.0, 174.0, 164.0, 163.0, 161.0, 164.0, 162.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 119.0, 79.0, 77.0, 77.0, 76.0, 100.0, 77.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 82.0, 82.0, 81.0, 107.0, 82.0, 82.0, 112.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 120.0, 118.0, 120.0, 117.0, 118.0, 118.0, 119.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 149.0, 149.0, 147.0, 147.0, 147.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 86.0, 86.0, 85.0, 88.0, 86.0, 85.0, 88.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 55.0, 54.0, 55.0, 56.0, 59.0, 55.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 87.0, 81.0, 81.0, 82.0, 85.0, 80.0, 81.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 144.0, 133.0, 138.0, 153.0, 137.0, 132.0, 142.0, 178.0, 133.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 164.0, 169.0, 166.0, 170.0, 165.0, 163.0, 170.0, 167.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 73.0, 67.0, 69.0, 71.0, 68.0, 66.0, 65.0, 71.0], "value": 68.6, "unit": "score"}]}]} 04:22:35 INFO - Return code: 0 04:22:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:22:35 ERROR - # TBPL SUCCESS # 04:22:35 INFO - Running post-action listener: _resource_record_post_action 04:22:35 INFO - [mozharness: 2016-10-26 11:22:35.916314Z] Finished run-tests step (success) 04:22:35 INFO - Running post-run listener: _resource_record_post_run 04:22:35 INFO - Total resource usage - Wall time: 1196s; CPU: 14.0%; Read bytes: 4096; Write bytes: 394960896; Read time: 8; Write time: 333660 04:22:35 INFO - TinderboxPrint: CPU usage
13.5% 04:22:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:22:35 INFO - TinderboxPrint: I/O write bytes / time
394,960,896 / 333,660 04:22:35 INFO - TinderboxPrint: CPU idle
8,245.3 (86.4%) 04:22:35 INFO - TinderboxPrint: CPU user
1,224.2 (12.8%) 04:22:35 INFO - TinderboxPrint: Swap in / out
0 / 0 04:22:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105725952; Read time: 0; Write time: 111784 04:22:36 INFO - run-tests - Wall time: 1180s; CPU: 14.0%; Read bytes: 0; Write bytes: 288890880; Read time: 0; Write time: 221876 04:22:36 INFO - Running post-run listener: _upload_blobber_files 04:22:36 INFO - Blob upload gear active. 04:22:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:22:36 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 04:22:36 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'] 04:22:36 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 04:22:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:22:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:22:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:22:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:37 INFO - (blobuploader) - INFO - Done attempting. 04:22:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:22:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:22:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:41 INFO - (blobuploader) - INFO - Done attempting. 04:22:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:22:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:22:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:22:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:22:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:22:42 INFO - (blobuploader) - INFO - Done attempting. 04:22:42 INFO - (blobuploader) - INFO - Iteration through files over. 04:22:42 INFO - Return code: 0 04:22:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:22:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:22:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea2e2808924480d4175401112c6b302f02ef3b58ee1de019c301319d8fbee909fe8ab08d108bbffd84c7809af623561afb1bb76af77e1fc61f6e932e28261241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af5fa8501712fab6b86c0b1a25fb8fa9b2837f9b46769cfc62977dc76aa385eab2173f0b06d77abc4cdd5e13876c0d8a19e70318e672116b91d35c26bc787374", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18dab897bf50b85c1caa4cf4a79613c3319e6a6b0430f8e93fa4e6e820194fbc4c42d7c910d382d67a40b52ea1e9eceb32cb6d5a1e8d45acd0167e93ee08ed5f"} 04:22:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:22:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:22:42 INFO - Contents: 04:22:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea2e2808924480d4175401112c6b302f02ef3b58ee1de019c301319d8fbee909fe8ab08d108bbffd84c7809af623561afb1bb76af77e1fc61f6e932e28261241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af5fa8501712fab6b86c0b1a25fb8fa9b2837f9b46769cfc62977dc76aa385eab2173f0b06d77abc4cdd5e13876c0d8a19e70318e672116b91d35c26bc787374", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18dab897bf50b85c1caa4cf4a79613c3319e6a6b0430f8e93fa4e6e820194fbc4c42d7c910d382d67a40b52ea1e9eceb32cb6d5a1e8d45acd0167e93ee08ed5f"} 04:22:42 INFO - Running post-run listener: copy_logs_to_upload_dir 04:22:42 INFO - Copying logs to upload dir... 04:22:42 INFO - mkdir: /builds/slave/test/build/upload/logs 04:22:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.777033 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-26 04:22:41.383159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 04:22:41.386880) ========= 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=52faae308a556c440401f8e5000001e8-1477479724.131930-206509336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea2e2808924480d4175401112c6b302f02ef3b58ee1de019c301319d8fbee909fe8ab08d108bbffd84c7809af623561afb1bb76af77e1fc61f6e932e28261241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af5fa8501712fab6b86c0b1a25fb8fa9b2837f9b46769cfc62977dc76aa385eab2173f0b06d77abc4cdd5e13876c0d8a19e70318e672116b91d35c26bc787374", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18dab897bf50b85c1caa4cf4a79613c3319e6a6b0430f8e93fa4e6e820194fbc4c42d7c910d382d67a40b52ea1e9eceb32cb6d5a1e8d45acd0167e93ee08ed5f"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011511 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477467021/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ea2e2808924480d4175401112c6b302f02ef3b58ee1de019c301319d8fbee909fe8ab08d108bbffd84c7809af623561afb1bb76af77e1fc61f6e932e28261241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af5fa8501712fab6b86c0b1a25fb8fa9b2837f9b46769cfc62977dc76aa385eab2173f0b06d77abc4cdd5e13876c0d8a19e70318e672116b91d35c26bc787374", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/18dab897bf50b85c1caa4cf4a79613c3319e6a6b0430f8e93fa4e6e820194fbc4c42d7c910d382d67a40b52ea1e9eceb32cb6d5a1e8d45acd0167e93ee08ed5f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-26 04:22:41.412737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 04:22:41.413067) ========= 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=52faae308a556c440401f8e5000001e8-1477479724.131930-206509336 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-26 04:22:41.495407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 04:22:41.495727) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-26 04:22:41.496009) ========= ========= Total master_lag: 0.14 =========