builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1477928289.18 results: success (0) buildid: 20161031063747 builduid: c6deb249ffaf41c4be2f92c07b67df9d revision: 72764ba31b81562e3069f6935da33cae06fe6b00 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.176506) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.176971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.177288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.197493) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.197809) ========= 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=41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 08:38:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.4M=0s 2016-10-31 08:38:09 (40.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.192947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.404658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.404968) ========= 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=41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.454016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:09.454401) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 72764ba31b81562e3069f6935da33cae06fe6b00 --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 72764ba31b81562e3069f6935da33cae06fe6b00 --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=41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 08:38:10,004 truncating revision to first 12 chars 2016-10-31 08:38:10,004 Setting DEBUG logging. 2016-10-31 08:38:10,004 attempt 1/10 2016-10-31 08:38:10,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/72764ba31b81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 08:38:10,629 unpacking tar archive at: mozilla-inbound-72764ba31b81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.932284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:10.400472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:10.400835) ========= script_repo_revision: 72764ba31b81562e3069f6935da33cae06fe6b00 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:10.401236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:10.401517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 08:38:10.411270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-31 08:38:10.411647) ========= /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=41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:38:11 INFO - MultiFileLogger online at 20161031 08:38:11 in /builds/slave/test 08:38:11 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 08:38:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:11 INFO - {'append_to_log': False, 08:38:11 INFO - 'base_work_dir': '/builds/slave/test', 08:38:11 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:38:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:11 INFO - 'branch': 'Mozilla-Inbound', 08:38:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:11 INFO - 'config_files': ('talos/linux_config.py',), 08:38:11 INFO - 'default_actions': ('clobber', 08:38:11 INFO - 'read-buildbot-config', 08:38:11 INFO - 'download-and-extract', 08:38:11 INFO - 'populate-webroot', 08:38:11 INFO - 'create-virtualenv', 08:38:11 INFO - 'install', 08:38:11 INFO - 'run-tests'), 08:38:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:11 INFO - 'download_minidump_stackwalk': True, 08:38:11 INFO - 'download_symbols': 'ondemand', 08:38:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:11 INFO - 'installer_path': 'installer.exe', 08:38:11 INFO - 'log_level': 'info', 08:38:11 INFO - 'log_name': 'talos', 08:38:11 INFO - 'log_to_console': True, 08:38:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:38:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:38:11 INFO - 'opt_config_files': (), 08:38:11 INFO - 'pip_index': False, 08:38:11 INFO - 'sps_profile': False, 08:38:11 INFO - 'sps_profile_interval': 0, 08:38:11 INFO - 'suite': 'dromaeojs', 08:38:11 INFO - 'system_bits': '32', 08:38:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:11 INFO - 'title': 'talos-linux64-ix-026', 08:38:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:11 INFO - 'use_talos_json': True, 08:38:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:11 INFO - 'work_dir': 'build'} 08:38:11 INFO - [mozharness: 2016-10-31 15:38:11.064245Z] Running clobber step. 08:38:11 INFO - Running pre-action listener: _resource_record_pre_action 08:38:11 INFO - Running main action method: clobber 08:38:11 INFO - rmtree: /builds/slave/test/build 08:38:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:11 INFO - Running post-action listener: _resource_record_post_action 08:38:11 INFO - [mozharness: 2016-10-31 15:38:11.529600Z] Finished clobber step (success) 08:38:11 INFO - [mozharness: 2016-10-31 15:38:11.529701Z] Running read-buildbot-config step. 08:38:11 INFO - Running pre-action listener: _resource_record_pre_action 08:38:11 INFO - Running main action method: read_buildbot_config 08:38:11 INFO - Using buildbot properties: 08:38:11 INFO - { 08:38:11 INFO - "project": "", 08:38:11 INFO - "product": "firefox", 08:38:11 INFO - "script_repo_revision": "production", 08:38:11 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 08:38:11 INFO - "repository": "", 08:38:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 08:38:11 INFO - "buildid": "20161031063747", 08:38:11 INFO - "stage_platform": "linux64-pgo", 08:38:11 INFO - "basedir": "/builds/slave/test", 08:38:11 INFO - "buildnumber": 1901, 08:38:11 INFO - "platform": "ubuntu64_hw", 08:38:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:38:11 INFO - "slavebuilddir": "test", 08:38:11 INFO - "branch": "mozilla-inbound", 08:38:11 INFO - "revision": "72764ba31b81562e3069f6935da33cae06fe6b00", 08:38:11 INFO - "slavename": "talos-linux64-ix-026", 08:38:11 INFO - "builduid": "c6deb249ffaf41c4be2f92c07b67df9d", 08:38:11 INFO - "repo_path": "integration/mozilla-inbound" 08:38:11 INFO - } 08:38:11 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:38:11 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 08:38:11 INFO - Running post-action listener: _resource_record_post_action 08:38:11 INFO - [mozharness: 2016-10-31 15:38:11.532089Z] Finished read-buildbot-config step (success) 08:38:11 INFO - [mozharness: 2016-10-31 15:38:11.532177Z] Running download-and-extract step. 08:38:11 INFO - Running pre-action listener: _resource_record_pre_action 08:38:11 INFO - Running main action method: download_and_extract 08:38:11 INFO - mkdir: /builds/slave/test/build/tests 08:38:11 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')]} 08:38:11 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:38:11 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:38:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:38:11 INFO - Downloaded 1361 bytes. 08:38:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:38:11 INFO - Using the following test package requirements: 08:38:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:38:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:38:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:38:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:11 INFO - u'jsshell-linux-x86_64.zip'], 08:38:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:38:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:38:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:38:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:38:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:38:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:38:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:38:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:38:11 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/1477693880/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:38:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:38:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:38:11 INFO - Http code: 200 08:38:11 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 08:38:11 INFO - x-amz-cf-id: OL0c37UDzSIDKES7gof3z46SgPT7R5GSwk_Gk9V8Z4McZDUx4YBBZw== 08:38:11 INFO - x-amz-replication-status: PENDING 08:38:11 INFO - x-amz-version-id: yMiXTD7ZeoTVV.zvJ1CVdfBBtNQpL1A. 08:38:11 INFO - Expected file size: 22011817 08:38:11 INFO - Obtained file size: 22011817 08:38:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:38:15 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/1477693880/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:38:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:38:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:38:15 INFO - Http code: 200 08:38:15 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 08:38:15 INFO - x-amz-cf-id: e5KwDsfxfIo-lI8-eyrdQWv0YornWm_r8dKwTseG3cUPW_p4ge3wrg== 08:38:15 INFO - x-amz-replication-status: PENDING 08:38:15 INFO - x-amz-version-id: yMiXTD7ZeoTVV.zvJ1CVdfBBtNQpL1A. 08:38:16 INFO - Expected file size: 22011817 08:38:16 INFO - Obtained file size: 22011817 08:38:20 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/1477693880/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:38:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:38:20 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:38:20 INFO - Http code: 200 08:38:20 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 08:38:20 INFO - x-amz-cf-id: G9Y73RmRfeuzoq3LlHxa-xX1PiN2jvbzyFeSQvbEQYehmkSjjvlITg== 08:38:20 INFO - x-amz-replication-status: PENDING 08:38:20 INFO - x-amz-version-id: HBChtoY.oxCLMA0IhnCoREL_QKwb8v1c 08:38:20 INFO - Expected file size: 14409030 08:38:20 INFO - Obtained file size: 14409030 08:38: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')]} 08:38:21 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:38:21 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:38:21 INFO - Downloaded 59414559 bytes. 08:38:21 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:38:21 INFO - mkdir: /builds/slave/test/properties 08:38:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:38:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:38:21 INFO - Contents: 08:38:21 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:38:22 INFO - Running post-action listener: _resource_record_post_action 08:38:22 INFO - Running post-action listener: set_extra_try_arguments 08:38:22 INFO - [mozharness: 2016-10-31 15:38:22.261036Z] Finished download-and-extract step (success) 08:38:22 INFO - [mozharness: 2016-10-31 15:38:22.261263Z] Running populate-webroot step. 08:38:22 INFO - Running pre-action listener: _resource_record_pre_action 08:38:22 INFO - Running main action method: populate_webroot 08:38:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:38:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:38:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:38:22 INFO - '--tppagecycles', 08:38:22 INFO - '7'], 08:38:22 INFO - 'tests': ['tsvgm']}}, 08:38:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:38:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:38:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:38:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:38:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:22 INFO - 'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:38:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:22 INFO - 'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['damp', 'tps']}, 08:38:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:22 INFO - 'tests': ['damp', 'tps']}, 08:38:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['dromaeo_dom']}, 08:38:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:38:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['basic_compositor_video']}, 08:38:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:38:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['a11yr', 08:38:22 INFO - 'ts_paint', 08:38:22 INFO - 'tpaint', 08:38:22 INFO - 'sessionrestore', 08:38:22 INFO - 'sessionrestore_no_auto_restore', 08:38:22 INFO - 'tabpaint']}, 08:38:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:38:22 INFO - 'ts_paint', 08:38:22 INFO - 'tpaint', 08:38:22 INFO - 'sessionrestore', 08:38:22 INFO - 'sessionrestore_no_auto_restore', 08:38:22 INFO - 'tabpaint']}, 08:38:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:38:22 INFO - 'ts_paint', 08:38:22 INFO - 'tpaint', 08:38:22 INFO - 'sessionrestore', 08:38:22 INFO - 'sessionrestore_no_auto_restore', 08:38:22 INFO - 'tabpaint']}, 08:38:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:38:22 INFO - 'ts_paint', 08:38:22 INFO - 'tpaint', 08:38:22 INFO - 'sessionrestore', 08:38:22 INFO - 'sessionrestore_no_auto_restore', 08:38:22 INFO - 'tabpaint']}, 08:38:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['a11yr', 08:38:22 INFO - 'ts_paint', 08:38:22 INFO - 'tpaint', 08:38:22 INFO - 'sessionrestore', 08:38:22 INFO - 'sessionrestore_no_auto_restore', 08:38:22 INFO - 'tabpaint']}, 08:38:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['a11yr', 08:38:22 INFO - 'ts_paint', 08:38:22 INFO - 'tpaint', 08:38:22 INFO - 'sessionrestore', 08:38:22 INFO - 'sessionrestore_no_auto_restore', 08:38:22 INFO - 'tabpaint']}, 08:38:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['tsvgx', 08:38:22 INFO - 'tsvgr_opacity', 08:38:22 INFO - 'tart', 08:38:22 INFO - 'tscrollx', 08:38:22 INFO - 'cart']}, 08:38:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:38:22 INFO - 'tsvgr_opacity', 08:38:22 INFO - 'tart', 08:38:22 INFO - 'tscrollx', 08:38:22 INFO - 'cart']}, 08:38:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:22 INFO - 'talos_options': ['--disable-e10s'], 08:38:22 INFO - 'tests': ['tp5o']}, 08:38:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:22 INFO - 'tests': ['tp5o']}, 08:38:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:22 INFO - 'talos_options': ['--disable-e10s', 08:38:22 INFO - '--xperf_path', 08:38:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:22 INFO - 'tests': ['tp5n']}, 08:38:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:38:22 INFO - 'talos_options': ['--xperf_path', 08:38:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:38:22 INFO - 'tests': ['tp5n']}}, 08:38:22 INFO - 'talos.zip': {'path': '', 08:38:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:38:22 INFO - Running post-action listener: _resource_record_post_action 08:38:22 INFO - [mozharness: 2016-10-31 15:38:22.279769Z] Finished populate-webroot step (success) 08:38:22 INFO - [mozharness: 2016-10-31 15:38:22.279857Z] Running create-virtualenv step. 08:38:22 INFO - Running pre-action listener: _resource_record_pre_action 08:38:22 INFO - Running main action method: create_virtualenv 08:38:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:38:22 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 08:38:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:38:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:38:22 INFO - Using real prefix '/usr' 08:38:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:38:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:38:24 INFO - Installing pip.................done. 08:38:24 INFO - Return code: 0 08:38:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:38:25 INFO - Reading from file tmpfile_stdout 08:38:25 INFO - Output received: 08:38:25 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) 08:38:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:38:25 INFO - Using env: {'DISPLAY': ':0', 08:38:25 INFO - 'HOME': '/home/cltbld', 08:38:25 INFO - 'LANG': 'en_US.UTF-8', 08:38:25 INFO - 'LANGUAGE': 'en_US:en', 08:38:25 INFO - 'LOGNAME': 'cltbld', 08:38:25 INFO - 'MAIL': '/var/mail/cltbld', 08:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:25 INFO - 'MOZ_NO_REMOTE': '1', 08:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:25 INFO - 'NO_EM_RESTART': '1', 08:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:25 INFO - 'PWD': '/builds/slave/test', 08:38:25 INFO - 'SHELL': '/bin/bash', 08:38:25 INFO - 'SHLVL': '1', 08:38:25 INFO - 'TERM': 'linux', 08:38:25 INFO - 'TMOUT': '86400', 08:38:25 INFO - 'USER': 'cltbld', 08:38:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:25 INFO - '_': '/tools/buildbot/bin/python'} 08:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:25 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 08:38:25 INFO - Cleaning up... 08:38:25 INFO - Return code: 0 08:38:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:38:25 INFO - Using env: {'DISPLAY': ':0', 08:38:25 INFO - 'HOME': '/home/cltbld', 08:38:25 INFO - 'LANG': 'en_US.UTF-8', 08:38:25 INFO - 'LANGUAGE': 'en_US:en', 08:38:25 INFO - 'LOGNAME': 'cltbld', 08:38:25 INFO - 'MAIL': '/var/mail/cltbld', 08:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:25 INFO - 'MOZ_NO_REMOTE': '1', 08:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:25 INFO - 'NO_EM_RESTART': '1', 08:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:25 INFO - 'PWD': '/builds/slave/test', 08:38:25 INFO - 'SHELL': '/bin/bash', 08:38:25 INFO - 'SHLVL': '1', 08:38:25 INFO - 'TERM': 'linux', 08:38:25 INFO - 'TMOUT': '86400', 08:38:25 INFO - 'USER': 'cltbld', 08:38:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:25 INFO - '_': '/tools/buildbot/bin/python'} 08:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:25 INFO - Downloading/unpacking psutil>=3.1.1 08:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:38:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:27 INFO - Installing collected packages: psutil 08:38:27 INFO - Running setup.py install for psutil 08:38:27 INFO - building 'psutil._psutil_linux' extension 08:38:27 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 08:38:27 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 08:38:27 INFO - building 'psutil._psutil_posix' extension 08:38:27 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 08:38:27 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 08:38:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:38:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:38:28 INFO - Successfully installed psutil 08:38:28 INFO - Cleaning up... 08:38:28 INFO - Return code: 0 08:38:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:38:28 INFO - Using env: {'DISPLAY': ':0', 08:38:28 INFO - 'HOME': '/home/cltbld', 08:38:28 INFO - 'LANG': 'en_US.UTF-8', 08:38:28 INFO - 'LANGUAGE': 'en_US:en', 08:38:28 INFO - 'LOGNAME': 'cltbld', 08:38:28 INFO - 'MAIL': '/var/mail/cltbld', 08:38:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:28 INFO - 'MOZ_NO_REMOTE': '1', 08:38:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:28 INFO - 'NO_EM_RESTART': '1', 08:38:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:28 INFO - 'PWD': '/builds/slave/test', 08:38:28 INFO - 'SHELL': '/bin/bash', 08:38:28 INFO - 'SHLVL': '1', 08:38:28 INFO - 'TERM': 'linux', 08:38:28 INFO - 'TMOUT': '86400', 08:38:28 INFO - 'USER': 'cltbld', 08:38:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:28 INFO - '_': '/tools/buildbot/bin/python'} 08:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:38:30 INFO - Installing collected packages: mozsystemmonitor 08:38:30 INFO - Running setup.py install for mozsystemmonitor 08:38:30 INFO - Successfully installed mozsystemmonitor 08:38:30 INFO - Cleaning up... 08:38:30 INFO - Return code: 0 08:38:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:38:30 INFO - Using env: {'DISPLAY': ':0', 08:38:30 INFO - 'HOME': '/home/cltbld', 08:38:30 INFO - 'LANG': 'en_US.UTF-8', 08:38:30 INFO - 'LANGUAGE': 'en_US:en', 08:38:30 INFO - 'LOGNAME': 'cltbld', 08:38:30 INFO - 'MAIL': '/var/mail/cltbld', 08:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:30 INFO - 'MOZ_NO_REMOTE': '1', 08:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:30 INFO - 'NO_EM_RESTART': '1', 08:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:30 INFO - 'PWD': '/builds/slave/test', 08:38:30 INFO - 'SHELL': '/bin/bash', 08:38:30 INFO - 'SHLVL': '1', 08:38:30 INFO - 'TERM': 'linux', 08:38:30 INFO - 'TMOUT': '86400', 08:38:30 INFO - 'USER': 'cltbld', 08:38:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:30 INFO - '_': '/tools/buildbot/bin/python'} 08:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:30 INFO - Downloading/unpacking jsonschema==2.5.1 08:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:38:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:32 INFO - Downloading functools32-3.2.3-2.tar.gz 08:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:38:32 INFO - warning: no files found matching '*.txt' 08:38:32 INFO - no previously-included directories found matching 'build' 08:38:32 INFO - no previously-included directories found matching 'dist' 08:38:32 INFO - no previously-included directories found matching '.git*' 08:38:32 INFO - Installing collected packages: jsonschema, functools32 08:38:32 INFO - Running setup.py install for functools32 08:38:33 INFO - warning: no files found matching '*.txt' 08:38:33 INFO - no previously-included directories found matching 'build' 08:38:33 INFO - no previously-included directories found matching 'dist' 08:38:33 INFO - no previously-included directories found matching '.git*' 08:38:33 INFO - Successfully installed jsonschema functools32 08:38:33 INFO - Cleaning up... 08:38:33 INFO - Return code: 0 08:38:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:33 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 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:33 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 08:38:33 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 08:38:33 INFO - Using env: {'DISPLAY': ':0', 08:38:33 INFO - 'HOME': '/home/cltbld', 08:38:33 INFO - 'LANG': 'en_US.UTF-8', 08:38:33 INFO - 'LANGUAGE': 'en_US:en', 08:38:33 INFO - 'LOGNAME': 'cltbld', 08:38:33 INFO - 'MAIL': '/var/mail/cltbld', 08:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:33 INFO - 'MOZ_NO_REMOTE': '1', 08:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:33 INFO - 'NO_EM_RESTART': '1', 08:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:33 INFO - 'PWD': '/builds/slave/test', 08:38:33 INFO - 'SHELL': '/bin/bash', 08:38:33 INFO - 'SHLVL': '1', 08:38:33 INFO - 'TERM': 'linux', 08:38:33 INFO - 'TMOUT': '86400', 08:38:33 INFO - 'USER': 'cltbld', 08:38:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:33 INFO - '_': '/tools/buildbot/bin/python'} 08:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:38:33 INFO - Cleaning up... 08:38:33 INFO - Return code: 0 08:38:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:33 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 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:33 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 08:38:33 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 08:38:33 INFO - Using env: {'DISPLAY': ':0', 08:38:33 INFO - 'HOME': '/home/cltbld', 08:38:33 INFO - 'LANG': 'en_US.UTF-8', 08:38:33 INFO - 'LANGUAGE': 'en_US:en', 08:38:33 INFO - 'LOGNAME': 'cltbld', 08:38:33 INFO - 'MAIL': '/var/mail/cltbld', 08:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:33 INFO - 'MOZ_NO_REMOTE': '1', 08:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:33 INFO - 'NO_EM_RESTART': '1', 08:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:33 INFO - 'PWD': '/builds/slave/test', 08:38:33 INFO - 'SHELL': '/bin/bash', 08:38:33 INFO - 'SHLVL': '1', 08:38:33 INFO - 'TERM': 'linux', 08:38:33 INFO - 'TMOUT': '86400', 08:38:33 INFO - 'USER': 'cltbld', 08:38:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:33 INFO - '_': '/tools/buildbot/bin/python'} 08:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:38:33 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 08:38:33 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 08:38:33 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 08:38:33 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 08:38:33 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 08:38:33 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 08:38:35 INFO - Downloading blobuploader-1.2.4.tar.gz 08:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:38:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:38:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:38:36 INFO - Downloading docopt-0.6.1.tar.gz 08:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:38:36 INFO - Installing collected packages: blobuploader, requests, docopt 08:38:36 INFO - Running setup.py install for blobuploader 08:38:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:38:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:38:36 INFO - Running setup.py install for requests 08:38:36 INFO - Running setup.py install for docopt 08:38:36 INFO - Successfully installed blobuploader requests docopt 08:38:36 INFO - Cleaning up... 08:38:36 INFO - Return code: 0 08:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:36 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')]} 08:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:36 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')]} 08:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:36 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 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:36 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 08:38:36 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 08:38:36 INFO - Using env: {'DISPLAY': ':0', 08:38:36 INFO - 'HOME': '/home/cltbld', 08:38:36 INFO - 'LANG': 'en_US.UTF-8', 08:38:36 INFO - 'LANGUAGE': 'en_US:en', 08:38:36 INFO - 'LOGNAME': 'cltbld', 08:38:36 INFO - 'MAIL': '/var/mail/cltbld', 08:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:36 INFO - 'MOZ_NO_REMOTE': '1', 08:38:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:36 INFO - 'NO_EM_RESTART': '1', 08:38:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:36 INFO - 'PWD': '/builds/slave/test', 08:38:36 INFO - 'SHELL': '/bin/bash', 08:38:36 INFO - 'SHLVL': '1', 08:38:36 INFO - 'TERM': 'linux', 08:38:36 INFO - 'TMOUT': '86400', 08:38:36 INFO - 'USER': 'cltbld', 08:38:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:36 INFO - '_': '/tools/buildbot/bin/python'} 08:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:37 INFO - Running setup.py (path:/tmp/pip-yag0Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:37 INFO - Running setup.py (path:/tmp/pip-aLMsOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:37 INFO - Running setup.py (path:/tmp/pip-3gFu3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:37 INFO - Running setup.py (path:/tmp/pip-ORoEGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:37 INFO - Running setup.py (path:/tmp/pip-01qVzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:37 INFO - Running setup.py (path:/tmp/pip-dRxUL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:37 INFO - Running setup.py (path:/tmp/pip-YP1nFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:37 INFO - Running setup.py (path:/tmp/pip-eZtNWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:37 INFO - Running setup.py (path:/tmp/pip-3ydNCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:37 INFO - Running setup.py (path:/tmp/pip-5t6sAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:37 INFO - Running setup.py (path:/tmp/pip-1ZVO2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:37 INFO - Running setup.py (path:/tmp/pip-o4WHZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:37 INFO - Running setup.py (path:/tmp/pip-hMrCtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:38 INFO - Running setup.py (path:/tmp/pip-MJHag3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:38 INFO - Running setup.py (path:/tmp/pip-Gr1lJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:38 INFO - Running setup.py (path:/tmp/pip-mT5Ia2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:38 INFO - Running setup.py (path:/tmp/pip-J83oFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:38:38 INFO - Running setup.py install for manifestparser 08:38:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:38:38 INFO - Running setup.py install for mozcrash 08:38:38 INFO - Running setup.py install for mozdebug 08:38:38 INFO - Running setup.py install for mozdevice 08:38:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:38:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:38:38 INFO - Running setup.py install for mozfile 08:38:38 INFO - Running setup.py install for mozhttpd 08:38:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:38:38 INFO - Running setup.py install for mozinfo 08:38:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Running setup.py install for mozInstall 08:38:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Running setup.py install for mozleak 08:38:39 INFO - Running setup.py install for mozlog 08:38:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Running setup.py install for moznetwork 08:38:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Running setup.py install for mozprocess 08:38:39 INFO - Running setup.py install for mozprofile 08:38:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Running setup.py install for mozrunner 08:38:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:38:39 INFO - Running setup.py install for mozscreenshot 08:38:39 INFO - Running setup.py install for moztest 08:38:40 INFO - Running setup.py install for mozversion 08:38:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:38:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:38:40 INFO - Cleaning up... 08:38:40 INFO - Return code: 0 08:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:40 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')]} 08:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:40 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')]} 08:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:40 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 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:40 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 08:38:40 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 08:38:40 INFO - Using env: {'DISPLAY': ':0', 08:38:40 INFO - 'HOME': '/home/cltbld', 08:38:40 INFO - 'LANG': 'en_US.UTF-8', 08:38:40 INFO - 'LANGUAGE': 'en_US:en', 08:38:40 INFO - 'LOGNAME': 'cltbld', 08:38:40 INFO - 'MAIL': '/var/mail/cltbld', 08:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:40 INFO - 'MOZ_NO_REMOTE': '1', 08:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:40 INFO - 'NO_EM_RESTART': '1', 08:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:40 INFO - 'PWD': '/builds/slave/test', 08:38:40 INFO - 'SHELL': '/bin/bash', 08:38:40 INFO - 'SHLVL': '1', 08:38:40 INFO - 'TERM': 'linux', 08:38:40 INFO - 'TMOUT': '86400', 08:38:40 INFO - 'USER': 'cltbld', 08:38:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:40 INFO - '_': '/tools/buildbot/bin/python'} 08:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:38:40 INFO - Running setup.py (path:/tmp/pip-PbUhVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:38:40 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)) 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:38:40 INFO - Running setup.py (path:/tmp/pip-Dl1qw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:38:40 INFO - Running setup.py (path:/tmp/pip-0xNZh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:38:40 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)) 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:38:40 INFO - Running setup.py (path:/tmp/pip-qeIHbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:38:40 INFO - Running setup.py (path:/tmp/pip-qHfst1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:38:40 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)) 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:38:40 INFO - Running setup.py (path:/tmp/pip-6nvFSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:38:40 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)) 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:38:40 INFO - Running setup.py (path:/tmp/pip-4lx70o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:38:40 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)) 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:38:40 INFO - Running setup.py (path:/tmp/pip-bxeIi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:38:40 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)) 08:38:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:38:40 INFO - Running setup.py (path:/tmp/pip-M6eEE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:38:41 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)) 08:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:38:41 INFO - Running setup.py (path:/tmp/pip-KsXXSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:38:41 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)) 08:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:38:41 INFO - Running setup.py (path:/tmp/pip-PWRXri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:38:41 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)) 08:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:38:41 INFO - Running setup.py (path:/tmp/pip-BkH7Dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:38:41 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)) 08:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:38:41 INFO - Running setup.py (path:/tmp/pip-1h2pX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:38:41 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)) 08:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:38:41 INFO - Running setup.py (path:/tmp/pip-pQnog4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:41 INFO - Running setup.py (path:/tmp/pip-YLmLBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:38:41 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)) 08:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:38:41 INFO - Running setup.py (path:/tmp/pip-ZZSfC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:38:41 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)) 08:38:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:38:41 INFO - Running setup.py (path:/tmp/pip-w1220t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:38:41 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)) 08:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:38:41 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)) 08:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:38:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:38:41 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 08:38:41 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 08:38:41 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 08:38:41 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 08:38:41 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 08:38:41 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 08:38:43 INFO - Downloading blessings-1.6.tar.gz 08:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:38:43 INFO - Installing collected packages: blessings 08:38:43 INFO - Running setup.py install for blessings 08:38:43 INFO - Successfully installed blessings 08:38:43 INFO - Cleaning up... 08:38:43 INFO - Return code: 0 08:38:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:38:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:43 INFO - Reading from file tmpfile_stdout 08:38:43 INFO - Current package versions: 08:38:43 INFO - argparse == 1.2.1 08:38:43 INFO - blessings == 1.6 08:38:43 INFO - blobuploader == 1.2.4 08:38:43 INFO - docopt == 0.6.1 08:38:43 INFO - functools32 == 3.2.3-2 08:38:43 INFO - jsonschema == 2.5.1 08:38:43 INFO - manifestparser == 1.1 08:38:43 INFO - mozInstall == 1.12 08:38:43 INFO - mozcrash == 0.17 08:38:43 INFO - mozdebug == 0.1 08:38:43 INFO - mozdevice == 0.48 08:38:43 INFO - mozfile == 1.2 08:38:43 INFO - mozhttpd == 0.7 08:38:43 INFO - mozinfo == 0.9 08:38:43 INFO - mozleak == 0.1 08:38:43 INFO - mozlog == 3.4 08:38:43 INFO - moznetwork == 0.27 08:38:43 INFO - mozprocess == 0.23 08:38:43 INFO - mozprofile == 0.28 08:38:43 INFO - mozrunner == 6.12 08:38:43 INFO - mozscreenshot == 0.1 08:38:43 INFO - mozsystemmonitor == 0.3 08:38:43 INFO - moztest == 0.7 08:38:43 INFO - mozversion == 1.4 08:38:43 INFO - psutil == 3.1.1 08:38:43 INFO - requests == 1.2.3 08:38:43 INFO - wsgiref == 0.1.2 08:38:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:38:43 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')]} 08:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:43 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')]} 08:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:44 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 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:44 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 08:38:44 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 08:38:44 INFO - Using env: {'DISPLAY': ':0', 08:38:44 INFO - 'HOME': '/home/cltbld', 08:38:44 INFO - 'LANG': 'en_US.UTF-8', 08:38:44 INFO - 'LANGUAGE': 'en_US:en', 08:38:44 INFO - 'LOGNAME': 'cltbld', 08:38:44 INFO - 'MAIL': '/var/mail/cltbld', 08:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:44 INFO - 'MOZ_NO_REMOTE': '1', 08:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:44 INFO - 'NO_EM_RESTART': '1', 08:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:44 INFO - 'PWD': '/builds/slave/test', 08:38:44 INFO - 'SHELL': '/bin/bash', 08:38:44 INFO - 'SHLVL': '1', 08:38:44 INFO - 'TERM': 'linux', 08:38:44 INFO - 'TMOUT': '86400', 08:38:44 INFO - 'USER': 'cltbld', 08:38:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:44 INFO - '_': '/tools/buildbot/bin/python'} 08:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 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)) 08:38:44 INFO - Cleaning up... 08:38:44 INFO - Return code: 0 08:38:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:38:44 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 0x7ff44c32df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x262d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26faca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, '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': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', '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 08:38:44 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 08:38:44 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 08:38:44 INFO - Using env: {'DISPLAY': ':0', 08:38:44 INFO - 'HOME': '/home/cltbld', 08:38:44 INFO - 'LANG': 'en_US.UTF-8', 08:38:44 INFO - 'LANGUAGE': 'en_US:en', 08:38:44 INFO - 'LOGNAME': 'cltbld', 08:38:44 INFO - 'MAIL': '/var/mail/cltbld', 08:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:38:44 INFO - 'MOZ_NO_REMOTE': '1', 08:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:38:44 INFO - 'NO_EM_RESTART': '1', 08:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:38:44 INFO - 'PWD': '/builds/slave/test', 08:38:44 INFO - 'SHELL': '/bin/bash', 08:38:44 INFO - 'SHLVL': '1', 08:38:44 INFO - 'TERM': 'linux', 08:38:44 INFO - 'TMOUT': '86400', 08:38:44 INFO - 'USER': 'cltbld', 08:38:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:38:44 INFO - '_': '/tools/buildbot/bin/python'} 08:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:38:44 INFO - Cleaning up... 08:38:44 INFO - Return code: 0 08:38:44 INFO - Running post-action listener: _resource_record_post_action 08:38:44 INFO - Running post-action listener: _start_resource_monitoring 08:38:44 INFO - Starting resource monitoring. 08:38:44 INFO - [mozharness: 2016-10-31 15:38:44.486001Z] Finished create-virtualenv step (success) 08:38:44 INFO - [mozharness: 2016-10-31 15:38:44.486509Z] Running install step. 08:38:44 INFO - Running pre-action listener: _resource_record_pre_action 08:38:44 INFO - Running main action method: install 08:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:38:44 INFO - Reading from file tmpfile_stdout 08:38:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:38:44 INFO - Reading from file tmpfile_stdout 08:38:44 INFO - Output received: 08:38:44 INFO - Usage: mozinstall [options] installer 08:38:44 INFO - Options: 08:38:44 INFO - -h, --help show this help message and exit 08:38:44 INFO - -d DEST, --destination=DEST 08:38:44 INFO - Directory to install application into. [default: 08:38:44 INFO - "/builds/slave/test"] 08:38:44 INFO - --app=APP Application being installed. [default: firefox] 08:38:44 INFO - mkdir: /builds/slave/test/build/application 08:38:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:39:01 INFO - Reading from file tmpfile_stdout 08:39:01 INFO - Output received: 08:39:01 INFO - /builds/slave/test/build/application/firefox/firefox 08:39:01 INFO - Running post-action listener: _resource_record_post_action 08:39:01 INFO - [mozharness: 2016-10-31 15:39:01.674544Z] Finished install step (success) 08:39:01 INFO - [mozharness: 2016-10-31 15:39:01.674883Z] Running run-tests step. 08:39:01 INFO - Running pre-action listener: _resource_record_pre_action 08:39:01 INFO - Running main action method: run_tests 08:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:39:01 INFO - Python 2.7.3 08:39:01 INFO - Return code: 0 08:39:01 INFO - grabbing minidump binary from tooltool 08:39:01 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')]} 08:39:01 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 0x26f7f60>, '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 0x26f8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:39:01 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 08:39:01 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 08:39:01 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 08:39:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:39:01 INFO - Return code: 0 08:39:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:39:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:39:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:39:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:39:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:39:01 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/1477693880/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 08:39:01 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/1477693880/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 08:39:01 INFO - Using env: {'DISPLAY': ':0', 08:39:01 INFO - 'HOME': '/home/cltbld', 08:39:01 INFO - 'LANG': 'en_US.UTF-8', 08:39:01 INFO - 'LANGUAGE': 'en_US:en', 08:39:01 INFO - 'LOGNAME': 'cltbld', 08:39:01 INFO - 'MAIL': '/var/mail/cltbld', 08:39:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:39:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:01 INFO - 'MOZ_NO_REMOTE': '1', 08:39:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:39:01 INFO - 'NO_EM_RESTART': '1', 08:39:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:01 INFO - 'PWD': '/builds/slave/test', 08:39:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:39:01 INFO - 'SHELL': '/bin/bash', 08:39:01 INFO - 'SHLVL': '1', 08:39:01 INFO - 'TERM': 'linux', 08:39:01 INFO - 'TMOUT': '86400', 08:39:01 INFO - 'USER': 'cltbld', 08:39:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873', 08:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:01 INFO - '_': '/tools/buildbot/bin/python'} 08:39:01 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/1477693880/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 08:39:01 INFO - mozversion application_buildid: 20161028153120 08:39:01 INFO - mozversion application_changeset: 72764ba31b81562e3069f6935da33cae06fe6b00 08:39:01 INFO - mozversion application_display_name: Nightly 08:39:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:39:01 INFO - mozversion application_name: Firefox 08:39:01 INFO - mozversion application_remotingname: firefox 08:39:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:39:01 INFO - mozversion application_vendor: Mozilla 08:39:01 INFO - mozversion application_version: 52.0a1 08:39:01 INFO - mozversion platform_buildid: 20161028153120 08:39:01 INFO - mozversion platform_changeset: 72764ba31b81562e3069f6935da33cae06fe6b00 08:39:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:39:01 INFO - mozversion platform_version: 52.0a1 08:39:01 INFO - using testdate: 1477928341 08:39:01 INFO - actual date: 1477928341 08:39:01 INFO - starting webserver on 'localhost:51102' 08:39:01 INFO - SUITE-START | Running 2 tests 08:39:01 INFO - TEST-START | dromaeo_css 08:39:01 INFO - operating with platform_type : linux_ 08:39:01 INFO - Initialising browser for dromaeo_css test... 08:39:01 INFO - TEST-INFO | started process 14634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr6vDhk/profile http://localhost:51102/getInfo.html) 08:39:05 INFO - PROCESS | 14634 | __metrics Screen width/height:1600/1200 08:39:05 INFO - PROCESS | 14634 | colorDepth:24 08:39:05 INFO - PROCESS | 14634 | Browser inner width/height: 1024/697 08:39:05 INFO - PROCESS | 14634 | __metrics 08:39:06 INFO - PROCESS | 14634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:39:06 INFO - PROCESS | 14634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:07 INFO - PROCESS | 14634 | console.error: PushService: 08:39:07 INFO - PROCESS | 14634 | stateChangeProcessEnqueue: Error transitioning state 08:39:07 INFO - PROCESS | 14634 | UnknownError 08:39:07 INFO - TEST-INFO | 14634: exit 0 08:39:07 INFO - Browser initialized. 08:39:07 INFO - Running cycle 1/1 for dromaeo_css test... 08:39:07 INFO - TEST-INFO | started process 14718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr6vDhk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:19 INFO - PROCESS | 14718 | RSS: Main: 173252608 08:39:19 INFO - PROCESS | 14718 | 08:40:10 INFO - PROCESS | 14718 | 1477928410950 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] 08:42:21 INFO - PROCESS | 14718 | Cycle 1(1): loaded http://localhost:51102/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51102/tests/dromaeo/cssquery-ext.html) 08:42:24 INFO - PROCESS | 14718 | RSS: Main: 413581312 08:42:24 INFO - PROCESS | 14718 | 08:45:27 INFO - PROCESS | 14718 | Cycle 1(1): loaded http://localhost:51102/tests/dromaeo/cssquery-ext.html (next: http://localhost:51102/tests/dromaeo/cssquery-jquery.html) 08:45:27 INFO - PROCESS | 14718 | RSS: Main: 279519232 08:45:27 INFO - PROCESS | 14718 | 08:48:29 INFO - PROCESS | 14718 | Cycle 1(1): loaded http://localhost:51102/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51102/tests/dromaeo/cssquery-mootools.html) 08:48:30 INFO - PROCESS | 14718 | RSS: Main: 217743360 08:48:30 INFO - PROCESS | 14718 | 08:51:32 INFO - PROCESS | 14718 | Cycle 1(1): loaded http://localhost:51102/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51102/tests/dromaeo/cssquery-prototype.html) 08:51:33 INFO - PROCESS | 14718 | RSS: Main: 261283840 08:51:33 INFO - PROCESS | 14718 | 08:54:35 INFO - PROCESS | 14718 | Cycle 1(1): loaded http://localhost:51102/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51102/tests/dromaeo/cssquery-yui.html) 08:54:36 INFO - PROCESS | 14718 | RSS: Main: 218566656 08:54:36 INFO - PROCESS | 14718 | 08:57:38 INFO - PROCESS | 14718 | Cycle 1(1): loaded http://localhost:51102/tests/dromaeo/cssquery-yui.html (next: http://localhost:51102/tests/dromaeo/cssquery-dojo.html) 08:57:39 INFO - PROCESS | 14718 | RSS: Main: 308957184 08:57:39 INFO - PROCESS | 14718 | 08:57:39 INFO - PROCESS | 14718 | __start_tp_report 08:57:39 INFO - PROCESS | 14718 | _x_x_mozilla_page_load 08:57:39 INFO - PROCESS | 14718 | _x_x_mozilla_page_load_details 08:57:39 INFO - PROCESS | 14718 | |i|pagename|runs| 08:57:39 INFO - PROCESS | 14718 | |0;dojo.html;2990.715881991211;3047.360054388578;3055.4500189965825;3060.739837113845;3065.8620362083702;5235.1885457754015;5310.176922576997;5351.197320401937;5425.511703946649;5448.863778405542;5339.679619222849;5342.1452567589195;5350.5184533391985;5352.57179425646;5352.9197062044;4820.39745031871;4826.517348265181;4849.175640141185;4870.878228044292;4911.287863259825;4885.267209918505;4895.437024742165;4916.704997700132;4940.678855874375;4992;4985.102681517325;4988.226824842137;4989.57588604969;4993.051320249141;5026.070177017245;722.0816300045423;4887.218045112765;4897.240927656219;4923.040007198598;4983.103041452537;4910.337104490919;4911.066897289539;4912.557869791736;4922.384701912261;4944.283078953567;5393.7303134843105;5395.244665746799;5396.10964190908;5430.212619170237;5451.509364157245;5536.363318218416;5575.972120139373;5582.218489411485;5652.378238393773;5752.597318187729;5759.913601295984;5772.538196944276;5807.070868660994;5860.7948721794955;5878.118282257653;5371.919421208685;5382.3541175059245;5386.622936394454;5388.703621300827;5404.162354835007;5656.575756818255;5709.172170035322;5878.441548053013;5888.911666324922;5893.263342082239;5563.972180139073;5640.8871822563315;5646.85882852932;5669.518090962232;5739.253896993364;5739.65562066269;5748.856278593069;5750.338711048199;5751.1085781703905;5758.107493338539;5551.639143455663;5634.1830434586755;5717;5733.856653583611;5736.741846616912;5586.608937374426;5695.316562012502;5698.401667824902;5703.486686198179;5705.600607957486;4432.180046691373;4434.224010798098;4436.378906953029;4441.400410944481;4441.400410944546;3926.842926282917;3989.7207195496617;4005.679545636342;4015.678745700337;4043.8584649537124;5519.420460851633;5547.44525547442;5555.194496798023;5558.305211848519;5558.499735023867;5798.188253644409;5813.040848260074;5819.098039803837;5826.388229235954;5883.411658834168;5394.298741163623;5429.104197807396;5498;5545.77816887328;5549.38956714761;5049.520295571915;5055.090083784954;5058.342415486037;5058.898822023539;5104.770285337168;6062.575619706667;6100.267967843798;6100.328963813889;6102.084687296852;6112.144299798032;5616.297962754656;5676.347220069745;5682.801101961411;5779.0464573344925;5795.652260864362;5962.761489540369;6020.729067191899;6035.1249068885645;6043.395660434097;6134.78528251509;5692.5730570208225;5695.715214239354;5696.316442026983;5746.13807928814;5748.626339287933;5732.656040637575;5748.913766293425;5791.82624521265;5800.796972105956;5804.65172089676;5498.477644623755;5551.639143455663;5556.888862222652;5655.660660360391;5666.433356664301;5624.072028115479;5624.550035997028;5627.690477023803;5630.662160270397;5638.830835074954;5601.103823388238;5605.411431799603;5606.411326810626;5607.130894711327;5609.158626206102;5593.524550413261;5640.32316122068;5648.039833228278;5651.208830763779;5663.716814159193;5469.343678758574;5519.116941289374;5532.75102620375;5537.169424586345;5545.279113715191 08:57:39 INFO - PROCESS | 14718 | |1;ext.html;589.4783116941506;599.7990673124503;600.765701376463;609.3875654966763;610.1671218786355;30621.10062390018;40537.59462405379;42222.78888605557;42248;46311.53688463115;44092.77953610235;44582.554174458244;44588.777056114755;44733.55266447343;44747.328790068175;7988.4408091433625;8772.122787721224;8904.065073167321;8906.51014194219;8911.598978046004;8102.5543595102245;8253.09215986241;8254.958725206396;10123.898761012406;10415.16678665705;10381.636642717507;10416.906224846396;10416.947915260413;10419.166466682647;10426.895731042707;10507.159427245802;10546.156307495383;10565.630202942899;10569.048785609255;10578.100861426788;10512.789744205073;10551.78896422075;10581.31221470602;10582;10587.788244235073;40549;40794;40823.59176408257;40884.79557602193;40970.79514602438;3388.3223355329033;3458.56767904012;3543.8050907200095;3788.412796016622;4045.6965727570255;30190;30208;30730;30908.14551126917;30956.047032474922;4429.202743506167;4432.3794668746405;4438.578335058197;4460.43022307127;4507.459104907432;324918;326676;327223;328018;328841.9999999976;57229.42770572324;57508.71245643745;57633.42366576364;57660.135097973565;57675.71162144246;34338;35188.29623407518;35338.469922951175;37343;55522.16716749252;13958.930205348908;13959.79060314096;13977.16137031761;14017.71964560703;14019.439222431192;10885.346879187116;11608.593699220486;11815.113866459878;11824.704382390337;11847.466863991142;15910.920445397698;17981.044170282516;18279.1774370151;18696.53258668544;19064.523386915436;6683.966580167068;6890.726904720218;6935.549189302679;6952.165740111219;7167.677454514559;920.5305294299956;941.8493041113526;1050.3382868792764;1072.7157303314627;1074.4896174317137;30876.22809429782;31485.212869677984;31496.68503314983;31497.685023149475;31927;1019.587067237755;1095.4905968724422;1120.8991190792706;1154.584349634131;1174.7356844710043;15607.921960390126;16278.67442651164;16290.918545407198;16408.343666253455;16490.58773530671;518866;527853;529064;529432;531483;55064.72467637636;55547.44452555504;55579.72210139004;55596.444035559936;55691.16463253054;1193.1588230297618;1224.1125184241532;1275.304958797439;1314.3296918571598;1350.6893414514716;30177.54733678953;32058.6794132065;32283;32318.35363292768;32758.836205818818;46541.76729116333;47171.764141179076;47256;47280.7635961818;47318.76340618275;368421;371454;371547;371683;371812;26419.471610568067;26454.86772566125;27308;27460.194465968776;28925;45179.741012949875;45506.77246613746;46055.53944460512;46582.30126548037;46956.53043469522;38185.236295274495;38203.80898095492;39968.800156000194;40082.799586001885;40513;38531.42202866903;39448.605513945644;40243.798781005906;40933.79533102315;41242.79378603088;39515.604843951194;40328.59671403249;40524.59475405208;40671;40699.3895091568;33177.66822331746;34736.478952815225;34794.25760786984;41805.79097104495;43341.783291083346;29911.850440747658;33492.1626959328;33651.66348336485;33780.831095845344;33794.15514612154 08:57:39 INFO - PROCESS | 14718 | |2;jquery.html;366.5601278465842;368.51356209803055;392.60935369307543;393.5513514593364;415.6674660271782;13980.790288145687;18078.367257146;19057.33299334522;19322.32371866985;20785.376438706862;16222.918885405586;16912.746308805377;17030.744538831896;17292.394766183184;17974.01142937141;5567.721613919308;5870.178175055496;5876.853078673024;5878.529717622601;5883.529317654598;4251.0860165064505;4443.289073748201;4466.5980061794435;5748.798792042279;5804.100364443518;6545.967270163643;6547.377999090078;6657.833554161136;6687.164104486939;6688.431483323923;6433.93566064338;6479.833629946607;6525.216973963107;6532.444742196919;6673.23257825349;5769.826905192809;5782.045962416239;5784.971075144597;5787.102999035156;5789.16057171712;22469.887650561643;23189.76810231893;23220.883895580584;23368.76631233683;23505.647415288786;2322.222055611372;2323.3726893738594;2340.871252081135;2630.302969713028;2653.7478939500716;13706;14216.92891535546;14894.925525372304;15146.772798408032;15196.316165772567;1901.895395753233;1921.135489029928;1942.3298961858277;1966.3412756726514;1974.664307067802;58529;71241;78030.6098469504;80511.99999999942;82193;10462.529186186639;10578.629747958785;10640.893591064145;10986;11081.168912331608;15283.624473797412;15285.159316237714;15305.158216297988;15314.081155130727;15335.386584536716;7743.303102720783;7948.403869709679;8035.919640803517;8134.75595732129;8168.387370947203;7695.653695583712;7695.730649427243;7787.844243115219;7860.174681658458;8016.997875265592;6522.184726909137;6546.770863019867;6573.80278591643;6728.226253980757;6801.863962720718;1847.8614103941989;1927.4410420977758;1928.816762407569;1936.786953435121;1948.6882098864114;921.5714692667941;928.99668358173;932.0865551759314;1038.896110388955;1051.673981065872;20035.39893803188;20457.590848182954;20478;20783.584328313653;20914.37256882296;969.5297780576415;993.7515621094726;998.565623953568;1015.5785349080197;1026.573971801694;10867.184961127947;11553.942230288963;11617.070634349231;11689.941550292195;11810.88189118115;433698;439279.2144157163;445687;445805;447582;80725;81834;82537;83538;89698.55150724335;986.8026394721085;1018.7402212435782;1033.8552602635637;1043.0508237503834;1043.801677681238;16743.33026678968;16852.494425167264;17527.21127549289;17706.91146544259;18107.81892181114;40988;41269.587304127774;41350.79738039318;41446.79276603598;42063;52203.47796521986;57109;58735.412645872995;58907.70546147242;60123;8385.706500272461;8464.687973364138;8600.1399860016;8738.300935925237;8774.780630484034;8024.558649274346;12693.111482196158;12724.1729287596;12779.36103194855;13213.075084743976;10790.73023174427;10904.50929708181;11031.889681103406;11343.149263805082;11797.646070617895;10986.230963832455;11244.381559014006;11255.155863310121;11316.660500185008;11338.943305283421;10207.7448063799;10757.515911783832;10856.674299771019;11273.661790146309;12049.277043377426;8266.751997440086;8409.789755256168;8444.746657600283;8615.569221539023;8639;8050.114487406264;10525.210609204187;10777.491151238675;10790.946045269724;11322.716932076764 08:57:39 INFO - PROCESS | 14718 | |3;mootools.html;1315.1517271359978;1406.360106151701;1446.3202294921387;1554.4248628007638;1716.7424886267065;7124.14510258769;7812.531248125109;8062.234087761668;8064.274215320613;8253.752387428387;8106.594670266478;8166.591670416485;8177;8184.099749027617;8194.262516373525;2270.6366981283;2287.0280130944366;2291.140822191678;2291.3355127013147;2295.5523672883796;2202;2225.2767850448668;2300.148944890393;2306.803921666652;2318.5131122464304;2209.977900221001;2255.9661605075853;2290.862548247102;2292.2321022457495;2304.2165663674346;2200.7799220077945;2207.5915955548116;2212.8229741620794;2215.3021798133536;2220.6891035255076;2229.8885055747146;2256.029907139929;2257.1986944634746;2257.548490301946;2257.582347265761;8119.147489513575;8233.79415514611;8314.667413303461;8316.750497485085;8324.875126873101;4943.233798761198;5158.53573178412;5158.7678554464765;5161.561267292284;5165.535101840815;3365.461526155828;3467.427874400721;3509.1578021274963;3523.6828685418177;3531.417316142859;1172.284906207213;1186.2467333243367;1191.559123124441;1200.6218041316956;1207.1911819081236;11151.498182581803;11210.66368008961;11289.54841806335;11304.208705390625;11318.094552435703;3946.8223929923224;4360.542143074995;4437.933430998538;4510.797014134372;4516.322551617283;9001.144891235323;9010.234130098885;9013.594388252544;9055.366124371363;9076.773080673036;4930.827421040246;4936.654434189572;4941.678790878582;4943.8516844494725;4949.90100197994;3990.501187351581;4134.565870583606;4330.631896288788;4625.098105869391;4631.745254010994;3571.428571428559;3607.639236076424;3669.5229620149744;3671.0638787109115;3703.222323312081;1108.711734948919;1131.9773604527863;1133.552246862501;1134.478140055567;1136.4545018391218;827.9337652987747;929.2658799548282;932.7714709896119;956.6077908057663;974.3131092579856;5654.321481422256;5665.121906104478;5675.31896172462;5714.571407144481;5823.708814559255;902.1700035966926;912.9178373946377;913.963441462334;922.9400088994194;950.6340059077305;3786.659200671953;3868.7485313454536;3875.9224815504094;3895.49358583388;3981.7411868228473;9994.200463962865;10410.68767936963;10439.37363758177;10476.319039262424;10476.52855621499;10130.696079117492;10429.426381549089;10456.947715261527;10462.633807816843;10492.947535262274;7593.430492713069;7881.960590197013;7882.645280962371;7919.3268572170855;7923.326517246099;5495.617160597794;5660.264165658438;5674.177244299471;5749.655020698771;5868.119782032729;9361.953190234006;9460.337776355589;9470.289728270545;9489.715308540755;9498.24014078886;8364.205400486944;9361.204297634506;9546.140847323773;9567.808643827224;9724.611015559298;6386.584871983307;6782.355676210752;6885.242623311532;6911.5853048817235;7103.573785572676;7915.722949696733;7988.600569971362;8021.197880211932;8101.311388532041;8154.918450815416;7075.327843854826;7142.9642851787485;7154.463415243774;7193.71225151009;7200.89198662031;6918.619475928872;6964.65176741171;7115.430765538641;7188.820279493055;7190.352868241884;6370.140031095742;6378.553501254868;6463.64449955257;6464.903026454513;6466.094746735367;4946.455889852042;4974.577160941216;4984.925226121539;5062.924056139087;5249.133892907627;4741.786619602057;4930.482299358516;5016.097102521435;5131.358580177478;5147.742612869416 08:57:39 INFO - PROCESS | 14718 | |4;prototype.html;318.9649138594756;325.50523204728813;330.33602459057295;330.56695728595525;333.8430937459393;5073.923891141636;5216.269722238885;5237.188235823449;5251.107311757001;5270.4729527047275;5109.948900510994;5150.896982060366;5162.896742065156;5197.246399272103;5237.947620523793;4104.199681062194;4108.77401742904;4118.773467459288;4119.526254480743;4132.917341653165;3892.734861170117;4043.1509383029597;4110.938335924963;4111.25271759501;4126.257273690734;4023.879283621496;4039.4950631171105;4045.5436043024633;4055.4119652650347;4056.7565946043183;4019.9799001004953;4026.6174713402474;4027.697922655798;4028.5568587455355;4057.57395473474;3449.379111759882;3547.9645203547893;3584.193556449804;3585.4980302757635;3589.5103532034173;5045.84862454127;5059.696418214919;5063.645544811865;5070.974645126751;5074.264231686422;4641.466231383401;4641.563179330845;4645.605123564501;4648.5583869532675;4658.720476771405;5264.8683782905355;5360.410354860962;5363.602842251116;5387.299651045379;5439.809606663787;3878.534575850916;3898.298306304864;3901.6878649708237;3913.591107201405;3914.3345631242755;5523.447655234485;5536.695481748502;5569.303837020372;5569.443055694479;5582.190582365534;3856.3829787234467;3920.862769803043;3950.459320864865;3969.960300396959;3970.5235371755575;3987.302222111119;3993.66053885423;4006.819693113817;4008.8596899108975;4018.176273863851;4557.521460246627;4562.768052625773;4572.0855828834365;4581.770911454414;4583.610393116555;5272.92090618641;5395.595330350239;5419.3225846769155;5423.593230507728;5428.4842939920645;1365.877071063609;1393.261571367177;1396.2599822094305;1397.6785339371797;1400.4888215801159;863.4775960543906;894.6868595991351;898.8651702244584;902.6299217320867;908.1735620585235;4694.272387779832;4699.812007519729;4708.9058218835435;4715.693479923794;4720.362751028567;4880.194328098555;4882.584980276716;4884.975575122102;4886.877828054256;4894;4377.898608667793;4687.296905464208;4694.906101877943;4707.811687532529;4720.362751028636;2598.974010259911;2608.2175347395705;2608.2305719812703;2615.856127912945;2622.069165446239;5049.065922804293;5055.469175736494;5081.256121694318;5082.898342033212;5097.490250974947;4723.952760472352;4836;4919.754012299442;4925.38432695913;4937.901241975141;5045.747712614355;5053.570446512088;5061.772220250097;5064.493075927366;5074.847754567369;4832.323474713473;4848.442429120696;4859.493556997342;4860.538248866352;4875.512448755097;4596.701649175412;4812.25410061441;4816.325714399917;4820.204666230033;4827.25177597473;5028.516587606738;5058.443571207238;5064.974675126601;5066.493350664904;5075.4417014127675;3637.7635453695425;3770.5286839145106;3873.1479074603544;3876.379779235309;4004.899877502969;5436.673799572039;5475.561955043508;5485.50630443262;5514.117741161395;5531.502164805187;5339.546138578265;5343.465653434625;5380;5395.919061214006;5401.810936617199;5172.146595811649;5363.329583802025;5363.892722145613;5366.302380690485;5379.879669791433;5314.1497360422145;5326.760295786621;5339.958708051892;5363.2759577456545;5375;5215.713135777569;5366.490183432567;5390.919136213039;5403.459654034722;5409.864753381197;5312.814051508179;5367.543758780547;5369.946300537101;5371.462853714597;5371.946280537145 08:57:39 INFO - PROCESS | 14718 | |5;yui.html;704.7075463682572;727.4871215792866;756.2550887375934;767.1408023014224;792.7542461836829;14520.709585808278;15621.531354059369;15622.531324060297;15640.608984775386;15664.608384790372;13896.235707036134;13943.093698909564;13956.581302560939;13975.16149031059;14073.92963035186;631.0880777276836;644.880697071041;761.7714685594327;769.2269269384275;781.281221276427;771.0708596141636;771.8301973565834;774.601080443572;775.5773103658491;775.871981123114;807.4388300131411;809.6558962440969;810.1979040749645;810.3517186251005;811.111832543367;658.4600627485464;676.2020815437756;781.8123650323938;800.591698233899;807.0718673525434;584.5469760935266;584.666739958224;584.6725833533235;584.8450160707416;585.3765739487433;13708.65728356799;13753.79369309461;13760;13780.242086685228;13802.65493362664;12579.308138052404;12732.108752387336;12947.935260323733;12985.285809280485;13048.608541743668;11723.746339131032;11894.405279735978;11971.760564788656;12442.56451024219;12552.184108032949;4263.317869140954;4284.378765079077;4291.377750226231;4293.635041021517;4376.168527979706;58945;59095.11357329643;59564.40435595632;59935.40064599342;62467;10364.429956352322;10434.68695939123;10518.526666300035;10570.735731606772;10591.779706864705;19017.80982190188;19046.809531904782;19076.809231907504;19098.71351929722;19196.80803191978;7558.622068896533;7583.317501424788;7699.692012319444;7950.363970882316;8126.146754590801;4173.436586060903;4197.601227883346;4244.554321796167;4293.334533147367;4326.199653064194;3082.9075127746205;3161.9051428456723;3162.4623813951684;3163.5412865134426;3167.04988503448;523.5288240583506;537.6988886223727;542.381684879238;546.4235231830457;548.4241546376289;552.4089224529714;625.5527297981873;657.3623585122424;659.9043138744855;671.60641668537;8309.169083091763;8356.456830306011;8586.48481091124;8809.471431714117;8917.509536975529;549.0939949084043;600.9423414790001;606.6087373644064;651.5691709600533;667.4511277452033;4108.897277568085;4156.9792151039055;4204.2432362175105;4205.3481710334945;4234.237837189336;52959.73520132452;53563.46436535662;67605.32394676088;68576.6571167141;70595.64702176559;42305.365419518734;43531.347029794575;54220.728896355264;67121.66439167772;69613.3038669617;39237.41143882844;51756;56976.43023569794;61570.38429615736;63056.054159187646;8596.653812043496;8901.955490222508;8935.419197752126;8956.910430895869;9053.366264361432;44946.3258051123;45233;45482.54517454783;45608.31587526256;45797.54202457933;52951.47048529465;57938.4206157933;58183;58428;60180.097298541434;11718.179727419;12324.50701971947;12409.193402428813;12418.446356651444;12644.178128421623;13547.25490098054;13882.791758123838;13895.166290022631;14393.136411815325;14622.268886555843;11975.76048479008;11978.700532486757;12056.216345937486;12365.258084514959;12374.319412432402;10964.06805421548;11955.103367247317;12069.57756478554;12285.447154878231;12416.317102559085;11768.176227663982;12084.274943503418;12435.875641243834;12487.500499980262;12800.871991279968;11002.174836887425;11533.077353811843;11824.23142495735;11837.940810295893;12145.453454594388;10030.799384012425;10788.838167427339;10899.509522071685;10990.120790336594;10990.945045274722 08:57:39 INFO - PROCESS | 14718 | __end_tp_report 08:57:39 INFO - PROCESS | 14718 | __start_cc_report 08:57:39 INFO - PROCESS | 14718 | _x_x_mozilla_cycle_collect,2558 08:57:39 INFO - PROCESS | 14718 | __end_cc_report 08:57:39 INFO - PROCESS | 14718 | __startTimestamp1477929459226__endTimestamp 08:57:39 INFO - PROCESS | 14718 | 08:57:39 INFO - PROCESS | 14718 | ------- Summary: start ------- 08:57:39 INFO - PROCESS | 14718 | Number of tests: 6 08:57:39 INFO - PROCESS | 14718 | 08:57:39 INFO - PROCESS | 14718 | [#0] dojo.html Cycles:165 Average:5333.25 Median:5558.31 stddev:705.38 (12.7%) stddev-sans-first:683.19 08:57:39 INFO - PROCESS | 14718 | Values: 2990.7 3047.4 3055.5 3060.7 3065.9 5235.2 5310.2 5351.2 5425.5 5448.9 5339.7 5342.1 5350.5 5352.6 5352.9 4820.4 4826.5 4849.2 4870.9 4911.3 4885.3 4895.4 4916.7 4940.7 4992.0 4985.1 4988.2 4989.6 4993.1 5026.1 722.1 4887.2 4897.2 4923.0 4983.1 4910.3 4911.1 4912.6 4922.4 4944.3 5393.7 5395.2 5396.1 5430.2 5451.5 5536.4 5576.0 5582.2 5652.4 5752.6 5759.9 5772.5 5807.1 5860.8 5878.1 5371.9 5382.4 5386.6 5388.7 5404.2 5656.6 5709.2 5878.4 5888.9 5893.3 5564.0 5640.9 5646.9 5669.5 5739.3 5739.7 5748.9 5750.3 5751.1 5758.1 5551.6 5634.2 5717.0 5733.9 5736.7 5586.6 5695.3 5698.4 5703.5 5705.6 4432.2 4434.2 4436.4 4441.4 4441.4 3926.8 3989.7 4005.7 4015.7 4043.9 5519.4 5547.4 5555.2 5558.3 5558.5 5798.2 5813.0 5819.1 5826.4 5883.4 5394.3 5429.1 5498.0 5545.8 5549.4 5049.5 5055.1 5058.3 5058.9 5104.8 6062.6 6100.3 6100.3 6102.1 6112.1 5616.3 5676.3 5682.8 5779.0 5795.7 5962.8 6020.7 6035.1 6043.4 6134.8 5692.6 5695.7 5696.3 5746.1 5748.6 5732.7 5748.9 5791.8 5800.8 5804.7 5498.5 5551.6 5556.9 5655.7 5666.4 5624.1 5624.6 5627.7 5630.7 5638.8 5601.1 5605.4 5606.4 5607.1 5609.2 5593.5 5640.3 5648.0 5651.2 5663.7 5469.3 5519.1 5532.8 5537.2 5545.3 08:57:39 INFO - PROCESS | 14718 | 08:57:39 INFO - PROCESS | 14718 | [#1] ext.html Cycles:180 Average:56572.78 Median:369937.50 stddev:110572.05 (29.9%) stddev-sans-first:110802.34 08:57:39 INFO - PROCESS | 14718 | Values: 589.5 599.8 600.8 609.4 610.2 30621.1 40537.6 42222.8 42248.0 46311.5 44092.8 44582.6 44588.8 44733.6 44747.3 7988.4 8772.1 8904.1 8906.5 8911.6 8102.6 8253.1 8255.0 10123.9 10415.2 10381.6 10416.9 10416.9 10419.2 10426.9 10507.2 10546.2 10565.6 10569.0 10578.1 10512.8 10551.8 10581.3 10582.0 10587.8 40549.0 40794.0 40823.6 40884.8 40970.8 3388.3 3458.6 3543.8 3788.4 4045.7 30190.0 30208.0 30730.0 30908.1 30956.0 4429.2 4432.4 4438.6 4460.4 4507.5 324918.0 326676.0 327223.0 328018.0 328842.0 57229.4 57508.7 57633.4 57660.1 57675.7 34338.0 35188.3 35338.5 37343.0 55522.2 13958.9 13959.8 13977.2 14017.7 14019.4 10885.3 11608.6 11815.1 11824.7 11847.5 15910.9 17981.0 18279.2 18696.5 19064.5 6684.0 6890.7 6935.5 6952.2 7167.7 920.5 941.8 1050.3 1072.7 1074.5 30876.2 31485.2 31496.7 31497.7 31927.0 1019.6 1095.5 1120.9 1154.6 1174.7 15607.9 16278.7 16290.9 16408.3 16490.6 518866.0 527853.0 529064.0 529432.0 531483.0 55064.7 55547.4 55579.7 55596.4 55691.2 1193.2 1224.1 1275.3 1314.3 1350.7 30177.5 32058.7 32283.0 32318.4 32758.8 46541.8 47171.8 47256.0 47280.8 47318.8 368421.0 371454.0 371547.0 371683.0 371812.0 26419.5 26454.9 27308.0 27460.2 28925.0 45179.7 45506.8 46055.5 46582.3 46956.5 38185.2 38203.8 39968.8 40082.8 40513.0 38531.4 39448.6 40243.8 40933.8 41242.8 39515.6 40328.6 40524.6 40671.0 40699.4 33177.7 34736.5 34794.3 41805.8 43341.8 29911.9 33492.2 33651.7 33780.8 33794.2 08:57:39 INFO - PROCESS | 14718 | 08:57:39 INFO - PROCESS | 14718 | [#2] jquery.html Cycles:180 Average:27281.74 Median:1510.15 stddev:72904.32 (4827.6%) stddev-sans-first:73080.82 08:57:39 INFO - PROCESS | 14718 | Values: 366.6 368.5 392.6 393.6 415.7 13980.8 18078.4 19057.3 19322.3 20785.4 16222.9 16912.7 17030.7 17292.4 17974.0 5567.7 5870.2 5876.9 5878.5 5883.5 4251.1 4443.3 4466.6 5748.8 5804.1 6546.0 6547.4 6657.8 6687.2 6688.4 6433.9 6479.8 6525.2 6532.4 6673.2 5769.8 5782.0 5785.0 5787.1 5789.2 22469.9 23189.8 23220.9 23368.8 23505.6 2322.2 2323.4 2340.9 2630.3 2653.7 13706.0 14216.9 14894.9 15146.8 15196.3 1901.9 1921.1 1942.3 1966.3 1974.7 58529.0 71241.0 78030.6 80512.0 82193.0 10462.5 10578.6 10640.9 10986.0 11081.2 15283.6 15285.2 15305.2 15314.1 15335.4 7743.3 7948.4 8035.9 8134.8 8168.4 7695.7 7695.7 7787.8 7860.2 8017.0 6522.2 6546.8 6573.8 6728.2 6801.9 1847.9 1927.4 1928.8 1936.8 1948.7 921.6 929.0 932.1 1038.9 1051.7 20035.4 20457.6 20478.0 20783.6 20914.4 969.5 993.8 998.6 1015.6 1026.6 10867.2 11553.9 11617.1 11689.9 11810.9 433698.0 439279.2 445687.0 445805.0 447582.0 80725.0 81834.0 82537.0 83538.0 89698.6 986.8 1018.7 1033.9 1043.1 1043.8 16743.3 16852.5 17527.2 17706.9 18107.8 40988.0 41269.6 41350.8 41446.8 42063.0 52203.5 57109.0 58735.4 58907.7 60123.0 8385.7 8464.7 8600.1 8738.3 8774.8 8024.6 12693.1 12724.2 12779.4 13213.1 10790.7 10904.5 11031.9 11343.1 11797.6 10986.2 11244.4 11255.2 11316.7 11338.9 10207.7 10757.5 10856.7 11273.7 12049.3 8266.8 8409.8 8444.7 8615.6 8639.0 8050.1 10525.2 10777.5 10790.9 11322.7 08:57:39 INFO - PROCESS | 14718 | 08:57:39 INFO - PROCESS | 14718 | [#3] mootools.html Cycles:180 Average:5432.96 Median:5039.51 stddev:3017.66 (59.9%) stddev-sans-first:3010.25 08:57:39 INFO - PROCESS | 14718 | Values: 1315.2 1406.4 1446.3 1554.4 1716.7 7124.1 7812.5 8062.2 8064.3 8253.8 8106.6 8166.6 8177.0 8184.1 8194.3 2270.6 2287.0 2291.1 2291.3 2295.6 2202.0 2225.3 2300.1 2306.8 2318.5 2210.0 2256.0 2290.9 2292.2 2304.2 2200.8 2207.6 2212.8 2215.3 2220.7 2229.9 2256.0 2257.2 2257.5 2257.6 8119.1 8233.8 8314.7 8316.8 8324.9 4943.2 5158.5 5158.8 5161.6 5165.5 3365.5 3467.4 3509.2 3523.7 3531.4 1172.3 1186.2 1191.6 1200.6 1207.2 11151.5 11210.7 11289.5 11304.2 11318.1 3946.8 4360.5 4437.9 4510.8 4516.3 9001.1 9010.2 9013.6 9055.4 9076.8 4930.8 4936.7 4941.7 4943.9 4949.9 3990.5 4134.6 4330.6 4625.1 4631.7 3571.4 3607.6 3669.5 3671.1 3703.2 1108.7 1132.0 1133.6 1134.5 1136.5 827.9 929.3 932.8 956.6 974.3 5654.3 5665.1 5675.3 5714.6 5823.7 902.2 912.9 914.0 922.9 950.6 3786.7 3868.7 3875.9 3895.5 3981.7 9994.2 10410.7 10439.4 10476.3 10476.5 10130.7 10429.4 10456.9 10462.6 10492.9 7593.4 7882.0 7882.6 7919.3 7923.3 5495.6 5660.3 5674.2 5749.7 5868.1 9362.0 9460.3 9470.3 9489.7 9498.2 8364.2 9361.2 9546.1 9567.8 9724.6 6386.6 6782.4 6885.2 6911.6 7103.6 7915.7 7988.6 8021.2 8101.3 8154.9 7075.3 7143.0 7154.5 7193.7 7200.9 6918.6 6964.7 7115.4 7188.8 7190.4 6370.1 6378.6 6463.6 6464.9 6466.1 4946.5 4974.6 4984.9 5062.9 5249.1 4741.8 4930.5 5016.1 5131.4 5147.7 08:57:39 INFO - PROCESS | 14718 | 08:57:39 INFO - PROCESS | 14718 | [#4] prototype.html Cycles:180 Average:4384.35 Median:4868.03 stddev:1254.72 (25.8%) stddev-sans-first:1220.57 08:57:39 INFO - PROCESS | 14718 | Values: 319.0 325.5 330.3 330.6 333.8 5073.9 5216.3 5237.2 5251.1 5270.5 5109.9 5150.9 5162.9 5197.2 5237.9 4104.2 4108.8 4118.8 4119.5 4132.9 3892.7 4043.2 4110.9 4111.3 4126.3 4023.9 4039.5 4045.5 4055.4 4056.8 4020.0 4026.6 4027.7 4028.6 4057.6 3449.4 3548.0 3584.2 3585.5 3589.5 5045.8 5059.7 5063.6 5071.0 5074.3 4641.5 4641.6 4645.6 4648.6 4658.7 5264.9 5360.4 5363.6 5387.3 5439.8 3878.5 3898.3 3901.7 3913.6 3914.3 5523.4 5536.7 5569.3 5569.4 5582.2 3856.4 3920.9 3950.5 3970.0 3970.5 3987.3 3993.7 4006.8 4008.9 4018.2 4557.5 4562.8 4572.1 4581.8 4583.6 5272.9 5395.6 5419.3 5423.6 5428.5 1365.9 1393.3 1396.3 1397.7 1400.5 863.5 894.7 898.9 902.6 908.2 4694.3 4699.8 4708.9 4715.7 4720.4 4880.2 4882.6 4885.0 4886.9 4894.0 4377.9 4687.3 4694.9 4707.8 4720.4 2599.0 2608.2 2608.2 2615.9 2622.1 5049.1 5055.5 5081.3 5082.9 5097.5 4724.0 4836.0 4919.8 4925.4 4937.9 5045.7 5053.6 5061.8 5064.5 5074.8 4832.3 4848.4 4859.5 4860.5 4875.5 4596.7 4812.3 4816.3 4820.2 4827.3 5028.5 5058.4 5065.0 5066.5 5075.4 3637.8 3770.5 3873.1 3876.4 4004.9 5436.7 5475.6 5485.5 5514.1 5531.5 5339.5 5343.5 5380.0 5395.9 5401.8 5172.1 5363.3 5363.9 5366.3 5379.9 5314.1 5326.8 5340.0 5363.3 5375.0 5215.7 5366.5 5390.9 5403.5 5409.9 5312.8 5367.5 5369.9 5371.5 5371.9 08:57:39 INFO - PROCESS | 14718 | 08:57:39 INFO - PROCESS | 14718 | [#5] yui.html Cycles:180 Average:15713.63 Median:23928.77 stddev:19095.24 (79.8%) stddev-sans-first:19115.54 08:57:39 INFO - PROCESS | 14718 | Values: 704.7 727.5 756.3 767.1 792.8 14520.7 15621.5 15622.5 15640.6 15664.6 13896.2 13943.1 13956.6 13975.2 14073.9 631.1 644.9 761.8 769.2 781.3 771.1 771.8 774.6 775.6 775.9 807.4 809.7 810.2 810.4 811.1 658.5 676.2 781.8 800.6 807.1 584.5 584.7 584.7 584.8 585.4 13708.7 13753.8 13760.0 13780.2 13802.7 12579.3 12732.1 12947.9 12985.3 13048.6 11723.7 11894.4 11971.8 12442.6 12552.2 4263.3 4284.4 4291.4 4293.6 4376.2 58945.0 59095.1 59564.4 59935.4 62467.0 10364.4 10434.7 10518.5 10570.7 10591.8 19017.8 19046.8 19076.8 19098.7 19196.8 7558.6 7583.3 7699.7 7950.4 8126.1 4173.4 4197.6 4244.6 4293.3 4326.2 3082.9 3161.9 3162.5 3163.5 3167.0 523.5 537.7 542.4 546.4 548.4 552.4 625.6 657.4 659.9 671.6 8309.2 8356.5 8586.5 8809.5 8917.5 549.1 600.9 606.6 651.6 667.5 4108.9 4157.0 4204.2 4205.3 4234.2 52959.7 53563.5 67605.3 68576.7 70595.6 42305.4 43531.3 54220.7 67121.7 69613.3 39237.4 51756.0 56976.4 61570.4 63056.1 8596.7 8902.0 8935.4 8956.9 9053.4 44946.3 45233.0 45482.5 45608.3 45797.5 52951.5 57938.4 58183.0 58428.0 60180.1 11718.2 12324.5 12409.2 12418.4 12644.2 13547.3 13882.8 13895.2 14393.1 14622.3 11975.8 11978.7 12056.2 12365.3 12374.3 10964.1 11955.1 12069.6 12285.4 12416.3 11768.2 12084.3 12435.9 12487.5 12800.9 11002.2 11533.1 11824.2 11837.9 12145.5 10030.8 10788.8 10899.5 10990.1 10990.9 08:57:39 INFO - PROCESS | 14718 | -------- Summary: end -------- 08:57:39 INFO - PROCESS | 14718 | 08:57:40 INFO - TEST-INFO | 14718: exit 0 08:57:40 INFO - TEST-OK | dromaeo_css | took 1118259ms 08:57:40 INFO - TEST-START | kraken 08:57:40 INFO - operating with platform_type : linux_ 08:57:40 INFO - Initialising browser for kraken test... 08:57:40 INFO - TEST-INFO | started process 15026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4B_pPW/profile http://localhost:51102/getInfo.html) 08:57:43 INFO - PROCESS | 15026 | __metrics Screen width/height:1600/1200 08:57:43 INFO - PROCESS | 15026 | colorDepth:24 08:57:43 INFO - PROCESS | 15026 | Browser inner width/height: 1024/697 08:57:43 INFO - PROCESS | 15026 | __metrics 08:57:44 INFO - PROCESS | 15026 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:57:44 INFO - PROCESS | 15026 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:45 INFO - PROCESS | 15026 | console.error: PushService: 08:57:45 INFO - PROCESS | 15026 | stateChangeProcessEnqueue: Error transitioning state 08:57:45 INFO - PROCESS | 15026 | UnknownError 08:57:45 INFO - TEST-INFO | 15026: exit 0 08:57:45 INFO - Browser initialized. 08:57:45 INFO - Running cycle 1/1 for kraken test... 08:57:45 INFO - TEST-INFO | started process 15110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4B_pPW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:57 INFO - PROCESS | 15110 | RSS: Main: 172867584 08:57:57 INFO - PROCESS | 15110 | 08:58:00 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51102/tests/kraken/driver.html?testName=audio-beat-detection) 08:58:01 INFO - PROCESS | 15110 | RSS: Main: 233611264 08:58:01 INFO - PROCESS | 15110 | 08:58:03 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51102/tests/kraken/driver.html?testName=audio-dft) 08:58:04 INFO - PROCESS | 15110 | RSS: Main: 216592384 08:58:04 INFO - PROCESS | 15110 | 08:58:07 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51102/tests/kraken/driver.html?testName=audio-fft) 08:58:08 INFO - PROCESS | 15110 | RSS: Main: 297820160 08:58:08 INFO - PROCESS | 15110 | 08:58:10 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51102/tests/kraken/driver.html?testName=audio-oscillator) 08:58:10 INFO - PROCESS | 15110 | RSS: Main: 207179776 08:58:10 INFO - PROCESS | 15110 | 08:58:12 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51102/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:58:13 INFO - PROCESS | 15110 | RSS: Main: 212144128 08:58:13 INFO - PROCESS | 15110 | 08:58:16 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51102/tests/kraken/driver.html?testName=imaging-darkroom) 08:58:17 INFO - PROCESS | 15110 | RSS: Main: 248819712 08:58:17 INFO - PROCESS | 15110 | 08:58:20 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51102/tests/kraken/driver.html?testName=imaging-desaturate) 08:58:21 INFO - PROCESS | 15110 | RSS: Main: 247664640 08:58:21 INFO - PROCESS | 15110 | 08:58:23 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51102/tests/kraken/driver.html?testName=json-parse-financial) 08:58:24 INFO - PROCESS | 15110 | RSS: Main: 246743040 08:58:24 INFO - PROCESS | 15110 | 08:58:25 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51102/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:58:26 INFO - PROCESS | 15110 | RSS: Main: 209358848 08:58:26 INFO - PROCESS | 15110 | 08:58:28 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51102/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:58:28 INFO - PROCESS | 15110 | RSS: Main: 216702976 08:58:28 INFO - PROCESS | 15110 | 08:58:30 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51102/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:58:31 INFO - PROCESS | 15110 | RSS: Main: 226328576 08:58:31 INFO - PROCESS | 15110 | 08:58:34 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:58:34 INFO - PROCESS | 15110 | RSS: Main: 235073536 08:58:34 INFO - PROCESS | 15110 | 08:58:37 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:58:38 INFO - PROCESS | 15110 | RSS: Main: 231792640 08:58:38 INFO - PROCESS | 15110 | 08:58:39 INFO - PROCESS | 15110 | Cycle 1(1): loaded http://localhost:51102/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51102/tests/kraken/driver.html?testName=ai-astar) 08:58:40 INFO - PROCESS | 15110 | RSS: Main: 282533888 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | __start_tp_report 08:58:40 INFO - PROCESS | 15110 | _x_x_mozilla_page_load 08:58:40 INFO - PROCESS | 15110 | _x_x_mozilla_page_load_details 08:58:40 INFO - PROCESS | 15110 | |i|pagename|runs| 08:58:40 INFO - PROCESS | 15110 | |0;ai-astar;102;112;111;110;111;112;112;111;111;110 08:58:40 INFO - PROCESS | 15110 | |1;audio-beat-detection;147;125;122;170;124;126;129;122;159;122 08:58:40 INFO - PROCESS | 15110 | |2;audio-dft;161;160;161;161;161;161;162;161;163;163 08:58:40 INFO - PROCESS | 15110 | |3;audio-fft;76;77;76;108;77;76;77;76;99;76 08:58:40 INFO - PROCESS | 15110 | |4;audio-oscillator;83;82;111;84;84;83;116;83;82;114 08:58:40 INFO - PROCESS | 15110 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;116;116;117 08:58:40 INFO - PROCESS | 15110 | |6;imaging-darkroom;146;146;146;146;145;146;146;147;145;146 08:58:40 INFO - PROCESS | 15110 | |7;imaging-desaturate;85;86;86;86;87;86;85;85;85;85 08:58:40 INFO - PROCESS | 15110 | |8;json-parse-financial;53;52;52;53;54;54;53;53;54;54 08:58:40 INFO - PROCESS | 15110 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;62;63;63 08:58:40 INFO - PROCESS | 15110 | |10;stanford-crypto-aes;80;80;80;82;79;79;81;79;79;83 08:58:40 INFO - PROCESS | 15110 | |11;stanford-crypto-ccm;133;141;131;135;148;128;133;134;171;129 08:58:40 INFO - PROCESS | 15110 | |12;stanford-crypto-pbkdf2;167;165;164;167;165;168;165;165;165;161 08:58:40 INFO - PROCESS | 15110 | |13;stanford-crypto-sha256-iterative;65;69;64;64;63;64;63;66;65;63 08:58:40 INFO - PROCESS | 15110 | __end_tp_report 08:58:40 INFO - PROCESS | 15110 | __start_cc_report 08:58:40 INFO - PROCESS | 15110 | _x_x_mozilla_cycle_collect,1696 08:58:40 INFO - PROCESS | 15110 | __end_cc_report 08:58:40 INFO - PROCESS | 15110 | __startTimestamp1477929520071__endTimestamp 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | ------- Summary: start ------- 08:58:40 INFO - PROCESS | 15110 | Number of tests: 14 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.97 (2.7%) stddev-sans-first:0.78 08:58:40 INFO - PROCESS | 15110 | Values: 102.0 112.0 111.0 110.0 111.0 112.0 112.0 111.0 111.0 110.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:127.50 stddev:17.60 (13.8%) stddev-sans-first:18.09 08:58:40 INFO - PROCESS | 15110 | Values: 147.0 125.0 122.0 170.0 124.0 126.0 129.0 122.0 159.0 122.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:58:40 INFO - PROCESS | 15110 | Values: 161.0 160.0 161.0 161.0 161.0 161.0 162.0 161.0 163.0 163.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.50 stddev:11.64 (15.2%) stddev-sans-first:12.16 08:58:40 INFO - PROCESS | 15110 | Values: 76.0 77.0 76.0 108.0 77.0 76.0 77.0 76.0 99.0 76.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.00 stddev:14.88 (17.9%) stddev-sans-first:15.40 08:58:40 INFO - PROCESS | 15110 | Values: 83.0 82.0 111.0 84.0 84.0 83.0 116.0 83.0 82.0 114.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:58:40 INFO - PROCESS | 15110 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 116.0 117.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:58:40 INFO - PROCESS | 15110 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 146.0 147.0 145.0 146.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 08:58:40 INFO - PROCESS | 15110 | Values: 85.0 86.0 86.0 86.0 87.0 86.0 85.0 85.0 85.0 85.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:0.79 (1.5%) stddev-sans-first:0.83 08:58:40 INFO - PROCESS | 15110 | Values: 53.0 52.0 52.0 53.0 54.0 54.0 53.0 53.0 54.0 54.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 08:58:40 INFO - PROCESS | 15110 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:1.40 (1.7%) stddev-sans-first:1.48 08:58:40 INFO - PROCESS | 15110 | Values: 80.0 80.0 80.0 82.0 79.0 79.0 81.0 79.0 79.0 83.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:134.50 stddev:12.92 (9.6%) stddev-sans-first:13.56 08:58:40 INFO - PROCESS | 15110 | Values: 133.0 141.0 131.0 135.0 148.0 128.0 133.0 134.0 171.0 129.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.00 stddev:1.93 (1.2%) stddev-sans-first:1.94 08:58:40 INFO - PROCESS | 15110 | Values: 167.0 165.0 164.0 167.0 165.0 168.0 165.0 165.0 165.0 161.0 08:58:40 INFO - PROCESS | 15110 | 08:58:40 INFO - PROCESS | 15110 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:1.84 (2.8%) stddev-sans-first:1.94 08:58:40 INFO - PROCESS | 15110 | Values: 65.0 69.0 64.0 64.0 63.0 64.0 63.0 66.0 65.0 63.0 08:58:40 INFO - PROCESS | 15110 | -------- Summary: end -------- 08:58:40 INFO - PROCESS | 15110 | 08:58:41 INFO - TEST-INFO | 15110: exit 0 08:58:41 INFO - TEST-OK | kraken | took 61097ms 08:58:41 INFO - SUITE-END | took 1179s 08:58:41 INFO - Completed test suite (00:19:39) 08:58:41 INFO - javascript benchmark 08:58:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2990.715881991211, 3047.360054388578, 3055.4500189965825, 3060.739837113845, 3065.8620362083702, 5235.1885457754015, 5310.176922576997, 5351.197320401937, 5425.511703946649, 5448.863778405542, 5339.679619222849, 5342.1452567589195, 5350.5184533391985, 5352.57179425646, 5352.9197062044, 4820.39745031871, 4826.517348265181, 4849.175640141185, 4870.878228044292, 4911.287863259825, 4885.267209918505, 4895.437024742165, 4916.704997700132, 4940.678855874375, 4992.0, 4985.102681517325, 4988.226824842137, 4989.57588604969, 4993.051320249141, 5026.070177017245, 722.0816300045423, 4887.218045112765, 4897.240927656219, 4923.040007198598, 4983.103041452537, 4910.337104490919, 4911.066897289539, 4912.557869791736, 4922.384701912261, 4944.283078953567, 5393.7303134843105, 5395.244665746799, 5396.10964190908, 5430.212619170237, 5451.509364157245, 5536.363318218416, 5575.972120139373, 5582.218489411485, 5652.378238393773, 5752.597318187729, 5759.913601295984, 5772.538196944276, 5807.070868660994, 5860.7948721794955, 5878.118282257653, 5371.919421208685, 5382.3541175059245, 5386.622936394454, 5388.703621300827, 5404.162354835007, 5656.575756818255, 5709.172170035322, 5878.441548053013, 5888.911666324922, 5893.263342082239, 5563.972180139073, 5640.8871822563315, 5646.85882852932, 5669.518090962232, 5739.253896993364, 5739.65562066269, 5748.856278593069, 5750.338711048199, 5751.1085781703905, 5758.107493338539, 5551.639143455663, 5634.1830434586755, 5717.0, 5733.856653583611, 5736.741846616912, 5586.608937374426, 5695.316562012502, 5698.401667824902, 5703.486686198179, 5705.600607957486, 4432.180046691373, 4434.224010798098, 4436.378906953029, 4441.400410944481, 4441.400410944546, 3926.842926282917, 3989.7207195496617, 4005.679545636342, 4015.678745700337, 4043.8584649537124, 5519.420460851633, 5547.44525547442, 5555.194496798023, 5558.305211848519, 5558.499735023867, 5798.188253644409, 5813.040848260074, 5819.098039803837, 5826.388229235954, 5883.411658834168, 5394.298741163623, 5429.104197807396, 5498.0, 5545.77816887328, 5549.38956714761, 5049.520295571915, 5055.090083784954, 5058.342415486037, 5058.898822023539, 5104.770285337168, 6062.575619706667, 6100.267967843798, 6100.328963813889, 6102.084687296852, 6112.144299798032, 5616.297962754656, 5676.347220069745, 5682.801101961411, 5779.0464573344925, 5795.652260864362, 5962.761489540369, 6020.729067191899, 6035.1249068885645, 6043.395660434097, 6134.78528251509, 5692.5730570208225, 5695.715214239354, 5696.316442026983, 5746.13807928814, 5748.626339287933, 5732.656040637575, 5748.913766293425, 5791.82624521265, 5800.796972105956, 5804.65172089676, 5498.477644623755, 5551.639143455663, 5556.888862222652, 5655.660660360391, 5666.433356664301, 5624.072028115479, 5624.550035997028, 5627.690477023803, 5630.662160270397, 5638.830835074954, 5601.103823388238, 5605.411431799603, 5606.411326810626, 5607.130894711327, 5609.158626206102, 5593.524550413261, 5640.32316122068, 5648.039833228278, 5651.208830763779, 5663.716814159193, 5469.343678758574, 5519.116941289374, 5532.75102620375, 5537.169424586345, 5545.279113715191], "value": 5287.160143745123, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.4783116941506, 599.7990673124503, 600.765701376463, 609.3875654966763, 610.1671218786355, 30621.10062390018, 40537.59462405379, 42222.78888605557, 42248.0, 46311.53688463115, 44092.77953610235, 44582.554174458244, 44588.777056114755, 44733.55266447343, 44747.328790068175, 7988.4408091433625, 8772.122787721224, 8904.065073167321, 8906.51014194219, 8911.598978046004, 8102.5543595102245, 8253.09215986241, 8254.958725206396, 10123.898761012406, 10415.16678665705, 10381.636642717507, 10416.906224846396, 10416.947915260413, 10419.166466682647, 10426.895731042707, 10507.159427245802, 10546.156307495383, 10565.630202942899, 10569.048785609255, 10578.100861426788, 10512.789744205073, 10551.78896422075, 10581.31221470602, 10582.0, 10587.788244235073, 40549.0, 40794.0, 40823.59176408257, 40884.79557602193, 40970.79514602438, 3388.3223355329033, 3458.56767904012, 3543.8050907200095, 3788.412796016622, 4045.6965727570255, 30190.0, 30208.0, 30730.0, 30908.14551126917, 30956.047032474922, 4429.202743506167, 4432.3794668746405, 4438.578335058197, 4460.43022307127, 4507.459104907432, 324918.0, 326676.0, 327223.0, 328018.0, 328841.9999999976, 57229.42770572324, 57508.71245643745, 57633.42366576364, 57660.135097973565, 57675.71162144246, 34338.0, 35188.29623407518, 35338.469922951175, 37343.0, 55522.16716749252, 13958.930205348908, 13959.79060314096, 13977.16137031761, 14017.71964560703, 14019.439222431192, 10885.346879187116, 11608.593699220486, 11815.113866459878, 11824.704382390337, 11847.466863991142, 15910.920445397698, 17981.044170282516, 18279.1774370151, 18696.53258668544, 19064.523386915436, 6683.966580167068, 6890.726904720218, 6935.549189302679, 6952.165740111219, 7167.677454514559, 920.5305294299956, 941.8493041113526, 1050.3382868792764, 1072.7157303314627, 1074.4896174317137, 30876.22809429782, 31485.212869677984, 31496.68503314983, 31497.685023149475, 31927.0, 1019.587067237755, 1095.4905968724422, 1120.8991190792706, 1154.584349634131, 1174.7356844710043, 15607.921960390126, 16278.67442651164, 16290.918545407198, 16408.343666253455, 16490.58773530671, 518866.0, 527853.0, 529064.0, 529432.0, 531483.0, 55064.72467637636, 55547.44452555504, 55579.72210139004, 55596.444035559936, 55691.16463253054, 1193.1588230297618, 1224.1125184241532, 1275.304958797439, 1314.3296918571598, 1350.6893414514716, 30177.54733678953, 32058.6794132065, 32283.0, 32318.35363292768, 32758.836205818818, 46541.76729116333, 47171.764141179076, 47256.0, 47280.7635961818, 47318.76340618275, 368421.0, 371454.0, 371547.0, 371683.0, 371812.0, 26419.471610568067, 26454.86772566125, 27308.0, 27460.194465968776, 28925.0, 45179.741012949875, 45506.77246613746, 46055.53944460512, 46582.30126548037, 46956.53043469522, 38185.236295274495, 38203.80898095492, 39968.800156000194, 40082.799586001885, 40513.0, 38531.42202866903, 39448.605513945644, 40243.798781005906, 40933.79533102315, 41242.79378603088, 39515.604843951194, 40328.59671403249, 40524.59475405208, 40671.0, 40699.3895091568, 33177.66822331746, 34736.478952815225, 34794.25760786984, 41805.79097104495, 43341.783291083346, 29911.850440747658, 33492.1626959328, 33651.66348336485, 33780.831095845344, 33794.15514612154], "value": 19640.047455071373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5601278465842, 368.51356209803055, 392.60935369307543, 393.5513514593364, 415.6674660271782, 13980.790288145687, 18078.367257146, 19057.33299334522, 19322.32371866985, 20785.376438706862, 16222.918885405586, 16912.746308805377, 17030.744538831896, 17292.394766183184, 17974.01142937141, 5567.721613919308, 5870.178175055496, 5876.853078673024, 5878.529717622601, 5883.529317654598, 4251.0860165064505, 4443.289073748201, 4466.5980061794435, 5748.798792042279, 5804.100364443518, 6545.967270163643, 6547.377999090078, 6657.833554161136, 6687.164104486939, 6688.431483323923, 6433.93566064338, 6479.833629946607, 6525.216973963107, 6532.444742196919, 6673.23257825349, 5769.826905192809, 5782.045962416239, 5784.971075144597, 5787.102999035156, 5789.16057171712, 22469.887650561643, 23189.76810231893, 23220.883895580584, 23368.76631233683, 23505.647415288786, 2322.222055611372, 2323.3726893738594, 2340.871252081135, 2630.302969713028, 2653.7478939500716, 13706.0, 14216.92891535546, 14894.925525372304, 15146.772798408032, 15196.316165772567, 1901.895395753233, 1921.135489029928, 1942.3298961858277, 1966.3412756726514, 1974.664307067802, 58529.0, 71241.0, 78030.6098469504, 80511.99999999942, 82193.0, 10462.529186186639, 10578.629747958785, 10640.893591064145, 10986.0, 11081.168912331608, 15283.624473797412, 15285.159316237714, 15305.158216297988, 15314.081155130727, 15335.386584536716, 7743.303102720783, 7948.403869709679, 8035.919640803517, 8134.75595732129, 8168.387370947203, 7695.653695583712, 7695.730649427243, 7787.844243115219, 7860.174681658458, 8016.997875265592, 6522.184726909137, 6546.770863019867, 6573.80278591643, 6728.226253980757, 6801.863962720718, 1847.8614103941989, 1927.4410420977758, 1928.816762407569, 1936.786953435121, 1948.6882098864114, 921.5714692667941, 928.99668358173, 932.0865551759314, 1038.896110388955, 1051.673981065872, 20035.39893803188, 20457.590848182954, 20478.0, 20783.584328313653, 20914.37256882296, 969.5297780576415, 993.7515621094726, 998.565623953568, 1015.5785349080197, 1026.573971801694, 10867.184961127947, 11553.942230288963, 11617.070634349231, 11689.941550292195, 11810.88189118115, 433698.0, 439279.2144157163, 445687.0, 445805.0, 447582.0, 80725.0, 81834.0, 82537.0, 83538.0, 89698.55150724335, 986.8026394721085, 1018.7402212435782, 1033.8552602635637, 1043.0508237503834, 1043.801677681238, 16743.33026678968, 16852.494425167264, 17527.21127549289, 17706.91146544259, 18107.81892181114, 40988.0, 41269.587304127774, 41350.79738039318, 41446.79276603598, 42063.0, 52203.47796521986, 57109.0, 58735.412645872995, 58907.70546147242, 60123.0, 8385.706500272461, 8464.687973364138, 8600.1399860016, 8738.300935925237, 8774.780630484034, 8024.558649274346, 12693.111482196158, 12724.1729287596, 12779.36103194855, 13213.075084743976, 10790.73023174427, 10904.50929708181, 11031.889681103406, 11343.149263805082, 11797.646070617895, 10986.230963832455, 11244.381559014006, 11255.155863310121, 11316.660500185008, 11338.943305283421, 10207.7448063799, 10757.515911783832, 10856.674299771019, 11273.661790146309, 12049.277043377426, 8266.751997440086, 8409.789755256168, 8444.746657600283, 8615.569221539023, 8639.0, 8050.114487406264, 10525.210609204187, 10777.491151238675, 10790.946045269724, 11322.716932076764], "value": 9252.399718058616, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.1517271359978, 1406.360106151701, 1446.3202294921387, 1554.4248628007638, 1716.7424886267065, 7124.14510258769, 7812.531248125109, 8062.234087761668, 8064.274215320613, 8253.752387428387, 8106.594670266478, 8166.591670416485, 8177.0, 8184.099749027617, 8194.262516373525, 2270.6366981283, 2287.0280130944366, 2291.140822191678, 2291.3355127013147, 2295.5523672883796, 2202.0, 2225.2767850448668, 2300.148944890393, 2306.803921666652, 2318.5131122464304, 2209.977900221001, 2255.9661605075853, 2290.862548247102, 2292.2321022457495, 2304.2165663674346, 2200.7799220077945, 2207.5915955548116, 2212.8229741620794, 2215.3021798133536, 2220.6891035255076, 2229.8885055747146, 2256.029907139929, 2257.1986944634746, 2257.548490301946, 2257.582347265761, 8119.147489513575, 8233.79415514611, 8314.667413303461, 8316.750497485085, 8324.875126873101, 4943.233798761198, 5158.53573178412, 5158.7678554464765, 5161.561267292284, 5165.535101840815, 3365.461526155828, 3467.427874400721, 3509.1578021274963, 3523.6828685418177, 3531.417316142859, 1172.284906207213, 1186.2467333243367, 1191.559123124441, 1200.6218041316956, 1207.1911819081236, 11151.498182581803, 11210.66368008961, 11289.54841806335, 11304.208705390625, 11318.094552435703, 3946.8223929923224, 4360.542143074995, 4437.933430998538, 4510.797014134372, 4516.322551617283, 9001.144891235323, 9010.234130098885, 9013.594388252544, 9055.366124371363, 9076.773080673036, 4930.827421040246, 4936.654434189572, 4941.678790878582, 4943.8516844494725, 4949.90100197994, 3990.501187351581, 4134.565870583606, 4330.631896288788, 4625.098105869391, 4631.745254010994, 3571.428571428559, 3607.639236076424, 3669.5229620149744, 3671.0638787109115, 3703.222323312081, 1108.711734948919, 1131.9773604527863, 1133.552246862501, 1134.478140055567, 1136.4545018391218, 827.9337652987747, 929.2658799548282, 932.7714709896119, 956.6077908057663, 974.3131092579856, 5654.321481422256, 5665.121906104478, 5675.31896172462, 5714.571407144481, 5823.708814559255, 902.1700035966926, 912.9178373946377, 913.963441462334, 922.9400088994194, 950.6340059077305, 3786.659200671953, 3868.7485313454536, 3875.9224815504094, 3895.49358583388, 3981.7411868228473, 9994.200463962865, 10410.68767936963, 10439.37363758177, 10476.319039262424, 10476.52855621499, 10130.696079117492, 10429.426381549089, 10456.947715261527, 10462.633807816843, 10492.947535262274, 7593.430492713069, 7881.960590197013, 7882.645280962371, 7919.3268572170855, 7923.326517246099, 5495.617160597794, 5660.264165658438, 5674.177244299471, 5749.655020698771, 5868.119782032729, 9361.953190234006, 9460.337776355589, 9470.289728270545, 9489.715308540755, 9498.24014078886, 8364.205400486944, 9361.204297634506, 9546.140847323773, 9567.808643827224, 9724.611015559298, 6386.584871983307, 6782.355676210752, 6885.242623311532, 6911.5853048817235, 7103.573785572676, 7915.722949696733, 7988.600569971362, 8021.197880211932, 8101.311388532041, 8154.918450815416, 7075.327843854826, 7142.9642851787485, 7154.463415243774, 7193.71225151009, 7200.89198662031, 6918.619475928872, 6964.65176741171, 7115.430765538641, 7188.820279493055, 7190.352868241884, 6370.140031095742, 6378.553501254868, 6463.64449955257, 6464.903026454513, 6466.094746735367, 4946.455889852042, 4974.577160941216, 4984.925226121539, 5062.924056139087, 5249.133892907627, 4741.786619602057, 4930.482299358516, 5016.097102521435, 5131.358580177478, 5147.742612869416], "value": 4392.976910186326, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.9649138594756, 325.50523204728813, 330.33602459057295, 330.56695728595525, 333.8430937459393, 5073.923891141636, 5216.269722238885, 5237.188235823449, 5251.107311757001, 5270.4729527047275, 5109.948900510994, 5150.896982060366, 5162.896742065156, 5197.246399272103, 5237.947620523793, 4104.199681062194, 4108.77401742904, 4118.773467459288, 4119.526254480743, 4132.917341653165, 3892.734861170117, 4043.1509383029597, 4110.938335924963, 4111.25271759501, 4126.257273690734, 4023.879283621496, 4039.4950631171105, 4045.5436043024633, 4055.4119652650347, 4056.7565946043183, 4019.9799001004953, 4026.6174713402474, 4027.697922655798, 4028.5568587455355, 4057.57395473474, 3449.379111759882, 3547.9645203547893, 3584.193556449804, 3585.4980302757635, 3589.5103532034173, 5045.84862454127, 5059.696418214919, 5063.645544811865, 5070.974645126751, 5074.264231686422, 4641.466231383401, 4641.563179330845, 4645.605123564501, 4648.5583869532675, 4658.720476771405, 5264.8683782905355, 5360.410354860962, 5363.602842251116, 5387.299651045379, 5439.809606663787, 3878.534575850916, 3898.298306304864, 3901.6878649708237, 3913.591107201405, 3914.3345631242755, 5523.447655234485, 5536.695481748502, 5569.303837020372, 5569.443055694479, 5582.190582365534, 3856.3829787234467, 3920.862769803043, 3950.459320864865, 3969.960300396959, 3970.5235371755575, 3987.302222111119, 3993.66053885423, 4006.819693113817, 4008.8596899108975, 4018.176273863851, 4557.521460246627, 4562.768052625773, 4572.0855828834365, 4581.770911454414, 4583.610393116555, 5272.92090618641, 5395.595330350239, 5419.3225846769155, 5423.593230507728, 5428.4842939920645, 1365.877071063609, 1393.261571367177, 1396.2599822094305, 1397.6785339371797, 1400.4888215801159, 863.4775960543906, 894.6868595991351, 898.8651702244584, 902.6299217320867, 908.1735620585235, 4694.272387779832, 4699.812007519729, 4708.9058218835435, 4715.693479923794, 4720.362751028567, 4880.194328098555, 4882.584980276716, 4884.975575122102, 4886.877828054256, 4894.0, 4377.898608667793, 4687.296905464208, 4694.906101877943, 4707.811687532529, 4720.362751028636, 2598.974010259911, 2608.2175347395705, 2608.2305719812703, 2615.856127912945, 2622.069165446239, 5049.065922804293, 5055.469175736494, 5081.256121694318, 5082.898342033212, 5097.490250974947, 4723.952760472352, 4836.0, 4919.754012299442, 4925.38432695913, 4937.901241975141, 5045.747712614355, 5053.570446512088, 5061.772220250097, 5064.493075927366, 5074.847754567369, 4832.323474713473, 4848.442429120696, 4859.493556997342, 4860.538248866352, 4875.512448755097, 4596.701649175412, 4812.25410061441, 4816.325714399917, 4820.204666230033, 4827.25177597473, 5028.516587606738, 5058.443571207238, 5064.974675126601, 5066.493350664904, 5075.4417014127675, 3637.7635453695425, 3770.5286839145106, 3873.1479074603544, 3876.379779235309, 4004.899877502969, 5436.673799572039, 5475.561955043508, 5485.50630443262, 5514.117741161395, 5531.502164805187, 5339.546138578265, 5343.465653434625, 5380.0, 5395.919061214006, 5401.810936617199, 5172.146595811649, 5363.329583802025, 5363.892722145613, 5366.302380690485, 5379.879669791433, 5314.1497360422145, 5326.760295786621, 5339.958708051892, 5363.2759577456545, 5375.0, 5215.713135777569, 5366.490183432567, 5390.919136213039, 5403.459654034722, 5409.864753381197, 5312.814051508179, 5367.543758780547, 5369.946300537101, 5371.462853714597, 5371.946280537145], "value": 3988.576577528478, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.7075463682572, 727.4871215792866, 756.2550887375934, 767.1408023014224, 792.7542461836829, 14520.709585808278, 15621.531354059369, 15622.531324060297, 15640.608984775386, 15664.608384790372, 13896.235707036134, 13943.093698909564, 13956.581302560939, 13975.16149031059, 14073.92963035186, 631.0880777276836, 644.880697071041, 761.7714685594327, 769.2269269384275, 781.281221276427, 771.0708596141636, 771.8301973565834, 774.601080443572, 775.5773103658491, 775.871981123114, 807.4388300131411, 809.6558962440969, 810.1979040749645, 810.3517186251005, 811.111832543367, 658.4600627485464, 676.2020815437756, 781.8123650323938, 800.591698233899, 807.0718673525434, 584.5469760935266, 584.666739958224, 584.6725833533235, 584.8450160707416, 585.3765739487433, 13708.65728356799, 13753.79369309461, 13760.0, 13780.242086685228, 13802.65493362664, 12579.308138052404, 12732.108752387336, 12947.935260323733, 12985.285809280485, 13048.608541743668, 11723.746339131032, 11894.405279735978, 11971.760564788656, 12442.56451024219, 12552.184108032949, 4263.317869140954, 4284.378765079077, 4291.377750226231, 4293.635041021517, 4376.168527979706, 58945.0, 59095.11357329643, 59564.40435595632, 59935.40064599342, 62467.0, 10364.429956352322, 10434.68695939123, 10518.526666300035, 10570.735731606772, 10591.779706864705, 19017.80982190188, 19046.809531904782, 19076.809231907504, 19098.71351929722, 19196.80803191978, 7558.622068896533, 7583.317501424788, 7699.692012319444, 7950.363970882316, 8126.146754590801, 4173.436586060903, 4197.601227883346, 4244.554321796167, 4293.334533147367, 4326.199653064194, 3082.9075127746205, 3161.9051428456723, 3162.4623813951684, 3163.5412865134426, 3167.04988503448, 523.5288240583506, 537.6988886223727, 542.381684879238, 546.4235231830457, 548.4241546376289, 552.4089224529714, 625.5527297981873, 657.3623585122424, 659.9043138744855, 671.60641668537, 8309.169083091763, 8356.456830306011, 8586.48481091124, 8809.471431714117, 8917.509536975529, 549.0939949084043, 600.9423414790001, 606.6087373644064, 651.5691709600533, 667.4511277452033, 4108.897277568085, 4156.9792151039055, 4204.2432362175105, 4205.3481710334945, 4234.237837189336, 52959.73520132452, 53563.46436535662, 67605.32394676088, 68576.6571167141, 70595.64702176559, 42305.365419518734, 43531.347029794575, 54220.728896355264, 67121.66439167772, 69613.3038669617, 39237.41143882844, 51756.0, 56976.43023569794, 61570.38429615736, 63056.054159187646, 8596.653812043496, 8901.955490222508, 8935.419197752126, 8956.910430895869, 9053.366264361432, 44946.3258051123, 45233.0, 45482.54517454783, 45608.31587526256, 45797.54202457933, 52951.47048529465, 57938.4206157933, 58183.0, 58428.0, 60180.097298541434, 11718.179727419, 12324.50701971947, 12409.193402428813, 12418.446356651444, 12644.178128421623, 13547.25490098054, 13882.791758123838, 13895.166290022631, 14393.136411815325, 14622.268886555843, 11975.76048479008, 11978.700532486757, 12056.216345937486, 12365.258084514959, 12374.319412432402, 10964.06805421548, 11955.103367247317, 12069.57756478554, 12285.447154878231, 12416.317102559085, 11768.176227663982, 12084.274943503418, 12435.875641243834, 12487.500499980262, 12800.871991279968, 11002.174836887425, 11533.077353811843, 11824.23142495735, 11837.940810295893, 12145.453454594388, 10030.799384012425, 10788.838167427339, 10899.509522071685, 10990.120790336594, 10990.945045274722], "value": 6673.153989486588, "unit": "score"}], "name": "dromaeo_css", "value": 6946.446762137561, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 110.0, 111.0, 112.0, 112.0, 111.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 125.0, 122.0, 170.0, 124.0, 126.0, 129.0, 122.0, 159.0, 122.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 163.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 108.0, 77.0, 76.0, 77.0, 76.0, 99.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 111.0, 84.0, 84.0, 83.0, 116.0, 83.0, 82.0, 114.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 87.0, 86.0, 85.0, 85.0, 85.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 82.0, 79.0, 79.0, 81.0, 79.0, 79.0, 83.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 141.0, 131.0, 135.0, 148.0, 128.0, 133.0, 134.0, 171.0, 129.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 164.0, 167.0, 165.0, 168.0, 165.0, 165.0, 165.0, 161.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 64.0, 64.0, 63.0, 64.0, 63.0, 66.0, 65.0, 63.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1491.8, "alertThreshold": 2.0}]} 08:58:41 INFO - Return code: 0 08:58:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:58:41 INFO - # TBPL SUCCESS # 08:58:41 INFO - Running post-action listener: _resource_record_post_action 08:58:41 INFO - [mozharness: 2016-10-31 15:58:41.873871Z] Finished run-tests step (success) 08:58:41 INFO - Running post-run listener: _resource_record_post_run 08:58:41 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 401346560; Read time: 0; Write time: 329980 08:58:41 INFO - TinderboxPrint: CPU usage
13.1% 08:58:41 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:58:41 INFO - TinderboxPrint: I/O write bytes / time
401,346,560 / 329,980 08:58:41 INFO - TinderboxPrint: CPU idle
8,299.8 (86.9%) 08:58:41 INFO - TinderboxPrint: CPU user
1,199.8 (12.6%) 08:58:41 INFO - TinderboxPrint: Swap in / out
0 / 0 08:58:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109957120; Read time: 0; Write time: 116132 08:58:41 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287477760; Read time: 0; Write time: 212948 08:58:42 INFO - Running post-run listener: _upload_blobber_files 08:58:42 INFO - Blob upload gear active. 08:58:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:58:42 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 08:58:42 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'] 08:58:42 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 08:58:42 INFO - (blobuploader) - INFO - Open directory for files ... 08:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:58:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:43 INFO - (blobuploader) - INFO - Done attempting. 08:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:44 INFO - (blobuploader) - INFO - Done attempting. 08:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:58:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:58:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:58:48 INFO - (blobuploader) - INFO - Done attempting. 08:58:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:58:48 INFO - Return code: 0 08:58:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:58:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:58:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f76e635241dc725b48acac6a79dfc5a2213dfa8522a9c5155f14cd977a8c234368f272beffe9de36f7af079357f57debe9fed3de8c23d6b788f088ba126ae03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3f01420d506c62dfafd2446921e16595d8e1d3ecb0942b84a13adf139e97baeeae2ffcb5ec0f71c105a0650dffc34ac01d1c4c3e8b9af3e5737f9f0af7f4c536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f970bd7f73bb462fc9db6e3d7695ee8242a21b36d9ea6b2bcb5c8380f75ad631610b32d0b3f4027a6c2f13c30d21eee820bfa364fde5fcbd048241609d5c09c0"} 08:58:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:58:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:58:48 INFO - Contents: 08:58:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f76e635241dc725b48acac6a79dfc5a2213dfa8522a9c5155f14cd977a8c234368f272beffe9de36f7af079357f57debe9fed3de8c23d6b788f088ba126ae03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3f01420d506c62dfafd2446921e16595d8e1d3ecb0942b84a13adf139e97baeeae2ffcb5ec0f71c105a0650dffc34ac01d1c4c3e8b9af3e5737f9f0af7f4c536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f970bd7f73bb462fc9db6e3d7695ee8242a21b36d9ea6b2bcb5c8380f75ad631610b32d0b3f4027a6c2f13c30d21eee820bfa364fde5fcbd048241609d5c09c0"} 08:58:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:58:48 INFO - Copying logs to upload dir... 08:58:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:58:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.440604 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-31 08:58:47.868321) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 08:58:47.871735) ========= 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=41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873 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/2f76e635241dc725b48acac6a79dfc5a2213dfa8522a9c5155f14cd977a8c234368f272beffe9de36f7af079357f57debe9fed3de8c23d6b788f088ba126ae03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3f01420d506c62dfafd2446921e16595d8e1d3ecb0942b84a13adf139e97baeeae2ffcb5ec0f71c105a0650dffc34ac01d1c4c3e8b9af3e5737f9f0af7f4c536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f970bd7f73bb462fc9db6e3d7695ee8242a21b36d9ea6b2bcb5c8380f75ad631610b32d0b3f4027a6c2f13c30d21eee820bfa364fde5fcbd048241609d5c09c0"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477693880/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2f76e635241dc725b48acac6a79dfc5a2213dfa8522a9c5155f14cd977a8c234368f272beffe9de36f7af079357f57debe9fed3de8c23d6b788f088ba126ae03", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3f01420d506c62dfafd2446921e16595d8e1d3ecb0942b84a13adf139e97baeeae2ffcb5ec0f71c105a0650dffc34ac01d1c4c3e8b9af3e5737f9f0af7f4c536", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f970bd7f73bb462fc9db6e3d7695ee8242a21b36d9ea6b2bcb5c8380f75ad631610b32d0b3f4027a6c2f13c30d21eee820bfa364fde5fcbd048241609d5c09c0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 08:58:47.897866) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:58:47.898197) ========= 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=41bf3e9aed84707956354da8000001c5-1477928288.854591-1445104873 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004391 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 08:58:47.982338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 08:58:47.982670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 08:58:47.982956) ========= ========= Total master_lag: 0.17 =========