builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1480030110.17 results: success (0) buildid: 20161124152652 builduid: 9c0a9ad5770e4719a17daeef32927c29 revision: 3a36e60d1c4ce25062d843d6cabd970c4c9cc84d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.173881) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.174324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.174605) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.195841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.196232) ========= 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=337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-24 15:28:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-11-24 15:28:30 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118108 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.328057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.328383) ========= 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=337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014889 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.378485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.378846) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3a36e60d1c4ce25062d843d6cabd970c4c9cc84d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 3a36e60d1c4ce25062d843d6cabd970c4c9cc84d --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=337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-24 15:28:30,546 truncating revision to first 12 chars 2016-11-24 15:28:30,546 Setting DEBUG logging. 2016-11-24 15:28:30,546 attempt 1/10 2016-11-24 15:28:30,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/3a36e60d1c4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 15:28:30,844 unpacking tar archive at: mozilla-inbound-3a36e60d1c4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601939 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.997380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.997783) ========= script_repo_revision: 3a36e60d1c4ce25062d843d6cabd970c4c9cc84d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.998231) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:30.998518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 15:28:31.010379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-24 15:28:31.010882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:28:31 INFO - MultiFileLogger online at 20161124 15:28:31 in /builds/slave/test 15:28:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:28:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:28:31 INFO - {'append_to_log': False, 15:28:31 INFO - 'base_work_dir': '/builds/slave/test', 15:28:31 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:28:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:28:31 INFO - 'branch': 'Mozilla-Inbound', 15:28:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:28:31 INFO - 'config_files': ('talos/linux_config.py',), 15:28:31 INFO - 'default_actions': ('clobber', 15:28:31 INFO - 'read-buildbot-config', 15:28:31 INFO - 'download-and-extract', 15:28:31 INFO - 'populate-webroot', 15:28:31 INFO - 'create-virtualenv', 15:28:31 INFO - 'install', 15:28:31 INFO - 'run-tests'), 15:28:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:28:31 INFO - 'download_minidump_stackwalk': True, 15:28:31 INFO - 'download_symbols': 'ondemand', 15:28:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:28:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:28:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:28:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:28:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:28:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:28:31 INFO - 'installer_path': 'installer.exe', 15:28:31 INFO - 'log_level': 'info', 15:28:31 INFO - 'log_name': 'talos', 15:28:31 INFO - 'log_to_console': True, 15:28:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:28:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:28:31 INFO - 'opt_config_files': (), 15:28:31 INFO - 'pip_index': False, 15:28:31 INFO - 'sps_profile': False, 15:28:31 INFO - 'sps_profile_interval': 0, 15:28:31 INFO - 'suite': 'dromaeojs', 15:28:31 INFO - 'system_bits': '32', 15:28:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:28:31 INFO - 'title': 'talos-linux64-ix-060', 15:28:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:28:31 INFO - 'use_talos_json': True, 15:28:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:28:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:28:31 INFO - 'work_dir': 'build'} 15:28:31 INFO - [mozharness: 2016-11-24 23:28:31.272444Z] Running clobber step. 15:28:31 INFO - Running pre-action listener: _resource_record_pre_action 15:28:31 INFO - Running main action method: clobber 15:28:31 INFO - rmtree: /builds/slave/test/build 15:28:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:28:31 INFO - Running post-action listener: _resource_record_post_action 15:28:31 INFO - [mozharness: 2016-11-24 23:28:31.731673Z] Finished clobber step (success) 15:28:31 INFO - [mozharness: 2016-11-24 23:28:31.731772Z] Running read-buildbot-config step. 15:28:31 INFO - Running pre-action listener: _resource_record_pre_action 15:28:31 INFO - Running main action method: read_buildbot_config 15:28:31 INFO - Using buildbot properties: 15:28:31 INFO - { 15:28:31 INFO - "project": "", 15:28:31 INFO - "product": "firefox", 15:28:31 INFO - "script_repo_revision": "production", 15:28:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:28:31 INFO - "repository": "", 15:28:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:28:31 INFO - "buildid": "20161124152652", 15:28:31 INFO - "stage_platform": "linux64-pgo", 15:28:31 INFO - "basedir": "/builds/slave/test", 15:28:31 INFO - "buildnumber": 2151, 15:28:31 INFO - "platform": "ubuntu64_hw", 15:28:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:28:31 INFO - "slavebuilddir": "test", 15:28:31 INFO - "branch": "mozilla-inbound", 15:28:31 INFO - "revision": "3a36e60d1c4ce25062d843d6cabd970c4c9cc84d", 15:28:31 INFO - "slavename": "talos-linux64-ix-060", 15:28:31 INFO - "builduid": "9c0a9ad5770e4719a17daeef32927c29", 15:28:31 INFO - "repo_path": "integration/mozilla-inbound" 15:28:31 INFO - } 15:28:31 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:28:31 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 15:28:31 INFO - Running post-action listener: _resource_record_post_action 15:28:31 INFO - [mozharness: 2016-11-24 23:28:31.734188Z] Finished read-buildbot-config step (success) 15:28:31 INFO - [mozharness: 2016-11-24 23:28:31.734276Z] Running download-and-extract step. 15:28:31 INFO - Running pre-action listener: _resource_record_pre_action 15:28:31 INFO - Running main action method: download_and_extract 15:28:31 INFO - mkdir: /builds/slave/test/build/tests 15:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:28:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:28:31 INFO - Downloaded 1361 bytes. 15:28:31 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:28:31 INFO - Using the following test package requirements: 15:28:31 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:31 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:28:31 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:28:31 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:31 INFO - u'jsshell-linux-x86_64.zip'], 15:28:31 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:28:31 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:28:31 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:28:31 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:28:31 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:28:31 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:28:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:28:31 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:28:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:28:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:28:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:28:31 INFO - Http code: 200 15:28:31 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 15:28:31 INFO - x-amz-cf-id: hIS1wjj33eq-ujc0FONgAwLJ5PO4i9PpJRdopHGY2WBgZsobRn6f9Q== 15:28:31 INFO - x-amz-replication-status: COMPLETED 15:28:31 INFO - x-amz-version-id: eUEm.m8vr0fG1AT5IZ3DWfRW3DYWaxjl 15:28:32 INFO - Expected file size: 21765507 15:28:32 INFO - Obtained file size: 21765507 15:28:36 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:28:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:28:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:28:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:28:36 INFO - Http code: 200 15:28:36 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 15:28:36 INFO - x-amz-cf-id: bj6wYcUf55xueAFw3mzkrHRag3IHL4LkQrpIRJrCiZl63SDvRzXzew== 15:28:36 INFO - x-amz-replication-status: COMPLETED 15:28:36 INFO - x-amz-version-id: eUEm.m8vr0fG1AT5IZ3DWfRW3DYWaxjl 15:28:36 INFO - Expected file size: 21765507 15:28:36 INFO - Obtained file size: 21765507 15:28:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:28:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:28:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:28:41 INFO - Http code: 200 15:28:41 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 15:28:41 INFO - x-amz-cf-id: huKVA__Qi4dDaSAtOHis1lh1s0VZn9E7wayo5seyz1sZOSQXxj6I8A== 15:28:41 INFO - x-amz-replication-status: COMPLETED 15:28:41 INFO - x-amz-version-id: CjGAOryrevZ1fiZSWE1h8ZMv5UE4zYc5 15:28:41 INFO - Expected file size: 14409702 15:28:41 INFO - Obtained file size: 14409702 15:28:41 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:28:41 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:28:41 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:28:42 INFO - Downloaded 59764119 bytes. 15:28:42 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:28:42 INFO - mkdir: /builds/slave/test/properties 15:28:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:28:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:28:42 INFO - Contents: 15:28:42 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:28:42 INFO - Running post-action listener: _resource_record_post_action 15:28:42 INFO - Running post-action listener: set_extra_try_arguments 15:28:42 INFO - [mozharness: 2016-11-24 23:28:42.395126Z] Finished download-and-extract step (success) 15:28:42 INFO - [mozharness: 2016-11-24 23:28:42.395353Z] Running populate-webroot step. 15:28:42 INFO - Running pre-action listener: _resource_record_pre_action 15:28:42 INFO - Running main action method: populate_webroot 15:28:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:28:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:28:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:28:42 INFO - '--tppagecycles', 15:28:42 INFO - '7'], 15:28:42 INFO - 'tests': ['tsvgm']}}, 15:28:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:28:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:28:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:28:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:28:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:28:42 INFO - 'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:28:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:28:42 INFO - 'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['damp', 'tps']}, 15:28:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:28:42 INFO - 'tests': ['damp', 'tps']}, 15:28:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['dromaeo_dom']}, 15:28:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:28:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['basic_compositor_video']}, 15:28:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:28:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['a11yr', 15:28:42 INFO - 'ts_paint', 15:28:42 INFO - 'tpaint', 15:28:42 INFO - 'sessionrestore', 15:28:42 INFO - 'sessionrestore_no_auto_restore', 15:28:42 INFO - 'tabpaint']}, 15:28:42 INFO - 'other-e10s': {'tests': ['a11yr', 15:28:42 INFO - 'ts_paint', 15:28:42 INFO - 'tpaint', 15:28:42 INFO - 'sessionrestore', 15:28:42 INFO - 'sessionrestore_no_auto_restore', 15:28:42 INFO - 'tabpaint']}, 15:28:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:28:42 INFO - 'ts_paint', 15:28:42 INFO - 'tpaint', 15:28:42 INFO - 'sessionrestore', 15:28:42 INFO - 'sessionrestore_no_auto_restore', 15:28:42 INFO - 'tabpaint']}, 15:28:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:28:42 INFO - 'ts_paint', 15:28:42 INFO - 'tpaint', 15:28:42 INFO - 'sessionrestore', 15:28:42 INFO - 'sessionrestore_no_auto_restore', 15:28:42 INFO - 'tabpaint']}, 15:28:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['a11yr', 15:28:42 INFO - 'ts_paint', 15:28:42 INFO - 'tpaint', 15:28:42 INFO - 'sessionrestore', 15:28:42 INFO - 'sessionrestore_no_auto_restore', 15:28:42 INFO - 'tabpaint']}, 15:28:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['a11yr', 15:28:42 INFO - 'ts_paint', 15:28:42 INFO - 'tpaint', 15:28:42 INFO - 'sessionrestore', 15:28:42 INFO - 'sessionrestore_no_auto_restore', 15:28:42 INFO - 'tabpaint']}, 15:28:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['tsvgx', 15:28:42 INFO - 'tsvgr_opacity', 15:28:42 INFO - 'tart', 15:28:42 INFO - 'tscrollx', 15:28:42 INFO - 'cart', 15:28:42 INFO - 'tsvg_static']}, 15:28:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:28:42 INFO - 'tsvgr_opacity', 15:28:42 INFO - 'tart', 15:28:42 INFO - 'tscrollx', 15:28:42 INFO - 'cart', 15:28:42 INFO - 'tsvg_static']}, 15:28:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:28:42 INFO - 'talos_options': ['--disable-e10s'], 15:28:42 INFO - 'tests': ['tp5o']}, 15:28:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:28:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:28:42 INFO - 'talos_options': ['--disable-e10s', 15:28:42 INFO - '--xperf_path', 15:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:42 INFO - 'tests': ['tp5n']}, 15:28:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:28:42 INFO - 'talos_options': ['--xperf_path', 15:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:28:42 INFO - 'tests': ['tp5n']}}, 15:28:42 INFO - 'talos.zip': {'path': '', 15:28:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:28:42 INFO - Running post-action listener: _resource_record_post_action 15:28:42 INFO - [mozharness: 2016-11-24 23:28:42.416541Z] Finished populate-webroot step (success) 15:28:42 INFO - [mozharness: 2016-11-24 23:28:42.416662Z] Running create-virtualenv step. 15:28:42 INFO - Running pre-action listener: _resource_record_pre_action 15:28:42 INFO - Running main action method: create_virtualenv 15:28:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:28:42 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:28:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:28:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:28:42 INFO - Using real prefix '/usr' 15:28:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:28:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:28:44 INFO - Installing pip.................done. 15:28:44 INFO - Return code: 0 15:28:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:28:45 INFO - Reading from file tmpfile_stdout 15:28:45 INFO - Output received: 15:28:45 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:28:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:45 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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:28:45 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:28:45 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:28:45 INFO - Using env: {'DISPLAY': ':0', 15:28:45 INFO - 'HOME': '/home/cltbld', 15:28:45 INFO - 'LANG': 'en_US.UTF-8', 15:28:45 INFO - 'LANGUAGE': 'en_US:en', 15:28:45 INFO - 'LOGNAME': 'cltbld', 15:28:45 INFO - 'MAIL': '/var/mail/cltbld', 15:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:45 INFO - 'MOZ_NO_REMOTE': '1', 15:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:45 INFO - 'NO_EM_RESTART': '1', 15:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:45 INFO - 'PWD': '/builds/slave/test', 15:28:45 INFO - 'SHELL': '/bin/bash', 15:28:45 INFO - 'SHLVL': '1', 15:28:45 INFO - 'TERM': 'linux', 15:28:45 INFO - 'TMOUT': '86400', 15:28:45 INFO - 'USER': 'cltbld', 15:28:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:45 INFO - '_': '/tools/buildbot/bin/python'} 15:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:45 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:28:45 INFO - Cleaning up... 15:28:45 INFO - Return code: 0 15:28:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:45 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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:28:45 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:28:45 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:28:45 INFO - Using env: {'DISPLAY': ':0', 15:28:45 INFO - 'HOME': '/home/cltbld', 15:28:45 INFO - 'LANG': 'en_US.UTF-8', 15:28:45 INFO - 'LANGUAGE': 'en_US:en', 15:28:45 INFO - 'LOGNAME': 'cltbld', 15:28:45 INFO - 'MAIL': '/var/mail/cltbld', 15:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:45 INFO - 'MOZ_NO_REMOTE': '1', 15:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:45 INFO - 'NO_EM_RESTART': '1', 15:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:45 INFO - 'PWD': '/builds/slave/test', 15:28:45 INFO - 'SHELL': '/bin/bash', 15:28:45 INFO - 'SHLVL': '1', 15:28:45 INFO - 'TERM': 'linux', 15:28:45 INFO - 'TMOUT': '86400', 15:28:45 INFO - 'USER': 'cltbld', 15:28:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:45 INFO - '_': '/tools/buildbot/bin/python'} 15:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:45 INFO - Downloading/unpacking psutil>=3.1.1 15:28:45 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:28:45 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:28:45 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:28:45 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:28:45 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:28:45 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:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:28:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:47 INFO - Installing collected packages: psutil 15:28:47 INFO - Running setup.py install for psutil 15:28:47 INFO - building 'psutil._psutil_linux' extension 15:28:47 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:28:47 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:28:47 INFO - building 'psutil._psutil_posix' extension 15:28:47 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:28:48 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:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:28:48 INFO - Successfully installed psutil 15:28:48 INFO - Cleaning up... 15:28:48 INFO - Return code: 0 15:28:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:28:48 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:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:48 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:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:48 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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:28:48 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:28:48 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:28:48 INFO - Using env: {'DISPLAY': ':0', 15:28:48 INFO - 'HOME': '/home/cltbld', 15:28:48 INFO - 'LANG': 'en_US.UTF-8', 15:28:48 INFO - 'LANGUAGE': 'en_US:en', 15:28:48 INFO - 'LOGNAME': 'cltbld', 15:28:48 INFO - 'MAIL': '/var/mail/cltbld', 15:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:48 INFO - 'MOZ_NO_REMOTE': '1', 15:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:48 INFO - 'NO_EM_RESTART': '1', 15:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:48 INFO - 'PWD': '/builds/slave/test', 15:28:48 INFO - 'SHELL': '/bin/bash', 15:28:48 INFO - 'SHLVL': '1', 15:28:48 INFO - 'TERM': 'linux', 15:28:48 INFO - 'TMOUT': '86400', 15:28:48 INFO - 'USER': 'cltbld', 15:28:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:48 INFO - '_': '/tools/buildbot/bin/python'} 15:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:28:48 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:28:48 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:28:48 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:28:48 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:28:48 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:28:48 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:28:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:28:50 INFO - Installing collected packages: mozsystemmonitor 15:28:50 INFO - Running setup.py install for mozsystemmonitor 15:28:50 INFO - Successfully installed mozsystemmonitor 15:28:50 INFO - Cleaning up... 15:28:50 INFO - Return code: 0 15:28:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:28:50 INFO - Using env: {'DISPLAY': ':0', 15:28:50 INFO - 'HOME': '/home/cltbld', 15:28:50 INFO - 'LANG': 'en_US.UTF-8', 15:28:50 INFO - 'LANGUAGE': 'en_US:en', 15:28:50 INFO - 'LOGNAME': 'cltbld', 15:28:50 INFO - 'MAIL': '/var/mail/cltbld', 15:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:50 INFO - 'MOZ_NO_REMOTE': '1', 15:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:50 INFO - 'NO_EM_RESTART': '1', 15:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:50 INFO - 'PWD': '/builds/slave/test', 15:28:50 INFO - 'SHELL': '/bin/bash', 15:28:50 INFO - 'SHLVL': '1', 15:28:50 INFO - 'TERM': 'linux', 15:28:50 INFO - 'TMOUT': '86400', 15:28:50 INFO - 'USER': 'cltbld', 15:28:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:50 INFO - '_': '/tools/buildbot/bin/python'} 15:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:50 INFO - Downloading/unpacking jsonschema==2.5.1 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:28:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:28:52 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:28:52 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:28:52 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:28:52 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:28:52 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:28:52 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:28:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:28:52 INFO - warning: no files found matching '*.txt' 15:28:52 INFO - no previously-included directories found matching 'build' 15:28:52 INFO - no previously-included directories found matching 'dist' 15:28:52 INFO - no previously-included directories found matching '.git*' 15:28:53 INFO - Installing collected packages: jsonschema, functools32 15:28:53 INFO - Running setup.py install for functools32 15:28:53 INFO - warning: no files found matching '*.txt' 15:28:53 INFO - no previously-included directories found matching 'build' 15:28:53 INFO - no previously-included directories found matching 'dist' 15:28:53 INFO - no previously-included directories found matching '.git*' 15:28:53 INFO - Successfully installed jsonschema functools32 15:28:53 INFO - Cleaning up... 15:28:53 INFO - Return code: 0 15:28:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:28:53 INFO - Using env: {'DISPLAY': ':0', 15:28:53 INFO - 'HOME': '/home/cltbld', 15:28:53 INFO - 'LANG': 'en_US.UTF-8', 15:28:53 INFO - 'LANGUAGE': 'en_US:en', 15:28:53 INFO - 'LOGNAME': 'cltbld', 15:28:53 INFO - 'MAIL': '/var/mail/cltbld', 15:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:53 INFO - 'MOZ_NO_REMOTE': '1', 15:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:53 INFO - 'NO_EM_RESTART': '1', 15:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:53 INFO - 'PWD': '/builds/slave/test', 15:28:53 INFO - 'SHELL': '/bin/bash', 15:28:53 INFO - 'SHLVL': '1', 15:28:53 INFO - 'TERM': 'linux', 15:28:53 INFO - 'TMOUT': '86400', 15:28:53 INFO - 'USER': 'cltbld', 15:28:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:53 INFO - '_': '/tools/buildbot/bin/python'} 15:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:28:53 INFO - Cleaning up... 15:28:53 INFO - Return code: 0 15:28:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:28:53 INFO - Using env: {'DISPLAY': ':0', 15:28:53 INFO - 'HOME': '/home/cltbld', 15:28:53 INFO - 'LANG': 'en_US.UTF-8', 15:28:53 INFO - 'LANGUAGE': 'en_US:en', 15:28:53 INFO - 'LOGNAME': 'cltbld', 15:28:53 INFO - 'MAIL': '/var/mail/cltbld', 15:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:53 INFO - 'MOZ_NO_REMOTE': '1', 15:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:53 INFO - 'NO_EM_RESTART': '1', 15:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:53 INFO - 'PWD': '/builds/slave/test', 15:28:53 INFO - 'SHELL': '/bin/bash', 15:28:53 INFO - 'SHLVL': '1', 15:28:53 INFO - 'TERM': 'linux', 15:28:53 INFO - 'TMOUT': '86400', 15:28:53 INFO - 'USER': 'cltbld', 15:28:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:53 INFO - '_': '/tools/buildbot/bin/python'} 15:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:28:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:28:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:28:56 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:28:56 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:28:56 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:28:56 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:28:56 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:28:56 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:28:56 INFO - Downloading docopt-0.6.1.tar.gz 15:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:28:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:28:56 INFO - Running setup.py install for blobuploader 15:28:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:28:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:28:56 INFO - Running setup.py install for requests 15:28:56 INFO - Running setup.py install for docopt 15:28:56 INFO - Successfully installed blobuploader requests docopt 15:28:56 INFO - Cleaning up... 15:28:56 INFO - Return code: 0 15:28:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:57 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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:28:57 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:28:57 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:28:57 INFO - Using env: {'DISPLAY': ':0', 15:28:57 INFO - 'HOME': '/home/cltbld', 15:28:57 INFO - 'LANG': 'en_US.UTF-8', 15:28:57 INFO - 'LANGUAGE': 'en_US:en', 15:28:57 INFO - 'LOGNAME': 'cltbld', 15:28:57 INFO - 'MAIL': '/var/mail/cltbld', 15:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:57 INFO - 'MOZ_NO_REMOTE': '1', 15:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:28:57 INFO - 'NO_EM_RESTART': '1', 15:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:57 INFO - 'PWD': '/builds/slave/test', 15:28:57 INFO - 'SHELL': '/bin/bash', 15:28:57 INFO - 'SHLVL': '1', 15:28:57 INFO - 'TERM': 'linux', 15:28:57 INFO - 'TMOUT': '86400', 15:28:57 INFO - 'USER': 'cltbld', 15:28:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:57 INFO - '_': '/tools/buildbot/bin/python'} 15:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:57 INFO - Running setup.py (path:/tmp/pip-0t71IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:57 INFO - Running setup.py (path:/tmp/pip-0n0EYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:57 INFO - Running setup.py (path:/tmp/pip-b0S6Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:57 INFO - Running setup.py (path:/tmp/pip-pze9_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:57 INFO - Running setup.py (path:/tmp/pip-2bV8Lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:57 INFO - Running setup.py (path:/tmp/pip-mASfn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:57 INFO - Running setup.py (path:/tmp/pip-feTddT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:57 INFO - Running setup.py (path:/tmp/pip-XW6y8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:57 INFO - Running setup.py (path:/tmp/pip-ZhQQYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:57 INFO - Running setup.py (path:/tmp/pip-K5fpyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:57 INFO - Running setup.py (path:/tmp/pip-2akgFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:58 INFO - Running setup.py (path:/tmp/pip-aQP__x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:58 INFO - Running setup.py (path:/tmp/pip-nzODal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:58 INFO - Running setup.py (path:/tmp/pip-iDL1sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:58 INFO - Running setup.py (path:/tmp/pip-XHQvJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:58 INFO - Running setup.py (path:/tmp/pip-dYbX3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:58 INFO - Running setup.py (path:/tmp/pip-EyUqUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:28:58 INFO - Running setup.py install for manifestparser 15:28:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:28:58 INFO - Running setup.py install for mozcrash 15:28:58 INFO - Running setup.py install for mozdebug 15:28:58 INFO - Running setup.py install for mozdevice 15:28:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:28:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:28:58 INFO - Running setup.py install for mozfile 15:28:58 INFO - Running setup.py install for mozhttpd 15:28:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Running setup.py install for mozinfo 15:28:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Running setup.py install for mozInstall 15:28:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Running setup.py install for mozleak 15:28:59 INFO - Running setup.py install for mozlog 15:28:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Running setup.py install for moznetwork 15:28:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Running setup.py install for mozprocess 15:28:59 INFO - Running setup.py install for mozprofile 15:28:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Running setup.py install for mozrunner 15:28:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:28:59 INFO - Running setup.py install for mozscreenshot 15:28:59 INFO - Running setup.py install for moztest 15:29:00 INFO - Running setup.py install for mozversion 15:29:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:29:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:29:00 INFO - Cleaning up... 15:29:00 INFO - Return code: 0 15:29:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:00 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:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:00 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:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:00 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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:29:00 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:29:00 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:29:00 INFO - Using env: {'DISPLAY': ':0', 15:29:00 INFO - 'HOME': '/home/cltbld', 15:29:00 INFO - 'LANG': 'en_US.UTF-8', 15:29:00 INFO - 'LANGUAGE': 'en_US:en', 15:29:00 INFO - 'LOGNAME': 'cltbld', 15:29:00 INFO - 'MAIL': '/var/mail/cltbld', 15:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:00 INFO - 'MOZ_NO_REMOTE': '1', 15:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:00 INFO - 'NO_EM_RESTART': '1', 15:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:00 INFO - 'PWD': '/builds/slave/test', 15:29:00 INFO - 'SHELL': '/bin/bash', 15:29:00 INFO - 'SHLVL': '1', 15:29:00 INFO - 'TERM': 'linux', 15:29:00 INFO - 'TMOUT': '86400', 15:29:00 INFO - 'USER': 'cltbld', 15:29:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:00 INFO - '_': '/tools/buildbot/bin/python'} 15:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:29:00 INFO - Running setup.py (path:/tmp/pip-Xy_Y6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:29:00 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:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:29:00 INFO - Running setup.py (path:/tmp/pip-L3uCEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:29:00 INFO - Running setup.py (path:/tmp/pip-9fcgGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:29:00 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:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:29:00 INFO - Running setup.py (path:/tmp/pip-HaCfCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:29:00 INFO - Running setup.py (path:/tmp/pip-ZFTJBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:29:00 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:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:29:00 INFO - Running setup.py (path:/tmp/pip-uGsGuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:29:00 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:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:29:00 INFO - Running setup.py (path:/tmp/pip-ogC2td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:29:00 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:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:29:00 INFO - Running setup.py (path:/tmp/pip-txS2Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:29:01 INFO - Running setup.py (path:/tmp/pip-mrRD4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:29:01 INFO - Running setup.py (path:/tmp/pip-3Prrv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:29:01 INFO - Running setup.py (path:/tmp/pip-6q8swH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:29:01 INFO - Running setup.py (path:/tmp/pip-y00xtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:29:01 INFO - Running setup.py (path:/tmp/pip-h320h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:29:01 INFO - Running setup.py (path:/tmp/pip-NytpdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:01 INFO - Running setup.py (path:/tmp/pip-4zkBlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:29:01 INFO - Running setup.py (path:/tmp/pip-uk1K0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:29:01 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:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:29:01 INFO - Running setup.py (path:/tmp/pip-ZiJMuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:29:01 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:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:29:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:29:01 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:29:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:29:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:29:03 INFO - Downloading blessings-1.6.tar.gz 15:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:29:03 INFO - Installing collected packages: blessings 15:29:03 INFO - Running setup.py install for blessings 15:29:03 INFO - Successfully installed blessings 15:29:03 INFO - Cleaning up... 15:29:03 INFO - Return code: 0 15:29:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:29:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:04 INFO - Reading from file tmpfile_stdout 15:29:04 INFO - Current package versions: 15:29:04 INFO - argparse == 1.2.1 15:29:04 INFO - blessings == 1.6 15:29:04 INFO - blobuploader == 1.2.4 15:29:04 INFO - docopt == 0.6.1 15:29:04 INFO - functools32 == 3.2.3-2 15:29:04 INFO - jsonschema == 2.5.1 15:29:04 INFO - manifestparser == 1.1 15:29:04 INFO - mozInstall == 1.12 15:29:04 INFO - mozcrash == 1.0 15:29:04 INFO - mozdebug == 0.1 15:29:04 INFO - mozdevice == 0.49 15:29:04 INFO - mozfile == 1.2 15:29:04 INFO - mozhttpd == 0.7 15:29:04 INFO - mozinfo == 0.9 15:29:04 INFO - mozleak == 0.1 15:29:04 INFO - mozlog == 3.4 15:29:04 INFO - moznetwork == 0.27 15:29:04 INFO - mozprocess == 0.23 15:29:04 INFO - mozprofile == 0.28 15:29:04 INFO - mozrunner == 6.13 15:29:04 INFO - mozscreenshot == 0.1 15:29:04 INFO - mozsystemmonitor == 0.3 15:29:04 INFO - moztest == 0.7 15:29:04 INFO - mozversion == 1.4 15:29:04 INFO - psutil == 3.1.1 15:29:04 INFO - requests == 1.2.3 15:29:04 INFO - wsgiref == 0.1.2 15:29:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:04 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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:29:04 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:29:04 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:29:04 INFO - Using env: {'DISPLAY': ':0', 15:29:04 INFO - 'HOME': '/home/cltbld', 15:29:04 INFO - 'LANG': 'en_US.UTF-8', 15:29:04 INFO - 'LANGUAGE': 'en_US:en', 15:29:04 INFO - 'LOGNAME': 'cltbld', 15:29:04 INFO - 'MAIL': '/var/mail/cltbld', 15:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:04 INFO - 'MOZ_NO_REMOTE': '1', 15:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:04 INFO - 'NO_EM_RESTART': '1', 15:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:04 INFO - 'PWD': '/builds/slave/test', 15:29:04 INFO - 'SHELL': '/bin/bash', 15:29:04 INFO - 'SHLVL': '1', 15:29:04 INFO - 'TERM': 'linux', 15:29:04 INFO - 'TMOUT': '86400', 15:29:04 INFO - 'USER': 'cltbld', 15:29:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:04 INFO - '_': '/tools/buildbot/bin/python'} 15:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:04 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:29:04 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:29:04 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:29:04 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:29:04 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:29:04 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:29:04 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:29:04 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:29:04 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:29:04 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:29:04 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:29:04 INFO - Cleaning up... 15:29:04 INFO - Return code: 0 15:29:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:29:04 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 0x7f5e4ef46e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c7b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1963130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, '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': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', '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:29:04 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:29:04 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:29:04 INFO - Using env: {'DISPLAY': ':0', 15:29:04 INFO - 'HOME': '/home/cltbld', 15:29:04 INFO - 'LANG': 'en_US.UTF-8', 15:29:04 INFO - 'LANGUAGE': 'en_US:en', 15:29:04 INFO - 'LOGNAME': 'cltbld', 15:29:04 INFO - 'MAIL': '/var/mail/cltbld', 15:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:04 INFO - 'MOZ_NO_REMOTE': '1', 15:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:04 INFO - 'NO_EM_RESTART': '1', 15:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:04 INFO - 'PWD': '/builds/slave/test', 15:29:04 INFO - 'SHELL': '/bin/bash', 15:29:04 INFO - 'SHLVL': '1', 15:29:04 INFO - 'TERM': 'linux', 15:29:04 INFO - 'TMOUT': '86400', 15:29:04 INFO - 'USER': 'cltbld', 15:29:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:04 INFO - '_': '/tools/buildbot/bin/python'} 15:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:29:04 INFO - Cleaning up... 15:29:04 INFO - Return code: 0 15:29:04 INFO - Running post-action listener: _resource_record_post_action 15:29:04 INFO - Running post-action listener: _start_resource_monitoring 15:29:04 INFO - Starting resource monitoring. 15:29:04 INFO - [mozharness: 2016-11-24 23:29:04.614004Z] Finished create-virtualenv step (success) 15:29:04 INFO - [mozharness: 2016-11-24 23:29:04.614481Z] Running install step. 15:29:04 INFO - Running pre-action listener: _resource_record_pre_action 15:29:04 INFO - Running main action method: install 15:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:29:04 INFO - Reading from file tmpfile_stdout 15:29:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:29:04 INFO - Reading from file tmpfile_stdout 15:29:04 INFO - Output received: 15:29:04 INFO - Usage: mozinstall [options] installer 15:29:04 INFO - Options: 15:29:04 INFO - -h, --help show this help message and exit 15:29:04 INFO - -d DEST, --destination=DEST 15:29:04 INFO - Directory to install application into. [default: 15:29:04 INFO - "/builds/slave/test"] 15:29:04 INFO - --app=APP Application being installed. [default: firefox] 15:29:04 INFO - mkdir: /builds/slave/test/build/application 15:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:29:21 INFO - Reading from file tmpfile_stdout 15:29:21 INFO - Output received: 15:29:21 INFO - /builds/slave/test/build/application/firefox/firefox 15:29:21 INFO - Running post-action listener: _resource_record_post_action 15:29:21 INFO - [mozharness: 2016-11-24 23:29:21.868322Z] Finished install step (success) 15:29:21 INFO - [mozharness: 2016-11-24 23:29:21.868601Z] Running run-tests step. 15:29:21 INFO - Running pre-action listener: _resource_record_pre_action 15:29:21 INFO - Running main action method: run_tests 15:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:29:21 INFO - Python 2.7.3 15:29:21 INFO - Return code: 0 15:29:21 INFO - grabbing minidump binary from tooltool 15:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:29:21 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 0x19f1fc0>, '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 0x19f2ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f3350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:29:21 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:29:21 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:29:21 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:29:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:29:21 INFO - Return code: 0 15:29:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:29:21 INFO - Using env: {'DISPLAY': ':0', 15:29:21 INFO - 'HOME': '/home/cltbld', 15:29:21 INFO - 'LANG': 'en_US.UTF-8', 15:29:21 INFO - 'LANGUAGE': 'en_US:en', 15:29:21 INFO - 'LOGNAME': 'cltbld', 15:29:21 INFO - 'MAIL': '/var/mail/cltbld', 15:29:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:29:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:21 INFO - 'MOZ_NO_REMOTE': '1', 15:29:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:21 INFO - 'NO_EM_RESTART': '1', 15:29:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:21 INFO - 'PWD': '/builds/slave/test', 15:29:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:29:21 INFO - 'SHELL': '/bin/bash', 15:29:21 INFO - 'SHLVL': '1', 15:29:21 INFO - 'TERM': 'linux', 15:29:21 INFO - 'TMOUT': '86400', 15:29:21 INFO - 'USER': 'cltbld', 15:29:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330', 15:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:21 INFO - '_': '/tools/buildbot/bin/python'} 15:29:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:29:22 INFO - mozversion application_buildid: 20161124123506 15:29:22 INFO - mozversion application_changeset: 3a36e60d1c4ce25062d843d6cabd970c4c9cc84d 15:29:22 INFO - mozversion application_display_name: Nightly 15:29:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:29:22 INFO - mozversion application_name: Firefox 15:29:22 INFO - mozversion application_remotingname: firefox 15:29:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:29:22 INFO - mozversion application_vendor: Mozilla 15:29:22 INFO - mozversion application_version: 53.0a1 15:29:22 INFO - mozversion platform_buildid: 20161124123506 15:29:22 INFO - mozversion platform_changeset: 3a36e60d1c4ce25062d843d6cabd970c4c9cc84d 15:29:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:29:22 INFO - mozversion platform_version: 53.0a1 15:29:22 INFO - using testdate: 1480030162 15:29:22 INFO - actual date: 1480030162 15:29:22 INFO - starting webserver on 'localhost:57201' 15:29:22 INFO - SUITE-START | Running 2 tests 15:29:22 INFO - TEST-START | dromaeo_css 15:29:22 INFO - operating with platform_type : linux_ 15:29:22 INFO - Initialising browser for dromaeo_css test... 15:29:22 INFO - TEST-INFO | started process 10981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL5Agkc/profile http://localhost:57201/getInfo.html) 15:29:26 INFO - PROCESS | 10981 | __metrics Screen width/height:1600/1200 15:29:26 INFO - PROCESS | 10981 | colorDepth:24 15:29:26 INFO - PROCESS | 10981 | Browser inner width/height: 1024/697 15:29:26 INFO - PROCESS | 10981 | __metrics 15:29:27 INFO - PROCESS | 10981 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:29:27 INFO - PROCESS | 10981 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:27 INFO - PROCESS | 10981 | console.error: PushService: 15:29:27 INFO - PROCESS | 10981 | stateChangeProcessEnqueue: Error transitioning state 15:29:27 INFO - PROCESS | 10981 | UnknownError 15:29:28 INFO - TEST-INFO | 10981: exit 0 15:29:28 INFO - Browser initialized. 15:29:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:29:28 INFO - TEST-INFO | started process 11065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL5Agkc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:40 INFO - PROCESS | 11065 | RSS: Main: 174481408 15:29:40 INFO - PROCESS | 11065 | 15:30:31 INFO - PROCESS | 11065 | 1480030231373 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:32:43 INFO - PROCESS | 11065 | Cycle 1(1): loaded http://localhost:57201/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57201/tests/dromaeo/cssquery-ext.html) 15:32:44 INFO - PROCESS | 11065 | RSS: Main: 303280128 15:32:44 INFO - PROCESS | 11065 | 15:35:47 INFO - PROCESS | 11065 | Cycle 1(1): loaded http://localhost:57201/tests/dromaeo/cssquery-ext.html (next: http://localhost:57201/tests/dromaeo/cssquery-jquery.html) 15:35:47 INFO - PROCESS | 11065 | RSS: Main: 277536768 15:35:47 INFO - PROCESS | 11065 | 15:38:49 INFO - PROCESS | 11065 | Cycle 1(1): loaded http://localhost:57201/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57201/tests/dromaeo/cssquery-mootools.html) 15:38:50 INFO - PROCESS | 11065 | RSS: Main: 252936192 15:38:50 INFO - PROCESS | 11065 | 15:41:52 INFO - PROCESS | 11065 | Cycle 1(1): loaded http://localhost:57201/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57201/tests/dromaeo/cssquery-prototype.html) 15:41:52 INFO - PROCESS | 11065 | RSS: Main: 256221184 15:41:52 INFO - PROCESS | 11065 | 15:44:55 INFO - PROCESS | 11065 | Cycle 1(1): loaded http://localhost:57201/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57201/tests/dromaeo/cssquery-yui.html) 15:44:56 INFO - PROCESS | 11065 | RSS: Main: 221171712 15:44:56 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | Cycle 1(1): loaded http://localhost:57201/tests/dromaeo/cssquery-yui.html (next: http://localhost:57201/tests/dromaeo/cssquery-dojo.html) 15:47:59 INFO - PROCESS | 11065 | RSS: Main: 269574144 15:47:59 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | __start_tp_report 15:47:59 INFO - PROCESS | 11065 | _x_x_mozilla_page_load 15:47:59 INFO - PROCESS | 11065 | _x_x_mozilla_page_load_details 15:47:59 INFO - PROCESS | 11065 | |i|pagename|runs| 15:47:59 INFO - PROCESS | 11065 | |0;dojo.html;3019.0489995651374;3052.2064263291536;3077.538369244613;3079.045495896271;3087.4751292280325;5289.68261904286;5359.624826262163;5368.865778355543;5396.325459317585;5433.619646624733;5354.303940487741;5373.704446255454;5374.838754837361;5392;5431.049566325897;4944.283078953549;4959.305697202394;5002.524760147799;5002.524760147799;5041.621878359119;4937.407511098673;5039.77321020555;5056.646034777567;5057.721825299607;5061.013102445025;4933.80264789408;4966.379202599675;5010.3737032870895;5036.1438555445475;5081.364829396325;4818.445878723956;4878.658493905428;4982.003599280159;4999.525045120708;5014.197728363462;4883.975580122076;4903.338049363361;4909.7790599423115;4914.336564563774;4986.10250154972;5328.520433161034;5372.167314066326;5375.892482150374;5377.5966802489575;5384.973075134639;5782.45066718661;5790.7683692652245;5791.971040144815;5798.449147330997;5839.036558967765;5636.577256705764;5695.088785794294;5698.544116470714;5759.68321742304;5769.394213607553;5405.729713514309;5412.269343638558;5413.296271484721;5414.187871819258;5443.319585051869;5877.5591830612875;5879.853003674857;5881.235439392937;5887.470127688529;5890.617109887844;5488.1767734839295;5500.119980803132;5619.943800562024;5638.943610563924;5659.26429564154;5744.655320680689;5773.191753154561;5797.188393624896;5817.970910145422;5839.0949402842625;5767;5767.942320576824;5773.336066352424;5779.566532509994;5827.388124246978;5556.944430555724;5566.276384070045;5566.332040155207;5754.683492407874;5780.913286300709;4385.342198670225;4415.205263052617;4423.07115505741;4436.534163912807;4473.194824931544;3902.3951287550476;3906.74606150605;3910.65082546521;3944.092858642471;3950.7234493585174;5325.2810870531985;5459.754311056012;5470.589705772083;5476.041692703761;5480.095784195563;5675.57433192504;5725.742341594639;5765.1928729977835;5767.538596912321;5858.882822343529;5424.240606315119;5474.534664553478;5476.67139971603;5477.370102438191;5478.945210547923;5017.623678224148;5020.49795020495;5024.648274620815;5028.622853286018;5077.111505486525;5733.827985160452;5737.483626473638;5955.047192449188;6003.129546215861;6007.8197654070445;5833.095870140135;5834.474897259267;5841.18223448726;5841.591088623755;5874.559408044328;6016.428439298435;6026.638401695912;6034.9094763577705;6042.939570604238;6047.03247480401;5450.645708028966;5482.5613950884635;5569.136783798518;5616.410276921028;5734.111212762028;5700.629459085146;5743.540516758566;5752.453516915886;5773.74018169175;5800.622959507618;5559.749811258584;5596.244506991504;5614.101743720985;5615;5622;5460.7542660579575;5490.5882058844945;5546.889062218814;5603.439656034527;5618.831435056954;5496.395396506461;5547.861303467445;5571.9442805571425;5606.803761868315;5618.775248990158;5582;5593.776248949996;5600.327960644586;5601.663900166003;5611.747471363717;5401.513863752281;5421.945780542144;5447.1829225616475;5518.44815518461;5519.116941289535 15:47:59 INFO - PROCESS | 11065 | |1;ext.html;551.3279893613093;576.2451188942485;592.9851753706158;603.1856993059367;605.7153138025127;32815.50776738351;43005.56994430055;43902.7804860976;44009.61860530221;44021.33967990483;43741.56258437414;43799.78100109495;43983.78008109955;44050;44064.77967610166;7895.8026049348655;8155.632996515142;8533.615987280587;8659.870101948476;8679.869801952944;10159.339642923223;10377.844332334984;10401.947990260038;10537.631182908599;10658.840117398246;10438.425886576235;10449.425281609509;10497.842532361983;10522.316049456798;10526.315789473698;10396.428196449193;10444.321119127271;10454.268201225917;10457.79084418315;10487.213458990605;10270.794584108351;10311.07200351972;10319.277650564463;10324.741881452948;10333.328333658288;40614.79692601548;40696.79651601753;40906.79546602278;41134.79432602848;41217.38173927394;3272.8527216275324;3311.2549676322874;3418.1112910643164;3440.6559344065395;3545.5213546171194;29423.11730648084;30253.394932101233;31664.525032124307;31802.681973180202;31814.522782158285;4059.289624315733;4159.085001299709;4225.957740422587;4228.9154216915795;4263.360495925605;321775;336205;338980;339038.3048084768;339294;60321.69839150776;61097.69451152716;61150.38849611447;61212.69393653092;61214.38785612176;64266.6786666073;64498.325251211754;64607;64700.64789633636;64774;13984.790228146587;14032.508862189774;14045;14068.859311406959;14071.226082565558;10673.46632668379;10714.517846696917;10873.945630271797;10896.182786290901;11370.431478426046;19120;19235.326763563207;19243.422697319103;19387.51531211731;19515.90242048809;7554.169041405441;7598.164201937782;7617.961910190414;7717.421193410517;7776.416768742367;925.6112432778249;975.4878688688495;1002.7793885345212;1018.2057994764095;1046.7749433871602;30524.389512209633;30626.84686576553;31006.84496577548;31018.914337998063;31340;1039.5477967084344;1060.5757696921294;1074.5486895503907;1075.8224892892586;1091.9781604367868;15988.76016859748;16290;16323.591910202102;16337.428190013292;16717.247723852455;514366;518460;519891;520253;521375;56771.71614141903;57281.69415434739;57321.426785732445;57321.426785732445;57351.426485734606;1212.4180393411211;1248.925064496115;1249.8937590304927;1337.6722702937843;1338.5716570697284;29525.745324791835;33555;33707.49438758371;33790;34117.658823411446;54347.18479222894;55274.72362638161;55291.44708552863;55295;55338.44661553333;401285;403326;404126;405186;405546;27855.582166267926;27910.860445697643;28914.42171156523;41920;42256.73229803111;44654;44671.77664111659;45002.77498612486;45042;45502;38853.805730971166;38883.222335552564;39258.411123833735;39620.405693914036;40474.39288410735;37716.816459556314;38651.6134838648;38719.22561548697;38976.6102338973;39822.60177398189;37977.81011094927;38421.61578384292;38423.615763843125;39254.80372598119;39634;31490;34272.31455370829;34585.48121778125;35128.29743405169;35294.47058294179;26634.623023754113;26732.866335668976;26925.30746925292;27017.189484315502;27113.322166945985 15:47:59 INFO - PROCESS | 11065 | |2;jquery.html;380.2736772764021;384.8941541076202;404.7348986413899;405.7200531633172;415.5989470161294;13366.398512066957;15523.534293971185;18706.719399209007;18719.625607487844;19227.423177304667;17819.37632182874;18229.270829166817;18409.723854142165;18967.62064758704;19046;5379.735762095905;5527.668339899609;5743.62666426681;5768.250127483421;5770.740316685759;5390.21841832934;5667.886642267152;5697.487226149646;5698.658080515162;5702.344230413514;5430.104032834578;5644.57665675074;5651.7739290428335;5652.74562644682;5657.179708942201;5635.887282254353;5637.548996080324;5674.290713660793;5675.063614503602;5679.2333035040365;4883.829065982709;5014.2979982802435;5032.798688052473;5075.746212689388;5077.441481437039;22580.096796128135;22699.432514187276;22809.885950570308;22898.656520152046;23104.42238944023;2301.1255722825385;2551.885165167572;2600.4929038837436;3041.422129795332;3081.4145312390574;13756.793648095287;14308.570742877626;14474.276286185754;14534.854651453456;14813;1845.7877344105466;1911.1399870058528;1937.0314842578712;1944.319488179126;1945.9805401946082;76720.23279767187;76776;76929;77395;78306.99999999943;10398.324108932895;10648.414337211529;10997.945010275058;11286.2348724563;11497.195196336175;14968.775468367983;15029.924850375897;15044.924775376054;15069.47256846005;15105.47130850415;7570.432217583703;7823.295903368724;7930.246626570467;8078.798030049295;8090.231428014329;7228.891566626505;7319.74380896666;7332.30343117403;7552.735654252075;7589.506682065648;6411.711472983727;6582.210134783857;6595.142631457879;6634.938409854401;6700.329967003358;1882.6517094337592;1887.7074053521726;1891.7919028906808;1897.133851670461;1956.9706454403195;819.995900020496;869.2915274051628;914.3234006834895;1007.1841808135433;1034.7568321444455;18350.908245458686;19641.41075767729;19684.803151968295;19815.900920495595;20048.69926951097;958.6453012385323;974.2644303550774;982.6757170133982;993.0813997052697;1000.4847503535685;10536;10989.450527473595;11019.724506887393;11070.889291107147;11172.608958686407;434799;440052;444732;448546;452037;82210;82313;82807.58596207101;83149.58425207835;84957.57521212478;962.6438217859297;964.744342749172;979.9559019844124;987.6049580167991;992.0228574853763;16811.159442027605;16974.660506790042;17368.39210627622;17454.247336822646;17841.286348545913;38398.424023640226;39196;40255;40388.79805600953;41277.587224127376;51587.48412515977;51860.48139518557;52346;52716;53378.73310633422;7480.251974802693;7543.434242431949;7694.461387702807;7765.650545725343;7893.84212315739;10410.68767936963;12288.938555307166;12351.876481235073;12358.382080895739;12361.258324500559;10786.930875484817;11297.26567773125;11360.488778005174;11533.135014874086;11742.412879355827;5266.34170728659;7838.686452542062;10855.666031802884;11072.889271107186;11242.7751444969;11076.280041797258;11194.608188713355;11207.887921120684;11474.77050459003;11674.94162529182;7205.891911621435;7451.40388768908;7600;7661.348785353307;8104;8284.337253019865;10358.741031474274;11158.163137764863;11178.27341222818;11543.8268425972 15:47:59 INFO - PROCESS | 11065 | |3;mootools.html;1421.218329918545;1459.0953608762566;1560.8985415947961;1697.6095498035459;1721.4749501402068;7659.463837531368;8168.754937351889;8170.754877353682;8175.550344731045;8175.877361839577;6990.510664253505;7161.89257161143;7653.119891212512;7844.058712954454;8051.516908985465;2294.7819957104048;2334.3463830127594;2335.5212181502834;2336.88315584221;2338.228384633067;2293.529826385587;2297.896594653236;2368.7157541095094;2370.8814559272055;2371.063429945171;2264.071730590458;2277.533105713325;2277.9202727904526;2290.702208712865;2331.428799944016;2212.1814928476488;2217.966730499044;2218.7670294619074;2225.9220927267547;2232.096001119533;2224.7552769195377;2234.7430045544806;2248.2468373095035;2252.335561009506;2253.7746225377496;7871.4883532570775;7917.7624671259955;7924.207579242087;7924.4849084809875;7926.207379262085;4851.951480485185;4990.226514890198;4999.925001124986;5000.7249601271915;5005.474425185376;3082.859342043436;3157.3843100595395;3470.2538954124734;3486.755927085105;3491.0748651607346;1040.5733649203867;1048.2086025051115;1083;1096.1942971915635;1114.0920150077661;10928.071113955324;10980.890191098066;11022.283551569122;11025.889741102646;11034.227604067719;4384.210842048398;4517.81928722854;4626.676132670681;4731.787069581808;4731.95268047322;9259.259259259243;9266.814663706687;9268.629254829866;9270.675526356545;9280.0719928008;5044.495550444926;5063.088644044107;5066.771995260222;5104.540591346722;5110.97444512775;4179.644730197906;4259.61663450291;4280.422143010716;4641.651876109306;4691.038337140878;3700.093477098128;3754.5494540655295;3799.8670046548236;3811.256804923069;3854.5567259764925;1231.1074471008626;1244.104244943639;1247.9625611231495;1262.0976002158318;1281.0968267371481;888.693400776731;948.184561277301;964.9855252171224;968.8595153702673;1001.8678892851032;5548.0845660465575;5575.163725441216;5595.916061259084;5846.707664616837;5864.912026319608;452.0890405832251;461.4278294914282;466.90195059037984;469.335889716048;471.0907947661047;3564.483149943244;3644.599094099647;3651.251493443891;3692.5015122958594;3827.0432391902023;9518.571664275125;9773.560189791477;9862.260330475243;9876.061774131445;9892.455914924605;9758.56086476096;9869.358491698016;9887.653932112486;9888.653897113567;9898.80202395948;7491.325780679765;7496.287852653989;7590.316871481593;7603.999999999889;7606.087269527692;5464.207689885024;5511.255980442749;5585.273914391103;5733.082706766897;5794.565407594531;8904.643814247358;8942.86585701202;8967.820643587222;8969.820603588023;9013.594388252675;9022.962359328498;9065.50139742294;9153.313501487282;9278.11857873501;9434.150926416656;6469.385408386196;6652.501062420434;6889.483288753263;7170.749023784142;7261.818454538678;7570.129435114812;7871.921280787348;7872.606369681378;7877.330426913776;7880.2513761192595;6961.756338528127;7048.471364647569;7073.752418665322;7101.254368291255;7176.461765367722;6827.863442731217;6930.618815964968;6934.965325173342;6997.580145191305;7050.894236586558;6262.624242545462;6393.680315984089;6446.226452825691;6446.806595802133;6502.869942601216;5026.271190677405;5090.796368145381;5115.87210319745;5182.404023537341;5213.582913366998;4835.492273311393;4905;5019.347484827095;5032.899342013213;5146.279520867157 15:47:59 INFO - PROCESS | 11065 | |4;prototype.html;322.6321992928061;327.66578090347843;331.08290036598623;333.55470446953325;340.7955226863884;5044.84865454036;5203.713795741232;5287.973560132199;5330.36035675719;5340.1722732976405;5041;5131.230315452684;5149.716765577892;5156.69059856408;5219.765110570024;4137.648299894513;4148.875533733993;4164.375343698454;4178.22702799983;4195.37069439585;4060.5736397678115;4163.7293575917465;4169.166166766644;4170.603792639709;4179.519355274152;4113.218488487193;4145;4154.397612346208;4164.146349998243;4165.979170104145;4114.280000999813;4136.4415803866395;4146.668266538685;4156;4177.728447650893;3684;3696.131409118882;3706.5181526401666;3712.962870371289;3744.4944932434046;4909.926351104737;5061.569766569846;5092.148396897749;5099.69401835891;5196.974015129938;4667.346571479996;4669.276262179367;4690.296455531663;4702.825592724897;4711.890152499334;5391.56867450603;5407.134858422633;5410.323709536308;5445.366390082999;5475.233467314579;3825.5218097737784;3931.113065728466;3953.367461206222;3963.0884896473685;3963.246983073207;5643.294588176478;5665.017243964579;5667.773289068432;5680.517156041741;5689.886202275931;4002.5597184309704;4008.7995600219874;4008.939865902014;4013.819378127991;4014.8594799181888;3831.2606486362383;4053.8783836484954;4058.492688413948;4058.918821623551;4077.8776636700354;4579.564941330568;4652.744099074515;4658.510856360102;4671.85984420468;4674.57928786404;5442.346918369821;5483.917741233885;5509.889802203934;5515.61390702655;5527.419620939824;1300.746354460871;1322.6891680455085;1360.7278544290984;1366.6993261482457;1379.8965077619218;922.23454532739;940.6096469964888;954.7899462118323;959.5058544849409;969.4764826993345;5063.594912406998;5063.746812659352;5070.670406423645;5086.567641750418;5091.468592952276;5394.460553944574;5410;5415.456594870443;5417.10617748075;5427.267318911975;4841.814323083743;5100.923486147711;5101.744912754348;5142.714321419645;5150.562202212779;2808.747212750862;2841.602175695404;2850.489240702431;2864.384157406126;2867.2258490207946;5552.194931734876;5577.581681373913;5578.30271216098;5620;5634.492895639412;5285.339332583427;5465.371482279509;5473.343198816167;5504.4770746778995;5525.861853453615;5538.44615538451;5544.584156188302;5598.216249725042;5626.521745651502;5652.3217213934595;5234.528892399702;5410.864728381822;5418.322709661293;5435.755391007493;5450.1007333789485;5325.786968521371;5342.7061511615675;5350.5184533392185;5369.301990741179;5388.030154572215;5552.7778888843995;5562.5549956002615;5565.30433695788;5581.246531718329;5635.380108188014;3862.8841134766003;3894.766314021168;3897.941530877096;3912.7847968360875;3952.960470395259;5317.920231196613;5585.804496842591;5597.580181486323;5607.271054762855;5614.382417934105;5319.734013299242;5360.597955153301;5511.834644960658;5522.668639881459;5525.723713814374;5480.287562616834;5488.231647569263;5498.140966697215;5498.257735205856;5500.1749737539685;5313.495217954288;5464.087569350695;5487.244081893915;5489.917651235314;5502.808371144806;5507.586930980113;5518.199861020049;5518.399664097366;5527.309086364205;5528.170774383874;5395.973020134874;5436.7281635918835;5443.346798384219;5494.560435165257;5502.889942201214 15:47:59 INFO - PROCESS | 11065 | |5;yui.html;732.3921145449277;743.4052757793767;768.416003837084;787.0909099989507;793.7737744742748;14585.270736463173;15437.922810385946;15440.61398465039;15464.458743943964;15471.922640386781;14070.94467914908;14250.358733856976;14253.714925701479;14255.287235638229;14270.785938210909;661.9338066193391;675.2302375292146;764.6673696941821;773.5590713293425;790.5019837502394;781.4959351218461;796.7569891183186;797.314309693663;798.3812545277399;799.3924617290871;835.8328334333128;837.3677873205752;837.9371547133959;837.9706710265142;838.4047326398264;696.8118607975869;711.1146622455077;796.9880451793227;823.505896462121;830.4560512864084;595.4283887468035;605.8303674971015;606.1332294818408;606.2300877885106;606.336062012096;13922.860771392257;13939.09395889264;13950.23273719945;13950.651233719238;13957.79063314051;12768.680782980407;12812.615621531275;13142.60572182836;13256.93371533136;13286.734265314737;11624.941875290653;11657.125715571367;12066.385999095397;12269.699723390066;12359.505619775198;4167.458230430055;4183.100633363842;4242.2576049191575;4311.245532031882;4325.805338759764;61021;61199.69400152971;62451;62874;62945.05582416267;10051.095401413908;10468.947655261674;10572.259941803999;10638.468076596138;10970.835437468444;19463.8053619462;19486.805131948782;19519.8048019518;19607.901960490108;19638.312659056865;7767.689292428239;7846.921530784619;7870.842583148305;7938.880916786253;8103.878441823377;4253.3619957006695;4350.151720414552;4370.584794444522;4469.910601788011;4479.70881892676;3796.0889386547583;3989.082511022481;3995.4805875236034;4012.1373904610064;4024.4566983457444;684.4866350237322;686.4165459359505;699.8215455058927;700.8002719224996;710.989335159973;597.832606870077;598.2521847690386;599.9040153575407;674.2549482821412;713.0801266366433;8769.956150219336;9000.956594523517;9421;9430.292728045286;9468.90531094694;670.1455644053871;677.2550194785795;677.5629718831425;677.8271540757075;695.4436450839308;4308.719933204332;4537.886552836206;4547.522510136388;4562.8631141065825;4690.624750019991;68384.6580767093;69715.65142174358;71462.64268678728;80381.59809200917;86828.13171868201;44716.55283447124;66220;69107.65446172738;70596;71872.2812771876;63944;64712.67643661846;65511.672441637485;66118;66435.00347494791;8642.78393040179;9072.410293330913;9251.76870578214;9294.117058879396;9390.718278451384;43130.56869431266;43668.781656091516;44319.34646862033;44833.55166448294;45080.549194507636;57299.42700572941;60300.39699603123;60791;60961.69519152376;61569;11301.26541774782;11983.820242696193;12149.392530373269;12280;12977.35113244353;13352.599422017354;13757.38091785892;13839.238841863391;14056.297185140498;14392.784108238175;12106;12221.266723996589;12382;12982.610521684364;13295.135816171918;12978.935105324414;13062.54281100157;13193.670158246121;13716.65708357299;13808.792868106786;12456.875431245933;12859.421326040538;12944.41750121228;12974.545890893773;13498.93250533741;10075;10492.422916739653;10868.184886133413;11141.2201145919;11221.607243746756;10622.28813093886;11090.5563777448;11231;11422.771544569228;11463.426828658367 15:47:59 INFO - PROCESS | 11065 | __end_tp_report 15:47:59 INFO - PROCESS | 11065 | __start_cc_report 15:47:59 INFO - PROCESS | 11065 | _x_x_mozilla_cycle_collect,1266 15:47:59 INFO - PROCESS | 11065 | __end_cc_report 15:47:59 INFO - PROCESS | 11065 | __startTimestamp1480031279540__endTimestamp 15:47:59 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | ------- Summary: start ------- 15:47:59 INFO - PROCESS | 11065 | Number of tests: 6 15:47:59 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | [#0] dojo.html Cycles:165 Average:5351.58 Median:5490.59 stddev:599.33 (10.9%) stddev-sans-first:572.55 15:47:59 INFO - PROCESS | 11065 | Values: 3019.0 3052.2 3077.5 3079.0 3087.5 5289.7 5359.6 5368.9 5396.3 5433.6 5354.3 5373.7 5374.8 5392.0 5431.0 4944.3 4959.3 5002.5 5002.5 5041.6 4937.4 5039.8 5056.6 5057.7 5061.0 4933.8 4966.4 5010.4 5036.1 5081.4 4818.4 4878.7 4982.0 4999.5 5014.2 4884.0 4903.3 4909.8 4914.3 4986.1 5328.5 5372.2 5375.9 5377.6 5385.0 5782.5 5790.8 5792.0 5798.4 5839.0 5636.6 5695.1 5698.5 5759.7 5769.4 5405.7 5412.3 5413.3 5414.2 5443.3 5877.6 5879.9 5881.2 5887.5 5890.6 5488.2 5500.1 5619.9 5638.9 5659.3 5744.7 5773.2 5797.2 5818.0 5839.1 5767.0 5767.9 5773.3 5779.6 5827.4 5556.9 5566.3 5566.3 5754.7 5780.9 4385.3 4415.2 4423.1 4436.5 4473.2 3902.4 3906.7 3910.7 3944.1 3950.7 5325.3 5459.8 5470.6 5476.0 5480.1 5675.6 5725.7 5765.2 5767.5 5858.9 5424.2 5474.5 5476.7 5477.4 5478.9 5017.6 5020.5 5024.6 5028.6 5077.1 5733.8 5737.5 5955.0 6003.1 6007.8 5833.1 5834.5 5841.2 5841.6 5874.6 6016.4 6026.6 6034.9 6042.9 6047.0 5450.6 5482.6 5569.1 5616.4 5734.1 5700.6 5743.5 5752.5 5773.7 5800.6 5559.7 5596.2 5614.1 5615.0 5622.0 5460.8 5490.6 5546.9 5603.4 5618.8 5496.4 5547.9 5571.9 5606.8 5618.8 5582.0 5593.8 5600.3 5601.7 5611.7 5401.5 5421.9 5447.2 5518.4 5519.1 15:47:59 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | [#1] ext.html Cycles:180 Average:58429.42 Median:19420.00 stddev:112802.76 (580.9%) stddev-sans-first:113035.50 15:47:59 INFO - PROCESS | 11065 | Values: 551.3 576.2 593.0 603.2 605.7 32815.5 43005.6 43902.8 44009.6 44021.3 43741.6 43799.8 43983.8 44050.0 44064.8 7895.8 8155.6 8533.6 8659.9 8679.9 10159.3 10377.8 10401.9 10537.6 10658.8 10438.4 10449.4 10497.8 10522.3 10526.3 10396.4 10444.3 10454.3 10457.8 10487.2 10270.8 10311.1 10319.3 10324.7 10333.3 40614.8 40696.8 40906.8 41134.8 41217.4 3272.9 3311.3 3418.1 3440.7 3545.5 29423.1 30253.4 31664.5 31802.7 31814.5 4059.3 4159.1 4226.0 4228.9 4263.4 321775.0 336205.0 338980.0 339038.3 339294.0 60321.7 61097.7 61150.4 61212.7 61214.4 64266.7 64498.3 64607.0 64700.6 64774.0 13984.8 14032.5 14045.0 14068.9 14071.2 10673.5 10714.5 10873.9 10896.2 11370.4 19120.0 19235.3 19243.4 19387.5 19515.9 7554.2 7598.2 7618.0 7717.4 7776.4 925.6 975.5 1002.8 1018.2 1046.8 30524.4 30626.8 31006.8 31018.9 31340.0 1039.5 1060.6 1074.5 1075.8 1092.0 15988.8 16290.0 16323.6 16337.4 16717.2 514366.0 518460.0 519891.0 520253.0 521375.0 56771.7 57281.7 57321.4 57321.4 57351.4 1212.4 1248.9 1249.9 1337.7 1338.6 29525.7 33555.0 33707.5 33790.0 34117.7 54347.2 55274.7 55291.4 55295.0 55338.4 401285.0 403326.0 404126.0 405186.0 405546.0 27855.6 27910.9 28914.4 41920.0 42256.7 44654.0 44671.8 45002.8 45042.0 45502.0 38853.8 38883.2 39258.4 39620.4 40474.4 37716.8 38651.6 38719.2 38976.6 39822.6 37977.8 38421.6 38423.6 39254.8 39634.0 31490.0 34272.3 34585.5 35128.3 35294.5 26634.6 26732.9 26925.3 27017.2 27113.3 15:47:59 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | [#2] jquery.html Cycles:180 Average:27003.32 Median:20396.77 stddev:73180.64 (358.8%) stddev-sans-first:73358.63 15:47:59 INFO - PROCESS | 11065 | Values: 380.3 384.9 404.7 405.7 415.6 13366.4 15523.5 18706.7 18719.6 19227.4 17819.4 18229.3 18409.7 18967.6 19046.0 5379.7 5527.7 5743.6 5768.3 5770.7 5390.2 5667.9 5697.5 5698.7 5702.3 5430.1 5644.6 5651.8 5652.7 5657.2 5635.9 5637.5 5674.3 5675.1 5679.2 4883.8 5014.3 5032.8 5075.7 5077.4 22580.1 22699.4 22809.9 22898.7 23104.4 2301.1 2551.9 2600.5 3041.4 3081.4 13756.8 14308.6 14474.3 14534.9 14813.0 1845.8 1911.1 1937.0 1944.3 1946.0 76720.2 76776.0 76929.0 77395.0 78307.0 10398.3 10648.4 10997.9 11286.2 11497.2 14968.8 15029.9 15044.9 15069.5 15105.5 7570.4 7823.3 7930.2 8078.8 8090.2 7228.9 7319.7 7332.3 7552.7 7589.5 6411.7 6582.2 6595.1 6634.9 6700.3 1882.7 1887.7 1891.8 1897.1 1957.0 820.0 869.3 914.3 1007.2 1034.8 18350.9 19641.4 19684.8 19815.9 20048.7 958.6 974.3 982.7 993.1 1000.5 10536.0 10989.5 11019.7 11070.9 11172.6 434799.0 440052.0 444732.0 448546.0 452037.0 82210.0 82313.0 82807.6 83149.6 84957.6 962.6 964.7 980.0 987.6 992.0 16811.2 16974.7 17368.4 17454.2 17841.3 38398.4 39196.0 40255.0 40388.8 41277.6 51587.5 51860.5 52346.0 52716.0 53378.7 7480.3 7543.4 7694.5 7765.7 7893.8 10410.7 12288.9 12351.9 12358.4 12361.3 10786.9 11297.3 11360.5 11533.1 11742.4 5266.3 7838.7 10855.7 11072.9 11242.8 11076.3 11194.6 11207.9 11474.8 11674.9 7205.9 7451.4 7600.0 7661.3 8104.0 8284.3 10358.7 11158.2 11178.3 11543.8 15:47:59 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | [#3] mootools.html Cycles:180 Average:5341.42 Median:5107.76 stddev:2919.74 (57.2%) stddev-sans-first:2913.06 15:47:59 INFO - PROCESS | 11065 | Values: 1421.2 1459.1 1560.9 1697.6 1721.5 7659.5 8168.8 8170.8 8175.6 8175.9 6990.5 7161.9 7653.1 7844.1 8051.5 2294.8 2334.3 2335.5 2336.9 2338.2 2293.5 2297.9 2368.7 2370.9 2371.1 2264.1 2277.5 2277.9 2290.7 2331.4 2212.2 2218.0 2218.8 2225.9 2232.1 2224.8 2234.7 2248.2 2252.3 2253.8 7871.5 7917.8 7924.2 7924.5 7926.2 4852.0 4990.2 4999.9 5000.7 5005.5 3082.9 3157.4 3470.3 3486.8 3491.1 1040.6 1048.2 1083.0 1096.2 1114.1 10928.1 10980.9 11022.3 11025.9 11034.2 4384.2 4517.8 4626.7 4731.8 4732.0 9259.3 9266.8 9268.6 9270.7 9280.1 5044.5 5063.1 5066.8 5104.5 5111.0 4179.6 4259.6 4280.4 4641.7 4691.0 3700.1 3754.5 3799.9 3811.3 3854.6 1231.1 1244.1 1248.0 1262.1 1281.1 888.7 948.2 965.0 968.9 1001.9 5548.1 5575.2 5595.9 5846.7 5864.9 452.1 461.4 466.9 469.3 471.1 3564.5 3644.6 3651.3 3692.5 3827.0 9518.6 9773.6 9862.3 9876.1 9892.5 9758.6 9869.4 9887.7 9888.7 9898.8 7491.3 7496.3 7590.3 7604.0 7606.1 5464.2 5511.3 5585.3 5733.1 5794.6 8904.6 8942.9 8967.8 8969.8 9013.6 9023.0 9065.5 9153.3 9278.1 9434.2 6469.4 6652.5 6889.5 7170.7 7261.8 7570.1 7871.9 7872.6 7877.3 7880.3 6961.8 7048.5 7073.8 7101.3 7176.5 6827.9 6930.6 6935.0 6997.6 7050.9 6262.6 6393.7 6446.2 6446.8 6502.9 5026.3 5090.8 5115.9 5182.4 5213.6 4835.5 4905.0 5019.3 5032.9 5146.3 15:47:59 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | [#4] prototype.html Cycles:180 Average:4568.20 Median:5211.74 stddev:1323.72 (25.4%) stddev-sans-first:1288.50 15:47:59 INFO - PROCESS | 11065 | Values: 322.6 327.7 331.1 333.6 340.8 5044.8 5203.7 5288.0 5330.4 5340.2 5041.0 5131.2 5149.7 5156.7 5219.8 4137.6 4148.9 4164.4 4178.2 4195.4 4060.6 4163.7 4169.2 4170.6 4179.5 4113.2 4145.0 4154.4 4164.1 4166.0 4114.3 4136.4 4146.7 4156.0 4177.7 3684.0 3696.1 3706.5 3713.0 3744.5 4909.9 5061.6 5092.1 5099.7 5197.0 4667.3 4669.3 4690.3 4702.8 4711.9 5391.6 5407.1 5410.3 5445.4 5475.2 3825.5 3931.1 3953.4 3963.1 3963.2 5643.3 5665.0 5667.8 5680.5 5689.9 4002.6 4008.8 4008.9 4013.8 4014.9 3831.3 4053.9 4058.5 4058.9 4077.9 4579.6 4652.7 4658.5 4671.9 4674.6 5442.3 5483.9 5509.9 5515.6 5527.4 1300.7 1322.7 1360.7 1366.7 1379.9 922.2 940.6 954.8 959.5 969.5 5063.6 5063.7 5070.7 5086.6 5091.5 5394.5 5410.0 5415.5 5417.1 5427.3 4841.8 5100.9 5101.7 5142.7 5150.6 2808.7 2841.6 2850.5 2864.4 2867.2 5552.2 5577.6 5578.3 5620.0 5634.5 5285.3 5465.4 5473.3 5504.5 5525.9 5538.4 5544.6 5598.2 5626.5 5652.3 5234.5 5410.9 5418.3 5435.8 5450.1 5325.8 5342.7 5350.5 5369.3 5388.0 5552.8 5562.6 5565.3 5581.2 5635.4 3862.9 3894.8 3897.9 3912.8 3953.0 5317.9 5585.8 5597.6 5607.3 5614.4 5319.7 5360.6 5511.8 5522.7 5525.7 5480.3 5488.2 5498.1 5498.3 5500.2 5313.5 5464.1 5487.2 5489.9 5502.8 5507.6 5518.2 5518.4 5527.3 5528.2 5396.0 5436.7 5443.3 5494.6 5502.9 15:47:59 INFO - PROCESS | 11065 | 15:47:59 INFO - PROCESS | 11065 | [#5] yui.html Cycles:180 Average:16861.23 Median:44957.05 stddev:21335.26 (47.5%) stddev-sans-first:21360.73 15:47:59 INFO - PROCESS | 11065 | Values: 732.4 743.4 768.4 787.1 793.8 14585.3 15437.9 15440.6 15464.5 15471.9 14070.9 14250.4 14253.7 14255.3 14270.8 661.9 675.2 764.7 773.6 790.5 781.5 796.8 797.3 798.4 799.4 835.8 837.4 837.9 838.0 838.4 696.8 711.1 797.0 823.5 830.5 595.4 605.8 606.1 606.2 606.3 13922.9 13939.1 13950.2 13950.7 13957.8 12768.7 12812.6 13142.6 13256.9 13286.7 11624.9 11657.1 12066.4 12269.7 12359.5 4167.5 4183.1 4242.3 4311.2 4325.8 61021.0 61199.7 62451.0 62874.0 62945.1 10051.1 10468.9 10572.3 10638.5 10970.8 19463.8 19486.8 19519.8 19607.9 19638.3 7767.7 7846.9 7870.8 7938.9 8103.9 4253.4 4350.2 4370.6 4469.9 4479.7 3796.1 3989.1 3995.5 4012.1 4024.5 684.5 686.4 699.8 700.8 711.0 597.8 598.3 599.9 674.3 713.1 8770.0 9001.0 9421.0 9430.3 9468.9 670.1 677.3 677.6 677.8 695.4 4308.7 4537.9 4547.5 4562.9 4690.6 68384.7 69715.7 71462.6 80381.6 86828.1 44716.6 66220.0 69107.7 70596.0 71872.3 63944.0 64712.7 65511.7 66118.0 66435.0 8642.8 9072.4 9251.8 9294.1 9390.7 43130.6 43668.8 44319.3 44833.6 45080.5 57299.4 60300.4 60791.0 60961.7 61569.0 11301.3 11983.8 12149.4 12280.0 12977.4 13352.6 13757.4 13839.2 14056.3 14392.8 12106.0 12221.3 12382.0 12982.6 13295.1 12978.9 13062.5 13193.7 13716.7 13808.8 12456.9 12859.4 12944.4 12974.5 13498.9 10075.0 10492.4 10868.2 11141.2 11221.6 10622.3 11090.6 11231.0 11422.8 11463.4 15:47:59 INFO - PROCESS | 11065 | -------- Summary: end -------- 15:47:59 INFO - PROCESS | 11065 | 15:48:00 INFO - TEST-INFO | 11065: exit 0 15:48:00 INFO - TEST-OK | dromaeo_css | took 1118312ms 15:48:00 INFO - TEST-START | kraken 15:48:00 INFO - operating with platform_type : linux_ 15:48:00 INFO - Initialising browser for kraken test... 15:48:00 INFO - TEST-INFO | started process 11370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz8RS4k/profile http://localhost:57201/getInfo.html) 15:48:04 INFO - PROCESS | 11370 | __metrics Screen width/height:1600/1200 15:48:04 INFO - PROCESS | 11370 | colorDepth:24 15:48:04 INFO - PROCESS | 11370 | Browser inner width/height: 1024/697 15:48:04 INFO - PROCESS | 11370 | __metrics 15:48:05 INFO - PROCESS | 11370 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:48:05 INFO - PROCESS | 11370 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:48:05 INFO - PROCESS | 11370 | console.error: PushService: 15:48:05 INFO - PROCESS | 11370 | stateChangeProcessEnqueue: Error transitioning state 15:48:05 INFO - PROCESS | 11370 | UnknownError 15:48:06 INFO - TEST-INFO | 11370: exit 0 15:48:06 INFO - Browser initialized. 15:48:06 INFO - Running cycle 1/1 for kraken test... 15:48:06 INFO - TEST-INFO | started process 11452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz8RS4k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:48:18 INFO - PROCESS | 11452 | RSS: Main: 173449216 15:48:18 INFO - PROCESS | 11452 | 15:48:21 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57201/tests/kraken/driver.html?testName=audio-beat-detection) 15:48:22 INFO - PROCESS | 11452 | RSS: Main: 231546880 15:48:22 INFO - PROCESS | 11452 | 15:48:24 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57201/tests/kraken/driver.html?testName=audio-dft) 15:48:25 INFO - PROCESS | 11452 | RSS: Main: 217812992 15:48:25 INFO - PROCESS | 11452 | 15:48:28 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57201/tests/kraken/driver.html?testName=audio-fft) 15:48:29 INFO - PROCESS | 11452 | RSS: Main: 299192320 15:48:29 INFO - PROCESS | 11452 | 15:48:31 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57201/tests/kraken/driver.html?testName=audio-oscillator) 15:48:31 INFO - PROCESS | 11452 | RSS: Main: 209698816 15:48:31 INFO - PROCESS | 11452 | 15:48:33 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57201/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:48:34 INFO - PROCESS | 11452 | RSS: Main: 214425600 15:48:34 INFO - PROCESS | 11452 | 15:48:37 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57201/tests/kraken/driver.html?testName=imaging-darkroom) 15:48:38 INFO - PROCESS | 11452 | RSS: Main: 253558784 15:48:38 INFO - PROCESS | 11452 | 15:48:41 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57201/tests/kraken/driver.html?testName=imaging-desaturate) 15:48:42 INFO - PROCESS | 11452 | RSS: Main: 252964864 15:48:42 INFO - PROCESS | 11452 | 15:48:44 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57201/tests/kraken/driver.html?testName=json-parse-financial) 15:48:45 INFO - PROCESS | 11452 | RSS: Main: 252157952 15:48:45 INFO - PROCESS | 11452 | 15:48:46 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57201/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:48:47 INFO - PROCESS | 11452 | RSS: Main: 213516288 15:48:47 INFO - PROCESS | 11452 | 15:48:49 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57201/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:48:49 INFO - PROCESS | 11452 | RSS: Main: 221884416 15:48:49 INFO - PROCESS | 11452 | 15:48:52 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57201/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:48:52 INFO - PROCESS | 11452 | RSS: Main: 230125568 15:48:52 INFO - PROCESS | 11452 | 15:48:55 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:56 INFO - PROCESS | 11452 | RSS: Main: 239579136 15:48:56 INFO - PROCESS | 11452 | 15:48:58 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:59 INFO - PROCESS | 11452 | RSS: Main: 236470272 15:48:59 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | Cycle 1(1): loaded http://localhost:57201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57201/tests/kraken/driver.html?testName=ai-astar) 15:49:01 INFO - PROCESS | 11452 | RSS: Main: 286101504 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | __start_tp_report 15:49:01 INFO - PROCESS | 11452 | _x_x_mozilla_page_load 15:49:01 INFO - PROCESS | 11452 | _x_x_mozilla_page_load_details 15:49:01 INFO - PROCESS | 11452 | |i|pagename|runs| 15:49:01 INFO - PROCESS | 11452 | |0;ai-astar;112;111;111;112;115;110;113;111;110;109 15:49:01 INFO - PROCESS | 11452 | |1;audio-beat-detection;153;121;124;170;124;124;126;128;148;128 15:49:01 INFO - PROCESS | 11452 | |2;audio-dft;161;163;162;160;162;162;161;161;160;161 15:49:01 INFO - PROCESS | 11452 | |3;audio-fft;75;76;75;108;75;77;77;77;97;75 15:49:01 INFO - PROCESS | 11452 | |4;audio-oscillator;82;82;106;83;83;83;95;82;83;106 15:49:01 INFO - PROCESS | 11452 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;116;117 15:49:01 INFO - PROCESS | 11452 | |6;imaging-darkroom;146;146;146;145;146;146;146;146;145;145 15:49:01 INFO - PROCESS | 11452 | |7;imaging-desaturate;96;95;95;95;96;95;96;95;95;94 15:49:01 INFO - PROCESS | 11452 | |8;json-parse-financial;51;51;52;51;53;53;54;52;53;54 15:49:01 INFO - PROCESS | 11452 | |9;json-stringify-tinderbox;63;63;63;63;63;63;63;63;63;63 15:49:01 INFO - PROCESS | 11452 | |10;stanford-crypto-aes;86;88;82;82;81;85;80;80;82;80 15:49:01 INFO - PROCESS | 11452 | |11;stanford-crypto-ccm;146;133;148;129;141;130;131;130;172;136 15:49:01 INFO - PROCESS | 11452 | |12;stanford-crypto-pbkdf2;171;164;164;169;167;167;165;164;164;164 15:49:01 INFO - PROCESS | 11452 | |13;stanford-crypto-sha256-iterative;67;65;64;68;66;65;68;63;62;63 15:49:01 INFO - PROCESS | 11452 | __end_tp_report 15:49:01 INFO - PROCESS | 11452 | __start_cc_report 15:49:01 INFO - PROCESS | 11452 | _x_x_mozilla_cycle_collect,1695 15:49:01 INFO - PROCESS | 11452 | __end_cc_report 15:49:01 INFO - PROCESS | 11452 | __startTimestamp1480031341325__endTimestamp 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | ------- Summary: start ------- 15:49:01 INFO - PROCESS | 11452 | Number of tests: 14 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:1.71 (1.5%) stddev-sans-first:1.80 15:49:01 INFO - PROCESS | 11452 | Values: 112.0 111.0 111.0 112.0 115.0 110.0 113.0 111.0 110.0 109.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:128.00 stddev:16.51 (12.9%) stddev-sans-first:16.12 15:49:01 INFO - PROCESS | 11452 | Values: 153.0 121.0 124.0 170.0 124.0 124.0 126.0 128.0 148.0 128.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 15:49:01 INFO - PROCESS | 11452 | Values: 161.0 163.0 162.0 160.0 162.0 162.0 161.0 161.0 160.0 161.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.50 stddev:11.55 (15.1%) stddev-sans-first:12.04 15:49:01 INFO - PROCESS | 11452 | Values: 75.0 76.0 75.0 108.0 75.0 77.0 77.0 77.0 97.0 75.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:83.00 stddev:10.01 (12.1%) stddev-sans-first:10.34 15:49:01 INFO - PROCESS | 11452 | Values: 82.0 82.0 106.0 83.0 83.0 83.0 95.0 82.0 83.0 106.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:49:01 INFO - PROCESS | 11452 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 15:49:01 INFO - PROCESS | 11452 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:49:01 INFO - PROCESS | 11452 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 94.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:1.17 (2.2%) stddev-sans-first:1.13 15:49:01 INFO - PROCESS | 11452 | Values: 51.0 51.0 52.0 51.0 53.0 53.0 54.0 52.0 53.0 54.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:49:01 INFO - PROCESS | 11452 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:2.80 (3.4%) stddev-sans-first:2.68 15:49:01 INFO - PROCESS | 11452 | Values: 86.0 88.0 82.0 82.0 81.0 85.0 80.0 80.0 82.0 80.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:138.50 stddev:13.29 (9.6%) stddev-sans-first:13.90 15:49:01 INFO - PROCESS | 11452 | Values: 146.0 133.0 148.0 129.0 141.0 130.0 131.0 130.0 172.0 136.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.00 stddev:2.51 (1.5%) stddev-sans-first:1.87 15:49:01 INFO - PROCESS | 11452 | Values: 171.0 164.0 164.0 169.0 167.0 167.0 165.0 164.0 164.0 164.0 15:49:01 INFO - PROCESS | 11452 | 15:49:01 INFO - PROCESS | 11452 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:2.13 (3.3%) stddev-sans-first:2.15 15:49:01 INFO - PROCESS | 11452 | Values: 67.0 65.0 64.0 68.0 66.0 65.0 68.0 63.0 62.0 63.0 15:49:01 INFO - PROCESS | 11452 | -------- Summary: end -------- 15:49:01 INFO - PROCESS | 11452 | 15:49:02 INFO - TEST-INFO | 11452: exit 0 15:49:02 INFO - TEST-OK | kraken | took 62137ms 15:49:02 INFO - SUITE-END | took 1180s 15:49:02 INFO - Completed test suite (00:19:40) 15:49:02 INFO - javascript benchmark 15:49:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3019.0489995651374, 3052.2064263291536, 3077.538369244613, 3079.045495896271, 3087.4751292280325, 5289.68261904286, 5359.624826262163, 5368.865778355543, 5396.325459317585, 5433.619646624733, 5354.303940487741, 5373.704446255454, 5374.838754837361, 5392.0, 5431.049566325897, 4944.283078953549, 4959.305697202394, 5002.524760147799, 5002.524760147799, 5041.621878359119, 4937.407511098673, 5039.77321020555, 5056.646034777567, 5057.721825299607, 5061.013102445025, 4933.80264789408, 4966.379202599675, 5010.3737032870895, 5036.1438555445475, 5081.364829396325, 4818.445878723956, 4878.658493905428, 4982.003599280159, 4999.525045120708, 5014.197728363462, 4883.975580122076, 4903.338049363361, 4909.7790599423115, 4914.336564563774, 4986.10250154972, 5328.520433161034, 5372.167314066326, 5375.892482150374, 5377.5966802489575, 5384.973075134639, 5782.45066718661, 5790.7683692652245, 5791.971040144815, 5798.449147330997, 5839.036558967765, 5636.577256705764, 5695.088785794294, 5698.544116470714, 5759.68321742304, 5769.394213607553, 5405.729713514309, 5412.269343638558, 5413.296271484721, 5414.187871819258, 5443.319585051869, 5877.5591830612875, 5879.853003674857, 5881.235439392937, 5887.470127688529, 5890.617109887844, 5488.1767734839295, 5500.119980803132, 5619.943800562024, 5638.943610563924, 5659.26429564154, 5744.655320680689, 5773.191753154561, 5797.188393624896, 5817.970910145422, 5839.0949402842625, 5767.0, 5767.942320576824, 5773.336066352424, 5779.566532509994, 5827.388124246978, 5556.944430555724, 5566.276384070045, 5566.332040155207, 5754.683492407874, 5780.913286300709, 4385.342198670225, 4415.205263052617, 4423.07115505741, 4436.534163912807, 4473.194824931544, 3902.3951287550476, 3906.74606150605, 3910.65082546521, 3944.092858642471, 3950.7234493585174, 5325.2810870531985, 5459.754311056012, 5470.589705772083, 5476.041692703761, 5480.095784195563, 5675.57433192504, 5725.742341594639, 5765.1928729977835, 5767.538596912321, 5858.882822343529, 5424.240606315119, 5474.534664553478, 5476.67139971603, 5477.370102438191, 5478.945210547923, 5017.623678224148, 5020.49795020495, 5024.648274620815, 5028.622853286018, 5077.111505486525, 5733.827985160452, 5737.483626473638, 5955.047192449188, 6003.129546215861, 6007.8197654070445, 5833.095870140135, 5834.474897259267, 5841.18223448726, 5841.591088623755, 5874.559408044328, 6016.428439298435, 6026.638401695912, 6034.9094763577705, 6042.939570604238, 6047.03247480401, 5450.645708028966, 5482.5613950884635, 5569.136783798518, 5616.410276921028, 5734.111212762028, 5700.629459085146, 5743.540516758566, 5752.453516915886, 5773.74018169175, 5800.622959507618, 5559.749811258584, 5596.244506991504, 5614.101743720985, 5615.0, 5622.0, 5460.7542660579575, 5490.5882058844945, 5546.889062218814, 5603.439656034527, 5618.831435056954, 5496.395396506461, 5547.861303467445, 5571.9442805571425, 5606.803761868315, 5618.775248990158, 5582.0, 5593.776248949996, 5600.327960644586, 5601.663900166003, 5611.747471363717, 5401.513863752281, 5421.945780542144, 5447.1829225616475, 5518.44815518461, 5519.116941289535], "value": 5311.004235857669, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.3279893613093, 576.2451188942485, 592.9851753706158, 603.1856993059367, 605.7153138025127, 32815.50776738351, 43005.56994430055, 43902.7804860976, 44009.61860530221, 44021.33967990483, 43741.56258437414, 43799.78100109495, 43983.78008109955, 44050.0, 44064.77967610166, 7895.8026049348655, 8155.632996515142, 8533.615987280587, 8659.870101948476, 8679.869801952944, 10159.339642923223, 10377.844332334984, 10401.947990260038, 10537.631182908599, 10658.840117398246, 10438.425886576235, 10449.425281609509, 10497.842532361983, 10522.316049456798, 10526.315789473698, 10396.428196449193, 10444.321119127271, 10454.268201225917, 10457.79084418315, 10487.213458990605, 10270.794584108351, 10311.07200351972, 10319.277650564463, 10324.741881452948, 10333.328333658288, 40614.79692601548, 40696.79651601753, 40906.79546602278, 41134.79432602848, 41217.38173927394, 3272.8527216275324, 3311.2549676322874, 3418.1112910643164, 3440.6559344065395, 3545.5213546171194, 29423.11730648084, 30253.394932101233, 31664.525032124307, 31802.681973180202, 31814.522782158285, 4059.289624315733, 4159.085001299709, 4225.957740422587, 4228.9154216915795, 4263.360495925605, 321775.0, 336205.0, 338980.0, 339038.3048084768, 339294.0, 60321.69839150776, 61097.69451152716, 61150.38849611447, 61212.69393653092, 61214.38785612176, 64266.6786666073, 64498.325251211754, 64607.0, 64700.64789633636, 64774.0, 13984.790228146587, 14032.508862189774, 14045.0, 14068.859311406959, 14071.226082565558, 10673.46632668379, 10714.517846696917, 10873.945630271797, 10896.182786290901, 11370.431478426046, 19120.0, 19235.326763563207, 19243.422697319103, 19387.51531211731, 19515.90242048809, 7554.169041405441, 7598.164201937782, 7617.961910190414, 7717.421193410517, 7776.416768742367, 925.6112432778249, 975.4878688688495, 1002.7793885345212, 1018.2057994764095, 1046.7749433871602, 30524.389512209633, 30626.84686576553, 31006.84496577548, 31018.914337998063, 31340.0, 1039.5477967084344, 1060.5757696921294, 1074.5486895503907, 1075.8224892892586, 1091.9781604367868, 15988.76016859748, 16290.0, 16323.591910202102, 16337.428190013292, 16717.247723852455, 514366.0, 518460.0, 519891.0, 520253.0, 521375.0, 56771.71614141903, 57281.69415434739, 57321.426785732445, 57321.426785732445, 57351.426485734606, 1212.4180393411211, 1248.925064496115, 1249.8937590304927, 1337.6722702937843, 1338.5716570697284, 29525.745324791835, 33555.0, 33707.49438758371, 33790.0, 34117.658823411446, 54347.18479222894, 55274.72362638161, 55291.44708552863, 55295.0, 55338.44661553333, 401285.0, 403326.0, 404126.0, 405186.0, 405546.0, 27855.582166267926, 27910.860445697643, 28914.42171156523, 41920.0, 42256.73229803111, 44654.0, 44671.77664111659, 45002.77498612486, 45042.0, 45502.0, 38853.805730971166, 38883.222335552564, 39258.411123833735, 39620.405693914036, 40474.39288410735, 37716.816459556314, 38651.6134838648, 38719.22561548697, 38976.6102338973, 39822.60177398189, 37977.81011094927, 38421.61578384292, 38423.615763843125, 39254.80372598119, 39634.0, 31490.0, 34272.31455370829, 34585.48121778125, 35128.29743405169, 35294.47058294179, 26634.623023754113, 26732.866335668976, 26925.30746925292, 27017.189484315502, 27113.322166945985], "value": 20012.715237629964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.2736772764021, 384.8941541076202, 404.7348986413899, 405.7200531633172, 415.5989470161294, 13366.398512066957, 15523.534293971185, 18706.719399209007, 18719.625607487844, 19227.423177304667, 17819.37632182874, 18229.270829166817, 18409.723854142165, 18967.62064758704, 19046.0, 5379.735762095905, 5527.668339899609, 5743.62666426681, 5768.250127483421, 5770.740316685759, 5390.21841832934, 5667.886642267152, 5697.487226149646, 5698.658080515162, 5702.344230413514, 5430.104032834578, 5644.57665675074, 5651.7739290428335, 5652.74562644682, 5657.179708942201, 5635.887282254353, 5637.548996080324, 5674.290713660793, 5675.063614503602, 5679.2333035040365, 4883.829065982709, 5014.2979982802435, 5032.798688052473, 5075.746212689388, 5077.441481437039, 22580.096796128135, 22699.432514187276, 22809.885950570308, 22898.656520152046, 23104.42238944023, 2301.1255722825385, 2551.885165167572, 2600.4929038837436, 3041.422129795332, 3081.4145312390574, 13756.793648095287, 14308.570742877626, 14474.276286185754, 14534.854651453456, 14813.0, 1845.7877344105466, 1911.1399870058528, 1937.0314842578712, 1944.319488179126, 1945.9805401946082, 76720.23279767187, 76776.0, 76929.0, 77395.0, 78306.99999999943, 10398.324108932895, 10648.414337211529, 10997.945010275058, 11286.2348724563, 11497.195196336175, 14968.775468367983, 15029.924850375897, 15044.924775376054, 15069.47256846005, 15105.47130850415, 7570.432217583703, 7823.295903368724, 7930.246626570467, 8078.798030049295, 8090.231428014329, 7228.891566626505, 7319.74380896666, 7332.30343117403, 7552.735654252075, 7589.506682065648, 6411.711472983727, 6582.210134783857, 6595.142631457879, 6634.938409854401, 6700.329967003358, 1882.6517094337592, 1887.7074053521726, 1891.7919028906808, 1897.133851670461, 1956.9706454403195, 819.995900020496, 869.2915274051628, 914.3234006834895, 1007.1841808135433, 1034.7568321444455, 18350.908245458686, 19641.41075767729, 19684.803151968295, 19815.900920495595, 20048.69926951097, 958.6453012385323, 974.2644303550774, 982.6757170133982, 993.0813997052697, 1000.4847503535685, 10536.0, 10989.450527473595, 11019.724506887393, 11070.889291107147, 11172.608958686407, 434799.0, 440052.0, 444732.0, 448546.0, 452037.0, 82210.0, 82313.0, 82807.58596207101, 83149.58425207835, 84957.57521212478, 962.6438217859297, 964.744342749172, 979.9559019844124, 987.6049580167991, 992.0228574853763, 16811.159442027605, 16974.660506790042, 17368.39210627622, 17454.247336822646, 17841.286348545913, 38398.424023640226, 39196.0, 40255.0, 40388.79805600953, 41277.587224127376, 51587.48412515977, 51860.48139518557, 52346.0, 52716.0, 53378.73310633422, 7480.251974802693, 7543.434242431949, 7694.461387702807, 7765.650545725343, 7893.84212315739, 10410.68767936963, 12288.938555307166, 12351.876481235073, 12358.382080895739, 12361.258324500559, 10786.930875484817, 11297.26567773125, 11360.488778005174, 11533.135014874086, 11742.412879355827, 5266.34170728659, 7838.686452542062, 10855.666031802884, 11072.889271107186, 11242.7751444969, 11076.280041797258, 11194.608188713355, 11207.887921120684, 11474.77050459003, 11674.94162529182, 7205.891911621435, 7451.40388768908, 7600.0, 7661.348785353307, 8104.0, 8284.337253019865, 10358.741031474274, 11158.163137764863, 11178.27341222818, 11543.8268425972], "value": 9001.07846068761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.218329918545, 1459.0953608762566, 1560.8985415947961, 1697.6095498035459, 1721.4749501402068, 7659.463837531368, 8168.754937351889, 8170.754877353682, 8175.550344731045, 8175.877361839577, 6990.510664253505, 7161.89257161143, 7653.119891212512, 7844.058712954454, 8051.516908985465, 2294.7819957104048, 2334.3463830127594, 2335.5212181502834, 2336.88315584221, 2338.228384633067, 2293.529826385587, 2297.896594653236, 2368.7157541095094, 2370.8814559272055, 2371.063429945171, 2264.071730590458, 2277.533105713325, 2277.9202727904526, 2290.702208712865, 2331.428799944016, 2212.1814928476488, 2217.966730499044, 2218.7670294619074, 2225.9220927267547, 2232.096001119533, 2224.7552769195377, 2234.7430045544806, 2248.2468373095035, 2252.335561009506, 2253.7746225377496, 7871.4883532570775, 7917.7624671259955, 7924.207579242087, 7924.4849084809875, 7926.207379262085, 4851.951480485185, 4990.226514890198, 4999.925001124986, 5000.7249601271915, 5005.474425185376, 3082.859342043436, 3157.3843100595395, 3470.2538954124734, 3486.755927085105, 3491.0748651607346, 1040.5733649203867, 1048.2086025051115, 1083.0, 1096.1942971915635, 1114.0920150077661, 10928.071113955324, 10980.890191098066, 11022.283551569122, 11025.889741102646, 11034.227604067719, 4384.210842048398, 4517.81928722854, 4626.676132670681, 4731.787069581808, 4731.95268047322, 9259.259259259243, 9266.814663706687, 9268.629254829866, 9270.675526356545, 9280.0719928008, 5044.495550444926, 5063.088644044107, 5066.771995260222, 5104.540591346722, 5110.97444512775, 4179.644730197906, 4259.61663450291, 4280.422143010716, 4641.651876109306, 4691.038337140878, 3700.093477098128, 3754.5494540655295, 3799.8670046548236, 3811.256804923069, 3854.5567259764925, 1231.1074471008626, 1244.104244943639, 1247.9625611231495, 1262.0976002158318, 1281.0968267371481, 888.693400776731, 948.184561277301, 964.9855252171224, 968.8595153702673, 1001.8678892851032, 5548.0845660465575, 5575.163725441216, 5595.916061259084, 5846.707664616837, 5864.912026319608, 452.0890405832251, 461.4278294914282, 466.90195059037984, 469.335889716048, 471.0907947661047, 3564.483149943244, 3644.599094099647, 3651.251493443891, 3692.5015122958594, 3827.0432391902023, 9518.571664275125, 9773.560189791477, 9862.260330475243, 9876.061774131445, 9892.455914924605, 9758.56086476096, 9869.358491698016, 9887.653932112486, 9888.653897113567, 9898.80202395948, 7491.325780679765, 7496.287852653989, 7590.316871481593, 7603.999999999889, 7606.087269527692, 5464.207689885024, 5511.255980442749, 5585.273914391103, 5733.082706766897, 5794.565407594531, 8904.643814247358, 8942.86585701202, 8967.820643587222, 8969.820603588023, 9013.594388252675, 9022.962359328498, 9065.50139742294, 9153.313501487282, 9278.11857873501, 9434.150926416656, 6469.385408386196, 6652.501062420434, 6889.483288753263, 7170.749023784142, 7261.818454538678, 7570.129435114812, 7871.921280787348, 7872.606369681378, 7877.330426913776, 7880.2513761192595, 6961.756338528127, 7048.471364647569, 7073.752418665322, 7101.254368291255, 7176.461765367722, 6827.863442731217, 6930.618815964968, 6934.965325173342, 6997.580145191305, 7050.894236586558, 6262.624242545462, 6393.680315984089, 6446.226452825691, 6446.806595802133, 6502.869942601216, 5026.271190677405, 5090.796368145381, 5115.87210319745, 5182.404023537341, 5213.582913366998, 4835.492273311393, 4905.0, 5019.347484827095, 5032.899342013213, 5146.279520867157], "value": 4286.1637464614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.6321992928061, 327.66578090347843, 331.08290036598623, 333.55470446953325, 340.7955226863884, 5044.84865454036, 5203.713795741232, 5287.973560132199, 5330.36035675719, 5340.1722732976405, 5041.0, 5131.230315452684, 5149.716765577892, 5156.69059856408, 5219.765110570024, 4137.648299894513, 4148.875533733993, 4164.375343698454, 4178.22702799983, 4195.37069439585, 4060.5736397678115, 4163.7293575917465, 4169.166166766644, 4170.603792639709, 4179.519355274152, 4113.218488487193, 4145.0, 4154.397612346208, 4164.146349998243, 4165.979170104145, 4114.280000999813, 4136.4415803866395, 4146.668266538685, 4156.0, 4177.728447650893, 3684.0, 3696.131409118882, 3706.5181526401666, 3712.962870371289, 3744.4944932434046, 4909.926351104737, 5061.569766569846, 5092.148396897749, 5099.69401835891, 5196.974015129938, 4667.346571479996, 4669.276262179367, 4690.296455531663, 4702.825592724897, 4711.890152499334, 5391.56867450603, 5407.134858422633, 5410.323709536308, 5445.366390082999, 5475.233467314579, 3825.5218097737784, 3931.113065728466, 3953.367461206222, 3963.0884896473685, 3963.246983073207, 5643.294588176478, 5665.017243964579, 5667.773289068432, 5680.517156041741, 5689.886202275931, 4002.5597184309704, 4008.7995600219874, 4008.939865902014, 4013.819378127991, 4014.8594799181888, 3831.2606486362383, 4053.8783836484954, 4058.492688413948, 4058.918821623551, 4077.8776636700354, 4579.564941330568, 4652.744099074515, 4658.510856360102, 4671.85984420468, 4674.57928786404, 5442.346918369821, 5483.917741233885, 5509.889802203934, 5515.61390702655, 5527.419620939824, 1300.746354460871, 1322.6891680455085, 1360.7278544290984, 1366.6993261482457, 1379.8965077619218, 922.23454532739, 940.6096469964888, 954.7899462118323, 959.5058544849409, 969.4764826993345, 5063.594912406998, 5063.746812659352, 5070.670406423645, 5086.567641750418, 5091.468592952276, 5394.460553944574, 5410.0, 5415.456594870443, 5417.10617748075, 5427.267318911975, 4841.814323083743, 5100.923486147711, 5101.744912754348, 5142.714321419645, 5150.562202212779, 2808.747212750862, 2841.602175695404, 2850.489240702431, 2864.384157406126, 2867.2258490207946, 5552.194931734876, 5577.581681373913, 5578.30271216098, 5620.0, 5634.492895639412, 5285.339332583427, 5465.371482279509, 5473.343198816167, 5504.4770746778995, 5525.861853453615, 5538.44615538451, 5544.584156188302, 5598.216249725042, 5626.521745651502, 5652.3217213934595, 5234.528892399702, 5410.864728381822, 5418.322709661293, 5435.755391007493, 5450.1007333789485, 5325.786968521371, 5342.7061511615675, 5350.5184533392185, 5369.301990741179, 5388.030154572215, 5552.7778888843995, 5562.5549956002615, 5565.30433695788, 5581.246531718329, 5635.380108188014, 3862.8841134766003, 3894.766314021168, 3897.941530877096, 3912.7847968360875, 3952.960470395259, 5317.920231196613, 5585.804496842591, 5597.580181486323, 5607.271054762855, 5614.382417934105, 5319.734013299242, 5360.597955153301, 5511.834644960658, 5522.668639881459, 5525.723713814374, 5480.287562616834, 5488.231647569263, 5498.140966697215, 5498.257735205856, 5500.1749737539685, 5313.495217954288, 5464.087569350695, 5487.244081893915, 5489.917651235314, 5502.808371144806, 5507.586930980113, 5518.199861020049, 5518.399664097366, 5527.309086364205, 5528.170774383874, 5395.973020134874, 5436.7281635918835, 5443.346798384219, 5494.560435165257, 5502.889942201214], "value": 4146.430991834003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.3921145449277, 743.4052757793767, 768.416003837084, 787.0909099989507, 793.7737744742748, 14585.270736463173, 15437.922810385946, 15440.61398465039, 15464.458743943964, 15471.922640386781, 14070.94467914908, 14250.358733856976, 14253.714925701479, 14255.287235638229, 14270.785938210909, 661.9338066193391, 675.2302375292146, 764.6673696941821, 773.5590713293425, 790.5019837502394, 781.4959351218461, 796.7569891183186, 797.314309693663, 798.3812545277399, 799.3924617290871, 835.8328334333128, 837.3677873205752, 837.9371547133959, 837.9706710265142, 838.4047326398264, 696.8118607975869, 711.1146622455077, 796.9880451793227, 823.505896462121, 830.4560512864084, 595.4283887468035, 605.8303674971015, 606.1332294818408, 606.2300877885106, 606.336062012096, 13922.860771392257, 13939.09395889264, 13950.23273719945, 13950.651233719238, 13957.79063314051, 12768.680782980407, 12812.615621531275, 13142.60572182836, 13256.93371533136, 13286.734265314737, 11624.941875290653, 11657.125715571367, 12066.385999095397, 12269.699723390066, 12359.505619775198, 4167.458230430055, 4183.100633363842, 4242.2576049191575, 4311.245532031882, 4325.805338759764, 61021.0, 61199.69400152971, 62451.0, 62874.0, 62945.05582416267, 10051.095401413908, 10468.947655261674, 10572.259941803999, 10638.468076596138, 10970.835437468444, 19463.8053619462, 19486.805131948782, 19519.8048019518, 19607.901960490108, 19638.312659056865, 7767.689292428239, 7846.921530784619, 7870.842583148305, 7938.880916786253, 8103.878441823377, 4253.3619957006695, 4350.151720414552, 4370.584794444522, 4469.910601788011, 4479.70881892676, 3796.0889386547583, 3989.082511022481, 3995.4805875236034, 4012.1373904610064, 4024.4566983457444, 684.4866350237322, 686.4165459359505, 699.8215455058927, 700.8002719224996, 710.989335159973, 597.832606870077, 598.2521847690386, 599.9040153575407, 674.2549482821412, 713.0801266366433, 8769.956150219336, 9000.956594523517, 9421.0, 9430.292728045286, 9468.90531094694, 670.1455644053871, 677.2550194785795, 677.5629718831425, 677.8271540757075, 695.4436450839308, 4308.719933204332, 4537.886552836206, 4547.522510136388, 4562.8631141065825, 4690.624750019991, 68384.6580767093, 69715.65142174358, 71462.64268678728, 80381.59809200917, 86828.13171868201, 44716.55283447124, 66220.0, 69107.65446172738, 70596.0, 71872.2812771876, 63944.0, 64712.67643661846, 65511.672441637485, 66118.0, 66435.00347494791, 8642.78393040179, 9072.410293330913, 9251.76870578214, 9294.117058879396, 9390.718278451384, 43130.56869431266, 43668.781656091516, 44319.34646862033, 44833.55166448294, 45080.549194507636, 57299.42700572941, 60300.39699603123, 60791.0, 60961.69519152376, 61569.0, 11301.26541774782, 11983.820242696193, 12149.392530373269, 12280.0, 12977.35113244353, 13352.599422017354, 13757.38091785892, 13839.238841863391, 14056.297185140498, 14392.784108238175, 12106.0, 12221.266723996589, 12382.0, 12982.610521684364, 13295.135816171918, 12978.935105324414, 13062.54281100157, 13193.670158246121, 13716.65708357299, 13808.792868106786, 12456.875431245933, 12859.421326040538, 12944.41750121228, 12974.545890893773, 13498.93250533741, 10075.0, 10492.422916739653, 10868.184886133413, 11141.2201145919, 11221.607243746756, 10622.28813093886, 11090.5563777448, 11231.0, 11422.771544569228, 11463.426828658367], "value": 7000.7879793391285, "unit": "score"}], "name": "dromaeo_css", "value": 7013.787505844527, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 112.0, 115.0, 110.0, 113.0, 111.0, 110.0, 109.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 124.0, 170.0, 124.0, 124.0, 126.0, 128.0, 148.0, 128.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 160.0, 162.0, 162.0, 161.0, 161.0, 160.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 108.0, 75.0, 77.0, 77.0, 77.0, 97.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 83.0, 83.0, 83.0, 95.0, 82.0, 83.0, 106.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 51.0, 53.0, 53.0, 54.0, 52.0, 53.0, 54.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 82.0, 82.0, 81.0, 85.0, 80.0, 80.0, 82.0, 80.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 133.0, 148.0, 129.0, 141.0, 130.0, 131.0, 130.0, 172.0, 136.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 164.0, 169.0, 167.0, 167.0, 165.0, 164.0, 164.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 64.0, 68.0, 66.0, 65.0, 68.0, 63.0, 62.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1503.1999999999998, "alertThreshold": 2.0}]} 15:49:03 INFO - Return code: 0 15:49:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:49:03 INFO - # TBPL SUCCESS # 15:49:03 INFO - Running post-action listener: _resource_record_post_action 15:49:03 INFO - [mozharness: 2016-11-24 23:49:03.121661Z] Finished run-tests step (success) 15:49:03 INFO - Running post-run listener: _resource_record_post_run 15:49:03 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 339968; Write bytes: 393191424; Read time: 68; Write time: 214972 15:49:03 INFO - TinderboxPrint: CPU usage
13.1% 15:49:03 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 68 15:49:03 INFO - TinderboxPrint: I/O write bytes / time
393,191,424 / 214,972 15:49:03 INFO - TinderboxPrint: CPU idle
8,303.9 (86.9%) 15:49:03 INFO - TinderboxPrint: CPU user
1,205.1 (12.6%) 15:49:03 INFO - TinderboxPrint: Swap in / out
0 / 0 15:49:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103911424; Read time: 0; Write time: 76464 15:49:03 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 339968; Write bytes: 289280000; Read time: 68; Write time: 138508 15:49:03 INFO - Running post-run listener: _upload_blobber_files 15:49:03 INFO - Blob upload gear active. 15:49:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:49:03 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 15:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:49:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:49:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:49:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:49:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:05 INFO - (blobuploader) - INFO - Done attempting. 15:49:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:49:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:49:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:06 INFO - (blobuploader) - INFO - Done attempting. 15:49:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:49:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:49:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:49:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:49:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:49:09 INFO - (blobuploader) - INFO - Done attempting. 15:49:09 INFO - (blobuploader) - INFO - Iteration through files over. 15:49:09 INFO - Return code: 0 15:49:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:49:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:49:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41fb14b10e1dd2a936aeaa4ccf8ae297669c69ab22f043e79e53d07a962b5c9808156ab894646585db97dd8629b36101c692cc2c6da4d348565ea2937a72a6a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/198f7e13177173101b7c2804db0191492df5f4a4e59fe74393f8a0c9df9b84b8038a1773b13ca44b5d4466d767d71fc6aa0e2bf549c5c98d79d124a3b609d4e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/627ee3953d0c7527ad4a012965e82d9598acec28aac9bc4743aadb25facac0363930edebaf7383a616f5f6d4ed8634ce079b5c9b32d7e7dc23ecfbe86c122afc"} 15:49:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:49:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:49:09 INFO - Contents: 15:49:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41fb14b10e1dd2a936aeaa4ccf8ae297669c69ab22f043e79e53d07a962b5c9808156ab894646585db97dd8629b36101c692cc2c6da4d348565ea2937a72a6a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/198f7e13177173101b7c2804db0191492df5f4a4e59fe74393f8a0c9df9b84b8038a1773b13ca44b5d4466d767d71fc6aa0e2bf549c5c98d79d124a3b609d4e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/627ee3953d0c7527ad4a012965e82d9598acec28aac9bc4743aadb25facac0363930edebaf7383a616f5f6d4ed8634ce079b5c9b32d7e7dc23ecfbe86c122afc"} 15:49:09 INFO - Running post-run listener: copy_logs_to_upload_dir 15:49:09 INFO - Copying logs to upload dir... 15:49:09 INFO - mkdir: /builds/slave/test/build/upload/logs 15:49:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.261815 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-24 15:49:09.566129) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 15:49:09.573690) ========= 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=337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41fb14b10e1dd2a936aeaa4ccf8ae297669c69ab22f043e79e53d07a962b5c9808156ab894646585db97dd8629b36101c692cc2c6da4d348565ea2937a72a6a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/198f7e13177173101b7c2804db0191492df5f4a4e59fe74393f8a0c9df9b84b8038a1773b13ca44b5d4466d767d71fc6aa0e2bf549c5c98d79d124a3b609d4e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/627ee3953d0c7527ad4a012965e82d9598acec28aac9bc4743aadb25facac0363930edebaf7383a616f5f6d4ed8634ce079b5c9b32d7e7dc23ecfbe86c122afc"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480019706/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/41fb14b10e1dd2a936aeaa4ccf8ae297669c69ab22f043e79e53d07a962b5c9808156ab894646585db97dd8629b36101c692cc2c6da4d348565ea2937a72a6a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/198f7e13177173101b7c2804db0191492df5f4a4e59fe74393f8a0c9df9b84b8038a1773b13ca44b5d4466d767d71fc6aa0e2bf549c5c98d79d124a3b609d4e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/627ee3953d0c7527ad4a012965e82d9598acec28aac9bc4743aadb25facac0363930edebaf7383a616f5f6d4ed8634ce079b5c9b32d7e7dc23ecfbe86c122afc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 15:49:09.606179) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-11-24 15:49:09.609512) ========= 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=337fe3f4b1febe37b85fccc40000019e-1480030109.453276-1998930330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 2.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-11-24 15:49:11.962687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 15:49:11.963114) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 15:49:11.964302) ========= ========= Total master_lag: 2.73 =========