builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1476226026.22 results: success (0) buildid: 20161011123004 builduid: 68b9b6d0db584a759547af1e8e61cec1 revision: 380b5366b20f4ad1cb21ee8252486017e0f66ad2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:06.224233) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:06.225159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:06.225897) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:06.242252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:06.242967) ========= 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=6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 15:47:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.4M=0s 2016-10-11 15:47:06 (88.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:06.348769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:06.349456) ========= 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=6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017445 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:06.401297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-11 15:47:06.402082) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 380b5366b20f4ad1cb21ee8252486017e0f66ad2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 380b5366b20f4ad1cb21ee8252486017e0f66ad2 --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=6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 15:47:06,533 truncating revision to first 12 chars 2016-10-11 15:47:06,533 Setting DEBUG logging. 2016-10-11 15:47:06,533 attempt 1/10 2016-10-11 15:47:06,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/380b5366b20f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 15:47:09,292 unpacking tar archive at: autoland-380b5366b20f/testing/mozharness/ program finished with exit code 0 elapsedTime=3.085498 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-11 15:47:09.608534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:09.609326) ========= script_repo_revision: 380b5366b20f4ad1cb21ee8252486017e0f66ad2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:09.609920) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:09.610218) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 15:47:09.622213) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-11 15:47:09.622893) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:47:09 INFO - MultiFileLogger online at 20161011 15:47:09 in /builds/slave/test 15:47:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:47:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:47:09 INFO - {'append_to_log': False, 15:47:09 INFO - 'base_work_dir': '/builds/slave/test', 15:47:09 INFO - 'blob_upload_branch': 'Autoland', 15:47:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:47:09 INFO - 'branch': 'Autoland', 15:47:09 INFO - 'buildbot_json_path': 'buildprops.json', 15:47:09 INFO - 'config_files': ('talos/linux_config.py',), 15:47:09 INFO - 'default_actions': ('clobber', 15:47:09 INFO - 'read-buildbot-config', 15:47:09 INFO - 'download-and-extract', 15:47:09 INFO - 'populate-webroot', 15:47:09 INFO - 'create-virtualenv', 15:47:09 INFO - 'install', 15:47:09 INFO - 'run-tests'), 15:47:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:47:09 INFO - 'download_minidump_stackwalk': True, 15:47:09 INFO - 'download_symbols': 'ondemand', 15:47:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:47:09 INFO - 'tooltool.py': '/tools/tooltool.py', 15:47:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:47:09 INFO - '/tools/misc-python/virtualenv.py')}, 15:47:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:47:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:47:09 INFO - 'installer_path': 'installer.exe', 15:47:09 INFO - 'log_level': 'info', 15:47:09 INFO - 'log_name': 'talos', 15:47:09 INFO - 'log_to_console': True, 15:47:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:47:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:47:09 INFO - 'opt_config_files': (), 15:47:09 INFO - 'pip_index': False, 15:47:09 INFO - 'sps_profile': False, 15:47:09 INFO - 'sps_profile_interval': 0, 15:47:09 INFO - 'suite': 'dromaeojs-e10s', 15:47:09 INFO - 'system_bits': '32', 15:47:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:47:09 INFO - 'title': 'talos-linux64-ix-050', 15:47:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:47:09 INFO - 'use_talos_json': True, 15:47:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:47:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:47:09 INFO - 'work_dir': 'build'} 15:47:09 INFO - [mozharness: 2016-10-11 22:47:09.851520Z] Running clobber step. 15:47:09 INFO - Running pre-action listener: _resource_record_pre_action 15:47:09 INFO - Running main action method: clobber 15:47:09 INFO - rmtree: /builds/slave/test/build 15:47:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:47:10 INFO - Running post-action listener: _resource_record_post_action 15:47:10 INFO - [mozharness: 2016-10-11 22:47:10.812068Z] Finished clobber step (success) 15:47:10 INFO - [mozharness: 2016-10-11 22:47:10.812168Z] Running read-buildbot-config step. 15:47:10 INFO - Running pre-action listener: _resource_record_pre_action 15:47:10 INFO - Running main action method: read_buildbot_config 15:47:10 INFO - Using buildbot properties: 15:47:10 INFO - { 15:47:10 INFO - "project": "", 15:47:10 INFO - "product": "firefox", 15:47:10 INFO - "script_repo_revision": "production", 15:47:10 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 15:47:10 INFO - "repository": "", 15:47:10 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 15:47:10 INFO - "buildid": "20161011123004", 15:47:10 INFO - "pgo_build": "True", 15:47:10 INFO - "basedir": "/builds/slave/test", 15:47:10 INFO - "buildnumber": 360, 15:47:10 INFO - "slavename": "talos-linux64-ix-050", 15:47:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:47:10 INFO - "platform": "ubuntu64_hw", 15:47:10 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 15:47:10 INFO - "branch": "autoland", 15:47:10 INFO - "repo_path": "integration/autoland", 15:47:10 INFO - "revision": "380b5366b20f4ad1cb21ee8252486017e0f66ad2", 15:47:10 INFO - "stage_platform": "linux64-pgo", 15:47:10 INFO - "builduid": "68b9b6d0db584a759547af1e8e61cec1", 15:47:10 INFO - "slavebuilddir": "test" 15:47:10 INFO - } 15:47:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:47:10 INFO - Running post-action listener: _resource_record_post_action 15:47:10 INFO - [mozharness: 2016-10-11 22:47:10.814584Z] Finished read-buildbot-config step (success) 15:47:10 INFO - [mozharness: 2016-10-11 22:47:10.814673Z] Running download-and-extract step. 15:47:10 INFO - Running pre-action listener: _resource_record_pre_action 15:47:10 INFO - Running main action method: download_and_extract 15:47:10 INFO - mkdir: /builds/slave/test/build/tests 15:47:10 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')]} 15:47:10 INFO - trying https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:47:10 INFO - Downloading https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:47:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:47:11 INFO - Downloaded 1361 bytes. 15:47:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:47:11 INFO - Using the following test package requirements: 15:47:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:47:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:47:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:11 INFO - u'jsshell-linux-x86_64.zip'], 15:47:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:47:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:47:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:47:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:47:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:47:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:47:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:47:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:47:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:47:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:47:11 INFO - Fetch https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:47:11 INFO - Http code: 200 15:47:11 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 15:47:11 INFO - x-amz-cf-id: gtbRuizH48lkjFk6YEPK3nxhywnjrb0MgjYOmd3_qiWIIzagVUvf-A== 15:47:11 INFO - x-amz-version-id: 3za3Smc4WI_Vi8_fDT5DL5VtGDXaRaN6 15:47:12 INFO - Expected file size: 22100429 15:47:12 INFO - Obtained file size: 22100429 15:47:16 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:47:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:47:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:47:16 INFO - Fetch https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:47:16 INFO - Http code: 200 15:47:16 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 15:47:16 INFO - x-amz-cf-id: WP5-LweDK401nlXBHg0DVQ4u1sUfHdS0NV3kQMXiRU49rmIEc4IbfQ== 15:47:16 INFO - x-amz-version-id: 3za3Smc4WI_Vi8_fDT5DL5VtGDXaRaN6 15:47:17 INFO - Expected file size: 22100429 15:47:17 INFO - Obtained file size: 22100429 15:47:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:47:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:47:21 INFO - Fetch https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:47:22 INFO - Http code: 200 15:47:22 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 15:47:22 INFO - x-amz-cf-id: 77JnBgE5K0WGelF5NWErN4VAtMGJ8Na-SGOkcUw_OPvFKQc266TWcw== 15:47:22 INFO - x-amz-version-id: PmNavyfmvbyNYDHJ3jlnguwnXXr5jxqj 15:47:22 INFO - Expected file size: 14409006 15:47:22 INFO - Obtained file size: 14409006 15:47:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:22 INFO - trying https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:47:22 INFO - Downloading https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:47:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:47:23 INFO - Downloaded 59756414 bytes. 15:47:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:47:23 INFO - mkdir: /builds/slave/test/properties 15:47:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:47:23 INFO - Writing to file /builds/slave/test/properties/build_url 15:47:23 INFO - Contents: 15:47:23 INFO - build_url:https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:47:24 INFO - Running post-action listener: _resource_record_post_action 15:47:24 INFO - Running post-action listener: set_extra_try_arguments 15:47:24 INFO - [mozharness: 2016-10-11 22:47:24.461485Z] Finished download-and-extract step (success) 15:47:24 INFO - [mozharness: 2016-10-11 22:47:24.461786Z] Running populate-webroot step. 15:47:24 INFO - Running pre-action listener: _resource_record_pre_action 15:47:24 INFO - Running main action method: populate_webroot 15:47:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:47:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:47:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:47:24 INFO - '--tppagecycles', 15:47:24 INFO - '7'], 15:47:24 INFO - 'tests': ['tsvgm']}}, 15:47:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:47:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:47:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:47:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:47:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:47:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['damp', 'tps']}, 15:47:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'tests': ['damp', 'tps']}, 15:47:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['dromaeo_dom']}, 15:47:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:47:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['basic_compositor_video']}, 15:47:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:47:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['a11yr', 15:47:24 INFO - 'ts_paint', 15:47:24 INFO - 'tpaint', 15:47:24 INFO - 'sessionrestore', 15:47:24 INFO - 'sessionrestore_no_auto_restore', 15:47:24 INFO - 'tabpaint']}, 15:47:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['tsvgx', 15:47:24 INFO - 'tsvgr_opacity', 15:47:24 INFO - 'tart', 15:47:24 INFO - 'tscrollx', 15:47:24 INFO - 'cart']}, 15:47:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:47:24 INFO - 'tsvgr_opacity', 15:47:24 INFO - 'tart', 15:47:24 INFO - 'tscrollx', 15:47:24 INFO - 'cart']}, 15:47:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--disable-e10s'], 15:47:24 INFO - 'tests': ['tp5o']}, 15:47:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'tests': ['tp5o']}, 15:47:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--disable-e10s', 15:47:24 INFO - '--xperf_path', 15:47:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:24 INFO - 'tests': ['tp5n']}, 15:47:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:47:24 INFO - 'talos_options': ['--xperf_path', 15:47:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:47:24 INFO - 'tests': ['tp5n']}}, 15:47:24 INFO - 'talos.zip': {'path': '', 15:47:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:47:24 INFO - Running post-action listener: _resource_record_post_action 15:47:24 INFO - [mozharness: 2016-10-11 22:47:24.485415Z] Finished populate-webroot step (success) 15:47:24 INFO - [mozharness: 2016-10-11 22:47:24.485508Z] Running create-virtualenv step. 15:47:24 INFO - Running pre-action listener: _resource_record_pre_action 15:47:24 INFO - Running main action method: create_virtualenv 15:47:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:47:24 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 15:47:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:47:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:47:24 INFO - Using real prefix '/usr' 15:47:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:47:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:47:27 INFO - Installing pip.................done. 15:47:27 INFO - Return code: 0 15:47:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:47:27 INFO - Reading from file tmpfile_stdout 15:47:27 INFO - Output received: 15:47:27 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) 15:47:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:47:27 INFO - Using env: {'DISPLAY': ':0', 15:47:27 INFO - 'HOME': '/home/cltbld', 15:47:27 INFO - 'LANG': 'en_US.UTF-8', 15:47:27 INFO - 'LANGUAGE': 'en_US:en', 15:47:27 INFO - 'LOGNAME': 'cltbld', 15:47:27 INFO - 'MAIL': '/var/mail/cltbld', 15:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:27 INFO - 'MOZ_NO_REMOTE': '1', 15:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:27 INFO - 'NO_EM_RESTART': '1', 15:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:27 INFO - 'PWD': '/builds/slave/test', 15:47:27 INFO - 'SHELL': '/bin/bash', 15:47:27 INFO - 'SHLVL': '1', 15:47:27 INFO - 'TERM': 'linux', 15:47:27 INFO - 'TMOUT': '86400', 15:47:27 INFO - 'USER': 'cltbld', 15:47:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:27 INFO - '_': '/tools/buildbot/bin/python'} 15:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:27 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 15:47:27 INFO - Cleaning up... 15:47:27 INFO - Return code: 0 15:47:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:47:27 INFO - Using env: {'DISPLAY': ':0', 15:47:27 INFO - 'HOME': '/home/cltbld', 15:47:27 INFO - 'LANG': 'en_US.UTF-8', 15:47:27 INFO - 'LANGUAGE': 'en_US:en', 15:47:27 INFO - 'LOGNAME': 'cltbld', 15:47:27 INFO - 'MAIL': '/var/mail/cltbld', 15:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:27 INFO - 'MOZ_NO_REMOTE': '1', 15:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:27 INFO - 'NO_EM_RESTART': '1', 15:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:27 INFO - 'PWD': '/builds/slave/test', 15:47:27 INFO - 'SHELL': '/bin/bash', 15:47:27 INFO - 'SHLVL': '1', 15:47:27 INFO - 'TERM': 'linux', 15:47:27 INFO - 'TMOUT': '86400', 15:47:27 INFO - 'USER': 'cltbld', 15:47:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:27 INFO - '_': '/tools/buildbot/bin/python'} 15:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:27 INFO - Downloading/unpacking psutil>=3.1.1 15:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:47:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:29 INFO - Installing collected packages: psutil 15:47:29 INFO - Running setup.py install for psutil 15:47:29 INFO - building 'psutil._psutil_linux' extension 15:47:29 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 15:47:30 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 15:47:30 INFO - building 'psutil._psutil_posix' extension 15:47:30 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 15:47:30 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 15:47:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:47:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:47:30 INFO - Successfully installed psutil 15:47:30 INFO - Cleaning up... 15:47:30 INFO - Return code: 0 15:47:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:47:30 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')]} 15:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:30 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')]} 15:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:30 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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:30 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 15:47:30 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 15:47:30 INFO - Using env: {'DISPLAY': ':0', 15:47:30 INFO - 'HOME': '/home/cltbld', 15:47:30 INFO - 'LANG': 'en_US.UTF-8', 15:47:30 INFO - 'LANGUAGE': 'en_US:en', 15:47:30 INFO - 'LOGNAME': 'cltbld', 15:47:30 INFO - 'MAIL': '/var/mail/cltbld', 15:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:30 INFO - 'MOZ_NO_REMOTE': '1', 15:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:30 INFO - 'NO_EM_RESTART': '1', 15:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:30 INFO - 'PWD': '/builds/slave/test', 15:47:30 INFO - 'SHELL': '/bin/bash', 15:47:30 INFO - 'SHLVL': '1', 15:47:30 INFO - 'TERM': 'linux', 15:47:30 INFO - 'TMOUT': '86400', 15:47:30 INFO - 'USER': 'cltbld', 15:47:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:30 INFO - '_': '/tools/buildbot/bin/python'} 15:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:47:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:47:32 INFO - Installing collected packages: mozsystemmonitor 15:47:32 INFO - Running setup.py install for mozsystemmonitor 15:47:32 INFO - Successfully installed mozsystemmonitor 15:47:32 INFO - Cleaning up... 15:47:32 INFO - Return code: 0 15:47:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:47:32 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')]} 15:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:32 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')]} 15:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:32 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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:32 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 15:47:32 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 15:47:32 INFO - Using env: {'DISPLAY': ':0', 15:47:32 INFO - 'HOME': '/home/cltbld', 15:47:32 INFO - 'LANG': 'en_US.UTF-8', 15:47:32 INFO - 'LANGUAGE': 'en_US:en', 15:47:32 INFO - 'LOGNAME': 'cltbld', 15:47:32 INFO - 'MAIL': '/var/mail/cltbld', 15:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:32 INFO - 'MOZ_NO_REMOTE': '1', 15:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:32 INFO - 'NO_EM_RESTART': '1', 15:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:32 INFO - 'PWD': '/builds/slave/test', 15:47:32 INFO - 'SHELL': '/bin/bash', 15:47:32 INFO - 'SHLVL': '1', 15:47:32 INFO - 'TERM': 'linux', 15:47:32 INFO - 'TMOUT': '86400', 15:47:32 INFO - 'USER': 'cltbld', 15:47:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:32 INFO - '_': '/tools/buildbot/bin/python'} 15:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:32 INFO - Downloading/unpacking jsonschema==2.5.1 15:47:32 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 15:47:32 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 15:47:32 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 15:47:32 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 15:47:32 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 15:47:32 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 15:47:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:47:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:47:34 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 15:47:34 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 15:47:34 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 15:47:34 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 15:47:34 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 15:47:34 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 15:47:35 INFO - Downloading functools32-3.2.3-2.tar.gz 15:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:47:35 INFO - warning: no files found matching '*.txt' 15:47:35 INFO - no previously-included directories found matching 'build' 15:47:35 INFO - no previously-included directories found matching 'dist' 15:47:35 INFO - no previously-included directories found matching '.git*' 15:47:35 INFO - Installing collected packages: jsonschema, functools32 15:47:35 INFO - Running setup.py install for functools32 15:47:35 INFO - warning: no files found matching '*.txt' 15:47:35 INFO - no previously-included directories found matching 'build' 15:47:35 INFO - no previously-included directories found matching 'dist' 15:47:35 INFO - no previously-included directories found matching '.git*' 15:47:35 INFO - Successfully installed jsonschema functools32 15:47:35 INFO - Cleaning up... 15:47:35 INFO - Return code: 0 15:47:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:47:35 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')]} 15:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:35 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')]} 15:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:35 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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:35 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 15:47:35 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 15:47:35 INFO - Using env: {'DISPLAY': ':0', 15:47:35 INFO - 'HOME': '/home/cltbld', 15:47:35 INFO - 'LANG': 'en_US.UTF-8', 15:47:35 INFO - 'LANGUAGE': 'en_US:en', 15:47:35 INFO - 'LOGNAME': 'cltbld', 15:47:35 INFO - 'MAIL': '/var/mail/cltbld', 15:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:35 INFO - 'MOZ_NO_REMOTE': '1', 15:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:35 INFO - 'NO_EM_RESTART': '1', 15:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:35 INFO - 'PWD': '/builds/slave/test', 15:47:35 INFO - 'SHELL': '/bin/bash', 15:47:35 INFO - 'SHLVL': '1', 15:47:35 INFO - 'TERM': 'linux', 15:47:35 INFO - 'TMOUT': '86400', 15:47:35 INFO - 'USER': 'cltbld', 15:47:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:35 INFO - '_': '/tools/buildbot/bin/python'} 15:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:47:35 INFO - Cleaning up... 15:47:35 INFO - Return code: 0 15:47:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:47:35 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')]} 15:47:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:35 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')]} 15:47:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:35 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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:35 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 15:47:35 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 15:47:35 INFO - Using env: {'DISPLAY': ':0', 15:47:35 INFO - 'HOME': '/home/cltbld', 15:47:35 INFO - 'LANG': 'en_US.UTF-8', 15:47:35 INFO - 'LANGUAGE': 'en_US:en', 15:47:35 INFO - 'LOGNAME': 'cltbld', 15:47:35 INFO - 'MAIL': '/var/mail/cltbld', 15:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:35 INFO - 'MOZ_NO_REMOTE': '1', 15:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:35 INFO - 'NO_EM_RESTART': '1', 15:47:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:35 INFO - 'PWD': '/builds/slave/test', 15:47:35 INFO - 'SHELL': '/bin/bash', 15:47:35 INFO - 'SHLVL': '1', 15:47:35 INFO - 'TERM': 'linux', 15:47:35 INFO - 'TMOUT': '86400', 15:47:35 INFO - 'USER': 'cltbld', 15:47:35 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:35 INFO - '_': '/tools/buildbot/bin/python'} 15:47:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:35 INFO - Downloading/unpacking blobuploader==1.2.4 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:35 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 15:47:37 INFO - Downloading blobuploader-1.2.4.tar.gz 15:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:47:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 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 15:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:47:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:47:38 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 15:47:38 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 15:47:38 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 15:47:38 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 15:47:38 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 15:47:38 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 15:47:38 INFO - Downloading docopt-0.6.1.tar.gz 15:47:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:47:38 INFO - Installing collected packages: blobuploader, requests, docopt 15:47:38 INFO - Running setup.py install for blobuploader 15:47:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:47:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:47:38 INFO - Running setup.py install for requests 15:47:38 INFO - Running setup.py install for docopt 15:47:38 INFO - Successfully installed blobuploader requests docopt 15:47:38 INFO - Cleaning up... 15:47:39 INFO - Return code: 0 15:47:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:39 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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:39 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 15:47:39 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 15:47:39 INFO - Using env: {'DISPLAY': ':0', 15:47:39 INFO - 'HOME': '/home/cltbld', 15:47:39 INFO - 'LANG': 'en_US.UTF-8', 15:47:39 INFO - 'LANGUAGE': 'en_US:en', 15:47:39 INFO - 'LOGNAME': 'cltbld', 15:47:39 INFO - 'MAIL': '/var/mail/cltbld', 15:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:39 INFO - 'MOZ_NO_REMOTE': '1', 15:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:39 INFO - 'NO_EM_RESTART': '1', 15:47:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:39 INFO - 'PWD': '/builds/slave/test', 15:47:39 INFO - 'SHELL': '/bin/bash', 15:47:39 INFO - 'SHLVL': '1', 15:47:39 INFO - 'TERM': 'linux', 15:47:39 INFO - 'TMOUT': '86400', 15:47:39 INFO - 'USER': 'cltbld', 15:47:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:39 INFO - '_': '/tools/buildbot/bin/python'} 15:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:39 INFO - Running setup.py (path:/tmp/pip-PP10fQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:39 INFO - Running setup.py (path:/tmp/pip-LUxUYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:39 INFO - Running setup.py (path:/tmp/pip-vdihKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:39 INFO - Running setup.py (path:/tmp/pip-xIvCX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:39 INFO - Running setup.py (path:/tmp/pip-yYy9bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:39 INFO - Running setup.py (path:/tmp/pip-KTiqW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:39 INFO - Running setup.py (path:/tmp/pip-cekQDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:39 INFO - Running setup.py (path:/tmp/pip-96U7fk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:39 INFO - Running setup.py (path:/tmp/pip-0mDhM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:39 INFO - Running setup.py (path:/tmp/pip-Qpwk5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:39 INFO - Running setup.py (path:/tmp/pip-s89eKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:40 INFO - Running setup.py (path:/tmp/pip-u7htiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:40 INFO - Running setup.py (path:/tmp/pip-EqAenY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:40 INFO - Running setup.py (path:/tmp/pip-YLoMXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:40 INFO - Running setup.py (path:/tmp/pip-eFnbSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:40 INFO - Running setup.py (path:/tmp/pip-s01an0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:40 INFO - Running setup.py (path:/tmp/pip-2F6gc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:47:40 INFO - Running setup.py install for manifestparser 15:47:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:47:40 INFO - Running setup.py install for mozcrash 15:47:40 INFO - Running setup.py install for mozdebug 15:47:40 INFO - Running setup.py install for mozdevice 15:47:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:47:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:47:40 INFO - Running setup.py install for mozfile 15:47:41 INFO - Running setup.py install for mozhttpd 15:47:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozinfo 15:47:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozInstall 15:47:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozleak 15:47:41 INFO - Running setup.py install for mozlog 15:47:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for moznetwork 15:47:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozprocess 15:47:41 INFO - Running setup.py install for mozprofile 15:47:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozrunner 15:47:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:47:41 INFO - Running setup.py install for mozscreenshot 15:47:42 INFO - Running setup.py install for moztest 15:47:42 INFO - Running setup.py install for mozversion 15:47:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:47:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:47:42 INFO - Cleaning up... 15:47:42 INFO - Return code: 0 15:47:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:42 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')]} 15:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:42 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')]} 15:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:42 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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:42 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 15:47:42 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 15:47:42 INFO - Using env: {'DISPLAY': ':0', 15:47:42 INFO - 'HOME': '/home/cltbld', 15:47:42 INFO - 'LANG': 'en_US.UTF-8', 15:47:42 INFO - 'LANGUAGE': 'en_US:en', 15:47:42 INFO - 'LOGNAME': 'cltbld', 15:47:42 INFO - 'MAIL': '/var/mail/cltbld', 15:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:42 INFO - 'MOZ_NO_REMOTE': '1', 15:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:42 INFO - 'NO_EM_RESTART': '1', 15:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:42 INFO - 'PWD': '/builds/slave/test', 15:47:42 INFO - 'SHELL': '/bin/bash', 15:47:42 INFO - 'SHLVL': '1', 15:47:42 INFO - 'TERM': 'linux', 15:47:42 INFO - 'TMOUT': '86400', 15:47:42 INFO - 'USER': 'cltbld', 15:47:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:42 INFO - '_': '/tools/buildbot/bin/python'} 15:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:47:42 INFO - Running setup.py (path:/tmp/pip-KOam1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:47:42 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)) 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:47:42 INFO - Running setup.py (path:/tmp/pip-vFwVqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:47:42 INFO - Running setup.py (path:/tmp/pip-LLkUGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:47:42 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)) 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:47:42 INFO - Running setup.py (path:/tmp/pip-TJPoG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:47:42 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)) 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:47:42 INFO - Running setup.py (path:/tmp/pip-rtdWFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:47:42 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)) 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:47:42 INFO - Running setup.py (path:/tmp/pip-epWnzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:47:42 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)) 15:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:47:42 INFO - Running setup.py (path:/tmp/pip-J1BgcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:47:43 INFO - Running setup.py (path:/tmp/pip-y9Eevh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:47:43 INFO - Running setup.py (path:/tmp/pip-mR3d7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:47:43 INFO - Running setup.py (path:/tmp/pip-i5H6Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:47:43 INFO - Running setup.py (path:/tmp/pip-ItDKid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:47:43 INFO - Running setup.py (path:/tmp/pip-dSzBOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:47:43 INFO - Running setup.py (path:/tmp/pip-KTQ2tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:47:43 INFO - Running setup.py (path:/tmp/pip-3qYMLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:43 INFO - Running setup.py (path:/tmp/pip-92W49f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:47:43 INFO - Running setup.py (path:/tmp/pip-CJUC9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:47:43 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)) 15:47:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:47:43 INFO - Running setup.py (path:/tmp/pip-WQJz_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:47:43 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)) 15:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:47:43 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)) 15:47:43 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)) 15:47:43 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)) 15:47:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:47:43 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 15:47:43 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 15:47:43 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 15:47:43 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 15:47:43 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 15:47:43 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 15:47:45 INFO - Downloading blessings-1.6.tar.gz 15:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:47:45 INFO - Installing collected packages: blessings 15:47:45 INFO - Running setup.py install for blessings 15:47:45 INFO - Successfully installed blessings 15:47:45 INFO - Cleaning up... 15:47:45 INFO - Return code: 0 15:47:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:47:46 INFO - Reading from file tmpfile_stdout 15:47:46 INFO - Current package versions: 15:47:46 INFO - argparse == 1.2.1 15:47:46 INFO - blessings == 1.6 15:47:46 INFO - blobuploader == 1.2.4 15:47:46 INFO - docopt == 0.6.1 15:47:46 INFO - functools32 == 3.2.3-2 15:47:46 INFO - jsonschema == 2.5.1 15:47:46 INFO - manifestparser == 1.1 15:47:46 INFO - mozInstall == 1.12 15:47:46 INFO - mozcrash == 0.17 15:47:46 INFO - mozdebug == 0.1 15:47:46 INFO - mozdevice == 0.48 15:47:46 INFO - mozfile == 1.2 15:47:46 INFO - mozhttpd == 0.7 15:47:46 INFO - mozinfo == 0.9 15:47:46 INFO - mozleak == 0.1 15:47:46 INFO - mozlog == 3.4 15:47:46 INFO - moznetwork == 0.27 15:47:46 INFO - mozprocess == 0.23 15:47:46 INFO - mozprofile == 0.28 15:47:46 INFO - mozrunner == 6.12 15:47:46 INFO - mozscreenshot == 0.1 15:47:46 INFO - mozsystemmonitor == 0.3 15:47:46 INFO - moztest == 0.7 15:47:46 INFO - mozversion == 1.4 15:47:46 INFO - psutil == 3.1.1 15:47:46 INFO - requests == 1.2.3 15:47:46 INFO - wsgiref == 0.1.2 15:47:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:47:46 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')]} 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 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')]} 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:46 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 15:47:46 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 15:47:46 INFO - Using env: {'DISPLAY': ':0', 15:47:46 INFO - 'HOME': '/home/cltbld', 15:47:46 INFO - 'LANG': 'en_US.UTF-8', 15:47:46 INFO - 'LANGUAGE': 'en_US:en', 15:47:46 INFO - 'LOGNAME': 'cltbld', 15:47:46 INFO - 'MAIL': '/var/mail/cltbld', 15:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:46 INFO - 'MOZ_NO_REMOTE': '1', 15:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:46 INFO - 'NO_EM_RESTART': '1', 15:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:46 INFO - 'PWD': '/builds/slave/test', 15:47:46 INFO - 'SHELL': '/bin/bash', 15:47:46 INFO - 'SHLVL': '1', 15:47:46 INFO - 'TERM': 'linux', 15:47:46 INFO - 'TMOUT': '86400', 15:47:46 INFO - 'USER': 'cltbld', 15:47:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:46 INFO - '_': '/tools/buildbot/bin/python'} 15:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 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)) 15:47:46 INFO - Cleaning up... 15:47:46 INFO - Return code: 0 15:47:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:47:46 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')]} 15:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 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')]} 15:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:47:46 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 0x7fbdaf337f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, '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': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', '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 15:47:46 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 15:47:46 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 15:47:46 INFO - Using env: {'DISPLAY': ':0', 15:47:46 INFO - 'HOME': '/home/cltbld', 15:47:46 INFO - 'LANG': 'en_US.UTF-8', 15:47:46 INFO - 'LANGUAGE': 'en_US:en', 15:47:46 INFO - 'LOGNAME': 'cltbld', 15:47:46 INFO - 'MAIL': '/var/mail/cltbld', 15:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:47:46 INFO - 'MOZ_NO_REMOTE': '1', 15:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:47:46 INFO - 'NO_EM_RESTART': '1', 15:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:47:46 INFO - 'PWD': '/builds/slave/test', 15:47:46 INFO - 'SHELL': '/bin/bash', 15:47:46 INFO - 'SHLVL': '1', 15:47:46 INFO - 'TERM': 'linux', 15:47:46 INFO - 'TMOUT': '86400', 15:47:46 INFO - 'USER': 'cltbld', 15:47:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:47:46 INFO - '_': '/tools/buildbot/bin/python'} 15:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:47:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:47:46 INFO - Cleaning up... 15:47:46 INFO - Return code: 0 15:47:46 INFO - Running post-action listener: _resource_record_post_action 15:47:46 INFO - Running post-action listener: _start_resource_monitoring 15:47:46 INFO - Starting resource monitoring. 15:47:46 INFO - [mozharness: 2016-10-11 22:47:46.621173Z] Finished create-virtualenv step (success) 15:47:46 INFO - [mozharness: 2016-10-11 22:47:46.621682Z] Running install step. 15:47:46 INFO - Running pre-action listener: _resource_record_pre_action 15:47:46 INFO - Running main action method: install 15:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:47:46 INFO - Reading from file tmpfile_stdout 15:47:46 INFO - Detecting whether we're running mozinstall >=1.0... 15:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:47:46 INFO - Reading from file tmpfile_stdout 15:47:46 INFO - Output received: 15:47:46 INFO - Usage: mozinstall [options] installer 15:47:46 INFO - Options: 15:47:46 INFO - -h, --help show this help message and exit 15:47:46 INFO - -d DEST, --destination=DEST 15:47:46 INFO - Directory to install application into. [default: 15:47:46 INFO - "/builds/slave/test"] 15:47:46 INFO - --app=APP Application being installed. [default: firefox] 15:47:46 INFO - mkdir: /builds/slave/test/build/application 15:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:48:03 INFO - Reading from file tmpfile_stdout 15:48:03 INFO - Output received: 15:48:03 INFO - /builds/slave/test/build/application/firefox/firefox 15:48:03 INFO - Running post-action listener: _resource_record_post_action 15:48:03 INFO - [mozharness: 2016-10-11 22:48:03.924470Z] Finished install step (success) 15:48:03 INFO - [mozharness: 2016-10-11 22:48:03.924715Z] Running run-tests step. 15:48:03 INFO - Running pre-action listener: _resource_record_pre_action 15:48:03 INFO - Running main action method: run_tests 15:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:48:03 INFO - Python 2.7.3 15:48:03 INFO - Return code: 0 15:48:03 INFO - grabbing minidump binary from tooltool 15:48:03 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')]} 15:48:03 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 0x1097930>, '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 0x1098830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:48:03 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 15:48:03 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 15:48:03 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 15:48:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:48:04 INFO - Return code: 0 15:48:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:48:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:48:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:48:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:48:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 15:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 15:48:04 INFO - Using env: {'DISPLAY': ':0', 15:48:04 INFO - 'HOME': '/home/cltbld', 15:48:04 INFO - 'LANG': 'en_US.UTF-8', 15:48:04 INFO - 'LANGUAGE': 'en_US:en', 15:48:04 INFO - 'LOGNAME': 'cltbld', 15:48:04 INFO - 'MAIL': '/var/mail/cltbld', 15:48:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:48:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:04 INFO - 'MOZ_NO_REMOTE': '1', 15:48:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:04 INFO - 'NO_EM_RESTART': '1', 15:48:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:04 INFO - 'PWD': '/builds/slave/test', 15:48:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:48:04 INFO - 'SHELL': '/bin/bash', 15:48:04 INFO - 'SHLVL': '1', 15:48:04 INFO - 'TERM': 'linux', 15:48:04 INFO - 'TMOUT': '86400', 15:48:04 INFO - 'USER': 'cltbld', 15:48:04 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321', 15:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:04 INFO - '_': '/tools/buildbot/bin/python'} 15:48:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 15:48:04 INFO - mozversion application_buildid: 20161011123004 15:48:04 INFO - mozversion application_changeset: 380b5366b20f4ad1cb21ee8252486017e0f66ad2 15:48:04 INFO - mozversion application_display_name: Nightly 15:48:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:48:04 INFO - mozversion application_name: Firefox 15:48:04 INFO - mozversion application_remotingname: firefox 15:48:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:48:04 INFO - mozversion application_vendor: Mozilla 15:48:04 INFO - mozversion application_version: 52.0a1 15:48:04 INFO - mozversion platform_buildid: 20161011123004 15:48:04 INFO - mozversion platform_changeset: 380b5366b20f4ad1cb21ee8252486017e0f66ad2 15:48:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:48:04 INFO - mozversion platform_version: 52.0a1 15:48:04 INFO - using testdate: 1476226084 15:48:04 INFO - actual date: 1476226084 15:48:04 INFO - starting webserver on 'localhost:47450' 15:48:04 INFO - SUITE-START | Running 2 tests 15:48:04 INFO - TEST-START | dromaeo_css 15:48:04 INFO - operating with platform_type : linux_ 15:48:04 INFO - Initialising browser for dromaeo_css test... 15:48:04 INFO - TEST-INFO | started process 13460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM4CHN8/profile http://localhost:47450/getInfo.html) 15:48:08 INFO - PROCESS | 13460 | __metrics Screen width/height:1600/1200 15:48:08 INFO - PROCESS | 13460 | colorDepth:24 15:48:08 INFO - PROCESS | 13460 | Browser inner width/height: 1024/697 15:48:08 INFO - PROCESS | 13460 | __metrics 15:48:09 ERROR - PROCESS | 13460 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 15:48:10 INFO - TEST-INFO | 13460: exit 0 15:48:10 INFO - Browser initialized. 15:48:10 INFO - Running cycle 1/1 for dromaeo_css test... 15:48:10 INFO - TEST-INFO | started process 13585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM4CHN8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:22 INFO - PROCESS | 13585 | RSS: Main: 185761792 15:48:22 INFO - PROCESS | 13585 | 15:49:12 INFO - PROCESS | 13585 | 1476226152173 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] 15:51:24 INFO - PROCESS | 13585 | Cycle 1(1): loaded http://localhost:47450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47450/tests/dromaeo/cssquery-ext.html) 15:51:25 INFO - PROCESS | 13585 | RSS: Main: 202547200 15:51:25 INFO - PROCESS | 13585 | 15:54:27 INFO - PROCESS | 13585 | Cycle 1(1): loaded http://localhost:47450/tests/dromaeo/cssquery-ext.html (next: http://localhost:47450/tests/dromaeo/cssquery-jquery.html) 15:54:28 INFO - PROCESS | 13585 | RSS: Main: 197402624 15:54:28 INFO - PROCESS | 13585 | 15:57:30 INFO - PROCESS | 13585 | Cycle 1(1): loaded http://localhost:47450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47450/tests/dromaeo/cssquery-mootools.html) 15:57:30 INFO - PROCESS | 13585 | RSS: Main: 198664192 15:57:30 INFO - PROCESS | 13585 | 16:00:32 INFO - PROCESS | 13585 | Cycle 1(1): loaded http://localhost:47450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47450/tests/dromaeo/cssquery-prototype.html) 16:00:33 INFO - PROCESS | 13585 | RSS: Main: 194830336 16:00:33 INFO - PROCESS | 13585 | 16:03:35 INFO - PROCESS | 13585 | Cycle 1(1): loaded http://localhost:47450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47450/tests/dromaeo/cssquery-yui.html) 16:03:36 INFO - PROCESS | 13585 | RSS: Main: 198967296 16:03:36 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | Cycle 1(1): loaded http://localhost:47450/tests/dromaeo/cssquery-yui.html (next: http://localhost:47450/tests/dromaeo/cssquery-dojo.html) 16:06:39 INFO - PROCESS | 13585 | RSS: Main: 199208960 16:06:39 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | __start_tp_report 16:06:39 INFO - PROCESS | 13585 | _x_x_mozilla_page_load 16:06:39 INFO - PROCESS | 13585 | _x_x_mozilla_page_load_details 16:06:39 INFO - PROCESS | 13585 | |i|pagename|runs| 16:06:39 INFO - PROCESS | 13585 | |0;dojo.html;2972.078655616759;2972.4203780262856;2984.6866079061692;2985.776066794991;3017.5473678948156;5178.067947769409;5290.338707661543;5298.867528311795;5410.269613602162;5411.783528658859;5221.973890130554;5273.736313184345;5303.973480132594;5307.920381194285;5338.839834804962;4836.492168322328;4867.586255168298;4873.658843880929;4930.457649658535;4953.678010929278;4869;4916;4933.605311575084;4944.35723355965;4980.626453016021;4872.317875497398;4899.338589290436;4949.901001979958;4955.331030310898;5011.874703132415;4772.880677983044;4798.136335459616;4811.9518804812205;4820.590249828769;4857.441394239672;4748.287756836502;4759.405074365704;4779.402574678165;4795.928061079052;4842.370491836074;5281.841544753664;5290.55030322423;5328.92006619901;5336.252924590561;5356.250124982505;5571.1086226203615;5623.662580245198;5636.49271565557;5646.350669672999;5653.010723123478;5657.20799088128;5665.688387138705;5703.5152012079025;5708.571857110692;5709.8287051388525;5338.439463856317;5339.5728341732565;5346.278252435949;5351.598630102758;5406.621536492407;5695.45893140151;5763.827085187451;5846.766129354778;5856.502197313191;5866.208061911672;5692.857678558069;5703.515201207861;5705.115707065412;5708.514776243983;5722.4277572242445;5749.88500229993;5756.453136952066;5761.683107429048;5763.7118144093465;5764.481196692318;5537.833864983976;5613.073842815971;5649.887002259932;5691.430856914359;5716.971415142898;5596.076647353141;5658.151277308437;5659.858503537444;5712.6286791358425;5725.3988331225455;4371.868843934687;4410.426644536254;4413.44831896013;4429.911401771947;4466.731996080245;3855.306044911943;3873.3028054949814;3899.005753532831;3903.4730311408166;3928;5412.242286079952;5446.945530544723;5449.3188351456065;5463.562914966793;5496.093144631171;5732.885342293131;5736.6558006519745;5738.081906894877;5744.167095771089;5749.1663708762;5263.421023687391;5311.814086506954;5396.487333703292;5427.864303392368;5507.421720719347;4882.145624515695;4919.975400122977;4921.409430868319;4929.9014019720125;4930.704157750546;5772.249607550992;5824.009918313896;5827.504662103769;5833.445822646841;5834.562407819346;5655.773769049192;5668.404817494104;5671.149327600728;5674.347450043133;5678.261825962763;5814.7964821232745;5829.59192856496;5829.970850145722;5834.883302333845;5844.620099693507;5549.889002220014;5589.273394458694;5604.8038318658655;5665.291838520185;5674.631148975469;5741.799037033684;5745;5745.511631511368;5760.366359700346;5771.278590176228;5554.944450555443;5609.775608975595;5626.071698169756;5633.126865335879;5637;5451;5476.205950137288;5498.120300751861;5502.80740174092;5619.129034999582;5407.864803379947;5472.644278121909;5509.146082357241;5537.280153580009;5556.055470569932;5486.1222204447095;5551.333839939233;5567.916481252703;5594.636348637326;5654.575906807088;5465.945340546544;5483.985462689415;5486.31421072366;5491.258680078138;5498.477644623755 16:06:39 INFO - PROCESS | 13585 | |1;ext.html;562.2072877243086;564.5032371513068;575.5481946671863;584.5411352088609;586.1559354529477;41987.37018944718;43499.34750978738;43667.78166109169;47356.52643473564;47384.52615473844;44963.55036449635;45308;45399;45403.545964540346;45420.54579454204;8803.295736341093;8933.062028487013;8958.955205223965;8965.193132618064;8967.41711788735;8799.648014079461;8806.075362086985;8852.734417967471;8852.955735221347;8857.955710221471;8901.243394311492;8965.506897120657;8967.596458159398;8973.28213742899;8977.640894364251;8768.73693789181;8831.205191532761;8876.423032502898;8885.244754195837;8886.86669699955;8702.651893924236;8772.429792063496;8817.382783205177;8827.911720882774;8833.779155521164;41958;42366.57633423688;42499.57500424987;42546.57453425488;42584;3316.7396389371884;3424.240172400976;3853.595372485877;3997.98001009996;4158.604932531404;31251.687483125104;31656.36687266265;31657.52513712296;31714.91269726228;31730.206744831332;4017.6986725995666;4143.585641435862;4148.543660197376;4305.440292761952;4339.435873336478;342217;345280.37756979384;345868;347436;348112;58437.41562584405;58947.41052589505;59034;59055;59137;59645;60260;60343.04339783887;60420.69789651024;60844.695776520835;16214.351425943067;16307.429239976544;16467.917660411622;16589.751153732705;16633.334666613442;12692.49230030807;12765.42555585001;12797.808032879515;12826.67933301675;12845.357732113356;16565.58586035359;17443.38349247623;17475.912620436815;17477.82522174762;17605.207765650575;6061.605995610271;6208.658523781235;6380.798624474549;6423.582467139621;6449.871542391;1000.3747657713928;1026.2867307221409;1051.6371851711147;1061.1510791366875;1114.5609426001224;31020.844895775375;31492.37015259682;31535.526967095513;31757.523637145463;32512.512312315335;1142.257532603814;1165.6794381545144;1166.393475392791;1170.4440390814295;1215.7872372334807;15714.68570628581;16753.83246167523;16840.578985525215;16844.494665160066;16899.408520701716;127387.3630631841;128294.35852820677;128402;128447.35776321245;128991;57513.71243143841;57876.710616446646;57973.20267973169;58028.70985645045;58440.12339814906;1295.5400832704443;1348.1237195822794;1356.572679605921;1364.1201425080965;1384.5015794314038;29309.56035659424;30736.692633073384;31359.529607055458;31379.529307059955;31887;50250;50682.493175069256;50808.49191508185;51029.489705102475;51149;421336;422610;423966;424442;425921;40387.3941890866;41237.1752564953;41938.161236775704;41989.37015944824;42129.57870421257;45577.088458229984;46457.535424646674;46832.297515537975;47344.763276183396;48411.27383089327;38730.80634596922;39470.40794388144;39685.52520276635;40687.59312406838;41173;39304.907739300455;39392.80303598464;40338.798306008284;40590.968925764515;41395.793021034704;36217;36977.07557311089;39247;40675;42353.36469952892;34219;36862.8156859214;37078.07304817293;37283.44074838825;37506.24987500289;27438.588421174096;27610.171694849185;27947.720522794512;28062.158135255973;28085.71914280913 16:06:39 INFO - PROCESS | 13585 | |2;jquery.html;385.34491364680053;388.5803332401005;397.9462772525709;398.2493000693693;423.9812534752562;14406.991510594236;18252.908735456338;19975.900120499395;19978;19986.001399860008;18940.526486837836;19159.42521724347;19295.035248237567;19382.22471101158;19412.805871941277;5008.84973450797;5320.9467905321035;5804.535637149039;5818.06910894257;5832.533397328203;5728.79949201778;5806.303243610772;5817.331006934214;5824.679642619654;5832.883342333151;5564.10974244121;5754.942450575503;5799.971000145015;5800.825975220729;5802.767889284423;5411.594130440233;5758.165066065439;5762.53899688026;5788.421157884178;5820.82537523875;5507.807226747044;5630.577706671975;5643.040683083886;5646.7859410227;5649.717514124277;13285.269310187936;13345.666358341023;13508.594742157653;13623.386947587382;13655.112417692819;2009.4172689919906;2072.834173266135;2201.9449513762124;2525.532776436347;2797.2447439191305;9504.762380940463;9644;9742.9512852436;10007.849882251772;10094.9495252524;1832.6243120160334;1915.7317975483443;1928.5757133430623;1935.2452543508043;1938.4087853204767;82331.5883420579;82370.58814705888;82944;84602.15397846005;89721.55139224327;11045.39250341239;11096.278741881752;11159.888401115884;11347.943260283646;11413.086953043736;13234.205947643171;13857.722845543234;15860.682786344209;15977.440789572309;16029.919850400673;7289.125304963438;7689.307962283421;7765.805854853674;7786.909832623437;8445.619947102396;7639.618019099023;7764.92235077642;7825.452218344775;7926.801829954297;8025.839483210303;4493.955060449419;4815.759212039384;4847.95152048475;4895.632827537949;4935.407751069894;1935.7096435534502;1938.6413513500047;2020.595880823841;2048.989755051215;2097.4127244371603;824.7525742277293;911.1571796088591;947.8909925358535;954.4321128928276;1040.6357774778767;17978.37075702344;19320.32378866733;19376.2249510018;19418.611627767365;19505.414837554898;953.4803532075035;954.1126752120595;978.1538968791943;981.3228872078244;1010.0808264479289;10461.529231184462;10795.892041079489;10871.239013268996;10872.891271087346;10892.237543372046;432609;435195;436349;439879;440074;87366.56316718503;88570.55714721385;89903;89959;90422.09577904268;926.9814603708023;949.0604301741226;981.2542467724438;981.254246772458;984.1339621133357;16492.475020868143;16610;16949.576260593585;17180.140992950553;17253.309867605156;38115.80942095272;41750.37374439446;42202;43528.42951490048;43579;49401.50598494113;52983.73508132589;57757.711211443675;57979.4202057974;58819.41180588139;7596.658150383136;7985.64064617082;8013.879791803244;8155.347572194329;8415.579221039046;11719.76560468803;13152.671183220496;13155.736885262433;13187.142835715647;13336.466541338626;11127.221094523306;11151.55393784272;11173.944130279297;11372.772544548898;11725.706857328634;10785.15321451024;10921.180911431515;11033.834492482458;11248.26886252391;11349.4892729829;11018.724531886766;11038.668839934815;11213.943930280297;11474.598389056342;11656.358900260568;8130.39022073335;8151.551664658264;8160.796584922156;8270.2556769891;8482.151784821468;8142.7557173284895;10149.086582207638;10867.456627168453;10874.619388321371;11897.524099036287 16:06:39 INFO - PROCESS | 13585 | |3;mootools.html;1430.628036710455;1479.7040591881625;1595.35388167792;1701.8638508919287;1749.893938259589;7535.321821036106;7785.610719464033;8215;8793.692220772275;8814.55927203639;7872.5276483411035;8149.470284431508;8150.184981501847;8389.580520973943;8405;2200.383892510096;2209.86740795552;2211.1266049910278;2216.7229096362953;2221.2114699281765;2136.9252076177336;2170.251263314154;2254.9098036078535;2256.7066281383395;2256.808171305441;2198.505336299336;2202.218212534551;2204.3056437222303;2206.415299945516;2222.588821068108;2173.8369622278315;2177.945551361213;2178.6840908068243;2179.063002908749;2180.945476363088;2154.7198864147563;2181.3237896252053;2183.879886606236;2190.9811937449003;2202.3392982105306;8496.235338819535;8615.913840861574;8624.568771561397;8636.006859211146;8647.135286471366;4879.682820616648;4997.250412438127;5019.824306149268;5022.321986531808;5035.1188542005;3036.6212771003284;3184.9203769905707;3235.7249633781157;3263.0537144228147;3272.640009598942;1038.9584416623402;1044.6657069737687;1070.817960946641;1100.2188446203206;1101.4988180377989;12000;12013.819792703116;12044.39778011096;12055.156139070268;12078.456469458895;4296.37702533131;4456.509783923766;4478.552144785561;4485.394471746273;4522.728636281834;10147.7463063424;10149.340292881086;10166.135878450266;10191.286609937233;10210.234232432449;5166.793328266827;5193.558547523503;5203.869903252449;5211.140161873324;5220.947790522122;4003.559608443069;4607;4628.166929952641;4788.281757736298;4799.424069111729;3872.4316651756085;3891.9416208756893;3943.940840887389;3957.406389041667;3963.92072158561;1230.5077968812548;1238.2508582307755;1269.9809502857279;1278.3799857069314;1292.2052937443405;822.5147163173756;906.2251774732508;925.8703781470599;930.6556574067638;944.4899754132829;5647.672796892727;5702.287214098238;5734.111212762028;5844.795432159854;5939.613925094855;456.6757602102478;460.091319643701;460.30723760739875;943.6649989253716;1011.3325205364424;3881.5342158940543;3899.337112690849;3903.8243279052513;3905.1603905160528;3983.64147226751;10355.741106472398;10888.237823352447;10894.18293627981;10896.61861834832;10908.23642345044;10571.735706607242;10644.680659580225;10844.945775271231;10855.240133190759;10920.2901811382;7975.122736498981;8022.679092836222;8068.677252909818;8114.269715725613;8166.142555031636;5563.443655634404;5587;5617.859553511195;5654.7455364509515;5807.506361959281;9763.121319081316;9925.602975880884;9982.800343993225;10048.939967306538;10088.192944564564;9293.907060929305;9708.029197080235;9732.951335243562;9925.900740992498;9974.950125249326;6727.461803055646;6964.094667693167;7443.888341674771;7701.768946931601;7885.960570197112;8045.718399855977;8395.202455766692;8402.117777633504;8414.200650938152;8420.70527531558;7136.143662760502;7404.037475128199;7429.4799364044;7448.106227252764;7480;7299.927000729925;7362.595057271901;7406.740764073232;7520.849583008418;7568.5837278950185;7030.367266945999;7049.6122713249215;7106.964465177641;7114.14630244374;7114.217436081924;4919.1883339248625;4922.556969872729;5076.695398276115;5131.10205714006;5214.13966695491;5097.745112744422;5106.642535022513;5206.401263854706;5229.764660590206;5248.685078895279 16:06:39 INFO - PROCESS | 13585 | |4;prototype.html;331.8698793514709;338.7645586317509;346.668931170732;351.0416562783602;355.3532570721288;5256.763445644946;5389.51494365507;5491.423400542945;5528.281323427958;5575.49820516154;5271.367435907697;5298.284731561238;5420.6747595144225;5431.158170483582;5444.265024221729;4239.092408416225;4296.5273819879785;4304.139172165564;4319.3952846601505;4329.30731083026;4231.259529582326;4253.723882835153;4301.182775272704;4326.156399502099;4327.285997810358;4233.809478573472;4252.724792236154;4254.340577210537;4272.145570885836;4290.120525292307;4208.137331846964;4213.43118678979;4220.6412454941365;4256.702030857841;4265.296226122686;3715.888523344304;3817.6564109230303;3819.427085937104;3820.331441997639;3827.138893748912;5203.453637368098;5228.686278823283;5237.8428647140645;5277.762500687479;5296.3909150447425;4870.22076467767;4885.998370334073;4896.75516224191;4897.583705385046;4903.436104847952;5462.754176062087;5617.522510586605;5655.632383895075;5659.7453114609525;5663.688497132656;4056.249593825152;4057.0383619957597;4070.4708387909677;4073.6537394321517;4114.465119534471;5844.766209351621;5850.385709500484;5905.793297234619;5912.46787789101;5959.73181206851;4110.958890411118;4175.665946724254;4189.2459357315975;4203.894902627398;4218.240716670967;4221.261279276115;4265.97867010663;4289.49064797091;4301.838503604009;4330.653547716175;4861.124997500413;4871.7333493292;4890.657653964188;4894.951050489521;4936.777844996984;5391.218273350342;5718.628289161191;5739.454751798572;5755.165501002331;5766.030494295441;1446.2696338349067;1457.5481600703604;1467.4717101843328;1469.860363265488;1477.933492992818;907.2832462354797;930.5486838883136;930.6370515498961;950.8288508068614;956.2302346610905;4778.348016850612;4793.520647935248;4803.903921921542;4815.927761083586;4845.9757701211975;5082.593392528589;5087.364079490064;5179.249008893689;5184.844454666366;5196.259253150161;4653.208954477747;4737.709078784312;4832.347633069561;4844.32179494871;4883.826697119819;2727.7545020947814;2727.9318017049336;2732.617433559303;2742.8217165884153;2751.408447183865;5258.553022993012;5308.92036619451;5337.546308563816;5350.571954243651;5365.409804921455;5014.348134742533;5115;5228.2941802856885;5262.236975638511;5264.6051546134195;5192.688438693691;5243.68537887728;5265.289185959923;5268.420473747885;5327.733613319396;5139.023585518739;5152.896942061213;5171.3277273954145;5186.369541321165;5211.296474975981;4807.495213002584;5042.168042272984;5083.415407228216;5084.211947148198;5137.845864624067;5263.92089621619;5279.234510995961;5302.416734159317;5312.840614781563;5352.946470535245;3785.7539259948016;3928.960710392974;4043.2317859606583;4138.213739389506;4280.165367753259;5712.6286791358425;5721.685307308138;5733.770649173986;5742.794013257263;5788.305403351625;5539.972300138474;5657.387644521292;5702.942970570241;5703.657780533182;5725.312962444534;5559.332880054258;5616.66300022;5642;5651;5669.829905102853;5628.352739435018;5666.914996274977;5695.288088988877;5711.914321285101;5742.741576629145;5559.416261292506;5616.831495055155;5621.269234999424;5629.662220266797;5700.230468886647;5513.972430137824;5526.640768350205;5527.585431092764;5535.142052981794;5543.667379957215 16:06:39 INFO - PROCESS | 13585 | |5;yui.html;711.9822004449888;751.5415596486146;753.7889390970529;793.9404544659152;804.0712976512124;15844.366225350986;16184.514464566082;16186.352545898164;16390.67218655626;16498.42255521057;15210.619734506616;15436.845631543682;15460.226988650578;15476.458323958665;15502.30239639216;797.8484088023272;811.5860910935406;814.9429539932207;818.5293456262673;819.1317203763999;812.7561731480562;817.81190326225;818.6766227340197;820.8030072782519;823.5223570329194;850.370725663008;851.1445996773265;853.6116067189414;854.0775961961067;854.1757204297851;849.9575021248975;850.0182289455657;850.336737344872;852.4033176776281;852.7186028610574;630.5302549600531;631.8515148939996;632.9398707122816;635.8569321902535;637.073058699591;14227.715445691132;14239.78640320396;14382.496612618614;14392.208428536427;14399.712005759826;12469.625911222678;12960.740785184338;13084.214947103204;13581.370369817816;13685.863141368558;11223;11266.66200014001;11344.14918881079;11371.715707107305;11562.710932226677;3762.7177961652988;3763.379042457991;3770.170562476251;3830.636089571486;3901.843926242947;53525.73237133829;54310.72844635791;66615;70872.73643093139;75787.24212757857;11088.06016297463;11522;11602.76794464106;11626.476808543635;11696.766064678828;21389.35831925045;21474.785252147278;21531.13875444996;21531.67702484464;21545.461363466038;8217.08369973618;8289.41974061822;8511.914880851236;8565.785855353666;8819.514926679094;4491.505934347219;4603.217453032992;4678.204705200124;4730.290456431563;4730.385049943486;3528.5060091587197;3676.8713095041544;3677.1726361568435;3678.7240956928335;3682.1899182179877;622.5828694774422;622.7203097634315;627.6516533324049;639.1850390751736;641.7112299465259;670.6847781542667;696.9963252915785;711.1111111111111;732.209214048826;740.4298690008663;9786;10032.297739158335;10035.247356448295;10519.52662130206;10727.302725322828;700.5761514283887;722.9132504099437;730.587218221703;733.7175187552831;738.7551974922274;4099.8360065597635;4638.350630911675;4803.231482962709;4827.975860120747;4866.562009419169;87072;111289;119992.40003799925;122490;125100;56018.43981560132;73893.63053184807;77469.61265193751;84619;91068.54465727761;80433.59783201046;86067;87044.56477717697;87064.12935870686;89466.55266723756;9212.3090768194;9410;9466.195373393064;9548.18840398574;9554.856677149988;51564.48435515597;51690.483095168565;51691.74154129356;52264;53042;69248.6537567309;75716.62141689476;76145.61927190328;76219;77790;12432.378381080729;12467.563635272722;12577.685557861127;12809.295488748208;12841;14904.329305181509;15249.560070389129;15366.231688415759;15374.769378459556;15660.13869237203;12491.37543122822;13500.93249533746;13507.324633768469;13767.793483097561;14169.36237869319;13132.934335328262;13290.667733306746;13340.399682014138;13495.325233738471;13837.515686950908;12335.321557314433;12531.49874005066;12641.747165056831;12763.298018609066;13317.33413329349;11067.557297708001;11591.826122608;11693.298402095901;11757.941210293893;11796.29222246668;9959.900400995897;11005.229633925868;11297.378644174649;11332.830007549728;11896.464659090534 16:06:39 INFO - PROCESS | 13585 | __end_tp_report 16:06:39 INFO - PROCESS | 13585 | __start_cc_report 16:06:39 INFO - PROCESS | 13585 | _x_x_mozilla_cycle_collect,346 16:06:39 INFO - PROCESS | 13585 | __end_cc_report 16:06:39 INFO - PROCESS | 13585 | __startTimestamp1476227199607__endTimestamp 16:06:39 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | ------- Summary: start ------- 16:06:39 INFO - PROCESS | 13585 | Number of tests: 6 16:06:39 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | [#0] dojo.html Cycles:165 Average:5293.60 Median:5496.09 stddev:602.37 (11.0%) stddev-sans-first:576.02 16:06:39 INFO - PROCESS | 13585 | Values: 2972.1 2972.4 2984.7 2985.8 3017.5 5178.1 5290.3 5298.9 5410.3 5411.8 5222.0 5273.7 5304.0 5307.9 5338.8 4836.5 4867.6 4873.7 4930.5 4953.7 4869.0 4916.0 4933.6 4944.4 4980.6 4872.3 4899.3 4949.9 4955.3 5011.9 4772.9 4798.1 4812.0 4820.6 4857.4 4748.3 4759.4 4779.4 4795.9 4842.4 5281.8 5290.6 5328.9 5336.3 5356.3 5571.1 5623.7 5636.5 5646.4 5653.0 5657.2 5665.7 5703.5 5708.6 5709.8 5338.4 5339.6 5346.3 5351.6 5406.6 5695.5 5763.8 5846.8 5856.5 5866.2 5692.9 5703.5 5705.1 5708.5 5722.4 5749.9 5756.5 5761.7 5763.7 5764.5 5537.8 5613.1 5649.9 5691.4 5717.0 5596.1 5658.2 5659.9 5712.6 5725.4 4371.9 4410.4 4413.4 4429.9 4466.7 3855.3 3873.3 3899.0 3903.5 3928.0 5412.2 5446.9 5449.3 5463.6 5496.1 5732.9 5736.7 5738.1 5744.2 5749.2 5263.4 5311.8 5396.5 5427.9 5507.4 4882.1 4920.0 4921.4 4929.9 4930.7 5772.2 5824.0 5827.5 5833.4 5834.6 5655.8 5668.4 5671.1 5674.3 5678.3 5814.8 5829.6 5830.0 5834.9 5844.6 5549.9 5589.3 5604.8 5665.3 5674.6 5741.8 5745.0 5745.5 5760.4 5771.3 5554.9 5609.8 5626.1 5633.1 5637.0 5451.0 5476.2 5498.1 5502.8 5619.1 5407.9 5472.6 5509.1 5537.3 5556.1 5486.1 5551.3 5567.9 5594.6 5654.6 5465.9 5484.0 5486.3 5491.3 5498.5 16:06:39 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | [#1] ext.html Cycles:180 Average:48622.70 Median:22769.69 stddev:85962.25 (377.5%) stddev-sans-first:86127.66 16:06:39 INFO - PROCESS | 13585 | Values: 562.2 564.5 575.5 584.5 586.2 41987.4 43499.3 43667.8 47356.5 47384.5 44963.6 45308.0 45399.0 45403.5 45420.5 8803.3 8933.1 8959.0 8965.2 8967.4 8799.6 8806.1 8852.7 8853.0 8858.0 8901.2 8965.5 8967.6 8973.3 8977.6 8768.7 8831.2 8876.4 8885.2 8886.9 8702.7 8772.4 8817.4 8827.9 8833.8 41958.0 42366.6 42499.6 42546.6 42584.0 3316.7 3424.2 3853.6 3998.0 4158.6 31251.7 31656.4 31657.5 31714.9 31730.2 4017.7 4143.6 4148.5 4305.4 4339.4 342217.0 345280.4 345868.0 347436.0 348112.0 58437.4 58947.4 59034.0 59055.0 59137.0 59645.0 60260.0 60343.0 60420.7 60844.7 16214.4 16307.4 16467.9 16589.8 16633.3 12692.5 12765.4 12797.8 12826.7 12845.4 16565.6 17443.4 17475.9 17477.8 17605.2 6061.6 6208.7 6380.8 6423.6 6449.9 1000.4 1026.3 1051.6 1061.2 1114.6 31020.8 31492.4 31535.5 31757.5 32512.5 1142.3 1165.7 1166.4 1170.4 1215.8 15714.7 16753.8 16840.6 16844.5 16899.4 127387.4 128294.4 128402.0 128447.4 128991.0 57513.7 57876.7 57973.2 58028.7 58440.1 1295.5 1348.1 1356.6 1364.1 1384.5 29309.6 30736.7 31359.5 31379.5 31887.0 50250.0 50682.5 50808.5 51029.5 51149.0 421336.0 422610.0 423966.0 424442.0 425921.0 40387.4 41237.2 41938.2 41989.4 42129.6 45577.1 46457.5 46832.3 47344.8 48411.3 38730.8 39470.4 39685.5 40687.6 41173.0 39304.9 39392.8 40338.8 40591.0 41395.8 36217.0 36977.1 39247.0 40675.0 42353.4 34219.0 36862.8 37078.1 37283.4 37506.2 27438.6 27610.2 27947.7 28062.2 28085.7 16:06:39 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | [#2] jquery.html Cycles:180 Average:27036.73 Median:216516.49 stddev:72401.33 (33.4%) stddev-sans-first:72576.78 16:06:39 INFO - PROCESS | 13585 | Values: 385.3 388.6 397.9 398.2 424.0 14407.0 18252.9 19975.9 19978.0 19986.0 18940.5 19159.4 19295.0 19382.2 19412.8 5008.8 5320.9 5804.5 5818.1 5832.5 5728.8 5806.3 5817.3 5824.7 5832.9 5564.1 5754.9 5800.0 5800.8 5802.8 5411.6 5758.2 5762.5 5788.4 5820.8 5507.8 5630.6 5643.0 5646.8 5649.7 13285.3 13345.7 13508.6 13623.4 13655.1 2009.4 2072.8 2201.9 2525.5 2797.2 9504.8 9644.0 9743.0 10007.8 10094.9 1832.6 1915.7 1928.6 1935.2 1938.4 82331.6 82370.6 82944.0 84602.2 89721.6 11045.4 11096.3 11159.9 11347.9 11413.1 13234.2 13857.7 15860.7 15977.4 16029.9 7289.1 7689.3 7765.8 7786.9 8445.6 7639.6 7764.9 7825.5 7926.8 8025.8 4494.0 4815.8 4848.0 4895.6 4935.4 1935.7 1938.6 2020.6 2049.0 2097.4 824.8 911.2 947.9 954.4 1040.6 17978.4 19320.3 19376.2 19418.6 19505.4 953.5 954.1 978.2 981.3 1010.1 10461.5 10795.9 10871.2 10872.9 10892.2 432609.0 435195.0 436349.0 439879.0 440074.0 87366.6 88570.6 89903.0 89959.0 90422.1 927.0 949.1 981.3 981.3 984.1 16492.5 16610.0 16949.6 17180.1 17253.3 38115.8 41750.4 42202.0 43528.4 43579.0 49401.5 52983.7 57757.7 57979.4 58819.4 7596.7 7985.6 8013.9 8155.3 8415.6 11719.8 13152.7 13155.7 13187.1 13336.5 11127.2 11151.6 11173.9 11372.8 11725.7 10785.2 10921.2 11033.8 11248.3 11349.5 11018.7 11038.7 11213.9 11474.6 11656.4 8130.4 8151.6 8160.8 8270.3 8482.2 8142.8 10149.1 10867.5 10874.6 11897.5 16:06:39 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | [#3] mootools.html Cycles:180 Average:5625.30 Median:4839.55 stddev:3238.24 (66.9%) stddev-sans-first:3231.98 16:06:39 INFO - PROCESS | 13585 | Values: 1430.6 1479.7 1595.4 1701.9 1749.9 7535.3 7785.6 8215.0 8793.7 8814.6 7872.5 8149.5 8150.2 8389.6 8405.0 2200.4 2209.9 2211.1 2216.7 2221.2 2136.9 2170.3 2254.9 2256.7 2256.8 2198.5 2202.2 2204.3 2206.4 2222.6 2173.8 2177.9 2178.7 2179.1 2180.9 2154.7 2181.3 2183.9 2191.0 2202.3 8496.2 8615.9 8624.6 8636.0 8647.1 4879.7 4997.3 5019.8 5022.3 5035.1 3036.6 3184.9 3235.7 3263.1 3272.6 1039.0 1044.7 1070.8 1100.2 1101.5 12000.0 12013.8 12044.4 12055.2 12078.5 4296.4 4456.5 4478.6 4485.4 4522.7 10147.7 10149.3 10166.1 10191.3 10210.2 5166.8 5193.6 5203.9 5211.1 5220.9 4003.6 4607.0 4628.2 4788.3 4799.4 3872.4 3891.9 3943.9 3957.4 3963.9 1230.5 1238.3 1270.0 1278.4 1292.2 822.5 906.2 925.9 930.7 944.5 5647.7 5702.3 5734.1 5844.8 5939.6 456.7 460.1 460.3 943.7 1011.3 3881.5 3899.3 3903.8 3905.2 3983.6 10355.7 10888.2 10894.2 10896.6 10908.2 10571.7 10644.7 10844.9 10855.2 10920.3 7975.1 8022.7 8068.7 8114.3 8166.1 5563.4 5587.0 5617.9 5654.7 5807.5 9763.1 9925.6 9982.8 10048.9 10088.2 9293.9 9708.0 9733.0 9925.9 9975.0 6727.5 6964.1 7443.9 7701.8 7886.0 8045.7 8395.2 8402.1 8414.2 8420.7 7136.1 7404.0 7429.5 7448.1 7480.0 7299.9 7362.6 7406.7 7520.8 7568.6 7030.4 7049.6 7107.0 7114.1 7114.2 4919.2 4922.6 5076.7 5131.1 5214.1 5097.7 5106.6 5206.4 5229.8 5248.7 16:06:39 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | [#4] prototype.html Cycles:180 Average:4606.96 Median:5162.11 stddev:1315.59 (25.5%) stddev-sans-first:1279.55 16:06:39 INFO - PROCESS | 13585 | Values: 331.9 338.8 346.7 351.0 355.4 5256.8 5389.5 5491.4 5528.3 5575.5 5271.4 5298.3 5420.7 5431.2 5444.3 4239.1 4296.5 4304.1 4319.4 4329.3 4231.3 4253.7 4301.2 4326.2 4327.3 4233.8 4252.7 4254.3 4272.1 4290.1 4208.1 4213.4 4220.6 4256.7 4265.3 3715.9 3817.7 3819.4 3820.3 3827.1 5203.5 5228.7 5237.8 5277.8 5296.4 4870.2 4886.0 4896.8 4897.6 4903.4 5462.8 5617.5 5655.6 5659.7 5663.7 4056.2 4057.0 4070.5 4073.7 4114.5 5844.8 5850.4 5905.8 5912.5 5959.7 4111.0 4175.7 4189.2 4203.9 4218.2 4221.3 4266.0 4289.5 4301.8 4330.7 4861.1 4871.7 4890.7 4895.0 4936.8 5391.2 5718.6 5739.5 5755.2 5766.0 1446.3 1457.5 1467.5 1469.9 1477.9 907.3 930.5 930.6 950.8 956.2 4778.3 4793.5 4803.9 4815.9 4846.0 5082.6 5087.4 5179.2 5184.8 5196.3 4653.2 4737.7 4832.3 4844.3 4883.8 2727.8 2727.9 2732.6 2742.8 2751.4 5258.6 5308.9 5337.5 5350.6 5365.4 5014.3 5115.0 5228.3 5262.2 5264.6 5192.7 5243.7 5265.3 5268.4 5327.7 5139.0 5152.9 5171.3 5186.4 5211.3 4807.5 5042.2 5083.4 5084.2 5137.8 5263.9 5279.2 5302.4 5312.8 5352.9 3785.8 3929.0 4043.2 4138.2 4280.2 5712.6 5721.7 5733.8 5742.8 5788.3 5540.0 5657.4 5702.9 5703.7 5725.3 5559.3 5616.7 5642.0 5651.0 5669.8 5628.4 5666.9 5695.3 5711.9 5742.7 5559.4 5616.8 5621.3 5629.7 5700.2 5514.0 5526.6 5527.6 5535.1 5543.7 16:06:39 INFO - PROCESS | 13585 | 16:06:39 INFO - PROCESS | 13585 | [#5] yui.html Cycles:180 Average:19792.20 Median:4658.28 stddev:27962.11 (600.3%) stddev-sans-first:28003.85 16:06:39 INFO - PROCESS | 13585 | Values: 712.0 751.5 753.8 793.9 804.1 15844.4 16184.5 16186.4 16390.7 16498.4 15210.6 15436.8 15460.2 15476.5 15502.3 797.8 811.6 814.9 818.5 819.1 812.8 817.8 818.7 820.8 823.5 850.4 851.1 853.6 854.1 854.2 850.0 850.0 850.3 852.4 852.7 630.5 631.9 632.9 635.9 637.1 14227.7 14239.8 14382.5 14392.2 14399.7 12469.6 12960.7 13084.2 13581.4 13685.9 11223.0 11266.7 11344.1 11371.7 11562.7 3762.7 3763.4 3770.2 3830.6 3901.8 53525.7 54310.7 66615.0 70872.7 75787.2 11088.1 11522.0 11602.8 11626.5 11696.8 21389.4 21474.8 21531.1 21531.7 21545.5 8217.1 8289.4 8511.9 8565.8 8819.5 4491.5 4603.2 4678.2 4730.3 4730.4 3528.5 3676.9 3677.2 3678.7 3682.2 622.6 622.7 627.7 639.2 641.7 670.7 697.0 711.1 732.2 740.4 9786.0 10032.3 10035.2 10519.5 10727.3 700.6 722.9 730.6 733.7 738.8 4099.8 4638.4 4803.2 4828.0 4866.6 87072.0 111289.0 119992.4 122490.0 125100.0 56018.4 73893.6 77469.6 84619.0 91068.5 80433.6 86067.0 87044.6 87064.1 89466.6 9212.3 9410.0 9466.2 9548.2 9554.9 51564.5 51690.5 51691.7 52264.0 53042.0 69248.7 75716.6 76145.6 76219.0 77790.0 12432.4 12467.6 12577.7 12809.3 12841.0 14904.3 15249.6 15366.2 15374.8 15660.1 12491.4 13500.9 13507.3 13767.8 14169.4 13132.9 13290.7 13340.4 13495.3 13837.5 12335.3 12531.5 12641.7 12763.3 13317.3 11067.6 11591.8 11693.3 11757.9 11796.3 9959.9 11005.2 11297.4 11332.8 11896.5 16:06:39 INFO - PROCESS | 13585 | -------- Summary: end -------- 16:06:39 INFO - PROCESS | 13585 | 16:06:40 INFO - TEST-INFO | 13585: exit 0 16:06:40 INFO - TEST-OK | dromaeo_css | took 1116497ms 16:06:40 INFO - TEST-START | kraken 16:06:40 INFO - operating with platform_type : linux_ 16:06:40 INFO - Initialising browser for kraken test... 16:06:40 INFO - TEST-INFO | started process 13949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHBmXgX/profile http://localhost:47450/getInfo.html) 16:06:45 INFO - PROCESS | 13949 | __metrics Screen width/height:1600/1200 16:06:45 INFO - PROCESS | 13949 | colorDepth:24 16:06:45 INFO - PROCESS | 13949 | Browser inner width/height: 1024/697 16:06:45 INFO - PROCESS | 13949 | __metrics 16:06:45 ERROR - PROCESS | 13949 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:06:46 INFO - TEST-INFO | 13949: exit 0 16:06:46 INFO - Browser initialized. 16:06:46 INFO - Running cycle 1/1 for kraken test... 16:06:46 INFO - TEST-INFO | started process 14074 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHBmXgX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:58 INFO - PROCESS | 14074 | RSS: Main: 184840192 16:06:58 INFO - PROCESS | 14074 | 16:07:01 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47450/tests/kraken/driver.html?testName=audio-beat-detection) 16:07:02 INFO - PROCESS | 14074 | RSS: Main: 199094272 16:07:02 INFO - PROCESS | 14074 | 16:07:05 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47450/tests/kraken/driver.html?testName=audio-dft) 16:07:06 INFO - PROCESS | 14074 | RSS: Main: 196939776 16:07:06 INFO - PROCESS | 14074 | 16:07:08 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47450/tests/kraken/driver.html?testName=audio-fft) 16:07:09 INFO - PROCESS | 14074 | RSS: Main: 192581632 16:07:09 INFO - PROCESS | 14074 | 16:07:11 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47450/tests/kraken/driver.html?testName=audio-oscillator) 16:07:12 INFO - PROCESS | 14074 | RSS: Main: 193142784 16:07:12 INFO - PROCESS | 14074 | 16:07:14 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:07:15 INFO - PROCESS | 14074 | RSS: Main: 192716800 16:07:15 INFO - PROCESS | 14074 | 16:07:18 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47450/tests/kraken/driver.html?testName=imaging-darkroom) 16:07:18 INFO - PROCESS | 14074 | RSS: Main: 193142784 16:07:18 INFO - PROCESS | 14074 | 16:07:22 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47450/tests/kraken/driver.html?testName=imaging-desaturate) 16:07:22 INFO - PROCESS | 14074 | RSS: Main: 191471616 16:07:22 INFO - PROCESS | 14074 | 16:07:25 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47450/tests/kraken/driver.html?testName=json-parse-financial) 16:07:26 INFO - PROCESS | 14074 | RSS: Main: 192421888 16:07:26 INFO - PROCESS | 14074 | 16:07:27 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:07:28 INFO - PROCESS | 14074 | RSS: Main: 192503808 16:07:28 INFO - PROCESS | 14074 | 16:07:30 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47450/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:07:31 INFO - PROCESS | 14074 | RSS: Main: 192602112 16:07:31 INFO - PROCESS | 14074 | 16:07:33 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:07:33 INFO - PROCESS | 14074 | RSS: Main: 192573440 16:07:33 INFO - PROCESS | 14074 | 16:07:36 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:07:37 INFO - PROCESS | 14074 | RSS: Main: 193822720 16:07:37 INFO - PROCESS | 14074 | 16:07:40 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:07:40 INFO - PROCESS | 14074 | RSS: Main: 193134592 16:07:40 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | Cycle 1(1): loaded http://localhost:47450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47450/tests/kraken/driver.html?testName=ai-astar) 16:07:42 INFO - PROCESS | 14074 | RSS: Main: 194793472 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | __start_tp_report 16:07:42 INFO - PROCESS | 14074 | _x_x_mozilla_page_load 16:07:42 INFO - PROCESS | 14074 | _x_x_mozilla_page_load_details 16:07:42 INFO - PROCESS | 14074 | |i|pagename|runs| 16:07:42 INFO - PROCESS | 14074 | |0;ai-astar;107;113;114;111;113;113;114;114;112;113 16:07:42 INFO - PROCESS | 14074 | |1;audio-beat-detection;153;125;126;170;128;122;123;126;151;127 16:07:42 INFO - PROCESS | 14074 | |2;audio-dft;162;166;167;167;162;163;163;161;161;164 16:07:42 INFO - PROCESS | 14074 | |3;audio-fft;76;75;76;113;77;79;77;78;101;76 16:07:42 INFO - PROCESS | 14074 | |4;audio-oscillator;83;83;114;86;84;83;106;83;82;124 16:07:42 INFO - PROCESS | 14074 | |5;imaging-gaussian-blur;117;118;117;117;117;117;119;119;118;118 16:07:42 INFO - PROCESS | 14074 | |6;imaging-darkroom;146;147;149;147;147;146;147;147;146;149 16:07:42 INFO - PROCESS | 14074 | |7;imaging-desaturate;95;95;96;96;97;96;97;96;95;97 16:07:42 INFO - PROCESS | 14074 | |8;json-parse-financial;52;55;53;52;55;54;54;53;54;55 16:07:42 INFO - PROCESS | 14074 | |9;json-stringify-tinderbox;61;62;60;61;62;60;61;61;65;61 16:07:42 INFO - PROCESS | 14074 | |10;stanford-crypto-aes;80;79;81;81;81;81;81;80;81;80 16:07:42 INFO - PROCESS | 14074 | |11;stanford-crypto-ccm;148;141;137;133;132;133;130;141;182;132 16:07:42 INFO - PROCESS | 14074 | |12;stanford-crypto-pbkdf2;167;169;174;167;164;165;165;174;165;165 16:07:42 INFO - PROCESS | 14074 | |13;stanford-crypto-sha256-iterative;69;66;69;66;67;67;68;64;65;67 16:07:42 INFO - PROCESS | 14074 | __end_tp_report 16:07:42 INFO - PROCESS | 14074 | __start_cc_report 16:07:42 INFO - PROCESS | 14074 | _x_x_mozilla_cycle_collect,827 16:07:42 INFO - PROCESS | 14074 | __end_cc_report 16:07:42 INFO - PROCESS | 14074 | __startTimestamp1476227262652__endTimestamp 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | ------- Summary: start ------- 16:07:42 INFO - PROCESS | 14074 | Number of tests: 14 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.12 (1.9%) stddev-sans-first:1.00 16:07:42 INFO - PROCESS | 14074 | Values: 107.0 113.0 114.0 111.0 113.0 113.0 114.0 114.0 112.0 113.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:127.50 stddev:16.64 (13.1%) stddev-sans-first:16.34 16:07:42 INFO - PROCESS | 14074 | Values: 153.0 125.0 126.0 170.0 128.0 122.0 123.0 126.0 151.0 127.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.32 (1.4%) stddev-sans-first:2.39 16:07:42 INFO - PROCESS | 14074 | Values: 162.0 166.0 167.0 167.0 162.0 163.0 163.0 161.0 161.0 164.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.50 stddev:13.11 (17.1%) stddev-sans-first:13.68 16:07:42 INFO - PROCESS | 14074 | Values: 76.0 75.0 76.0 113.0 77.0 79.0 77.0 78.0 101.0 76.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:83.00 stddev:15.71 (18.9%) stddev-sans-first:16.26 16:07:42 INFO - PROCESS | 14074 | Values: 83.0 83.0 114.0 86.0 84.0 83.0 106.0 83.0 82.0 124.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 16:07:42 INFO - PROCESS | 14074 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 119.0 119.0 118.0 118.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:1.09 16:07:42 INFO - PROCESS | 14074 | Values: 146.0 147.0 149.0 147.0 147.0 146.0 147.0 147.0 146.0 149.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 16:07:42 INFO - PROCESS | 14074 | Values: 95.0 95.0 96.0 96.0 97.0 96.0 97.0 96.0 95.0 97.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.16 (2.1%) stddev-sans-first:1.05 16:07:42 INFO - PROCESS | 14074 | Values: 52.0 55.0 53.0 52.0 55.0 54.0 54.0 53.0 54.0 55.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:1.43 (2.3%) stddev-sans-first:1.51 16:07:42 INFO - PROCESS | 14074 | Values: 61.0 62.0 60.0 61.0 62.0 60.0 61.0 61.0 65.0 61.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:0.71 (0.9%) stddev-sans-first:0.73 16:07:42 INFO - PROCESS | 14074 | Values: 80.0 79.0 81.0 81.0 81.0 81.0 81.0 80.0 81.0 80.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:139.00 stddev:15.48 (11.1%) stddev-sans-first:16.21 16:07:42 INFO - PROCESS | 14074 | Values: 148.0 141.0 137.0 133.0 132.0 133.0 130.0 141.0 182.0 132.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.00 stddev:3.72 (2.2%) stddev-sans-first:3.94 16:07:42 INFO - PROCESS | 14074 | Values: 167.0 169.0 174.0 167.0 164.0 165.0 165.0 174.0 165.0 165.0 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.51 16:07:42 INFO - PROCESS | 14074 | Values: 69.0 66.0 69.0 66.0 67.0 67.0 68.0 64.0 65.0 67.0 16:07:42 INFO - PROCESS | 14074 | -------- Summary: end -------- 16:07:42 INFO - PROCESS | 14074 | 16:07:42 INFO - PROCESS | 14074 | [Parent 14074] WARNING: pipe error (77): Connection reset by peer: file /builds/slave/autoland-l64-pgo-0000000000000/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 322 16:07:43 INFO - TEST-INFO | 14074: exit 0 16:07:43 INFO - TEST-OK | kraken | took 63154ms 16:07:43 INFO - SUITE-END | took 1179s 16:07:44 INFO - Completed test suite (00:19:40) 16:07:44 INFO - javascript benchmark 16:07:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7078.914997602238, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2972.078655616759, 2972.4203780262856, 2984.6866079061692, 2985.776066794991, 3017.5473678948156, 5178.067947769409, 5290.338707661543, 5298.867528311795, 5410.269613602162, 5411.783528658859, 5221.973890130554, 5273.736313184345, 5303.973480132594, 5307.920381194285, 5338.839834804962, 4836.492168322328, 4867.586255168298, 4873.658843880929, 4930.457649658535, 4953.678010929278, 4869.0, 4916.0, 4933.605311575084, 4944.35723355965, 4980.626453016021, 4872.317875497398, 4899.338589290436, 4949.901001979958, 4955.331030310898, 5011.874703132415, 4772.880677983044, 4798.136335459616, 4811.9518804812205, 4820.590249828769, 4857.441394239672, 4748.287756836502, 4759.405074365704, 4779.402574678165, 4795.928061079052, 4842.370491836074, 5281.841544753664, 5290.55030322423, 5328.92006619901, 5336.252924590561, 5356.250124982505, 5571.1086226203615, 5623.662580245198, 5636.49271565557, 5646.350669672999, 5653.010723123478, 5657.20799088128, 5665.688387138705, 5703.5152012079025, 5708.571857110692, 5709.8287051388525, 5338.439463856317, 5339.5728341732565, 5346.278252435949, 5351.598630102758, 5406.621536492407, 5695.45893140151, 5763.827085187451, 5846.766129354778, 5856.502197313191, 5866.208061911672, 5692.857678558069, 5703.515201207861, 5705.115707065412, 5708.514776243983, 5722.4277572242445, 5749.88500229993, 5756.453136952066, 5761.683107429048, 5763.7118144093465, 5764.481196692318, 5537.833864983976, 5613.073842815971, 5649.887002259932, 5691.430856914359, 5716.971415142898, 5596.076647353141, 5658.151277308437, 5659.858503537444, 5712.6286791358425, 5725.3988331225455, 4371.868843934687, 4410.426644536254, 4413.44831896013, 4429.911401771947, 4466.731996080245, 3855.306044911943, 3873.3028054949814, 3899.005753532831, 3903.4730311408166, 3928.0, 5412.242286079952, 5446.945530544723, 5449.3188351456065, 5463.562914966793, 5496.093144631171, 5732.885342293131, 5736.6558006519745, 5738.081906894877, 5744.167095771089, 5749.1663708762, 5263.421023687391, 5311.814086506954, 5396.487333703292, 5427.864303392368, 5507.421720719347, 4882.145624515695, 4919.975400122977, 4921.409430868319, 4929.9014019720125, 4930.704157750546, 5772.249607550992, 5824.009918313896, 5827.504662103769, 5833.445822646841, 5834.562407819346, 5655.773769049192, 5668.404817494104, 5671.149327600728, 5674.347450043133, 5678.261825962763, 5814.7964821232745, 5829.59192856496, 5829.970850145722, 5834.883302333845, 5844.620099693507, 5549.889002220014, 5589.273394458694, 5604.8038318658655, 5665.291838520185, 5674.631148975469, 5741.799037033684, 5745.0, 5745.511631511368, 5760.366359700346, 5771.278590176228, 5554.944450555443, 5609.775608975595, 5626.071698169756, 5633.126865335879, 5637.0, 5451.0, 5476.205950137288, 5498.120300751861, 5502.80740174092, 5619.129034999582, 5407.864803379947, 5472.644278121909, 5509.146082357241, 5537.280153580009, 5556.055470569932, 5486.1222204447095, 5551.333839939233, 5567.916481252703, 5594.636348637326, 5654.575906807088, 5465.945340546544, 5483.985462689415, 5486.31421072366, 5491.258680078138, 5498.477644623755], "value": 5251.891007100603, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2072877243086, 564.5032371513068, 575.5481946671863, 584.5411352088609, 586.1559354529477, 41987.37018944718, 43499.34750978738, 43667.78166109169, 47356.52643473564, 47384.52615473844, 44963.55036449635, 45308.0, 45399.0, 45403.545964540346, 45420.54579454204, 8803.295736341093, 8933.062028487013, 8958.955205223965, 8965.193132618064, 8967.41711788735, 8799.648014079461, 8806.075362086985, 8852.734417967471, 8852.955735221347, 8857.955710221471, 8901.243394311492, 8965.506897120657, 8967.596458159398, 8973.28213742899, 8977.640894364251, 8768.73693789181, 8831.205191532761, 8876.423032502898, 8885.244754195837, 8886.86669699955, 8702.651893924236, 8772.429792063496, 8817.382783205177, 8827.911720882774, 8833.779155521164, 41958.0, 42366.57633423688, 42499.57500424987, 42546.57453425488, 42584.0, 3316.7396389371884, 3424.240172400976, 3853.595372485877, 3997.98001009996, 4158.604932531404, 31251.687483125104, 31656.36687266265, 31657.52513712296, 31714.91269726228, 31730.206744831332, 4017.6986725995666, 4143.585641435862, 4148.543660197376, 4305.440292761952, 4339.435873336478, 342217.0, 345280.37756979384, 345868.0, 347436.0, 348112.0, 58437.41562584405, 58947.41052589505, 59034.0, 59055.0, 59137.0, 59645.0, 60260.0, 60343.04339783887, 60420.69789651024, 60844.695776520835, 16214.351425943067, 16307.429239976544, 16467.917660411622, 16589.751153732705, 16633.334666613442, 12692.49230030807, 12765.42555585001, 12797.808032879515, 12826.67933301675, 12845.357732113356, 16565.58586035359, 17443.38349247623, 17475.912620436815, 17477.82522174762, 17605.207765650575, 6061.605995610271, 6208.658523781235, 6380.798624474549, 6423.582467139621, 6449.871542391, 1000.3747657713928, 1026.2867307221409, 1051.6371851711147, 1061.1510791366875, 1114.5609426001224, 31020.844895775375, 31492.37015259682, 31535.526967095513, 31757.523637145463, 32512.512312315335, 1142.257532603814, 1165.6794381545144, 1166.393475392791, 1170.4440390814295, 1215.7872372334807, 15714.68570628581, 16753.83246167523, 16840.578985525215, 16844.494665160066, 16899.408520701716, 127387.3630631841, 128294.35852820677, 128402.0, 128447.35776321245, 128991.0, 57513.71243143841, 57876.710616446646, 57973.20267973169, 58028.70985645045, 58440.12339814906, 1295.5400832704443, 1348.1237195822794, 1356.572679605921, 1364.1201425080965, 1384.5015794314038, 29309.56035659424, 30736.692633073384, 31359.529607055458, 31379.529307059955, 31887.0, 50250.0, 50682.493175069256, 50808.49191508185, 51029.489705102475, 51149.0, 421336.0, 422610.0, 423966.0, 424442.0, 425921.0, 40387.3941890866, 41237.1752564953, 41938.161236775704, 41989.37015944824, 42129.57870421257, 45577.088458229984, 46457.535424646674, 46832.297515537975, 47344.763276183396, 48411.27383089327, 38730.80634596922, 39470.40794388144, 39685.52520276635, 40687.59312406838, 41173.0, 39304.907739300455, 39392.80303598464, 40338.798306008284, 40590.968925764515, 41395.793021034704, 36217.0, 36977.07557311089, 39247.0, 40675.0, 42353.36469952892, 34219.0, 36862.8156859214, 37078.07304817293, 37283.44074838825, 37506.24987500289, 27438.588421174096, 27610.171694849185, 27947.720522794512, 28062.158135255973, 28085.71914280913], "value": 19341.603665524068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.34491364680053, 388.5803332401005, 397.9462772525709, 398.2493000693693, 423.9812534752562, 14406.991510594236, 18252.908735456338, 19975.900120499395, 19978.0, 19986.001399860008, 18940.526486837836, 19159.42521724347, 19295.035248237567, 19382.22471101158, 19412.805871941277, 5008.84973450797, 5320.9467905321035, 5804.535637149039, 5818.06910894257, 5832.533397328203, 5728.79949201778, 5806.303243610772, 5817.331006934214, 5824.679642619654, 5832.883342333151, 5564.10974244121, 5754.942450575503, 5799.971000145015, 5800.825975220729, 5802.767889284423, 5411.594130440233, 5758.165066065439, 5762.53899688026, 5788.421157884178, 5820.82537523875, 5507.807226747044, 5630.577706671975, 5643.040683083886, 5646.7859410227, 5649.717514124277, 13285.269310187936, 13345.666358341023, 13508.594742157653, 13623.386947587382, 13655.112417692819, 2009.4172689919906, 2072.834173266135, 2201.9449513762124, 2525.532776436347, 2797.2447439191305, 9504.762380940463, 9644.0, 9742.9512852436, 10007.849882251772, 10094.9495252524, 1832.6243120160334, 1915.7317975483443, 1928.5757133430623, 1935.2452543508043, 1938.4087853204767, 82331.5883420579, 82370.58814705888, 82944.0, 84602.15397846005, 89721.55139224327, 11045.39250341239, 11096.278741881752, 11159.888401115884, 11347.943260283646, 11413.086953043736, 13234.205947643171, 13857.722845543234, 15860.682786344209, 15977.440789572309, 16029.919850400673, 7289.125304963438, 7689.307962283421, 7765.805854853674, 7786.909832623437, 8445.619947102396, 7639.618019099023, 7764.92235077642, 7825.452218344775, 7926.801829954297, 8025.839483210303, 4493.955060449419, 4815.759212039384, 4847.95152048475, 4895.632827537949, 4935.407751069894, 1935.7096435534502, 1938.6413513500047, 2020.595880823841, 2048.989755051215, 2097.4127244371603, 824.7525742277293, 911.1571796088591, 947.8909925358535, 954.4321128928276, 1040.6357774778767, 17978.37075702344, 19320.32378866733, 19376.2249510018, 19418.611627767365, 19505.414837554898, 953.4803532075035, 954.1126752120595, 978.1538968791943, 981.3228872078244, 1010.0808264479289, 10461.529231184462, 10795.892041079489, 10871.239013268996, 10872.891271087346, 10892.237543372046, 432609.0, 435195.0, 436349.0, 439879.0, 440074.0, 87366.56316718503, 88570.55714721385, 89903.0, 89959.0, 90422.09577904268, 926.9814603708023, 949.0604301741226, 981.2542467724438, 981.254246772458, 984.1339621133357, 16492.475020868143, 16610.0, 16949.576260593585, 17180.140992950553, 17253.309867605156, 38115.80942095272, 41750.37374439446, 42202.0, 43528.42951490048, 43579.0, 49401.50598494113, 52983.73508132589, 57757.711211443675, 57979.4202057974, 58819.41180588139, 7596.658150383136, 7985.64064617082, 8013.879791803244, 8155.347572194329, 8415.579221039046, 11719.76560468803, 13152.671183220496, 13155.736885262433, 13187.142835715647, 13336.466541338626, 11127.221094523306, 11151.55393784272, 11173.944130279297, 11372.772544548898, 11725.706857328634, 10785.15321451024, 10921.180911431515, 11033.834492482458, 11248.26886252391, 11349.4892729829, 11018.724531886766, 11038.668839934815, 11213.943930280297, 11474.598389056342, 11656.358900260568, 8130.39022073335, 8151.551664658264, 8160.796584922156, 8270.2556769891, 8482.151784821468, 8142.7557173284895, 10149.086582207638, 10867.456627168453, 10874.619388321371, 11897.524099036287], "value": 8888.920181127423, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.628036710455, 1479.7040591881625, 1595.35388167792, 1701.8638508919287, 1749.893938259589, 7535.321821036106, 7785.610719464033, 8215.0, 8793.692220772275, 8814.55927203639, 7872.5276483411035, 8149.470284431508, 8150.184981501847, 8389.580520973943, 8405.0, 2200.383892510096, 2209.86740795552, 2211.1266049910278, 2216.7229096362953, 2221.2114699281765, 2136.9252076177336, 2170.251263314154, 2254.9098036078535, 2256.7066281383395, 2256.808171305441, 2198.505336299336, 2202.218212534551, 2204.3056437222303, 2206.415299945516, 2222.588821068108, 2173.8369622278315, 2177.945551361213, 2178.6840908068243, 2179.063002908749, 2180.945476363088, 2154.7198864147563, 2181.3237896252053, 2183.879886606236, 2190.9811937449003, 2202.3392982105306, 8496.235338819535, 8615.913840861574, 8624.568771561397, 8636.006859211146, 8647.135286471366, 4879.682820616648, 4997.250412438127, 5019.824306149268, 5022.321986531808, 5035.1188542005, 3036.6212771003284, 3184.9203769905707, 3235.7249633781157, 3263.0537144228147, 3272.640009598942, 1038.9584416623402, 1044.6657069737687, 1070.817960946641, 1100.2188446203206, 1101.4988180377989, 12000.0, 12013.819792703116, 12044.39778011096, 12055.156139070268, 12078.456469458895, 4296.37702533131, 4456.509783923766, 4478.552144785561, 4485.394471746273, 4522.728636281834, 10147.7463063424, 10149.340292881086, 10166.135878450266, 10191.286609937233, 10210.234232432449, 5166.793328266827, 5193.558547523503, 5203.869903252449, 5211.140161873324, 5220.947790522122, 4003.559608443069, 4607.0, 4628.166929952641, 4788.281757736298, 4799.424069111729, 3872.4316651756085, 3891.9416208756893, 3943.940840887389, 3957.406389041667, 3963.92072158561, 1230.5077968812548, 1238.2508582307755, 1269.9809502857279, 1278.3799857069314, 1292.2052937443405, 822.5147163173756, 906.2251774732508, 925.8703781470599, 930.6556574067638, 944.4899754132829, 5647.672796892727, 5702.287214098238, 5734.111212762028, 5844.795432159854, 5939.613925094855, 456.6757602102478, 460.091319643701, 460.30723760739875, 943.6649989253716, 1011.3325205364424, 3881.5342158940543, 3899.337112690849, 3903.8243279052513, 3905.1603905160528, 3983.64147226751, 10355.741106472398, 10888.237823352447, 10894.18293627981, 10896.61861834832, 10908.23642345044, 10571.735706607242, 10644.680659580225, 10844.945775271231, 10855.240133190759, 10920.2901811382, 7975.122736498981, 8022.679092836222, 8068.677252909818, 8114.269715725613, 8166.142555031636, 5563.443655634404, 5587.0, 5617.859553511195, 5654.7455364509515, 5807.506361959281, 9763.121319081316, 9925.602975880884, 9982.800343993225, 10048.939967306538, 10088.192944564564, 9293.907060929305, 9708.029197080235, 9732.951335243562, 9925.900740992498, 9974.950125249326, 6727.461803055646, 6964.094667693167, 7443.888341674771, 7701.768946931601, 7885.960570197112, 8045.718399855977, 8395.202455766692, 8402.117777633504, 8414.200650938152, 8420.70527531558, 7136.143662760502, 7404.037475128199, 7429.4799364044, 7448.106227252764, 7480.0, 7299.927000729925, 7362.595057271901, 7406.740764073232, 7520.849583008418, 7568.5837278950185, 7030.367266945999, 7049.6122713249215, 7106.964465177641, 7114.14630244374, 7114.217436081924, 4919.1883339248625, 4922.556969872729, 5076.695398276115, 5131.10205714006, 5214.13966695491, 5097.745112744422, 5106.642535022513, 5206.401263854706, 5229.764660590206, 5248.685078895279], "value": 4454.329797246429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.8698793514709, 338.7645586317509, 346.668931170732, 351.0416562783602, 355.3532570721288, 5256.763445644946, 5389.51494365507, 5491.423400542945, 5528.281323427958, 5575.49820516154, 5271.367435907697, 5298.284731561238, 5420.6747595144225, 5431.158170483582, 5444.265024221729, 4239.092408416225, 4296.5273819879785, 4304.139172165564, 4319.3952846601505, 4329.30731083026, 4231.259529582326, 4253.723882835153, 4301.182775272704, 4326.156399502099, 4327.285997810358, 4233.809478573472, 4252.724792236154, 4254.340577210537, 4272.145570885836, 4290.120525292307, 4208.137331846964, 4213.43118678979, 4220.6412454941365, 4256.702030857841, 4265.296226122686, 3715.888523344304, 3817.6564109230303, 3819.427085937104, 3820.331441997639, 3827.138893748912, 5203.453637368098, 5228.686278823283, 5237.8428647140645, 5277.762500687479, 5296.3909150447425, 4870.22076467767, 4885.998370334073, 4896.75516224191, 4897.583705385046, 4903.436104847952, 5462.754176062087, 5617.522510586605, 5655.632383895075, 5659.7453114609525, 5663.688497132656, 4056.249593825152, 4057.0383619957597, 4070.4708387909677, 4073.6537394321517, 4114.465119534471, 5844.766209351621, 5850.385709500484, 5905.793297234619, 5912.46787789101, 5959.73181206851, 4110.958890411118, 4175.665946724254, 4189.2459357315975, 4203.894902627398, 4218.240716670967, 4221.261279276115, 4265.97867010663, 4289.49064797091, 4301.838503604009, 4330.653547716175, 4861.124997500413, 4871.7333493292, 4890.657653964188, 4894.951050489521, 4936.777844996984, 5391.218273350342, 5718.628289161191, 5739.454751798572, 5755.165501002331, 5766.030494295441, 1446.2696338349067, 1457.5481600703604, 1467.4717101843328, 1469.860363265488, 1477.933492992818, 907.2832462354797, 930.5486838883136, 930.6370515498961, 950.8288508068614, 956.2302346610905, 4778.348016850612, 4793.520647935248, 4803.903921921542, 4815.927761083586, 4845.9757701211975, 5082.593392528589, 5087.364079490064, 5179.249008893689, 5184.844454666366, 5196.259253150161, 4653.208954477747, 4737.709078784312, 4832.347633069561, 4844.32179494871, 4883.826697119819, 2727.7545020947814, 2727.9318017049336, 2732.617433559303, 2742.8217165884153, 2751.408447183865, 5258.553022993012, 5308.92036619451, 5337.546308563816, 5350.571954243651, 5365.409804921455, 5014.348134742533, 5115.0, 5228.2941802856885, 5262.236975638511, 5264.6051546134195, 5192.688438693691, 5243.68537887728, 5265.289185959923, 5268.420473747885, 5327.733613319396, 5139.023585518739, 5152.896942061213, 5171.3277273954145, 5186.369541321165, 5211.296474975981, 4807.495213002584, 5042.168042272984, 5083.415407228216, 5084.211947148198, 5137.845864624067, 5263.92089621619, 5279.234510995961, 5302.416734159317, 5312.840614781563, 5352.946470535245, 3785.7539259948016, 3928.960710392974, 4043.2317859606583, 4138.213739389506, 4280.165367753259, 5712.6286791358425, 5721.685307308138, 5733.770649173986, 5742.794013257263, 5788.305403351625, 5539.972300138474, 5657.387644521292, 5702.942970570241, 5703.657780533182, 5725.312962444534, 5559.332880054258, 5616.66300022, 5642.0, 5651.0, 5669.829905102853, 5628.352739435018, 5666.914996274977, 5695.288088988877, 5711.914321285101, 5742.741576629145, 5559.416261292506, 5616.831495055155, 5621.269234999424, 5629.662220266797, 5700.230468886647, 5513.972430137824, 5526.640768350205, 5527.585431092764, 5535.142052981794, 5543.667379957215], "value": 4191.788514459454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.9822004449888, 751.5415596486146, 753.7889390970529, 793.9404544659152, 804.0712976512124, 15844.366225350986, 16184.514464566082, 16186.352545898164, 16390.67218655626, 16498.42255521057, 15210.619734506616, 15436.845631543682, 15460.226988650578, 15476.458323958665, 15502.30239639216, 797.8484088023272, 811.5860910935406, 814.9429539932207, 818.5293456262673, 819.1317203763999, 812.7561731480562, 817.81190326225, 818.6766227340197, 820.8030072782519, 823.5223570329194, 850.370725663008, 851.1445996773265, 853.6116067189414, 854.0775961961067, 854.1757204297851, 849.9575021248975, 850.0182289455657, 850.336737344872, 852.4033176776281, 852.7186028610574, 630.5302549600531, 631.8515148939996, 632.9398707122816, 635.8569321902535, 637.073058699591, 14227.715445691132, 14239.78640320396, 14382.496612618614, 14392.208428536427, 14399.712005759826, 12469.625911222678, 12960.740785184338, 13084.214947103204, 13581.370369817816, 13685.863141368558, 11223.0, 11266.66200014001, 11344.14918881079, 11371.715707107305, 11562.710932226677, 3762.7177961652988, 3763.379042457991, 3770.170562476251, 3830.636089571486, 3901.843926242947, 53525.73237133829, 54310.72844635791, 66615.0, 70872.73643093139, 75787.24212757857, 11088.06016297463, 11522.0, 11602.76794464106, 11626.476808543635, 11696.766064678828, 21389.35831925045, 21474.785252147278, 21531.13875444996, 21531.67702484464, 21545.461363466038, 8217.08369973618, 8289.41974061822, 8511.914880851236, 8565.785855353666, 8819.514926679094, 4491.505934347219, 4603.217453032992, 4678.204705200124, 4730.290456431563, 4730.385049943486, 3528.5060091587197, 3676.8713095041544, 3677.1726361568435, 3678.7240956928335, 3682.1899182179877, 622.5828694774422, 622.7203097634315, 627.6516533324049, 639.1850390751736, 641.7112299465259, 670.6847781542667, 696.9963252915785, 711.1111111111111, 732.209214048826, 740.4298690008663, 9786.0, 10032.297739158335, 10035.247356448295, 10519.52662130206, 10727.302725322828, 700.5761514283887, 722.9132504099437, 730.587218221703, 733.7175187552831, 738.7551974922274, 4099.8360065597635, 4638.350630911675, 4803.231482962709, 4827.975860120747, 4866.562009419169, 87072.0, 111289.0, 119992.40003799925, 122490.0, 125100.0, 56018.43981560132, 73893.63053184807, 77469.61265193751, 84619.0, 91068.54465727761, 80433.59783201046, 86067.0, 87044.56477717697, 87064.12935870686, 89466.55266723756, 9212.3090768194, 9410.0, 9466.195373393064, 9548.18840398574, 9554.856677149988, 51564.48435515597, 51690.483095168565, 51691.74154129356, 52264.0, 53042.0, 69248.6537567309, 75716.62141689476, 76145.61927190328, 76219.0, 77790.0, 12432.378381080729, 12467.563635272722, 12577.685557861127, 12809.295488748208, 12841.0, 14904.329305181509, 15249.560070389129, 15366.231688415759, 15374.769378459556, 15660.13869237203, 12491.37543122822, 13500.93249533746, 13507.324633768469, 13767.793483097561, 14169.36237869319, 13132.934335328262, 13290.667733306746, 13340.399682014138, 13495.325233738471, 13837.515686950908, 12335.321557314433, 12531.49874005066, 12641.747165056831, 12763.298018609066, 13317.33413329349, 11067.557297708001, 11591.826122608, 11693.298402095901, 11757.941210293893, 11796.29222246668, 9959.900400995897, 11005.229633925868, 11297.378644174649, 11332.830007549728, 11896.464659090534], "value": 7463.045228139404, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 114.0, 111.0, 113.0, 113.0, 114.0, 114.0, 112.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 126.0, 170.0, 128.0, 122.0, 123.0, 126.0, 151.0, 127.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 167.0, 167.0, 162.0, 163.0, 163.0, 161.0, 161.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 113.0, 77.0, 79.0, 77.0, 78.0, 101.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 86.0, 84.0, 83.0, 106.0, 83.0, 82.0, 124.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 119.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 149.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 149.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 95.0, 97.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 53.0, 52.0, 55.0, 54.0, 54.0, 53.0, 54.0, 55.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 62.0, 60.0, 61.0, 61.0, 65.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 81.0, 81.0, 81.0, 81.0, 80.0, 81.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 141.0, 137.0, 133.0, 132.0, 133.0, 130.0, 141.0, 182.0, 132.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 174.0, 167.0, 164.0, 165.0, 165.0, 174.0, 165.0, 165.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 69.0, 66.0, 67.0, 67.0, 68.0, 64.0, 65.0, 67.0], "value": 66.8, "unit": "score"}]}]} 16:07:44 INFO - Return code: 0 16:07:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:07:44 ERROR - # TBPL SUCCESS # 16:07:44 INFO - Running post-action listener: _resource_record_post_action 16:07:44 INFO - [mozharness: 2016-10-11 23:07:44.469655Z] Finished run-tests step (success) 16:07:44 INFO - Running post-run listener: _resource_record_post_run 16:07:44 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 410517504; Read time: 96; Write time: 244400 16:07:44 INFO - TinderboxPrint: CPU usage
13.5% 16:07:44 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 96 16:07:44 INFO - TinderboxPrint: I/O write bytes / time
410,517,504 / 244,400 16:07:44 INFO - TinderboxPrint: CPU idle
8,259.2 (86.5%) 16:07:44 INFO - TinderboxPrint: CPU user
1,224.3 (12.8%) 16:07:44 INFO - TinderboxPrint: Swap in / out
0 / 0 16:07:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103845888; Read time: 0; Write time: 89368 16:07:44 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289767424; Read time: 84; Write time: 150800 16:07:45 INFO - Running post-run listener: _upload_blobber_files 16:07:45 INFO - Blob upload gear active. 16:07:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:07:45 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 16:07:45 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:07:45 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:07:45 INFO - (blobuploader) - INFO - Open directory for files ... 16:07:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:07:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:07:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:46 INFO - (blobuploader) - INFO - Done attempting. 16:07:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:07:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:49 INFO - (blobuploader) - INFO - Done attempting. 16:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:07:50 INFO - (blobuploader) - INFO - Done attempting. 16:07:50 INFO - (blobuploader) - INFO - Iteration through files over. 16:07:50 INFO - Return code: 0 16:07:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:07:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:07:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19beacc2bb92bbab4859a4835c666e0a5ae8688be10acda1cccea95073276babeac323d435a62b449e23972caa7fb4e93e357698d67f08a85cd4785e496693e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e7c78169b19b29732dccb4a0a5048a9adfb4026c86052db49898e5bb57ddde643b74c88809090c2d9288c60984fb102d9d17100da40a4964a27cc37e513cd8ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bb78e5aa22b9719cd7fa0faf6bc25e1945f3c562171f9f05dda6f70d93ffebaf7a970abbda2913628f60839fa4fcc653b67691640be153e60e272ee0dda947c"} 16:07:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:07:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:07:50 INFO - Contents: 16:07:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19beacc2bb92bbab4859a4835c666e0a5ae8688be10acda1cccea95073276babeac323d435a62b449e23972caa7fb4e93e357698d67f08a85cd4785e496693e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e7c78169b19b29732dccb4a0a5048a9adfb4026c86052db49898e5bb57ddde643b74c88809090c2d9288c60984fb102d9d17100da40a4964a27cc37e513cd8ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bb78e5aa22b9719cd7fa0faf6bc25e1945f3c562171f9f05dda6f70d93ffebaf7a970abbda2913628f60839fa4fcc653b67691640be153e60e272ee0dda947c"} 16:07:50 INFO - Running post-run listener: copy_logs_to_upload_dir 16:07:50 INFO - Copying logs to upload dir... 16:07:50 INFO - mkdir: /builds/slave/test/build/upload/logs 16:07:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.926616 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-11 16:07:50.569696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 16:07:50.573411) ========= 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=6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321 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/Autoland/sha512/19beacc2bb92bbab4859a4835c666e0a5ae8688be10acda1cccea95073276babeac323d435a62b449e23972caa7fb4e93e357698d67f08a85cd4785e496693e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e7c78169b19b29732dccb4a0a5048a9adfb4026c86052db49898e5bb57ddde643b74c88809090c2d9288c60984fb102d9d17100da40a4964a27cc37e513cd8ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bb78e5aa22b9719cd7fa0faf6bc25e1945f3c562171f9f05dda6f70d93ffebaf7a970abbda2913628f60839fa4fcc653b67691640be153e60e272ee0dda947c"} build_url:https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/K5x3JTf_SGqoXwQ6850Jbw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19beacc2bb92bbab4859a4835c666e0a5ae8688be10acda1cccea95073276babeac323d435a62b449e23972caa7fb4e93e357698d67f08a85cd4785e496693e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e7c78169b19b29732dccb4a0a5048a9adfb4026c86052db49898e5bb57ddde643b74c88809090c2d9288c60984fb102d9d17100da40a4964a27cc37e513cd8ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bb78e5aa22b9719cd7fa0faf6bc25e1945f3c562171f9f05dda6f70d93ffebaf7a970abbda2913628f60839fa4fcc653b67691640be153e60e272ee0dda947c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 16:07:50.608065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:07:50.608613) ========= 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=6dbc10da6d83fee962c624be000001a8-1476226025.561576-734438321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 16:07:50.693718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 16:07:50.694069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 16:07:50.694396) ========= ========= Total master_lag: 0.30 =========