builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1480159849.35 results: success (0) buildid: 20161126004005 builduid: 2dd85c114d6048d08be196af4bcca96f revision: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.347810) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.348313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.348612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.379034) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.379330) ========= 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=745a4373a2a16df560f216e000000264-1480150411.59490-882513106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-26 03:30:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-11-26 03:30:50 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.516413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.517068) ========= 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=745a4373a2a16df560f216e000000264-1480150411.59490-882513106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019941 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.567581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:49.567960) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d87b17a47f600b30cad7e7a48dfaa42d3faa7678 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d87b17a47f600b30cad7e7a48dfaa42d3faa7678 --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=745a4373a2a16df560f216e000000264-1480150411.59490-882513106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-26 03:30:51,117 truncating revision to first 12 chars 2016-11-26 03:30:51,117 Setting DEBUG logging. 2016-11-26 03:30:51,117 attempt 1/10 2016-11-26 03:30:51,117 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d87b17a47f60?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-26 03:30:51,413 unpacking tar archive at: mozilla-aurora-d87b17a47f60/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634293 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.215666) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.216015) ========= script_repo_revision: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.216444) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.216756) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-26 03:30:50.225954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-26 03:30:50.226444) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=745a4373a2a16df560f216e000000264-1480150411.59490-882513106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:51 INFO - MultiFileLogger online at 20161126 03:30:51 in /builds/slave/test 03:30:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:30:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:51 INFO - {'append_to_log': False, 03:30:51 INFO - 'base_work_dir': '/builds/slave/test', 03:30:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:30:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:51 INFO - 'branch': 'Mozilla-Aurora', 03:30:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:51 INFO - 'config_files': ('talos/linux_config.py',), 03:30:51 INFO - 'default_actions': ('clobber', 03:30:51 INFO - 'read-buildbot-config', 03:30:51 INFO - 'download-and-extract', 03:30:51 INFO - 'populate-webroot', 03:30:51 INFO - 'create-virtualenv', 03:30:51 INFO - 'install', 03:30:51 INFO - 'run-tests'), 03:30:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:51 INFO - 'download_minidump_stackwalk': True, 03:30:51 INFO - 'download_symbols': 'ondemand', 03:30:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:51 INFO - 'installer_path': 'installer.exe', 03:30:51 INFO - 'log_level': 'info', 03:30:51 INFO - 'log_name': 'talos', 03:30:51 INFO - 'log_to_console': True, 03:30:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:51 INFO - 'opt_config_files': (), 03:30:51 INFO - 'pip_index': False, 03:30:51 INFO - 'sps_profile': False, 03:30:51 INFO - 'sps_profile_interval': 0, 03:30:51 INFO - 'suite': 'dromaeojs-e10s', 03:30:51 INFO - 'system_bits': '32', 03:30:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:51 INFO - 'title': 'talos-linux64-ix-032', 03:30:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:51 INFO - 'use_talos_json': True, 03:30:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:51 INFO - 'work_dir': 'build'} 03:30:51 INFO - [mozharness: 2016-11-26 11:30:51.872970Z] Running clobber step. 03:30:51 INFO - Running pre-action listener: _resource_record_pre_action 03:30:51 INFO - Running main action method: clobber 03:30:51 INFO - rmtree: /builds/slave/test/build 03:30:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:52 INFO - Running post-action listener: _resource_record_post_action 03:30:52 INFO - [mozharness: 2016-11-26 11:30:52.850623Z] Finished clobber step (success) 03:30:52 INFO - [mozharness: 2016-11-26 11:30:52.850721Z] Running read-buildbot-config step. 03:30:52 INFO - Running pre-action listener: _resource_record_pre_action 03:30:52 INFO - Running main action method: read_buildbot_config 03:30:52 INFO - Using buildbot properties: 03:30:52 INFO - { 03:30:52 INFO - "project": "", 03:30:52 INFO - "product": "firefox", 03:30:52 INFO - "script_repo_revision": "production", 03:30:52 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:30:52 INFO - "repository": "", 03:30:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:30:52 INFO - "buildid": "20161126004005", 03:30:52 INFO - "stage_platform": "linux64-pgo", 03:30:52 INFO - "basedir": "/builds/slave/test", 03:30:52 INFO - "nightly_build": "True", 03:30:52 INFO - "buildnumber": 666, 03:30:52 INFO - "slavename": "talos-linux64-ix-032", 03:30:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:30:52 INFO - "platform": "ubuntu64_hw", 03:30:52 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:30:52 INFO - "branch": "mozilla-aurora", 03:30:52 INFO - "repo_path": "releases/mozilla-aurora", 03:30:52 INFO - "revision": "d87b17a47f600b30cad7e7a48dfaa42d3faa7678", 03:30:52 INFO - "pgo_build": "True", 03:30:52 INFO - "builduid": "2dd85c114d6048d08be196af4bcca96f", 03:30:52 INFO - "slavebuilddir": "test" 03:30:52 INFO - } 03:30:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:30:52 INFO - Running post-action listener: _resource_record_post_action 03:30:52 INFO - [mozharness: 2016-11-26 11:30:52.853192Z] Finished read-buildbot-config step (success) 03:30:52 INFO - [mozharness: 2016-11-26 11:30:52.853279Z] Running download-and-extract step. 03:30:52 INFO - Running pre-action listener: _resource_record_pre_action 03:30:52 INFO - Running main action method: download_and_extract 03:30:52 INFO - mkdir: /builds/slave/test/build/tests 03:30:52 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')]} 03:30:52 INFO - trying https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:52 INFO - Downloading https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:30:53 INFO - Downloaded 1361 bytes. 03:30:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:53 INFO - Using the following test package requirements: 03:30:53 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:53 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:53 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:53 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:53 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:30:53 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:53 INFO - u'jsshell-linux-x86_64.zip'], 03:30:53 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:53 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:53 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:53 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:53 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:30:53 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:53 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:30:53 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:53 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:53 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:53 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:53 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:30:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:53 INFO - Fetch https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:30:53 INFO - Http code: 200 03:30:53 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 03:30:53 INFO - x-amz-cf-id: Iekz3zK2GoZlmYkEeOMwBPrQV8v54xFfaFeZK12bdc8Rsy36SaDa8w== 03:30:53 INFO - x-amz-version-id: jTS9PUHa9e1xTTkyceU6MJz5saDMS5H7 03:30:54 INFO - Expected file size: 21951483 03:30:54 INFO - Obtained file size: 21951483 03:30:58 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:30:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:30:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:58 INFO - Fetch https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:30:58 INFO - Http code: 200 03:30:58 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 03:30:58 INFO - x-amz-cf-id: e9VdJMMDWFqUKMILZ_v7SJ450u5nKEWZ87nc3b7KBVtoTK0Vw18k9Q== 03:30:58 INFO - x-amz-version-id: jTS9PUHa9e1xTTkyceU6MJz5saDMS5H7 03:30:59 INFO - Expected file size: 21951483 03:30:59 INFO - Obtained file size: 21951483 03:31:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:31:03 INFO - Fetch https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:31:04 INFO - Http code: 200 03:31:04 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 03:31:04 INFO - x-amz-cf-id: ykosvHdkYFu8G04ndfmY7EmT_IUPrdpnGDjsVHKAxDdCLqRjNInNOg== 03:31:04 INFO - x-amz-version-id: Aj4ImqDA8y0lTly.spXZjjCGn0KGUY2o 03:31:04 INFO - Expected file size: 14409038 03:31:04 INFO - Obtained file size: 14409038 03:31:04 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')]} 03:31:04 INFO - trying https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:31:04 INFO - Downloading https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:31:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:31:05 INFO - Downloaded 63960267 bytes. 03:31:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:31:05 INFO - mkdir: /builds/slave/test/properties 03:31:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:05 INFO - Contents: 03:31:05 INFO - build_url:https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:31:06 INFO - Running post-action listener: _resource_record_post_action 03:31:06 INFO - Running post-action listener: set_extra_try_arguments 03:31:06 INFO - [mozharness: 2016-11-26 11:31:06.445859Z] Finished download-and-extract step (success) 03:31:06 INFO - [mozharness: 2016-11-26 11:31:06.446085Z] Running populate-webroot step. 03:31:06 INFO - Running pre-action listener: _resource_record_pre_action 03:31:06 INFO - Running main action method: populate_webroot 03:31:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:06 INFO - '--tppagecycles', 03:31:06 INFO - '7'], 03:31:06 INFO - 'tests': ['tsvgm']}}, 03:31:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:06 INFO - 'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:06 INFO - 'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['damp', 'tps']}, 03:31:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:06 INFO - 'tests': ['damp', 'tps']}, 03:31:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['dromaeo_dom']}, 03:31:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['basic_compositor_video']}, 03:31:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:31:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['a11yr', 03:31:06 INFO - 'ts_paint', 03:31:06 INFO - 'tpaint', 03:31:06 INFO - 'sessionrestore', 03:31:06 INFO - 'sessionrestore_no_auto_restore', 03:31:06 INFO - 'tabpaint']}, 03:31:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:06 INFO - 'ts_paint', 03:31:06 INFO - 'tpaint', 03:31:06 INFO - 'sessionrestore', 03:31:06 INFO - 'sessionrestore_no_auto_restore', 03:31:06 INFO - 'tabpaint']}, 03:31:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:06 INFO - 'ts_paint', 03:31:06 INFO - 'tpaint', 03:31:06 INFO - 'sessionrestore', 03:31:06 INFO - 'sessionrestore_no_auto_restore', 03:31:06 INFO - 'tabpaint']}, 03:31:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:06 INFO - 'ts_paint', 03:31:06 INFO - 'tpaint', 03:31:06 INFO - 'sessionrestore', 03:31:06 INFO - 'sessionrestore_no_auto_restore', 03:31:06 INFO - 'tabpaint']}, 03:31:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['a11yr', 03:31:06 INFO - 'ts_paint', 03:31:06 INFO - 'tpaint', 03:31:06 INFO - 'sessionrestore', 03:31:06 INFO - 'sessionrestore_no_auto_restore', 03:31:06 INFO - 'tabpaint']}, 03:31:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['a11yr', 03:31:06 INFO - 'ts_paint', 03:31:06 INFO - 'tpaint', 03:31:06 INFO - 'sessionrestore', 03:31:06 INFO - 'sessionrestore_no_auto_restore', 03:31:06 INFO - 'tabpaint']}, 03:31:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['tsvgx', 03:31:06 INFO - 'tsvgr_opacity', 03:31:06 INFO - 'tart', 03:31:06 INFO - 'tscrollx', 03:31:06 INFO - 'cart']}, 03:31:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:06 INFO - 'tsvgr_opacity', 03:31:06 INFO - 'tart', 03:31:06 INFO - 'tscrollx', 03:31:06 INFO - 'cart']}, 03:31:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:06 INFO - 'talos_options': ['--disable-e10s'], 03:31:06 INFO - 'tests': ['tp5o']}, 03:31:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:06 INFO - 'tests': ['tp5o']}, 03:31:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:06 INFO - 'talos_options': ['--disable-e10s', 03:31:06 INFO - '--xperf_path', 03:31:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:06 INFO - 'tests': ['tp5n']}, 03:31:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:06 INFO - 'talos_options': ['--xperf_path', 03:31:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:06 INFO - 'tests': ['tp5n']}}, 03:31:06 INFO - 'talos.zip': {'path': '', 03:31:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:06 INFO - Running post-action listener: _resource_record_post_action 03:31:06 INFO - [mozharness: 2016-11-26 11:31:06.461446Z] Finished populate-webroot step (success) 03:31:06 INFO - [mozharness: 2016-11-26 11:31:06.461534Z] Running create-virtualenv step. 03:31:06 INFO - Running pre-action listener: _resource_record_pre_action 03:31:06 INFO - Running main action method: create_virtualenv 03:31:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:06 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 03:31:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:06 INFO - Using real prefix '/usr' 03:31:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:09 INFO - Installing pip.................done. 03:31:09 INFO - Return code: 0 03:31:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:31:09 INFO - Reading from file tmpfile_stdout 03:31:09 INFO - Output received: 03:31:09 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) 03:31:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:31:09 INFO - Using env: {'DISPLAY': ':0', 03:31:09 INFO - 'HOME': '/home/cltbld', 03:31:09 INFO - 'LANG': 'en_US.UTF-8', 03:31:09 INFO - 'LANGUAGE': 'en_US:en', 03:31:09 INFO - 'LOGNAME': 'cltbld', 03:31:09 INFO - 'MAIL': '/var/mail/cltbld', 03:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:09 INFO - 'MOZ_NO_REMOTE': '1', 03:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:09 INFO - 'NO_EM_RESTART': '1', 03:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:09 INFO - 'PWD': '/builds/slave/test', 03:31:09 INFO - 'SHELL': '/bin/bash', 03:31:09 INFO - 'SHLVL': '1', 03:31:09 INFO - 'TERM': 'linux', 03:31:09 INFO - 'TMOUT': '86400', 03:31:09 INFO - 'USER': 'cltbld', 03:31:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:09 INFO - '_': '/tools/buildbot/bin/python'} 03:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:09 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 03:31:09 INFO - Cleaning up... 03:31:09 INFO - Return code: 0 03:31:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:31:09 INFO - Using env: {'DISPLAY': ':0', 03:31:09 INFO - 'HOME': '/home/cltbld', 03:31:09 INFO - 'LANG': 'en_US.UTF-8', 03:31:09 INFO - 'LANGUAGE': 'en_US:en', 03:31:09 INFO - 'LOGNAME': 'cltbld', 03:31:09 INFO - 'MAIL': '/var/mail/cltbld', 03:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:09 INFO - 'MOZ_NO_REMOTE': '1', 03:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:09 INFO - 'NO_EM_RESTART': '1', 03:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:09 INFO - 'PWD': '/builds/slave/test', 03:31:09 INFO - 'SHELL': '/bin/bash', 03:31:09 INFO - 'SHLVL': '1', 03:31:09 INFO - 'TERM': 'linux', 03:31:09 INFO - 'TMOUT': '86400', 03:31:09 INFO - 'USER': 'cltbld', 03:31:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:09 INFO - '_': '/tools/buildbot/bin/python'} 03:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:09 INFO - Downloading/unpacking psutil>=3.1.1 03:31:09 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 03:31:09 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 03:31:09 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 03:31:09 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 03:31:09 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 03:31:09 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 03:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:11 INFO - Installing collected packages: psutil 03:31:11 INFO - Running setup.py install for psutil 03:31:11 INFO - building 'psutil._psutil_linux' extension 03:31:11 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 03:31:11 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 03:31:11 INFO - building 'psutil._psutil_posix' extension 03:31:11 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 03:31:12 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 03:31:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:12 INFO - Successfully installed psutil 03:31:12 INFO - Cleaning up... 03:31:12 INFO - Return code: 0 03:31:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:12 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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:12 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 03:31:12 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 03:31:12 INFO - Using env: {'DISPLAY': ':0', 03:31:12 INFO - 'HOME': '/home/cltbld', 03:31:12 INFO - 'LANG': 'en_US.UTF-8', 03:31:12 INFO - 'LANGUAGE': 'en_US:en', 03:31:12 INFO - 'LOGNAME': 'cltbld', 03:31:12 INFO - 'MAIL': '/var/mail/cltbld', 03:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:12 INFO - 'MOZ_NO_REMOTE': '1', 03:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:12 INFO - 'NO_EM_RESTART': '1', 03:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:12 INFO - 'PWD': '/builds/slave/test', 03:31:12 INFO - 'SHELL': '/bin/bash', 03:31:12 INFO - 'SHLVL': '1', 03:31:12 INFO - 'TERM': 'linux', 03:31:12 INFO - 'TMOUT': '86400', 03:31:12 INFO - 'USER': 'cltbld', 03:31:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:12 INFO - '_': '/tools/buildbot/bin/python'} 03:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:12 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 03:31:12 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 03:31:12 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 03:31:12 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 03:31:12 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 03:31:12 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 03:31:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:14 INFO - Installing collected packages: mozsystemmonitor 03:31:14 INFO - Running setup.py install for mozsystemmonitor 03:31:14 INFO - Successfully installed mozsystemmonitor 03:31:14 INFO - Cleaning up... 03:31:14 INFO - Return code: 0 03:31:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:31:14 INFO - Using env: {'DISPLAY': ':0', 03:31:14 INFO - 'HOME': '/home/cltbld', 03:31:14 INFO - 'LANG': 'en_US.UTF-8', 03:31:14 INFO - 'LANGUAGE': 'en_US:en', 03:31:14 INFO - 'LOGNAME': 'cltbld', 03:31:14 INFO - 'MAIL': '/var/mail/cltbld', 03:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:14 INFO - 'MOZ_NO_REMOTE': '1', 03:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:14 INFO - 'NO_EM_RESTART': '1', 03:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:14 INFO - 'PWD': '/builds/slave/test', 03:31:14 INFO - 'SHELL': '/bin/bash', 03:31:14 INFO - 'SHLVL': '1', 03:31:14 INFO - 'TERM': 'linux', 03:31:14 INFO - 'TMOUT': '86400', 03:31:14 INFO - 'USER': 'cltbld', 03:31:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:14 INFO - '_': '/tools/buildbot/bin/python'} 03:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 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 03:31:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:17 INFO - warning: no files found matching '*.txt' 03:31:17 INFO - no previously-included directories found matching 'build' 03:31:17 INFO - no previously-included directories found matching 'dist' 03:31:17 INFO - no previously-included directories found matching '.git*' 03:31:17 INFO - Installing collected packages: jsonschema, functools32 03:31:17 INFO - Running setup.py install for functools32 03:31:17 INFO - warning: no files found matching '*.txt' 03:31:17 INFO - no previously-included directories found matching 'build' 03:31:17 INFO - no previously-included directories found matching 'dist' 03:31:17 INFO - no previously-included directories found matching '.git*' 03:31:17 INFO - Successfully installed jsonschema functools32 03:31:17 INFO - Cleaning up... 03:31:17 INFO - Return code: 0 03:31:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:31:17 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')]} 03:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:17 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')]} 03:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:17 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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:17 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 03:31:17 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 03:31:17 INFO - Using env: {'DISPLAY': ':0', 03:31:17 INFO - 'HOME': '/home/cltbld', 03:31:17 INFO - 'LANG': 'en_US.UTF-8', 03:31:17 INFO - 'LANGUAGE': 'en_US:en', 03:31:17 INFO - 'LOGNAME': 'cltbld', 03:31:17 INFO - 'MAIL': '/var/mail/cltbld', 03:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:17 INFO - 'MOZ_NO_REMOTE': '1', 03:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:17 INFO - 'NO_EM_RESTART': '1', 03:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:17 INFO - 'PWD': '/builds/slave/test', 03:31:17 INFO - 'SHELL': '/bin/bash', 03:31:17 INFO - 'SHLVL': '1', 03:31:17 INFO - 'TERM': 'linux', 03:31:17 INFO - 'TMOUT': '86400', 03:31:17 INFO - 'USER': 'cltbld', 03:31:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:17 INFO - '_': '/tools/buildbot/bin/python'} 03:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:31:17 INFO - Cleaning up... 03:31:17 INFO - Return code: 0 03:31:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:17 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')]} 03:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:17 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')]} 03:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:17 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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:17 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 03:31:17 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 03:31:17 INFO - Using env: {'DISPLAY': ':0', 03:31:17 INFO - 'HOME': '/home/cltbld', 03:31:17 INFO - 'LANG': 'en_US.UTF-8', 03:31:17 INFO - 'LANGUAGE': 'en_US:en', 03:31:17 INFO - 'LOGNAME': 'cltbld', 03:31:17 INFO - 'MAIL': '/var/mail/cltbld', 03:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:17 INFO - 'MOZ_NO_REMOTE': '1', 03:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:17 INFO - 'NO_EM_RESTART': '1', 03:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:17 INFO - 'PWD': '/builds/slave/test', 03:31:17 INFO - 'SHELL': '/bin/bash', 03:31:17 INFO - 'SHLVL': '1', 03:31:17 INFO - 'TERM': 'linux', 03:31:17 INFO - 'TMOUT': '86400', 03:31:17 INFO - 'USER': 'cltbld', 03:31:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:17 INFO - '_': '/tools/buildbot/bin/python'} 03:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:20 INFO - Downloading docopt-0.6.1.tar.gz 03:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:20 INFO - Running setup.py install for blobuploader 03:31:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:20 INFO - Running setup.py install for requests 03:31:20 INFO - Running setup.py install for docopt 03:31:20 INFO - Successfully installed blobuploader requests docopt 03:31:20 INFO - Cleaning up... 03:31:21 INFO - Return code: 0 03:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:21 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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:21 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 03:31:21 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 03:31:21 INFO - Using env: {'DISPLAY': ':0', 03:31:21 INFO - 'HOME': '/home/cltbld', 03:31:21 INFO - 'LANG': 'en_US.UTF-8', 03:31:21 INFO - 'LANGUAGE': 'en_US:en', 03:31:21 INFO - 'LOGNAME': 'cltbld', 03:31:21 INFO - 'MAIL': '/var/mail/cltbld', 03:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:21 INFO - 'MOZ_NO_REMOTE': '1', 03:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:21 INFO - 'NO_EM_RESTART': '1', 03:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:21 INFO - 'PWD': '/builds/slave/test', 03:31:21 INFO - 'SHELL': '/bin/bash', 03:31:21 INFO - 'SHLVL': '1', 03:31:21 INFO - 'TERM': 'linux', 03:31:21 INFO - 'TMOUT': '86400', 03:31:21 INFO - 'USER': 'cltbld', 03:31:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:21 INFO - '_': '/tools/buildbot/bin/python'} 03:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:21 INFO - Running setup.py (path:/tmp/pip-X0X6hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:21 INFO - Running setup.py (path:/tmp/pip-MTvg05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:21 INFO - Running setup.py (path:/tmp/pip-MiNT8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:21 INFO - Running setup.py (path:/tmp/pip-_htlFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:21 INFO - Running setup.py (path:/tmp/pip-wVC2Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:21 INFO - Running setup.py (path:/tmp/pip-1FnwA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:21 INFO - Running setup.py (path:/tmp/pip-rnFbfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:21 INFO - Running setup.py (path:/tmp/pip-aYghjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:21 INFO - Running setup.py (path:/tmp/pip-2uvK1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:21 INFO - Running setup.py (path:/tmp/pip-S_gbuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:21 INFO - Running setup.py (path:/tmp/pip-llmza3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:22 INFO - Running setup.py (path:/tmp/pip-8tF30f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:22 INFO - Running setup.py (path:/tmp/pip-svWa2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:22 INFO - Running setup.py (path:/tmp/pip-D7QRyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:22 INFO - Running setup.py (path:/tmp/pip-KlKw2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:22 INFO - Running setup.py (path:/tmp/pip-Rw1mxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:22 INFO - Running setup.py (path:/tmp/pip-HqmQwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:22 INFO - Running setup.py install for manifestparser 03:31:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Running setup.py install for mozcrash 03:31:22 INFO - Running setup.py install for mozdebug 03:31:22 INFO - Running setup.py install for mozdevice 03:31:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:22 INFO - Running setup.py install for mozfile 03:31:22 INFO - Running setup.py install for mozhttpd 03:31:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for mozinfo 03:31:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for mozInstall 03:31:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for mozleak 03:31:23 INFO - Running setup.py install for mozlog 03:31:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for moznetwork 03:31:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for mozprocess 03:31:23 INFO - Running setup.py install for mozprofile 03:31:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for mozrunner 03:31:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:23 INFO - Running setup.py install for mozscreenshot 03:31:24 INFO - Running setup.py install for moztest 03:31:24 INFO - Running setup.py install for mozversion 03:31:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:24 INFO - Cleaning up... 03:31:24 INFO - Return code: 0 03:31:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:24 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')]} 03:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:24 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')]} 03:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:24 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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:24 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 03:31:24 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 03:31:24 INFO - Using env: {'DISPLAY': ':0', 03:31:24 INFO - 'HOME': '/home/cltbld', 03:31:24 INFO - 'LANG': 'en_US.UTF-8', 03:31:24 INFO - 'LANGUAGE': 'en_US:en', 03:31:24 INFO - 'LOGNAME': 'cltbld', 03:31:24 INFO - 'MAIL': '/var/mail/cltbld', 03:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:24 INFO - 'MOZ_NO_REMOTE': '1', 03:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:24 INFO - 'NO_EM_RESTART': '1', 03:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:24 INFO - 'PWD': '/builds/slave/test', 03:31:24 INFO - 'SHELL': '/bin/bash', 03:31:24 INFO - 'SHLVL': '1', 03:31:24 INFO - 'TERM': 'linux', 03:31:24 INFO - 'TMOUT': '86400', 03:31:24 INFO - 'USER': 'cltbld', 03:31:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:24 INFO - '_': '/tools/buildbot/bin/python'} 03:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:24 INFO - Running setup.py (path:/tmp/pip-xDOZ2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:24 INFO - Running setup.py (path:/tmp/pip-O1hr84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:24 INFO - Running setup.py (path:/tmp/pip-kQNxaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:24 INFO - Running setup.py (path:/tmp/pip-rccdzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:24 INFO - Running setup.py (path:/tmp/pip-y5x2jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:24 INFO - Running setup.py (path:/tmp/pip-Ge5fcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:24 INFO - Running setup.py (path:/tmp/pip-sK_aVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:24 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)) 03:31:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:24 INFO - Running setup.py (path:/tmp/pip-bhPPqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:25 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)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:25 INFO - Running setup.py (path:/tmp/pip-_FH6qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:25 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)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:25 INFO - Running setup.py (path:/tmp/pip-A7l7QO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:25 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)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:25 INFO - Running setup.py (path:/tmp/pip-rqA9tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:25 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)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:25 INFO - Running setup.py (path:/tmp/pip-qgEO9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:25 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)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:25 INFO - Running setup.py (path:/tmp/pip-MdHEJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:25 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)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:25 INFO - Running setup.py (path:/tmp/pip-2crN9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:25 INFO - Running setup.py (path:/tmp/pip-lbNVXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:25 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)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:25 INFO - Running setup.py (path:/tmp/pip-XLr1GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:25 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)) 03:31:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:25 INFO - Running setup.py (path:/tmp/pip-N_hxAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:25 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)) 03:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:25 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)) 03:31:25 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)) 03:31:25 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)) 03:31:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:27 INFO - Downloading blessings-1.6.tar.gz 03:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:27 INFO - Installing collected packages: blessings 03:31:27 INFO - Running setup.py install for blessings 03:31:27 INFO - Successfully installed blessings 03:31:27 INFO - Cleaning up... 03:31:27 INFO - Return code: 0 03:31:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:28 INFO - Reading from file tmpfile_stdout 03:31:28 INFO - Current package versions: 03:31:28 INFO - argparse == 1.2.1 03:31:28 INFO - blessings == 1.6 03:31:28 INFO - blobuploader == 1.2.4 03:31:28 INFO - docopt == 0.6.1 03:31:28 INFO - functools32 == 3.2.3-2 03:31:28 INFO - jsonschema == 2.5.1 03:31:28 INFO - manifestparser == 1.1 03:31:28 INFO - mozInstall == 1.12 03:31:28 INFO - mozcrash == 1.0 03:31:28 INFO - mozdebug == 0.1 03:31:28 INFO - mozdevice == 0.48 03:31:28 INFO - mozfile == 1.2 03:31:28 INFO - mozhttpd == 0.7 03:31:28 INFO - mozinfo == 0.9 03:31:28 INFO - mozleak == 0.1 03:31:28 INFO - mozlog == 3.4 03:31:28 INFO - moznetwork == 0.27 03:31:28 INFO - mozprocess == 0.23 03:31:28 INFO - mozprofile == 0.28 03:31:28 INFO - mozrunner == 6.13 03:31:28 INFO - mozscreenshot == 0.1 03:31:28 INFO - mozsystemmonitor == 0.3 03:31:28 INFO - moztest == 0.7 03:31:28 INFO - mozversion == 1.4 03:31:28 INFO - psutil == 3.1.1 03:31:28 INFO - requests == 1.2.3 03:31:28 INFO - wsgiref == 0.1.2 03:31:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:28 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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:28 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 03:31:28 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 03:31:28 INFO - Using env: {'DISPLAY': ':0', 03:31:28 INFO - 'HOME': '/home/cltbld', 03:31:28 INFO - 'LANG': 'en_US.UTF-8', 03:31:28 INFO - 'LANGUAGE': 'en_US:en', 03:31:28 INFO - 'LOGNAME': 'cltbld', 03:31:28 INFO - 'MAIL': '/var/mail/cltbld', 03:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:28 INFO - 'MOZ_NO_REMOTE': '1', 03:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:28 INFO - 'NO_EM_RESTART': '1', 03:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:28 INFO - 'PWD': '/builds/slave/test', 03:31:28 INFO - 'SHELL': '/bin/bash', 03:31:28 INFO - 'SHLVL': '1', 03:31:28 INFO - 'TERM': 'linux', 03:31:28 INFO - 'TMOUT': '86400', 03:31:28 INFO - 'USER': 'cltbld', 03:31:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:28 INFO - '_': '/tools/buildbot/bin/python'} 03:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 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)) 03:31:28 INFO - Cleaning up... 03:31:28 INFO - Return code: 0 03:31:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:28 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 0x7f2b7ab7cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe61ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, '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': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', '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 03:31:28 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 03:31:28 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 03:31:28 INFO - Using env: {'DISPLAY': ':0', 03:31:28 INFO - 'HOME': '/home/cltbld', 03:31:28 INFO - 'LANG': 'en_US.UTF-8', 03:31:28 INFO - 'LANGUAGE': 'en_US:en', 03:31:28 INFO - 'LOGNAME': 'cltbld', 03:31:28 INFO - 'MAIL': '/var/mail/cltbld', 03:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:28 INFO - 'MOZ_NO_REMOTE': '1', 03:31:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:28 INFO - 'NO_EM_RESTART': '1', 03:31:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:28 INFO - 'PWD': '/builds/slave/test', 03:31:28 INFO - 'SHELL': '/bin/bash', 03:31:28 INFO - 'SHLVL': '1', 03:31:28 INFO - 'TERM': 'linux', 03:31:28 INFO - 'TMOUT': '86400', 03:31:28 INFO - 'USER': 'cltbld', 03:31:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:28 INFO - '_': '/tools/buildbot/bin/python'} 03:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:28 INFO - Cleaning up... 03:31:28 INFO - Return code: 0 03:31:28 INFO - Running post-action listener: _resource_record_post_action 03:31:28 INFO - Running post-action listener: _start_resource_monitoring 03:31:28 INFO - Starting resource monitoring. 03:31:28 INFO - [mozharness: 2016-11-26 11:31:28.653330Z] Finished create-virtualenv step (success) 03:31:28 INFO - [mozharness: 2016-11-26 11:31:28.653876Z] Running install step. 03:31:28 INFO - Running pre-action listener: _resource_record_pre_action 03:31:28 INFO - Running main action method: install 03:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:28 INFO - Reading from file tmpfile_stdout 03:31:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:28 INFO - Reading from file tmpfile_stdout 03:31:28 INFO - Output received: 03:31:28 INFO - Usage: mozinstall [options] installer 03:31:28 INFO - Options: 03:31:28 INFO - -h, --help show this help message and exit 03:31:28 INFO - -d DEST, --destination=DEST 03:31:28 INFO - Directory to install application into. [default: 03:31:28 INFO - "/builds/slave/test"] 03:31:28 INFO - --app=APP Application being installed. [default: firefox] 03:31:28 INFO - mkdir: /builds/slave/test/build/application 03:31:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:31:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:31:44 INFO - Reading from file tmpfile_stdout 03:31:44 INFO - Output received: 03:31:44 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:44 INFO - Running post-action listener: _resource_record_post_action 03:31:44 INFO - [mozharness: 2016-11-26 11:31:44.864200Z] Finished install step (success) 03:31:44 INFO - [mozharness: 2016-11-26 11:31:44.864441Z] Running run-tests step. 03:31:44 INFO - Running pre-action listener: _resource_record_pre_action 03:31:44 INFO - Running main action method: run_tests 03:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:44 INFO - Python 2.7.3 03:31:44 INFO - Return code: 0 03:31:44 INFO - grabbing minidump binary from tooltool 03:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:44 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 0xe5ef60>, '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 0xe5fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe601d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:44 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 03:31:44 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 03:31:44 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 03:31:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:44 INFO - Return code: 0 03:31:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 03:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 03:31:44 INFO - Using env: {'DISPLAY': ':0', 03:31:44 INFO - 'HOME': '/home/cltbld', 03:31:44 INFO - 'LANG': 'en_US.UTF-8', 03:31:44 INFO - 'LANGUAGE': 'en_US:en', 03:31:44 INFO - 'LOGNAME': 'cltbld', 03:31:44 INFO - 'MAIL': '/var/mail/cltbld', 03:31:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:44 INFO - 'MOZ_NO_REMOTE': '1', 03:31:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:44 INFO - 'NO_EM_RESTART': '1', 03:31:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:44 INFO - 'PWD': '/builds/slave/test', 03:31:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:44 INFO - 'SHELL': '/bin/bash', 03:31:44 INFO - 'SHLVL': '1', 03:31:44 INFO - 'TERM': 'linux', 03:31:44 INFO - 'TMOUT': '86400', 03:31:44 INFO - 'USER': 'cltbld', 03:31:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1480150411.59490-882513106', 03:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:44 INFO - '_': '/tools/buildbot/bin/python'} 03:31:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 03:31:45 INFO - mozversion application_buildid: 20161126004005 03:31:45 INFO - mozversion application_changeset: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 03:31:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:31:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:45 INFO - mozversion application_name: Firefox 03:31:45 INFO - mozversion application_remotingname: firefox-dev 03:31:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:45 INFO - mozversion application_vendor: Mozilla 03:31:45 INFO - mozversion application_version: 52.0a2 03:31:45 INFO - mozversion platform_buildid: 20161126004005 03:31:45 INFO - mozversion platform_changeset: d87b17a47f600b30cad7e7a48dfaa42d3faa7678 03:31:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:45 INFO - mozversion platform_version: 52.0a2 03:31:45 INFO - using testdate: 1480159905 03:31:45 INFO - actual date: 1480159905 03:31:45 INFO - starting webserver on 'localhost:58895' 03:31:45 INFO - SUITE-START | Running 2 tests 03:31:45 INFO - TEST-START | dromaeo_css 03:31:45 INFO - operating with platform_type : linux_ 03:31:45 INFO - Initialising browser for dromaeo_css test... 03:31:45 INFO - TEST-INFO | started process 3924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptzgLBW/profile http://localhost:58895/getInfo.html) 03:31:50 INFO - PROCESS | 3924 | __metrics Screen width/height:1600/1200 03:31:50 INFO - PROCESS | 3924 | colorDepth:24 03:31:50 INFO - PROCESS | 3924 | Browser inner width/height: 1024/697 03:31:50 INFO - PROCESS | 3924 | __metrics 03:31:50 ERROR - PROCESS | 3924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:31:51 INFO - TEST-INFO | 3924: exit 0 03:31:51 INFO - Browser initialized. 03:31:51 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:51 INFO - TEST-INFO | started process 4055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptzgLBW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:03 INFO - PROCESS | 4055 | RSS: Main: 151871488 03:32:03 INFO - PROCESS | 4055 | 03:32:53 INFO - PROCESS | 4055 | 1480159973314 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] 03:35:04 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58895/tests/dromaeo/cssquery-ext.html) 03:35:05 INFO - PROCESS | 4055 | RSS: Main: 156053504 03:35:05 INFO - PROCESS | 4055 | 03:38:07 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-ext.html (next: http://localhost:58895/tests/dromaeo/cssquery-jquery.html) 03:38:08 INFO - PROCESS | 4055 | RSS: Main: 153763840 03:38:08 INFO - PROCESS | 4055 | 03:41:10 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58895/tests/dromaeo/cssquery-mootools.html) 03:41:10 INFO - PROCESS | 4055 | RSS: Main: 152772608 03:41:10 INFO - PROCESS | 4055 | 03:44:12 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58895/tests/dromaeo/cssquery-prototype.html) 03:44:13 INFO - PROCESS | 4055 | RSS: Main: 152010752 03:44:13 INFO - PROCESS | 4055 | 03:47:15 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58895/tests/dromaeo/cssquery-yui.html) 03:47:16 INFO - PROCESS | 4055 | RSS: Main: 154873856 03:47:16 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:58895/tests/dromaeo/cssquery-yui.html (next: http://localhost:58895/tests/dromaeo/cssquery-dojo.html) 03:50:18 INFO - PROCESS | 4055 | RSS: Main: 154914816 03:50:18 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | __start_tp_report 03:50:18 INFO - PROCESS | 4055 | _x_x_mozilla_page_load 03:50:18 INFO - PROCESS | 4055 | _x_x_mozilla_page_load_details 03:50:18 INFO - PROCESS | 4055 | |i|pagename|runs| 03:50:18 INFO - PROCESS | 4055 | |0;dojo.html;3309.66903309669;3338.1487720631235;3338.9499157512632;3346.9791713527366;3353.312570922961;5760.855978600532;5786.508146807521;5807.245058142441;5817.970910145454;5838.737256823442;5841.591088623798;5885.4997325227405;5889.528837692985;5897.646141231518;5899.2036075129845;5265.684058956465;5337.2794672719265;5355.384130824966;5365.141577347626;5372.892542149155;5399.595030372718;5402.729863506828;5404.162354834987;5407.026735187665;5446.183072539111;5177.508136727005;5178.119719647669;5371.140617501201;5404.270423492818;5411.648242864201;5270.262163297122;5285.180796976475;5297.993381257549;5309.893802123975;5351;5168.948310516885;5256.159014557652;5262.131748261532;5298.231756395339;5348.1442969124755;5825.038868586678;5871.647701137946;5872.5889187756875;5908.970455147697;5935.881282374328;6079.817605471843;6099.939000609981;6118.3269840317525;6121.081837724332;6145.985912324461;6172.698064805396;6185.938140618581;6213.689315534205;6239.438450539473;6263.937360626381;5712.571557133231;5856.267966504187;5869.882602347929;5876.706164691748;5907.793227237069;6191.783287584913;6232.189815323979;6232.688365581794;6258.874822503524;6382.457491113215;6109.053096770008;6113.633182009094;6120.908186377208;6123.601965872204;6142.232220972379;6185.072239164071;6202.875942481125;6206.565540412218;6207.162033125561;6211.130441738161;5931.673757943268;6067.2112625359305;6068.089786532056;6080.027195648675;6092.086187071886;6180.5673602848265;6198.039303907902;6202.875942481125;6205.100260462208;6220.284667263232;4745.098431298043;4753.429588449409;4761.5714585686765;4762.309465127537;4812.109759694467;4188.602082802129;4204.474440694913;4207.26372884744;4218.8312467500955;4224.429701990253;5933.495652869555;5968;5982.162497250389;6010.549208809357;6036;6089.117078023751;6225.533085018642;6229.968850155811;6267.6866156692895;6270.059491076375;5843.853903652443;5885.676287804212;5901.114832775118;5919.786443779015;6026.276846778414;5329.706866122323;5338.893222135535;5339.038972984822;5341.3857406398765;5366.463353664681;6528.575642583407;6533.1180290661105;6551.0173473979285;6553.4101930826455;6562.901556476561;6071.210742603434;6124.755009799558;6145.463634091477;6168.784092556739;6184.196054512884;6487.156669632917;6509.511786616117;6511.674416279262;6513.934860651333;6558.540902136805;6146.139540464249;6190.969045154746;6192.783252586138;6194.256689197145;6211.65835879031;6084.574079814548;6136.7948077883175;6138.662373569497;6146.723397447215;6291.339409362135;6145.231846019247;6184.783532576518;6196.318404975359;6201.906971395342;6203.038529028008;6136.987397079611;6143.938560614337;6145.047517634774;6152.753889844356;6155.107509411021;5879.73541190656;5905.734241959208;5941.405859414024;5962.761489540369;6043.2748070231855;6064.666443345658;6136.610985192662;6182.319944805978;6191.535634827496;6193.287771906108;6004.34229243097;6011.909821352596;6031.879362412815;6034.668093254738;6070.0591408331775 03:50:18 INFO - PROCESS | 4055 | |1;ext.html;603.7554790309924;617.9505639548837;639.0924886660941;643.6363454648126;669.7890164598148;40234;43189.784051079776;43214.78392608037;43432.565674343285;43460.56539434605;43013.569864301346;43036.354454683205;43610;43631.345529817;43671.12657746843;8493.36299777516;8592.785180370478;8606.139386061406;8624.266937310336;8625.137486251388;8521.95739021304;8623.870641940375;8656.783580410509;8657.783555411102;8675.609597568093;8647.913520864773;8665.566721663923;8694.39139260252;8704.390692651517;8705.173008564176;8567.271781898546;8626.396152269344;8643.697470588499;8656.783580410509;8672.52301123438;8580.742577722616;8630.180132887428;8641.351898607629;8651.134886511298;8653.697120600811;41864.790676046425;42226;42274;42280.365794513105;42346.57653423488;3501.77238479498;3631.2555926035097;4002.2595819773437;4246.150769846012;4262.722923010026;32329.353412931843;32332.191695207574;32532.674673253438;32597.185070373194;33002.17494562631;4550.704204226715;4556.567126123013;4579.244424669925;4589.059242855206;4594.333821595883;346546.9999999975;348100;348192;348299;348933;59573.40426595765;59763.40236597578;60151.69924150351;60170.69914650486;60197;63729;63759;63777.36222637714;63857;63938;18698.252069917322;18902.338418155574;18938.526536836413;18992.240310387708;19024.239030438628;15017.699646007019;15028.849711502964;15071.246437678072;15117.848821511863;15129.167895765839;16370.672586548202;16466.83533164653;16548.669026619402;16602.75095873563;16849.578760531083;6412.198475190601;6502.902456463157;6529.640869752209;6576.704048317837;6623.8739414298725;936.3585943628636;1009.0867764672983;1012.473513772834;1082.3397727386289;1116.6823148684468;31067.223319416742;31728.841355793535;32175.67824321727;32213.194670133435;32226.516602250984;1110.4780753046055;1116.3748300951493;1129.0628778114146;1177.9469923853276;1191.3209470601846;16886.40897568579;17365.2185651646;17425.390111346296;17549.91225043892;17584.12079396025;499695;504541;505069;505996;506433;60695.69652151711;60963.695181523806;60971.390286097456;60994.69502652458;61011.694941525006;1383.4258782605107;1422.6585619451464;1438.8345340285791;1443.0475885915246;1446.1034158821599;30179.849100754356;31566.842165789025;31625.84187079142;31862.522062169548;32396;52034.21948670848;52765.472345277594;52773;52904.47095528995;52948.47051529436;418801;419060;419142;419460;420302;41353.586464134976;41539.1692166161;42786.78606606947;42997.35503967506;43152;48461.27308090311;48851.755741221066;49246.753766232374;49720.75139624423;50866.23700644419;40997.54014759124;41622.37566436567;42865.35701964411;43379;43898.78050609727;41122.383164251965;41255.7937210312;41818.79090604527;42455.15089698127;43247.702568922985;37893.81053094717;38930.80534597309;40886.38670420006;42010;44737.328940066574;35620.46569301515;36686.26627467382;36822;37075.258494830494;37419.251614967005;28146.008167100383;28637.71362286434;28656.57015144733;28690.282742931595;28734.425311493236 03:50:18 INFO - PROCESS | 4055 | |2;jquery.html;419.20978954670437;425.9723117997332;426.5862113749663;430.09894271501196;450.8895320646442;19039.52401189969;20102.59794804103;20360.08379622917;20556;20701.378958631245;17069.57326066849;18869.433916982478;19256.90371548144;19296.421107366765;19416.320428784995;5183.326167598226;5437.782488700447;5439;5439.292891924044;5440.129579267318;4006.3589825627905;5345.705986170759;5409;5415.972920135414;6343.365663433666;6481.93518064818;6484.092227088211;6488.837779055514;6498.285188629271;6503.057056726771;6245.500359971192;6386.936130638681;6421.8394540136405;6440.645764482952;6492.383223593751;5611.775528978836;5749.971250143764;5757.68332741699;5783.826485205408;5790.305163380379;14217;14539.200343981076;22743.090276388924;23888.761112388827;24213.515729685307;2295.6556516522487;2334.4280651240383;2455.1897873701637;2569.0366112707734;2770;10972.780544389147;11270.211085224038;11443.427828608535;11538;13122.015848811281;1906.9427917162368;1988.6519859024756;2007.6687346587796;2069.193014724259;2113.19698514565;77996;82691.17308826956;85249.57375213085;89325.55337223338;93958;11536;11723.769004254431;11900.464479098462;12132.636020919386;12323.815142772686;17268.222929968182;17269.39557115495;17313.39403120885;17337.306507739802;17358.39245626397;7231.566106033655;7480.364169045583;7533.585652789039;8119.634616442156;9137.63449462014;8599.61301741423;8648.610812513452;8660.740177794676;8809.647614095493;8815.338849586307;5039.748012599355;5122.410922743858;5186.118359878829;5231.973840130775;5291.100512912814;1807.6746185686702;1847.8706490545533;2130.552583957355;2217.2239716099557;2230.252865290146;954.8854137503544;962.8459446488528;980.2158273381267;1000.3997601439079;1037.0355569320604;18879.3392231274;19400.611987760167;19783.802161978198;19847.30534431288;20140.597188056156;985.8225519406576;1006.8691070160833;1013.1337706261188;1035.5133087448887;1067.4395942130288;9894.257930655229;10826.67519974402;10922.672319830417;10925.672229833117;10982.780344393228;522314;525375;529967;539314;549366;93758.53120734352;95213.52393237989;95220;97603;100172;1035.8601588785418;1056.2078441169124;1086.6088208245026;1091.252492042953;1097.429336744904;18303.084845757927;18620.44138675842;18699.439016829518;19095.52261193481;19255.13351899196;32331.676683232865;33777.66222337844;44359;44571.77714111538;46044.079118416776;65047.67476162778;66260;66829;67309;68388.31611683819;9215.585298661443;9238.815223695623;9381.765455863659;12556.488702259767;12803.87196128064;12598.118131730691;12918.612441626767;13430.731385372042;13525.256110913993;13971.091879028238;11625.069994400259;11717.531298748296;11719.17965742424;11922.880771192176;13183.934080329536;11720.589779358022;12365.567205147776;12688.809667855174;12885.162464439782;13044.086913916315;13015.544455943997;13211;13252.138610990254;13295.20228786276;13331.200127992352;12778.68053298675;13310;13351.532696355582;13388.866111339152;13501.797473037715;12176.269423834598;12410;12566.748665026831;12674.302913339854;12797.232166070065 03:50:18 INFO - PROCESS | 4055 | |3;mootools.html;1498.3706843125885;1528.3351741992235;1661.6042524279603;1691.7716108325371;1773.6009397885477;7648.770536883902;7839.490433121843;8134.67461301548;8689.261412779913;8703.651853925836;7843.921560784391;8057.1539988301265;8082.232187942136;8234.38242131841;8251.504909705422;2456.214011516311;2488.502299540099;2490.2280293109193;2493.2395619336094;2500.3374105861963;2413.2398294537165;2514.8113891458124;2518.3829961659326;2529.620556916459;2529.7090834553987;2452.2520631207476;2488.6142647889606;2490.9750902491014;2491.6511688363644;2494.5260400523935;2358.905643774247;2368.6802281691926;2403.9158629447975;2427.3324835670155;2428.8178386621075;2215.0586000949693;2232.3079845248026;2238.2389987404363;2244.1920908472935;2380.143148466568;8374.748757537283;8505.149485051445;8553.40126191167;8565.571721413904;8584.31325493959;5374.731263436852;5485.807996720096;5490.286262785812;5492.093804522249;5495.587830912697;3439.9656003439895;3488.354654388946;3582.9104272393397;3610.079429745398;3652.105234217607;1180.887815657511;1193.5643490126042;1223.406647775828;1234.2902830872194;1272.7899896517063;11487.597934072352;11548.3648399338;11569.074474042056;11624;11684.182107252496;4703.318018887242;4860.149473842063;4867.805287788519;4933.309336692866;4938.802447902043;9846.359986600992;9869.605215791431;9892.208623310262;9895.901040989498;9951.80096398068;5514.476124768221;5529.585281103933;5544.861378465571;5548.472895074961;5552.083906155439;4541.659375546781;4712.104700106968;4961.42943561495;5041.924371134436;5083.8983220335385;4135.001790474706;4154.1068670236045;4198.916021679549;4222.19778242133;4229.746215227096;1381.716748066644;1389.124851343647;1390.2840037380756;1397.8672026157499;1427.1722401007391;855.9572021398906;980.9019098090134;994.472929347447;1003.372891942536;1010.8483727440943;5865.4427829357;5970.402959704082;5976.133460648181;6012.789552365646;6016.09758536223;463.30041637127505;463.9164950308909;465.8276437718066;473.48390254622626;475.1731986343737;4087.0191154122795;4122.134351786159;4138.193052354762;4158.438610787565;4162.1259535497275;9996.750081248027;10496.475176241158;10513.474326283807;10539.998700123477;10540.683779486628;10306.33008854422;10367.740806479747;10394.16846652266;10397.532111055021;10400.947995259976;7595.810104747315;7923.445358824943;7956.7215147470715;8036.156203598655;8054.436189466681;5965.940340596712;6005.459508644243;6122.5408094392205;6147.569670123227;6229.96885015572;9449.574769135543;9663.420194788336;9826.115649591571;9837.213022958289;9859.211263098792;9644.614215431304;9781.119699227103;9804.26468014916;9821.558029888529;9829.164521015793;6860.588364698134;7066.328698773608;7390.334869861738;7501.137369202612;7626.428017898791;7934.523928564305;8227.917720822716;8245.83508329842;8289.4197406181;8293.875591866248;7439.665215065227;7443.813904652427;7470.551766894004;7517.210692877388;7529.774106776806;7358.595277259802;7392.44556658242;7448.031755871702;7465.552066876005;7485.588292643957;6828.317168283132;6943.47923905699;6988.720451181895;7005.369516743517;7015.579065255897;4966.428860681068;5060.696358218519;5071.54356107952;5099.847004589868;5257.158854583248;5056.924146137737;5106.106431374569;5142.537171654569;5233.188855727369;5330.253764473055 03:50:18 INFO - PROCESS | 4055 | |4;prototype.html;342.1190434630826;345.8293675907054;346.4889288299758;357.3389229924639;358.183341980285;5632.915821146176;5694.430556944303;5695.971520142393;5714.571407144465;5727.312722473309;5563.36021357544;5609.4757359188325;5609.971950140254;5630.634008789426;5650.3219613646315;3957.643812056914;4207.179599978005;4323.329883868006;4384.4519435070615;4392.824287028515;4415.867523974286;4437.047699012441;4447.155040542303;4455.153520831048;4466.731996080245;4456.9777151114195;4457.710248833815;4459.487158976727;4476.350929115276;4490.371348011281;4185.602367775087;4355.368471571636;4395.406620106277;4475.731456112628;4488.259437192875;3862.555806082308;3870.1098747288283;3871.5160604924386;3871.5741268460447;3887.6198949372847;5515.227868098469;5538.529225015878;5546.639468434539;5547.55619550435;5564.248826408423;4949.604031677457;4996.17639561561;5045.47022562633;5071.188609822448;5107.591392688576;5881.735321910524;5883.764649414018;5894;5920;5920.940790592125;4308.46144231971;4317.11499142675;4318.568143185687;4321.848735294249;4325.783710814447;6013.308469525973;6062.818115456499;6106.4809491192855;6122.234720659918;6133.6319820810895;4273.252180868398;4290.592393722592;4297.72064815786;4301.860007098121;4308.9353659695125;4370.737755734666;4371.825126994884;4373.934390984138;4374.540673229265;4392.692511524227;4876.5854902332985;4949.529794669501;4990.426100998432;5025.899482010413;5042;5878.382769809194;5898.050974512744;5923.466887980103;5933.732982015819;6001.7599296027665;1486.0340778494065;1494.6487575419767;1497.1466264229502;1499.6925630245773;1507.6532397548626;1009.7425156585024;1018.8471729240673;1028.2699283508794;1038.2887721910515;1041.250299784154;5429.6199266051;5534.861628459321;5567.276254086943;5568.220449137043;5589.441055894378;5859.794907178229;5870.354261031283;5870.653727375355;5875.882482350415;5876.559258055663;5514.558835293167;5597.888042239214;5733.111367738007;5834.883302333929;5896.410358964069;3127.37452509499;3130.968690313068;3152.9752830330235;3157.5105858591955;3161.0674850919036;6068;6156.260464093525;6270.059491076284;6302.527310451735;6382.393672601095;6080.665563394055;6255.310216606812;6255.562110652301;6259.186305780219;6303.653299068504;6314.905276420857;6373.74505019794;6391.01878417692;6439.356064393523;6471;6159.753609855556;6179.69101544912;6197.287311959182;6222.62664240147;6234.75060997555;5912.379200183918;6050.364711705208;6054.485368743706;6068.848278793065;6102.565897014287;6350.491960643045;6375.298717141018;6408.4232419080645;6412.61524308543;6426.903596445964;4191.455110835694;4372.584604462571;4426.645868330462;4443.777811109496;4444.755538445416;6053.667048312385;6061.636301821904;6081.239845019372;6101.772852908568;6121.204243448323;5952.404759524013;5982.52139828804;6000.249968753906;6045.758169673164;6069.2688290270435;5826.213461182686;5838.678872661874;5905.704714764331;5913.91129133072;5983.790567330123;5866.384029676822;5868.354481007171;5908.822735317947;5918.816236752753;5924.060499767606;5848.473637372657;5925.674087925206;6001.4298641628975;6054.878902422015;6069.119977603311;5803;5819.9736137207565;5820.185174075548;5828.76684932598;5830.854228644318 03:50:18 INFO - PROCESS | 4055 | |5;yui.html;758.7116895579683;799.9400044996623;836.8661014237722;857.2327766648854;868.6959564152545;15093.396264149435;15604.531864044096;15746.606334841621;15849.762253566205;15860;14492;14596.124232546028;14597.124172549627;14613.634659133528;14638.926805365985;835.9707410240627;853.8676505141713;856.7900864288227;858.3305022082785;859.8237361340941;848.5545088828384;849.2823564088367;850.7277671145235;853.2619284319051;858.3090612057291;892.8660700894885;893.1604291965564;900.2392977933669;900.2437952120217;904.0281697175529;890.0698769785557;890.3767362846002;893.821235752852;894.2622336572289;894.789724414762;664.050407916679;664.3821246240994;664.4352300544499;664.6178447392768;665.5773583774289;13941.093828901088;14041.22773247471;14072.22602756848;14076.436942522287;14079.296035198198;12589.622311330675;13001;13259.86740132596;13336.333183340794;13432.664183395493;11277.492512836941;11327.433628318551;12059.577914773028;12131.878681213251;12156.149069565134;3945.3687410014545;4001.199760047973;4001.8199181036925;4002.9199416011515;4013.57857424972;59060;63189.368106318805;63342.366576334105;67565.32434675639;69598.3040169597;11958;12003.579874704517;12491.188072775241;12634.557790477289;12782.23306601607;21889;22022.33932982013;22102.557948840935;22172.113115475524;22415.21546745856;8841.425307355;8974.730758077269;9004.144606262395;9472.857907131262;9567.712968610953;4868.245421959602;5028.79884804611;5085.885323545369;5105.285260063594;5162.948370516322;3798.734088613826;3862.671672907778;3918.5689574146822;3928.273269445162;3936.842526298916;642.3448082955359;647.207171215267;654.6595770199469;658.2134349452358;677.2245778583494;647.7635662982977;704.8977898204731;761.8362052158813;762.4396068889362;812.3054788156041;9618.403031181542;10495.317804342845;10568.313059651098;10597.62908298206;10601.363918164781;762.6803048735029;770.9103207484238;789.5529983744411;809.639710328898;811.975640730779;4595.563421474954;4870.4155501339355;4870.902581948341;4946.1344264753525;4949.327363223891;87379;88974;90803.54598226967;92222.53888730513;95968.52015739877;52934.20598691023;54925;65991;69755.95366069411;77756.61121694355;43431.131377372905;62148.68925655433;67723.66138169277;68532.31467685259;69181.3081869175;10161.187105031728;10428.426436546062;10676.679699609023;10677.839832402366;10903.454827258764;47777.522224777305;47855.28217076677;48583;48662.27006594833;49304.75347623239;56919.29242122743;62098.0685289712;63332;63420.68289658522;65002;12363.69090772738;12651.367431628198;12841.422136004088;12984.350782461028;13072.215667060007;15191.164485953379;15423.768643470581;15437.22813859325;15475.458358957383;15735.842641573896;14189.503367382093;14522.273886305853;14597.197154156624;14649.707005860037;14716.264186790404;13586.388612512263;13638.659033524242;13648;13961.72043654045;14052.508162214273;13220.603381898558;13322.800157997444;13376.197428154343;13469.39387727535;13585.184888906697;11132.443377830914;11152.052075573343;11236.550537978716;11344.773104538028;11507.079433645456;11523.942380288045;11561.942190288995;11835.349055802013;11905.940470297593;11962.70093247641 03:50:18 INFO - PROCESS | 4055 | __end_tp_report 03:50:18 INFO - PROCESS | 4055 | __start_cc_report 03:50:18 INFO - PROCESS | 4055 | _x_x_mozilla_cycle_collect,310 03:50:18 INFO - PROCESS | 4055 | __end_cc_report 03:50:18 INFO - PROCESS | 4055 | __startTimestamp1480161018682__endTimestamp 03:50:18 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | ------- Summary: start ------- 03:50:18 INFO - PROCESS | 4055 | Number of tests: 6 03:50:18 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | [#0] dojo.html Cycles:165 Average:5787.54 Median:6034.67 stddev:658.01 (10.9%) stddev-sans-first:630.66 03:50:18 INFO - PROCESS | 4055 | Values: 3309.7 3338.1 3338.9 3347.0 3353.3 5760.9 5786.5 5807.2 5818.0 5838.7 5841.6 5885.5 5889.5 5897.6 5899.2 5265.7 5337.3 5355.4 5365.1 5372.9 5399.6 5402.7 5404.2 5407.0 5446.2 5177.5 5178.1 5371.1 5404.3 5411.6 5270.3 5285.2 5298.0 5309.9 5351.0 5168.9 5256.2 5262.1 5298.2 5348.1 5825.0 5871.6 5872.6 5909.0 5935.9 6079.8 6099.9 6118.3 6121.1 6146.0 6172.7 6185.9 6213.7 6239.4 6263.9 5712.6 5856.3 5869.9 5876.7 5907.8 6191.8 6232.2 6232.7 6258.9 6382.5 6109.1 6113.6 6120.9 6123.6 6142.2 6185.1 6202.9 6206.6 6207.2 6211.1 5931.7 6067.2 6068.1 6080.0 6092.1 6180.6 6198.0 6202.9 6205.1 6220.3 4745.1 4753.4 4761.6 4762.3 4812.1 4188.6 4204.5 4207.3 4218.8 4224.4 5933.5 5968.0 5982.2 6010.5 6036.0 6089.1 6225.5 6230.0 6267.7 6270.1 5843.9 5885.7 5901.1 5919.8 6026.3 5329.7 5338.9 5339.0 5341.4 5366.5 6528.6 6533.1 6551.0 6553.4 6562.9 6071.2 6124.8 6145.5 6168.8 6184.2 6487.2 6509.5 6511.7 6513.9 6558.5 6146.1 6191.0 6192.8 6194.3 6211.7 6084.6 6136.8 6138.7 6146.7 6291.3 6145.2 6184.8 6196.3 6201.9 6203.0 6137.0 6143.9 6145.0 6152.8 6155.1 5879.7 5905.7 5941.4 5962.8 6043.3 6064.7 6136.6 6182.3 6191.5 6193.3 6004.3 6011.9 6031.9 6034.7 6070.1 03:50:18 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | [#1] ext.html Cycles:180 Average:59617.75 Median:4254.44 stddev:113277.89 (2662.6%) stddev-sans-first:113509.01 03:50:18 INFO - PROCESS | 4055 | Values: 603.8 618.0 639.1 643.6 669.8 40234.0 43189.8 43214.8 43432.6 43460.6 43013.6 43036.4 43610.0 43631.3 43671.1 8493.4 8592.8 8606.1 8624.3 8625.1 8522.0 8623.9 8656.8 8657.8 8675.6 8647.9 8665.6 8694.4 8704.4 8705.2 8567.3 8626.4 8643.7 8656.8 8672.5 8580.7 8630.2 8641.4 8651.1 8653.7 41864.8 42226.0 42274.0 42280.4 42346.6 3501.8 3631.3 4002.3 4246.2 4262.7 32329.4 32332.2 32532.7 32597.2 33002.2 4550.7 4556.6 4579.2 4589.1 4594.3 346547.0 348100.0 348192.0 348299.0 348933.0 59573.4 59763.4 60151.7 60170.7 60197.0 63729.0 63759.0 63777.4 63857.0 63938.0 18698.3 18902.3 18938.5 18992.2 19024.2 15017.7 15028.8 15071.2 15117.8 15129.2 16370.7 16466.8 16548.7 16602.8 16849.6 6412.2 6502.9 6529.6 6576.7 6623.9 936.4 1009.1 1012.5 1082.3 1116.7 31067.2 31728.8 32175.7 32213.2 32226.5 1110.5 1116.4 1129.1 1177.9 1191.3 16886.4 17365.2 17425.4 17549.9 17584.1 499695.0 504541.0 505069.0 505996.0 506433.0 60695.7 60963.7 60971.4 60994.7 61011.7 1383.4 1422.7 1438.8 1443.0 1446.1 30179.8 31566.8 31625.8 31862.5 32396.0 52034.2 52765.5 52773.0 52904.5 52948.5 418801.0 419060.0 419142.0 419460.0 420302.0 41353.6 41539.2 42786.8 42997.4 43152.0 48461.3 48851.8 49246.8 49720.8 50866.2 40997.5 41622.4 42865.4 43379.0 43898.8 41122.4 41255.8 41818.8 42455.2 43247.7 37893.8 38930.8 40886.4 42010.0 44737.3 35620.5 36686.3 36822.0 37075.3 37419.3 28146.0 28637.7 28656.6 28690.3 28734.4 03:50:18 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | [#2] jquery.html Cycles:180 Average:31112.14 Median:11407.29 stddev:87883.47 (770.4%) stddev-sans-first:88099.79 03:50:18 INFO - PROCESS | 4055 | Values: 419.2 426.0 426.6 430.1 450.9 19039.5 20102.6 20360.1 20556.0 20701.4 17069.6 18869.4 19256.9 19296.4 19416.3 5183.3 5437.8 5439.0 5439.3 5440.1 4006.4 5345.7 5409.0 5416.0 6343.4 6481.9 6484.1 6488.8 6498.3 6503.1 6245.5 6386.9 6421.8 6440.6 6492.4 5611.8 5750.0 5757.7 5783.8 5790.3 14217.0 14539.2 22743.1 23888.8 24213.5 2295.7 2334.4 2455.2 2569.0 2770.0 10972.8 11270.2 11443.4 11538.0 13122.0 1906.9 1988.7 2007.7 2069.2 2113.2 77996.0 82691.2 85249.6 89325.6 93958.0 11536.0 11723.8 11900.5 12132.6 12323.8 17268.2 17269.4 17313.4 17337.3 17358.4 7231.6 7480.4 7533.6 8119.6 9137.6 8599.6 8648.6 8660.7 8809.6 8815.3 5039.7 5122.4 5186.1 5232.0 5291.1 1807.7 1847.9 2130.6 2217.2 2230.3 954.9 962.8 980.2 1000.4 1037.0 18879.3 19400.6 19783.8 19847.3 20140.6 985.8 1006.9 1013.1 1035.5 1067.4 9894.3 10826.7 10922.7 10925.7 10982.8 522314.0 525375.0 529967.0 539314.0 549366.0 93758.5 95213.5 95220.0 97603.0 100172.0 1035.9 1056.2 1086.6 1091.3 1097.4 18303.1 18620.4 18699.4 19095.5 19255.1 32331.7 33777.7 44359.0 44571.8 46044.1 65047.7 66260.0 66829.0 67309.0 68388.3 9215.6 9238.8 9381.8 12556.5 12803.9 12598.1 12918.6 13430.7 13525.3 13971.1 11625.1 11717.5 11719.2 11922.9 13183.9 11720.6 12365.6 12688.8 12885.2 13044.1 13015.5 13211.0 13252.1 13295.2 13331.2 12778.7 13310.0 13351.5 13388.9 13501.8 12176.3 12410.0 12566.7 12674.3 12797.2 03:50:18 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | [#3] mootools.html Cycles:180 Average:5683.42 Median:5102.98 stddev:3087.10 (60.5%) stddev-sans-first:3079.74 03:50:18 INFO - PROCESS | 4055 | Values: 1498.4 1528.3 1661.6 1691.8 1773.6 7648.8 7839.5 8134.7 8689.3 8703.7 7843.9 8057.2 8082.2 8234.4 8251.5 2456.2 2488.5 2490.2 2493.2 2500.3 2413.2 2514.8 2518.4 2529.6 2529.7 2452.3 2488.6 2491.0 2491.7 2494.5 2358.9 2368.7 2403.9 2427.3 2428.8 2215.1 2232.3 2238.2 2244.2 2380.1 8374.7 8505.1 8553.4 8565.6 8584.3 5374.7 5485.8 5490.3 5492.1 5495.6 3440.0 3488.4 3582.9 3610.1 3652.1 1180.9 1193.6 1223.4 1234.3 1272.8 11487.6 11548.4 11569.1 11624.0 11684.2 4703.3 4860.1 4867.8 4933.3 4938.8 9846.4 9869.6 9892.2 9895.9 9951.8 5514.5 5529.6 5544.9 5548.5 5552.1 4541.7 4712.1 4961.4 5041.9 5083.9 4135.0 4154.1 4198.9 4222.2 4229.7 1381.7 1389.1 1390.3 1397.9 1427.2 856.0 980.9 994.5 1003.4 1010.8 5865.4 5970.4 5976.1 6012.8 6016.1 463.3 463.9 465.8 473.5 475.2 4087.0 4122.1 4138.2 4158.4 4162.1 9996.8 10496.5 10513.5 10540.0 10540.7 10306.3 10367.7 10394.2 10397.5 10400.9 7595.8 7923.4 7956.7 8036.2 8054.4 5965.9 6005.5 6122.5 6147.6 6230.0 9449.6 9663.4 9826.1 9837.2 9859.2 9644.6 9781.1 9804.3 9821.6 9829.2 6860.6 7066.3 7390.3 7501.1 7626.4 7934.5 8227.9 8245.8 8289.4 8293.9 7439.7 7443.8 7470.6 7517.2 7529.8 7358.6 7392.4 7448.0 7465.6 7485.6 6828.3 6943.5 6988.7 7005.4 7015.6 4966.4 5060.7 5071.5 5099.8 5257.2 5056.9 5106.1 5142.5 5233.2 5330.3 03:50:18 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | [#4] prototype.html Cycles:180 Average:4996.76 Median:5631.77 stddev:1478.29 (26.2%) stddev-sans-first:1440.56 03:50:18 INFO - PROCESS | 4055 | Values: 342.1 345.8 346.5 357.3 358.2 5632.9 5694.4 5696.0 5714.6 5727.3 5563.4 5609.5 5610.0 5630.6 5650.3 3957.6 4207.2 4323.3 4384.5 4392.8 4415.9 4437.0 4447.2 4455.2 4466.7 4457.0 4457.7 4459.5 4476.4 4490.4 4185.6 4355.4 4395.4 4475.7 4488.3 3862.6 3870.1 3871.5 3871.6 3887.6 5515.2 5538.5 5546.6 5547.6 5564.2 4949.6 4996.2 5045.5 5071.2 5107.6 5881.7 5883.8 5894.0 5920.0 5920.9 4308.5 4317.1 4318.6 4321.8 4325.8 6013.3 6062.8 6106.5 6122.2 6133.6 4273.3 4290.6 4297.7 4301.9 4308.9 4370.7 4371.8 4373.9 4374.5 4392.7 4876.6 4949.5 4990.4 5025.9 5042.0 5878.4 5898.1 5923.5 5933.7 6001.8 1486.0 1494.6 1497.1 1499.7 1507.7 1009.7 1018.8 1028.3 1038.3 1041.3 5429.6 5534.9 5567.3 5568.2 5589.4 5859.8 5870.4 5870.7 5875.9 5876.6 5514.6 5597.9 5733.1 5834.9 5896.4 3127.4 3131.0 3153.0 3157.5 3161.1 6068.0 6156.3 6270.1 6302.5 6382.4 6080.7 6255.3 6255.6 6259.2 6303.7 6314.9 6373.7 6391.0 6439.4 6471.0 6159.8 6179.7 6197.3 6222.6 6234.8 5912.4 6050.4 6054.5 6068.8 6102.6 6350.5 6375.3 6408.4 6412.6 6426.9 4191.5 4372.6 4426.6 4443.8 4444.8 6053.7 6061.6 6081.2 6101.8 6121.2 5952.4 5982.5 6000.2 6045.8 6069.3 5826.2 5838.7 5905.7 5913.9 5983.8 5866.4 5868.4 5908.8 5918.8 5924.1 5848.5 5925.7 6001.4 6054.9 6069.1 5803.0 5820.0 5820.2 5828.8 5830.9 03:50:18 INFO - PROCESS | 4055 | 03:50:18 INFO - PROCESS | 4055 | [#5] yui.html Cycles:180 Average:17899.88 Median:26186.54 stddev:22789.17 (87.0%) stddev-sans-first:22816.75 03:50:18 INFO - PROCESS | 4055 | Values: 758.7 799.9 836.9 857.2 868.7 15093.4 15604.5 15746.6 15849.8 15860.0 14492.0 14596.1 14597.1 14613.6 14638.9 836.0 853.9 856.8 858.3 859.8 848.6 849.3 850.7 853.3 858.3 892.9 893.2 900.2 900.2 904.0 890.1 890.4 893.8 894.3 894.8 664.1 664.4 664.4 664.6 665.6 13941.1 14041.2 14072.2 14076.4 14079.3 12589.6 13001.0 13259.9 13336.3 13432.7 11277.5 11327.4 12059.6 12131.9 12156.1 3945.4 4001.2 4001.8 4002.9 4013.6 59060.0 63189.4 63342.4 67565.3 69598.3 11958.0 12003.6 12491.2 12634.6 12782.2 21889.0 22022.3 22102.6 22172.1 22415.2 8841.4 8974.7 9004.1 9472.9 9567.7 4868.2 5028.8 5085.9 5105.3 5162.9 3798.7 3862.7 3918.6 3928.3 3936.8 642.3 647.2 654.7 658.2 677.2 647.8 704.9 761.8 762.4 812.3 9618.4 10495.3 10568.3 10597.6 10601.4 762.7 770.9 789.6 809.6 812.0 4595.6 4870.4 4870.9 4946.1 4949.3 87379.0 88974.0 90803.5 92222.5 95968.5 52934.2 54925.0 65991.0 69756.0 77756.6 43431.1 62148.7 67723.7 68532.3 69181.3 10161.2 10428.4 10676.7 10677.8 10903.5 47777.5 47855.3 48583.0 48662.3 49304.8 56919.3 62098.1 63332.0 63420.7 65002.0 12363.7 12651.4 12841.4 12984.4 13072.2 15191.2 15423.8 15437.2 15475.5 15735.8 14189.5 14522.3 14597.2 14649.7 14716.3 13586.4 13638.7 13648.0 13961.7 14052.5 13220.6 13322.8 13376.2 13469.4 13585.2 11132.4 11152.1 11236.6 11344.8 11507.1 11523.9 11561.9 11835.3 11905.9 11962.7 03:50:18 INFO - PROCESS | 4055 | -------- Summary: end -------- 03:50:18 INFO - PROCESS | 4055 | 03:50:19 INFO - TEST-INFO | 4055: exit 0 03:50:19 INFO - TEST-OK | dromaeo_css | took 1114288ms 03:50:19 INFO - TEST-START | kraken 03:50:19 INFO - operating with platform_type : linux_ 03:50:19 INFO - Initialising browser for kraken test... 03:50:19 INFO - TEST-INFO | started process 4426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZcPEUl/profile http://localhost:58895/getInfo.html) 03:50:24 INFO - PROCESS | 4426 | __metrics Screen width/height:1600/1200 03:50:24 INFO - PROCESS | 4426 | colorDepth:24 03:50:24 INFO - PROCESS | 4426 | Browser inner width/height: 1024/697 03:50:24 INFO - PROCESS | 4426 | __metrics 03:50:24 ERROR - PROCESS | 4426 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:50:25 INFO - TEST-INFO | 4426: exit 0 03:50:25 INFO - Browser initialized. 03:50:25 INFO - Running cycle 1/1 for kraken test... 03:50:25 INFO - TEST-INFO | started process 4558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZcPEUl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:37 INFO - PROCESS | 4558 | RSS: Main: 151883776 03:50:37 INFO - PROCESS | 4558 | 03:50:40 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58895/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:41 INFO - PROCESS | 4558 | RSS: Main: 156864512 03:50:41 INFO - PROCESS | 4558 | 03:50:43 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58895/tests/kraken/driver.html?testName=audio-dft) 03:50:44 INFO - PROCESS | 4558 | RSS: Main: 154746880 03:50:44 INFO - PROCESS | 4558 | 03:50:47 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58895/tests/kraken/driver.html?testName=audio-fft) 03:50:47 INFO - PROCESS | 4558 | RSS: Main: 155201536 03:50:47 INFO - PROCESS | 4558 | 03:50:50 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58895/tests/kraken/driver.html?testName=audio-oscillator) 03:50:50 INFO - PROCESS | 4558 | RSS: Main: 155533312 03:50:50 INFO - PROCESS | 4558 | 03:50:52 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58895/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:53 INFO - PROCESS | 4558 | RSS: Main: 155262976 03:50:53 INFO - PROCESS | 4558 | 03:50:56 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58895/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:56 INFO - PROCESS | 4558 | RSS: Main: 158769152 03:50:57 INFO - PROCESS | 4558 | 03:51:00 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58895/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:01 INFO - PROCESS | 4558 | RSS: Main: 158859264 03:51:01 INFO - PROCESS | 4558 | 03:51:03 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58895/tests/kraken/driver.html?testName=json-parse-financial) 03:51:04 INFO - PROCESS | 4558 | RSS: Main: 158601216 03:51:04 INFO - PROCESS | 4558 | 03:51:05 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58895/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:06 INFO - PROCESS | 4558 | RSS: Main: 157442048 03:51:06 INFO - PROCESS | 4558 | 03:51:08 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:08 INFO - PROCESS | 4558 | RSS: Main: 157274112 03:51:08 INFO - PROCESS | 4558 | 03:51:10 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:11 INFO - PROCESS | 4558 | RSS: Main: 157433856 03:51:11 INFO - PROCESS | 4558 | 03:51:14 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:14 INFO - PROCESS | 4558 | RSS: Main: 157356032 03:51:14 INFO - PROCESS | 4558 | 03:51:17 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:18 INFO - PROCESS | 4558 | RSS: Main: 157360128 03:51:18 INFO - PROCESS | 4558 | 03:51:19 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:58895/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58895/tests/kraken/driver.html?testName=ai-astar) 03:51:20 INFO - PROCESS | 4558 | RSS: Main: 159285248 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | __start_tp_report 03:51:20 INFO - PROCESS | 4558 | _x_x_mozilla_page_load 03:51:20 INFO - PROCESS | 4558 | _x_x_mozilla_page_load_details 03:51:20 INFO - PROCESS | 4558 | |i|pagename|runs| 03:51:20 INFO - PROCESS | 4558 | |0;ai-astar;102;112;111;111;111;111;112;112;112;111 03:51:20 INFO - PROCESS | 4558 | |1;audio-beat-detection;152;123;121;160;123;122;125;122;144;122 03:51:20 INFO - PROCESS | 4558 | |2;audio-dft;162;164;163;163;162;162;163;164;162;169 03:51:20 INFO - PROCESS | 4558 | |3;audio-fft;76;76;77;112;76;75;77;78;117;75 03:51:20 INFO - PROCESS | 4558 | |4;audio-oscillator;81;81;111;83;82;82;98;82;82;111 03:51:20 INFO - PROCESS | 4558 | |5;imaging-gaussian-blur;118;119;117;118;118;117;117;118;117;123 03:51:20 INFO - PROCESS | 4558 | |6;imaging-darkroom;148;147;146;146;147;148;148;150;148;147 03:51:20 INFO - PROCESS | 4558 | |7;imaging-desaturate;85;86;88;87;86;85;85;85;85;85 03:51:20 INFO - PROCESS | 4558 | |8;json-parse-financial;51;59;50;50;50;50;52;50;51;51 03:51:20 INFO - PROCESS | 4558 | |9;json-stringify-tinderbox;60;58;59;60;60;65;60;60;59;59 03:51:20 INFO - PROCESS | 4558 | |10;stanford-crypto-aes;76;76;75;76;75;75;76;75;77;76 03:51:20 INFO - PROCESS | 4558 | |11;stanford-crypto-ccm;140;137;132;128;129;126;136;129;169;131 03:51:20 INFO - PROCESS | 4558 | |12;stanford-crypto-pbkdf2;156;157;160;158;158;152;156;159;156;158 03:51:20 INFO - PROCESS | 4558 | |13;stanford-crypto-sha256-iterative;62;65;63;61;65;66;60;61;60;61 03:51:20 INFO - PROCESS | 4558 | __end_tp_report 03:51:20 INFO - PROCESS | 4558 | __start_cc_report 03:51:20 INFO - PROCESS | 4558 | _x_x_mozilla_cycle_collect,815 03:51:20 INFO - PROCESS | 4558 | __end_cc_report 03:51:20 INFO - PROCESS | 4558 | __startTimestamp1480161080011__endTimestamp 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | ------- Summary: start ------- 03:51:20 INFO - PROCESS | 4558 | Number of tests: 14 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.03 (2.7%) stddev-sans-first:0.53 03:51:20 INFO - PROCESS | 4558 | Values: 102.0 112.0 111.0 111.0 111.0 111.0 112.0 112.0 112.0 111.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#1] audio-beat-detection Cycles:10 Average:131.40 Median:124.00 stddev:14.74 (11.9%) stddev-sans-first:13.62 03:51:20 INFO - PROCESS | 4558 | Values: 152.0 123.0 121.0 160.0 123.0 122.0 125.0 122.0 144.0 122.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.12 (1.3%) stddev-sans-first:2.19 03:51:20 INFO - PROCESS | 4558 | Values: 162.0 164.0 163.0 163.0 162.0 162.0 163.0 164.0 162.0 169.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:16.20 (21.3%) stddev-sans-first:16.92 03:51:20 INFO - PROCESS | 4558 | Values: 76.0 76.0 77.0 112.0 76.0 75.0 77.0 78.0 117.0 75.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.00 stddev:12.51 (15.3%) stddev-sans-first:12.90 03:51:20 INFO - PROCESS | 4558 | Values: 81.0 81.0 111.0 83.0 82.0 82.0 98.0 82.0 82.0 111.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.81 (1.5%) stddev-sans-first:1.92 03:51:20 INFO - PROCESS | 4558 | Values: 118.0 119.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 123.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.18 (0.8%) stddev-sans-first:1.24 03:51:20 INFO - PROCESS | 4558 | Values: 148.0 147.0 146.0 146.0 147.0 148.0 148.0 150.0 148.0 147.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:85.50 stddev:1.06 (1.2%) stddev-sans-first:1.09 03:51:20 INFO - PROCESS | 4558 | Values: 85.0 86.0 88.0 87.0 86.0 85.0 85.0 85.0 85.0 85.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:2.76 (5.4%) stddev-sans-first:2.92 03:51:20 INFO - PROCESS | 4558 | Values: 51.0 59.0 50.0 50.0 50.0 50.0 52.0 50.0 51.0 51.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:1.89 (3.1%) stddev-sans-first:2.00 03:51:20 INFO - PROCESS | 4558 | Values: 60.0 58.0 59.0 60.0 60.0 65.0 60.0 60.0 59.0 59.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.00 stddev:0.67 (0.9%) stddev-sans-first:0.71 03:51:20 INFO - PROCESS | 4558 | Values: 76.0 76.0 75.0 76.0 75.0 75.0 76.0 75.0 77.0 76.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:134.00 stddev:12.51 (9.3%) stddev-sans-first:13.17 03:51:20 INFO - PROCESS | 4558 | Values: 140.0 137.0 132.0 128.0 129.0 126.0 136.0 129.0 169.0 131.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.00 Median:158.00 stddev:2.21 (1.4%) stddev-sans-first:2.32 03:51:20 INFO - PROCESS | 4558 | Values: 156.0 157.0 160.0 158.0 158.0 152.0 156.0 159.0 156.0 158.0 03:51:20 INFO - PROCESS | 4558 | 03:51:20 INFO - PROCESS | 4558 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:2.22 (3.6%) stddev-sans-first:2.35 03:51:20 INFO - PROCESS | 4558 | Values: 62.0 65.0 63.0 61.0 65.0 66.0 60.0 61.0 60.0 61.0 03:51:20 INFO - PROCESS | 4558 | -------- Summary: end -------- 03:51:20 INFO - PROCESS | 4558 | 03:51:21 INFO - TEST-INFO | 4558: exit 0 03:51:21 INFO - TEST-OK | kraken | took 61733ms 03:51:21 INFO - SUITE-END | took 1176s 03:51:21 INFO - Completed test suite (00:19:36) 03:51:21 INFO - javascript benchmark 03:51:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7506.896476157334, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3309.66903309669, 3338.1487720631235, 3338.9499157512632, 3346.9791713527366, 3353.312570922961, 5760.855978600532, 5786.508146807521, 5807.245058142441, 5817.970910145454, 5838.737256823442, 5841.591088623798, 5885.4997325227405, 5889.528837692985, 5897.646141231518, 5899.2036075129845, 5265.684058956465, 5337.2794672719265, 5355.384130824966, 5365.141577347626, 5372.892542149155, 5399.595030372718, 5402.729863506828, 5404.162354834987, 5407.026735187665, 5446.183072539111, 5177.508136727005, 5178.119719647669, 5371.140617501201, 5404.270423492818, 5411.648242864201, 5270.262163297122, 5285.180796976475, 5297.993381257549, 5309.893802123975, 5351.0, 5168.948310516885, 5256.159014557652, 5262.131748261532, 5298.231756395339, 5348.1442969124755, 5825.038868586678, 5871.647701137946, 5872.5889187756875, 5908.970455147697, 5935.881282374328, 6079.817605471843, 6099.939000609981, 6118.3269840317525, 6121.081837724332, 6145.985912324461, 6172.698064805396, 6185.938140618581, 6213.689315534205, 6239.438450539473, 6263.937360626381, 5712.571557133231, 5856.267966504187, 5869.882602347929, 5876.706164691748, 5907.793227237069, 6191.783287584913, 6232.189815323979, 6232.688365581794, 6258.874822503524, 6382.457491113215, 6109.053096770008, 6113.633182009094, 6120.908186377208, 6123.601965872204, 6142.232220972379, 6185.072239164071, 6202.875942481125, 6206.565540412218, 6207.162033125561, 6211.130441738161, 5931.673757943268, 6067.2112625359305, 6068.089786532056, 6080.027195648675, 6092.086187071886, 6180.5673602848265, 6198.039303907902, 6202.875942481125, 6205.100260462208, 6220.284667263232, 4745.098431298043, 4753.429588449409, 4761.5714585686765, 4762.309465127537, 4812.109759694467, 4188.602082802129, 4204.474440694913, 4207.26372884744, 4218.8312467500955, 4224.429701990253, 5933.495652869555, 5968.0, 5982.162497250389, 6010.549208809357, 6036.0, 6089.117078023751, 6225.533085018642, 6229.968850155811, 6267.6866156692895, 6270.059491076375, 5843.853903652443, 5885.676287804212, 5901.114832775118, 5919.786443779015, 6026.276846778414, 5329.706866122323, 5338.893222135535, 5339.038972984822, 5341.3857406398765, 5366.463353664681, 6528.575642583407, 6533.1180290661105, 6551.0173473979285, 6553.4101930826455, 6562.901556476561, 6071.210742603434, 6124.755009799558, 6145.463634091477, 6168.784092556739, 6184.196054512884, 6487.156669632917, 6509.511786616117, 6511.674416279262, 6513.934860651333, 6558.540902136805, 6146.139540464249, 6190.969045154746, 6192.783252586138, 6194.256689197145, 6211.65835879031, 6084.574079814548, 6136.7948077883175, 6138.662373569497, 6146.723397447215, 6291.339409362135, 6145.231846019247, 6184.783532576518, 6196.318404975359, 6201.906971395342, 6203.038529028008, 6136.987397079611, 6143.938560614337, 6145.047517634774, 6152.753889844356, 6155.107509411021, 5879.73541190656, 5905.734241959208, 5941.405859414024, 5962.761489540369, 6043.2748070231855, 6064.666443345658, 6136.610985192662, 6182.319944805978, 6191.535634827496, 6193.287771906108, 6004.34229243097, 6011.909821352596, 6031.879362412815, 6034.668093254738, 6070.0591408331775], "value": 5742.518227527902, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.7554790309924, 617.9505639548837, 639.0924886660941, 643.6363454648126, 669.7890164598148, 40234.0, 43189.784051079776, 43214.78392608037, 43432.565674343285, 43460.56539434605, 43013.569864301346, 43036.354454683205, 43610.0, 43631.345529817, 43671.12657746843, 8493.36299777516, 8592.785180370478, 8606.139386061406, 8624.266937310336, 8625.137486251388, 8521.95739021304, 8623.870641940375, 8656.783580410509, 8657.783555411102, 8675.609597568093, 8647.913520864773, 8665.566721663923, 8694.39139260252, 8704.390692651517, 8705.173008564176, 8567.271781898546, 8626.396152269344, 8643.697470588499, 8656.783580410509, 8672.52301123438, 8580.742577722616, 8630.180132887428, 8641.351898607629, 8651.134886511298, 8653.697120600811, 41864.790676046425, 42226.0, 42274.0, 42280.365794513105, 42346.57653423488, 3501.77238479498, 3631.2555926035097, 4002.2595819773437, 4246.150769846012, 4262.722923010026, 32329.353412931843, 32332.191695207574, 32532.674673253438, 32597.185070373194, 33002.17494562631, 4550.704204226715, 4556.567126123013, 4579.244424669925, 4589.059242855206, 4594.333821595883, 346546.9999999975, 348100.0, 348192.0, 348299.0, 348933.0, 59573.40426595765, 59763.40236597578, 60151.69924150351, 60170.69914650486, 60197.0, 63729.0, 63759.0, 63777.36222637714, 63857.0, 63938.0, 18698.252069917322, 18902.338418155574, 18938.526536836413, 18992.240310387708, 19024.239030438628, 15017.699646007019, 15028.849711502964, 15071.246437678072, 15117.848821511863, 15129.167895765839, 16370.672586548202, 16466.83533164653, 16548.669026619402, 16602.75095873563, 16849.578760531083, 6412.198475190601, 6502.902456463157, 6529.640869752209, 6576.704048317837, 6623.8739414298725, 936.3585943628636, 1009.0867764672983, 1012.473513772834, 1082.3397727386289, 1116.6823148684468, 31067.223319416742, 31728.841355793535, 32175.67824321727, 32213.194670133435, 32226.516602250984, 1110.4780753046055, 1116.3748300951493, 1129.0628778114146, 1177.9469923853276, 1191.3209470601846, 16886.40897568579, 17365.2185651646, 17425.390111346296, 17549.91225043892, 17584.12079396025, 499695.0, 504541.0, 505069.0, 505996.0, 506433.0, 60695.69652151711, 60963.695181523806, 60971.390286097456, 60994.69502652458, 61011.694941525006, 1383.4258782605107, 1422.6585619451464, 1438.8345340285791, 1443.0475885915246, 1446.1034158821599, 30179.849100754356, 31566.842165789025, 31625.84187079142, 31862.522062169548, 32396.0, 52034.21948670848, 52765.472345277594, 52773.0, 52904.47095528995, 52948.47051529436, 418801.0, 419060.0, 419142.0, 419460.0, 420302.0, 41353.586464134976, 41539.1692166161, 42786.78606606947, 42997.35503967506, 43152.0, 48461.27308090311, 48851.755741221066, 49246.753766232374, 49720.75139624423, 50866.23700644419, 40997.54014759124, 41622.37566436567, 42865.35701964411, 43379.0, 43898.78050609727, 41122.383164251965, 41255.7937210312, 41818.79090604527, 42455.15089698127, 43247.702568922985, 37893.81053094717, 38930.80534597309, 40886.38670420006, 42010.0, 44737.328940066574, 35620.46569301515, 36686.26627467382, 36822.0, 37075.258494830494, 37419.251614967005, 28146.008167100383, 28637.71362286434, 28656.57015144733, 28690.282742931595, 28734.425311493236], "value": 20554.826812705487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.20978954670437, 425.9723117997332, 426.5862113749663, 430.09894271501196, 450.8895320646442, 19039.52401189969, 20102.59794804103, 20360.08379622917, 20556.0, 20701.378958631245, 17069.57326066849, 18869.433916982478, 19256.90371548144, 19296.421107366765, 19416.320428784995, 5183.326167598226, 5437.782488700447, 5439.0, 5439.292891924044, 5440.129579267318, 4006.3589825627905, 5345.705986170759, 5409.0, 5415.972920135414, 6343.365663433666, 6481.93518064818, 6484.092227088211, 6488.837779055514, 6498.285188629271, 6503.057056726771, 6245.500359971192, 6386.936130638681, 6421.8394540136405, 6440.645764482952, 6492.383223593751, 5611.775528978836, 5749.971250143764, 5757.68332741699, 5783.826485205408, 5790.305163380379, 14217.0, 14539.200343981076, 22743.090276388924, 23888.761112388827, 24213.515729685307, 2295.6556516522487, 2334.4280651240383, 2455.1897873701637, 2569.0366112707734, 2770.0, 10972.780544389147, 11270.211085224038, 11443.427828608535, 11538.0, 13122.015848811281, 1906.9427917162368, 1988.6519859024756, 2007.6687346587796, 2069.193014724259, 2113.19698514565, 77996.0, 82691.17308826956, 85249.57375213085, 89325.55337223338, 93958.0, 11536.0, 11723.769004254431, 11900.464479098462, 12132.636020919386, 12323.815142772686, 17268.222929968182, 17269.39557115495, 17313.39403120885, 17337.306507739802, 17358.39245626397, 7231.566106033655, 7480.364169045583, 7533.585652789039, 8119.634616442156, 9137.63449462014, 8599.61301741423, 8648.610812513452, 8660.740177794676, 8809.647614095493, 8815.338849586307, 5039.748012599355, 5122.410922743858, 5186.118359878829, 5231.973840130775, 5291.100512912814, 1807.6746185686702, 1847.8706490545533, 2130.552583957355, 2217.2239716099557, 2230.252865290146, 954.8854137503544, 962.8459446488528, 980.2158273381267, 1000.3997601439079, 1037.0355569320604, 18879.3392231274, 19400.611987760167, 19783.802161978198, 19847.30534431288, 20140.597188056156, 985.8225519406576, 1006.8691070160833, 1013.1337706261188, 1035.5133087448887, 1067.4395942130288, 9894.257930655229, 10826.67519974402, 10922.672319830417, 10925.672229833117, 10982.780344393228, 522314.0, 525375.0, 529967.0, 539314.0, 549366.0, 93758.53120734352, 95213.52393237989, 95220.0, 97603.0, 100172.0, 1035.8601588785418, 1056.2078441169124, 1086.6088208245026, 1091.252492042953, 1097.429336744904, 18303.084845757927, 18620.44138675842, 18699.439016829518, 19095.52261193481, 19255.13351899196, 32331.676683232865, 33777.66222337844, 44359.0, 44571.77714111538, 46044.079118416776, 65047.67476162778, 66260.0, 66829.0, 67309.0, 68388.31611683819, 9215.585298661443, 9238.815223695623, 9381.765455863659, 12556.488702259767, 12803.87196128064, 12598.118131730691, 12918.612441626767, 13430.731385372042, 13525.256110913993, 13971.091879028238, 11625.069994400259, 11717.531298748296, 11719.17965742424, 11922.880771192176, 13183.934080329536, 11720.589779358022, 12365.567205147776, 12688.809667855174, 12885.162464439782, 13044.086913916315, 13015.544455943997, 13211.0, 13252.138610990254, 13295.20228786276, 13331.200127992352, 12778.68053298675, 13310.0, 13351.532696355582, 13388.866111339152, 13501.797473037715, 12176.269423834598, 12410.0, 12566.748665026831, 12674.302913339854, 12797.232166070065], "value": 9788.948090847662, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.3706843125885, 1528.3351741992235, 1661.6042524279603, 1691.7716108325371, 1773.6009397885477, 7648.770536883902, 7839.490433121843, 8134.67461301548, 8689.261412779913, 8703.651853925836, 7843.921560784391, 8057.1539988301265, 8082.232187942136, 8234.38242131841, 8251.504909705422, 2456.214011516311, 2488.502299540099, 2490.2280293109193, 2493.2395619336094, 2500.3374105861963, 2413.2398294537165, 2514.8113891458124, 2518.3829961659326, 2529.620556916459, 2529.7090834553987, 2452.2520631207476, 2488.6142647889606, 2490.9750902491014, 2491.6511688363644, 2494.5260400523935, 2358.905643774247, 2368.6802281691926, 2403.9158629447975, 2427.3324835670155, 2428.8178386621075, 2215.0586000949693, 2232.3079845248026, 2238.2389987404363, 2244.1920908472935, 2380.143148466568, 8374.748757537283, 8505.149485051445, 8553.40126191167, 8565.571721413904, 8584.31325493959, 5374.731263436852, 5485.807996720096, 5490.286262785812, 5492.093804522249, 5495.587830912697, 3439.9656003439895, 3488.354654388946, 3582.9104272393397, 3610.079429745398, 3652.105234217607, 1180.887815657511, 1193.5643490126042, 1223.406647775828, 1234.2902830872194, 1272.7899896517063, 11487.597934072352, 11548.3648399338, 11569.074474042056, 11624.0, 11684.182107252496, 4703.318018887242, 4860.149473842063, 4867.805287788519, 4933.309336692866, 4938.802447902043, 9846.359986600992, 9869.605215791431, 9892.208623310262, 9895.901040989498, 9951.80096398068, 5514.476124768221, 5529.585281103933, 5544.861378465571, 5548.472895074961, 5552.083906155439, 4541.659375546781, 4712.104700106968, 4961.42943561495, 5041.924371134436, 5083.8983220335385, 4135.001790474706, 4154.1068670236045, 4198.916021679549, 4222.19778242133, 4229.746215227096, 1381.716748066644, 1389.124851343647, 1390.2840037380756, 1397.8672026157499, 1427.1722401007391, 855.9572021398906, 980.9019098090134, 994.472929347447, 1003.372891942536, 1010.8483727440943, 5865.4427829357, 5970.402959704082, 5976.133460648181, 6012.789552365646, 6016.09758536223, 463.30041637127505, 463.9164950308909, 465.8276437718066, 473.48390254622626, 475.1731986343737, 4087.0191154122795, 4122.134351786159, 4138.193052354762, 4158.438610787565, 4162.1259535497275, 9996.750081248027, 10496.475176241158, 10513.474326283807, 10539.998700123477, 10540.683779486628, 10306.33008854422, 10367.740806479747, 10394.16846652266, 10397.532111055021, 10400.947995259976, 7595.810104747315, 7923.445358824943, 7956.7215147470715, 8036.156203598655, 8054.436189466681, 5965.940340596712, 6005.459508644243, 6122.5408094392205, 6147.569670123227, 6229.96885015572, 9449.574769135543, 9663.420194788336, 9826.115649591571, 9837.213022958289, 9859.211263098792, 9644.614215431304, 9781.119699227103, 9804.26468014916, 9821.558029888529, 9829.164521015793, 6860.588364698134, 7066.328698773608, 7390.334869861738, 7501.137369202612, 7626.428017898791, 7934.523928564305, 8227.917720822716, 8245.83508329842, 8289.4197406181, 8293.875591866248, 7439.665215065227, 7443.813904652427, 7470.551766894004, 7517.210692877388, 7529.774106776806, 7358.595277259802, 7392.44556658242, 7448.031755871702, 7465.552066876005, 7485.588292643957, 6828.317168283132, 6943.47923905699, 6988.720451181895, 7005.369516743517, 7015.579065255897, 4966.428860681068, 5060.696358218519, 5071.54356107952, 5099.847004589868, 5257.158854583248, 5056.924146137737, 5106.106431374569, 5142.537171654569, 5233.188855727369, 5330.253764473055], "value": 4564.105213539925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.1190434630826, 345.8293675907054, 346.4889288299758, 357.3389229924639, 358.183341980285, 5632.915821146176, 5694.430556944303, 5695.971520142393, 5714.571407144465, 5727.312722473309, 5563.36021357544, 5609.4757359188325, 5609.971950140254, 5630.634008789426, 5650.3219613646315, 3957.643812056914, 4207.179599978005, 4323.329883868006, 4384.4519435070615, 4392.824287028515, 4415.867523974286, 4437.047699012441, 4447.155040542303, 4455.153520831048, 4466.731996080245, 4456.9777151114195, 4457.710248833815, 4459.487158976727, 4476.350929115276, 4490.371348011281, 4185.602367775087, 4355.368471571636, 4395.406620106277, 4475.731456112628, 4488.259437192875, 3862.555806082308, 3870.1098747288283, 3871.5160604924386, 3871.5741268460447, 3887.6198949372847, 5515.227868098469, 5538.529225015878, 5546.639468434539, 5547.55619550435, 5564.248826408423, 4949.604031677457, 4996.17639561561, 5045.47022562633, 5071.188609822448, 5107.591392688576, 5881.735321910524, 5883.764649414018, 5894.0, 5920.0, 5920.940790592125, 4308.46144231971, 4317.11499142675, 4318.568143185687, 4321.848735294249, 4325.783710814447, 6013.308469525973, 6062.818115456499, 6106.4809491192855, 6122.234720659918, 6133.6319820810895, 4273.252180868398, 4290.592393722592, 4297.72064815786, 4301.860007098121, 4308.9353659695125, 4370.737755734666, 4371.825126994884, 4373.934390984138, 4374.540673229265, 4392.692511524227, 4876.5854902332985, 4949.529794669501, 4990.426100998432, 5025.899482010413, 5042.0, 5878.382769809194, 5898.050974512744, 5923.466887980103, 5933.732982015819, 6001.7599296027665, 1486.0340778494065, 1494.6487575419767, 1497.1466264229502, 1499.6925630245773, 1507.6532397548626, 1009.7425156585024, 1018.8471729240673, 1028.2699283508794, 1038.2887721910515, 1041.250299784154, 5429.6199266051, 5534.861628459321, 5567.276254086943, 5568.220449137043, 5589.441055894378, 5859.794907178229, 5870.354261031283, 5870.653727375355, 5875.882482350415, 5876.559258055663, 5514.558835293167, 5597.888042239214, 5733.111367738007, 5834.883302333929, 5896.410358964069, 3127.37452509499, 3130.968690313068, 3152.9752830330235, 3157.5105858591955, 3161.0674850919036, 6068.0, 6156.260464093525, 6270.059491076284, 6302.527310451735, 6382.393672601095, 6080.665563394055, 6255.310216606812, 6255.562110652301, 6259.186305780219, 6303.653299068504, 6314.905276420857, 6373.74505019794, 6391.01878417692, 6439.356064393523, 6471.0, 6159.753609855556, 6179.69101544912, 6197.287311959182, 6222.62664240147, 6234.75060997555, 5912.379200183918, 6050.364711705208, 6054.485368743706, 6068.848278793065, 6102.565897014287, 6350.491960643045, 6375.298717141018, 6408.4232419080645, 6412.61524308543, 6426.903596445964, 4191.455110835694, 4372.584604462571, 4426.645868330462, 4443.777811109496, 4444.755538445416, 6053.667048312385, 6061.636301821904, 6081.239845019372, 6101.772852908568, 6121.204243448323, 5952.404759524013, 5982.52139828804, 6000.249968753906, 6045.758169673164, 6069.2688290270435, 5826.213461182686, 5838.678872661874, 5905.704714764331, 5913.91129133072, 5983.790567330123, 5866.384029676822, 5868.354481007171, 5908.822735317947, 5918.816236752753, 5924.060499767606, 5848.473637372657, 5925.674087925206, 6001.4298641628975, 6054.878902422015, 6069.119977603311, 5803.0, 5819.9736137207565, 5820.185174075548, 5828.76684932598, 5830.854228644318], "value": 4524.67237743915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.7116895579683, 799.9400044996623, 836.8661014237722, 857.2327766648854, 868.6959564152545, 15093.396264149435, 15604.531864044096, 15746.606334841621, 15849.762253566205, 15860.0, 14492.0, 14596.124232546028, 14597.124172549627, 14613.634659133528, 14638.926805365985, 835.9707410240627, 853.8676505141713, 856.7900864288227, 858.3305022082785, 859.8237361340941, 848.5545088828384, 849.2823564088367, 850.7277671145235, 853.2619284319051, 858.3090612057291, 892.8660700894885, 893.1604291965564, 900.2392977933669, 900.2437952120217, 904.0281697175529, 890.0698769785557, 890.3767362846002, 893.821235752852, 894.2622336572289, 894.789724414762, 664.050407916679, 664.3821246240994, 664.4352300544499, 664.6178447392768, 665.5773583774289, 13941.093828901088, 14041.22773247471, 14072.22602756848, 14076.436942522287, 14079.296035198198, 12589.622311330675, 13001.0, 13259.86740132596, 13336.333183340794, 13432.664183395493, 11277.492512836941, 11327.433628318551, 12059.577914773028, 12131.878681213251, 12156.149069565134, 3945.3687410014545, 4001.199760047973, 4001.8199181036925, 4002.9199416011515, 4013.57857424972, 59060.0, 63189.368106318805, 63342.366576334105, 67565.32434675639, 69598.3040169597, 11958.0, 12003.579874704517, 12491.188072775241, 12634.557790477289, 12782.23306601607, 21889.0, 22022.33932982013, 22102.557948840935, 22172.113115475524, 22415.21546745856, 8841.425307355, 8974.730758077269, 9004.144606262395, 9472.857907131262, 9567.712968610953, 4868.245421959602, 5028.79884804611, 5085.885323545369, 5105.285260063594, 5162.948370516322, 3798.734088613826, 3862.671672907778, 3918.5689574146822, 3928.273269445162, 3936.842526298916, 642.3448082955359, 647.207171215267, 654.6595770199469, 658.2134349452358, 677.2245778583494, 647.7635662982977, 704.8977898204731, 761.8362052158813, 762.4396068889362, 812.3054788156041, 9618.403031181542, 10495.317804342845, 10568.313059651098, 10597.62908298206, 10601.363918164781, 762.6803048735029, 770.9103207484238, 789.5529983744411, 809.639710328898, 811.975640730779, 4595.563421474954, 4870.4155501339355, 4870.902581948341, 4946.1344264753525, 4949.327363223891, 87379.0, 88974.0, 90803.54598226967, 92222.53888730513, 95968.52015739877, 52934.20598691023, 54925.0, 65991.0, 69755.95366069411, 77756.61121694355, 43431.131377372905, 62148.68925655433, 67723.66138169277, 68532.31467685259, 69181.3081869175, 10161.187105031728, 10428.426436546062, 10676.679699609023, 10677.839832402366, 10903.454827258764, 47777.522224777305, 47855.28217076677, 48583.0, 48662.27006594833, 49304.75347623239, 56919.29242122743, 62098.0685289712, 63332.0, 63420.68289658522, 65002.0, 12363.69090772738, 12651.367431628198, 12841.422136004088, 12984.350782461028, 13072.215667060007, 15191.164485953379, 15423.768643470581, 15437.22813859325, 15475.458358957383, 15735.842641573896, 14189.503367382093, 14522.273886305853, 14597.197154156624, 14649.707005860037, 14716.264186790404, 13586.388612512263, 13638.659033524242, 13648.0, 13961.72043654045, 14052.508162214273, 13220.603381898558, 13322.800157997444, 13376.197428154343, 13469.39387727535, 13585.184888906697, 11132.443377830914, 11152.052075573343, 11236.550537978716, 11344.773104538028, 11507.079433645456, 11523.942380288045, 11561.942190288995, 11835.349055802013, 11905.940470297593, 11962.70093247641], "value": 7499.365172888514, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 111.0, 111.0, 111.0, 112.0, 112.0, 112.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 123.0, 121.0, 160.0, 123.0, 122.0, 125.0, 122.0, 144.0, 122.0], "value": 131.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 163.0, 162.0, 162.0, 163.0, 164.0, 162.0, 169.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 112.0, 76.0, 75.0, 77.0, 78.0, 117.0, 75.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 111.0, 83.0, 82.0, 82.0, 98.0, 82.0, 82.0, 111.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 123.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 147.0, 148.0, 148.0, 150.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 87.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 59.0, 50.0, 50.0, 50.0, 50.0, 52.0, 50.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 59.0, 60.0, 60.0, 65.0, 60.0, 60.0, 59.0, 59.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 75.0, 75.0, 76.0, 75.0, 77.0, 76.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 132.0, 128.0, 129.0, 126.0, 136.0, 129.0, 169.0, 131.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 160.0, 158.0, 158.0, 152.0, 156.0, 159.0, 156.0, 158.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 61.0, 65.0, 66.0, 60.0, 61.0, 60.0, 61.0], "value": 62.4, "unit": "score"}]}]} 03:51:21 INFO - Return code: 0 03:51:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:21 ERROR - # TBPL SUCCESS # 03:51:21 INFO - Running post-action listener: _resource_record_post_action 03:51:21 INFO - [mozharness: 2016-11-26 11:51:21.306677Z] Finished run-tests step (success) 03:51:21 INFO - Running post-run listener: _resource_record_post_run 03:51:21 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 368427008; Read time: 12; Write time: 372632 03:51:21 INFO - TinderboxPrint: CPU usage
13.3% 03:51:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 03:51:21 INFO - TinderboxPrint: I/O write bytes / time
368,427,008 / 372,632 03:51:21 INFO - TinderboxPrint: CPU idle
8,242.7 (86.7%) 03:51:21 INFO - TinderboxPrint: CPU user
1,206.0 (12.7%) 03:51:21 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124047360; Read time: 0; Write time: 119268 03:51:21 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 243826688; Read time: 0; Write time: 253356 03:51:21 INFO - Running post-run listener: _upload_blobber_files 03:51:21 INFO - Blob upload gear active. 03:51:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:21 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 03:51:21 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:21 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:25 INFO - (blobuploader) - INFO - Done attempting. 03:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:26 INFO - (blobuploader) - INFO - Done attempting. 03:51:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:51:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:51:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:27 INFO - (blobuploader) - INFO - Done attempting. 03:51:27 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:27 INFO - Return code: 0 03:51:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd3ccb09f3a513ea0a8e888599c9e9668c39e6375e61446445b38b28003c1b0c7d1293325b55e35d51cf685e8e5ca23f7a6daf7c99b287aba78d377cb77295b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffc58037e045a5d84a8c0174912fc1a292ef4188f0570405fa709eb18eee6d4d2296bda44fef29095771a4a4bbe5b1e0282907870e62431e1bda216dc82076ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51912006cc874d5bbaad9f6b1578a9820fbbb9136c032a3766215c70e25855c4f7381e07641df523986a8a4fe2ed727fb96775d0af6936497e7bb14b36af4d56"} 03:51:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:27 INFO - Contents: 03:51:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd3ccb09f3a513ea0a8e888599c9e9668c39e6375e61446445b38b28003c1b0c7d1293325b55e35d51cf685e8e5ca23f7a6daf7c99b287aba78d377cb77295b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffc58037e045a5d84a8c0174912fc1a292ef4188f0570405fa709eb18eee6d4d2296bda44fef29095771a4a4bbe5b1e0282907870e62431e1bda216dc82076ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51912006cc874d5bbaad9f6b1578a9820fbbb9136c032a3766215c70e25855c4f7381e07641df523986a8a4fe2ed727fb96775d0af6936497e7bb14b36af4d56"} 03:51:27 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:27 INFO - Copying logs to upload dir... 03:51:27 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.601810 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-26 03:51:25.840581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 03:51:25.844326) ========= 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=745a4373a2a16df560f216e000000264-1480150411.59490-882513106 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/Mozilla-Aurora/sha512/bd3ccb09f3a513ea0a8e888599c9e9668c39e6375e61446445b38b28003c1b0c7d1293325b55e35d51cf685e8e5ca23f7a6daf7c99b287aba78d377cb77295b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffc58037e045a5d84a8c0174912fc1a292ef4188f0570405fa709eb18eee6d4d2296bda44fef29095771a4a4bbe5b1e0282907870e62431e1bda216dc82076ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51912006cc874d5bbaad9f6b1578a9820fbbb9136c032a3766215c70e25855c4f7381e07641df523986a8a4fe2ed727fb96775d0af6936497e7bb14b36af4d56"} build_url:https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011562 build_url: 'https://queue.taskcluster.net/v1/task/HeD91FHvSMminn4F4M1nvg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bd3ccb09f3a513ea0a8e888599c9e9668c39e6375e61446445b38b28003c1b0c7d1293325b55e35d51cf685e8e5ca23f7a6daf7c99b287aba78d377cb77295b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffc58037e045a5d84a8c0174912fc1a292ef4188f0570405fa709eb18eee6d4d2296bda44fef29095771a4a4bbe5b1e0282907870e62431e1bda216dc82076ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51912006cc874d5bbaad9f6b1578a9820fbbb9136c032a3766215c70e25855c4f7381e07641df523986a8a4fe2ed727fb96775d0af6936497e7bb14b36af4d56"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-26 03:51:25.869343) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:51:25.869659) ========= 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=745a4373a2a16df560f216e000000264-1480150411.59490-882513106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-26 03:51:25.953739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 03:51:25.957091) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-26 03:51:25.957479) ========= ========= Total master_lag: 0.17 =========