builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1476465633.45 results: success (0) buildid: 20161014073004 builduid: efac60dc9551466bad1ee1b7abcd890b revision: cb2dd5a34dd7b374500fedd72fe19df13c9a7a4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.448229) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.448705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.448971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.463461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.463784) ========= 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=31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 10:20:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.5M=0s 2016-10-14 10:20:33 (39.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.600108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.600436) ========= 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=31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014401 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.649601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:33.649955) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb2dd5a34dd7b374500fedd72fe19df13c9a7a4d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cb2dd5a34dd7b374500fedd72fe19df13c9a7a4d --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=31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 10:20:33,846 truncating revision to first 12 chars 2016-10-14 10:20:33,846 Setting DEBUG logging. 2016-10-14 10:20:33,846 attempt 1/10 2016-10-14 10:20:33,846 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb2dd5a34dd7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 10:20:34,196 unpacking tar archive at: mozilla-central-cb2dd5a34dd7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.746682 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:34.409769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:34.410082) ========= script_repo_revision: cb2dd5a34dd7b374500fedd72fe19df13c9a7a4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:34.410550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:34.410994) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:34.420312) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-14 10:20:34.420605) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:20:34 INFO - MultiFileLogger online at 20161014 10:20:34 in /builds/slave/test 10:20:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:20:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:20:34 INFO - {'append_to_log': False, 10:20:34 INFO - 'base_work_dir': '/builds/slave/test', 10:20:34 INFO - 'blob_upload_branch': 'Firefox', 10:20:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:20:34 INFO - 'branch': 'Firefox', 10:20:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:20:34 INFO - 'config_files': ('talos/linux_config.py',), 10:20:34 INFO - 'default_actions': ('clobber', 10:20:34 INFO - 'read-buildbot-config', 10:20:34 INFO - 'download-and-extract', 10:20:34 INFO - 'populate-webroot', 10:20:34 INFO - 'create-virtualenv', 10:20:34 INFO - 'install', 10:20:34 INFO - 'run-tests'), 10:20:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:20:34 INFO - 'download_minidump_stackwalk': True, 10:20:34 INFO - 'download_symbols': 'ondemand', 10:20:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:20:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:20:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:20:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:20:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:20:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:20:34 INFO - 'installer_path': 'installer.exe', 10:20:34 INFO - 'log_level': 'info', 10:20:34 INFO - 'log_name': 'talos', 10:20:34 INFO - 'log_to_console': True, 10:20:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:20:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:20:34 INFO - 'opt_config_files': (), 10:20:34 INFO - 'pip_index': False, 10:20:34 INFO - 'sps_profile': False, 10:20:34 INFO - 'sps_profile_interval': 0, 10:20:34 INFO - 'suite': 'dromaeojs', 10:20:34 INFO - 'system_bits': '32', 10:20:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:20:34 INFO - 'title': 'talos-linux64-ix-014', 10:20:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:20:34 INFO - 'use_talos_json': True, 10:20:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:20:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:20:34 INFO - 'work_dir': 'build'} 10:20:34 INFO - [mozharness: 2016-10-14 17:20:34.716085Z] Running clobber step. 10:20:34 INFO - Running pre-action listener: _resource_record_pre_action 10:20:34 INFO - Running main action method: clobber 10:20:34 INFO - rmtree: /builds/slave/test/build 10:20:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:20:35 INFO - Running post-action listener: _resource_record_post_action 10:20:35 INFO - [mozharness: 2016-10-14 17:20:35.706793Z] Finished clobber step (success) 10:20:35 INFO - [mozharness: 2016-10-14 17:20:35.706893Z] Running read-buildbot-config step. 10:20:35 INFO - Running pre-action listener: _resource_record_pre_action 10:20:35 INFO - Running main action method: read_buildbot_config 10:20:35 INFO - Using buildbot properties: 10:20:35 INFO - { 10:20:35 INFO - "project": "", 10:20:35 INFO - "product": "firefox", 10:20:35 INFO - "script_repo_revision": "production", 10:20:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:20:35 INFO - "repository": "", 10:20:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:20:35 INFO - "buildid": "20161014073004", 10:20:35 INFO - "pgo_build": "True", 10:20:35 INFO - "basedir": "/builds/slave/test", 10:20:35 INFO - "buildnumber": 594, 10:20:35 INFO - "slavename": "talos-linux64-ix-014", 10:20:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:20:35 INFO - "platform": "ubuntu64_hw", 10:20:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:20:35 INFO - "branch": "mozilla-central", 10:20:35 INFO - "repo_path": "mozilla-central", 10:20:35 INFO - "revision": "cb2dd5a34dd7b374500fedd72fe19df13c9a7a4d", 10:20:35 INFO - "stage_platform": "linux64-pgo", 10:20:35 INFO - "builduid": "efac60dc9551466bad1ee1b7abcd890b", 10:20:35 INFO - "slavebuilddir": "test" 10:20:35 INFO - } 10:20:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:20:35 INFO - Running post-action listener: _resource_record_post_action 10:20:35 INFO - [mozharness: 2016-10-14 17:20:35.709351Z] Finished read-buildbot-config step (success) 10:20:35 INFO - [mozharness: 2016-10-14 17:20:35.709439Z] Running download-and-extract step. 10:20:35 INFO - Running pre-action listener: _resource_record_pre_action 10:20:35 INFO - Running main action method: download_and_extract 10:20:35 INFO - mkdir: /builds/slave/test/build/tests 10:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:35 INFO - trying https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:35 INFO - Downloading https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:20:36 INFO - Downloaded 1361 bytes. 10:20:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:20:36 INFO - Using the following test package requirements: 10:20:36 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:20:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:20:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'jsshell-linux-x86_64.zip'], 10:20:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:20:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:20:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:20:36 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:20:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:20:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:20:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:20:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:20:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:20:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:36 INFO - Fetch https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:20:36 INFO - Http code: 200 10:20:36 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 10:20:36 INFO - x-amz-cf-id: 2gLwjw7MmZ8PgvwU6-dZDUI6ugdvnEvnjXrA0wNZ_R6Kwh8rszr-Dw== 10:20:36 INFO - x-amz-version-id: U_Tqc3IIPjg6s292n09PZt0_lTXeObMx 10:20:37 INFO - Expected file size: 22123115 10:20:37 INFO - Obtained file size: 22123115 10:20:41 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 10:20:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:20:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:20:41 INFO - Fetch https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:20:41 INFO - Http code: 200 10:20:41 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 10:20:41 INFO - x-amz-cf-id: buiD8FJ46f4BWmWqmh68ClTWw7k3xbtyznd0eqiCQZvaGEpwHRr9iQ== 10:20:41 INFO - x-amz-version-id: U_Tqc3IIPjg6s292n09PZt0_lTXeObMx 10:20:42 INFO - Expected file size: 22123115 10:20:42 INFO - Obtained file size: 22123115 10:20:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:20:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:20:46 INFO - Fetch https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:20:47 INFO - Http code: 200 10:20:47 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 10:20:47 INFO - x-amz-cf-id: DLi_Cfsq4H8cuRxH6b1IWtzOzz4ngoR4Tl2KGrwqdlbWAwHDmpC3Qw== 10:20:47 INFO - x-amz-version-id: 3_7ATCWpKtGOJAZPYmy4rUvQFdVdMy2e 10:20:47 INFO - Expected file size: 14409006 10:20:47 INFO - Obtained file size: 14409006 10:20:47 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')]} 10:20:47 INFO - trying https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:47 INFO - Downloading https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:20:48 INFO - Downloaded 59627833 bytes. 10:20:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:48 INFO - mkdir: /builds/slave/test/properties 10:20:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:20:48 INFO - Writing to file /builds/slave/test/properties/build_url 10:20:48 INFO - Contents: 10:20:48 INFO - build_url:https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:20:49 INFO - Running post-action listener: _resource_record_post_action 10:20:49 INFO - Running post-action listener: set_extra_try_arguments 10:20:49 INFO - [mozharness: 2016-10-14 17:20:49.446534Z] Finished download-and-extract step (success) 10:20:49 INFO - [mozharness: 2016-10-14 17:20:49.446762Z] Running populate-webroot step. 10:20:49 INFO - Running pre-action listener: _resource_record_pre_action 10:20:49 INFO - Running main action method: populate_webroot 10:20:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:20:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:20:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:20:49 INFO - '--tppagecycles', 10:20:49 INFO - '7'], 10:20:49 INFO - 'tests': ['tsvgm']}}, 10:20:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:20:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:20:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:20:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:20:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:49 INFO - 'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:20:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:49 INFO - 'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['damp', 'tps']}, 10:20:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:49 INFO - 'tests': ['damp', 'tps']}, 10:20:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['dromaeo_dom']}, 10:20:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:20:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['basic_compositor_video']}, 10:20:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:20:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['a11yr', 10:20:49 INFO - 'ts_paint', 10:20:49 INFO - 'tpaint', 10:20:49 INFO - 'sessionrestore', 10:20:49 INFO - 'sessionrestore_no_auto_restore', 10:20:49 INFO - 'tabpaint']}, 10:20:49 INFO - 'other-e10s': {'tests': ['a11yr', 10:20:49 INFO - 'ts_paint', 10:20:49 INFO - 'tpaint', 10:20:49 INFO - 'sessionrestore', 10:20:49 INFO - 'sessionrestore_no_auto_restore', 10:20:49 INFO - 'tabpaint']}, 10:20:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:20:49 INFO - 'ts_paint', 10:20:49 INFO - 'tpaint', 10:20:49 INFO - 'sessionrestore', 10:20:49 INFO - 'sessionrestore_no_auto_restore', 10:20:49 INFO - 'tabpaint']}, 10:20:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:20:49 INFO - 'ts_paint', 10:20:49 INFO - 'tpaint', 10:20:49 INFO - 'sessionrestore', 10:20:49 INFO - 'sessionrestore_no_auto_restore', 10:20:49 INFO - 'tabpaint']}, 10:20:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['a11yr', 10:20:49 INFO - 'ts_paint', 10:20:49 INFO - 'tpaint', 10:20:49 INFO - 'sessionrestore', 10:20:49 INFO - 'sessionrestore_no_auto_restore', 10:20:49 INFO - 'tabpaint']}, 10:20:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['a11yr', 10:20:49 INFO - 'ts_paint', 10:20:49 INFO - 'tpaint', 10:20:49 INFO - 'sessionrestore', 10:20:49 INFO - 'sessionrestore_no_auto_restore', 10:20:49 INFO - 'tabpaint']}, 10:20:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['tsvgx', 10:20:49 INFO - 'tsvgr_opacity', 10:20:49 INFO - 'tart', 10:20:49 INFO - 'tscrollx', 10:20:49 INFO - 'cart']}, 10:20:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:20:49 INFO - 'tsvgr_opacity', 10:20:49 INFO - 'tart', 10:20:49 INFO - 'tscrollx', 10:20:49 INFO - 'cart']}, 10:20:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:49 INFO - 'talos_options': ['--disable-e10s'], 10:20:49 INFO - 'tests': ['tp5o']}, 10:20:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:49 INFO - 'tests': ['tp5o']}, 10:20:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:49 INFO - 'talos_options': ['--disable-e10s', 10:20:49 INFO - '--xperf_path', 10:20:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:49 INFO - 'tests': ['tp5n']}, 10:20:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:20:49 INFO - 'talos_options': ['--xperf_path', 10:20:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:20:49 INFO - 'tests': ['tp5n']}}, 10:20:49 INFO - 'talos.zip': {'path': '', 10:20:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:20:49 INFO - Running post-action listener: _resource_record_post_action 10:20:49 INFO - [mozharness: 2016-10-14 17:20:49.468983Z] Finished populate-webroot step (success) 10:20:49 INFO - [mozharness: 2016-10-14 17:20:49.469071Z] Running create-virtualenv step. 10:20:49 INFO - Running pre-action listener: _resource_record_pre_action 10:20:49 INFO - Running main action method: create_virtualenv 10:20:49 INFO - Creating virtualenv /builds/slave/test/build/venv 10:20:49 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 10:20:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:20:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:20:49 INFO - Using real prefix '/usr' 10:20:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:20:50 INFO - Installing distribute.............................................................................................................................................................................................done. 10:20:52 INFO - Installing pip.................done. 10:20:52 INFO - Return code: 0 10:20:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:20:52 INFO - Reading from file tmpfile_stdout 10:20:52 INFO - Output received: 10:20:52 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) 10:20:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:52 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:20:52 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 10:20:52 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 10:20:52 INFO - Using env: {'DISPLAY': ':0', 10:20:52 INFO - 'HOME': '/home/cltbld', 10:20:52 INFO - 'LANG': 'en_US.UTF-8', 10:20:52 INFO - 'LANGUAGE': 'en_US:en', 10:20:52 INFO - 'LOGNAME': 'cltbld', 10:20:52 INFO - 'MAIL': '/var/mail/cltbld', 10:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:52 INFO - 'MOZ_NO_REMOTE': '1', 10:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:52 INFO - 'NO_EM_RESTART': '1', 10:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:52 INFO - 'PWD': '/builds/slave/test', 10:20:52 INFO - 'SHELL': '/bin/bash', 10:20:52 INFO - 'SHLVL': '1', 10:20:52 INFO - 'TERM': 'linux', 10:20:52 INFO - 'TMOUT': '86400', 10:20:52 INFO - 'USER': 'cltbld', 10:20:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:52 INFO - '_': '/tools/buildbot/bin/python'} 10:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:52 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 10:20:52 INFO - Cleaning up... 10:20:52 INFO - Return code: 0 10:20:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:52 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:20:52 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 10:20:52 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 10:20:52 INFO - Using env: {'DISPLAY': ':0', 10:20:52 INFO - 'HOME': '/home/cltbld', 10:20:52 INFO - 'LANG': 'en_US.UTF-8', 10:20:52 INFO - 'LANGUAGE': 'en_US:en', 10:20:52 INFO - 'LOGNAME': 'cltbld', 10:20:52 INFO - 'MAIL': '/var/mail/cltbld', 10:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:52 INFO - 'MOZ_NO_REMOTE': '1', 10:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:52 INFO - 'NO_EM_RESTART': '1', 10:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:52 INFO - 'PWD': '/builds/slave/test', 10:20:52 INFO - 'SHELL': '/bin/bash', 10:20:52 INFO - 'SHLVL': '1', 10:20:52 INFO - 'TERM': 'linux', 10:20:52 INFO - 'TMOUT': '86400', 10:20:52 INFO - 'USER': 'cltbld', 10:20:52 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:52 INFO - '_': '/tools/buildbot/bin/python'} 10:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:52 INFO - Downloading/unpacking psutil>=3.1.1 10:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:20:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:54 INFO - Installing collected packages: psutil 10:20:54 INFO - Running setup.py install for psutil 10:20:54 INFO - building 'psutil._psutil_linux' extension 10:20:54 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 10:20:54 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 10:20:55 INFO - building 'psutil._psutil_posix' extension 10:20:55 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 10:20:55 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 10:20:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:20:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:20:55 INFO - Successfully installed psutil 10:20:55 INFO - Cleaning up... 10:20:55 INFO - Return code: 0 10:20:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:20:55 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')]} 10:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:55 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')]} 10:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:55 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:20:55 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 10:20:55 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 10:20:55 INFO - Using env: {'DISPLAY': ':0', 10:20:55 INFO - 'HOME': '/home/cltbld', 10:20:55 INFO - 'LANG': 'en_US.UTF-8', 10:20:55 INFO - 'LANGUAGE': 'en_US:en', 10:20:55 INFO - 'LOGNAME': 'cltbld', 10:20:55 INFO - 'MAIL': '/var/mail/cltbld', 10:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:55 INFO - 'MOZ_NO_REMOTE': '1', 10:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:55 INFO - 'NO_EM_RESTART': '1', 10:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:55 INFO - 'PWD': '/builds/slave/test', 10:20:55 INFO - 'SHELL': '/bin/bash', 10:20:55 INFO - 'SHLVL': '1', 10:20:55 INFO - 'TERM': 'linux', 10:20:55 INFO - 'TMOUT': '86400', 10:20:55 INFO - 'USER': 'cltbld', 10:20:55 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:55 INFO - '_': '/tools/buildbot/bin/python'} 10:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:20:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:20:57 INFO - Installing collected packages: mozsystemmonitor 10:20:57 INFO - Running setup.py install for mozsystemmonitor 10:20:57 INFO - Successfully installed mozsystemmonitor 10:20:57 INFO - Cleaning up... 10:20:57 INFO - Return code: 0 10:20:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:20:57 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')]} 10:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:57 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')]} 10:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:20:57 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:20:57 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 10:20:57 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 10:20:57 INFO - Using env: {'DISPLAY': ':0', 10:20:57 INFO - 'HOME': '/home/cltbld', 10:20:57 INFO - 'LANG': 'en_US.UTF-8', 10:20:57 INFO - 'LANGUAGE': 'en_US:en', 10:20:57 INFO - 'LOGNAME': 'cltbld', 10:20:57 INFO - 'MAIL': '/var/mail/cltbld', 10:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:20:57 INFO - 'MOZ_NO_REMOTE': '1', 10:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:20:57 INFO - 'NO_EM_RESTART': '1', 10:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:20:57 INFO - 'PWD': '/builds/slave/test', 10:20:57 INFO - 'SHELL': '/bin/bash', 10:20:57 INFO - 'SHLVL': '1', 10:20:57 INFO - 'TERM': 'linux', 10:20:57 INFO - 'TMOUT': '86400', 10:20:57 INFO - 'USER': 'cltbld', 10:20:57 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:20:57 INFO - '_': '/tools/buildbot/bin/python'} 10:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:20:57 INFO - Downloading/unpacking jsonschema==2.5.1 10:20:57 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 10:20:57 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 10:20:57 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 10:20:57 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 10:20:57 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 10:20:57 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 10:20:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:20:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:20:59 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 10:20:59 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 10:20:59 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 10:20:59 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 10:20:59 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 10:20:59 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 10:21:00 INFO - Downloading functools32-3.2.3-2.tar.gz 10:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:21:00 INFO - warning: no files found matching '*.txt' 10:21:00 INFO - no previously-included directories found matching 'build' 10:21:00 INFO - no previously-included directories found matching 'dist' 10:21:00 INFO - no previously-included directories found matching '.git*' 10:21:00 INFO - Installing collected packages: jsonschema, functools32 10:21:00 INFO - Running setup.py install for functools32 10:21:00 INFO - warning: no files found matching '*.txt' 10:21:00 INFO - no previously-included directories found matching 'build' 10:21:00 INFO - no previously-included directories found matching 'dist' 10:21:00 INFO - no previously-included directories found matching '.git*' 10:21:00 INFO - Successfully installed jsonschema functools32 10:21:00 INFO - Cleaning up... 10:21:00 INFO - Return code: 0 10:21:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:00 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:21:00 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 10:21:00 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 10:21:00 INFO - Using env: {'DISPLAY': ':0', 10:21:00 INFO - 'HOME': '/home/cltbld', 10:21:00 INFO - 'LANG': 'en_US.UTF-8', 10:21:00 INFO - 'LANGUAGE': 'en_US:en', 10:21:00 INFO - 'LOGNAME': 'cltbld', 10:21:00 INFO - 'MAIL': '/var/mail/cltbld', 10:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:00 INFO - 'MOZ_NO_REMOTE': '1', 10:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:00 INFO - 'NO_EM_RESTART': '1', 10:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:00 INFO - 'PWD': '/builds/slave/test', 10:21:00 INFO - 'SHELL': '/bin/bash', 10:21:00 INFO - 'SHLVL': '1', 10:21:00 INFO - 'TERM': 'linux', 10:21:00 INFO - 'TMOUT': '86400', 10:21:00 INFO - 'USER': 'cltbld', 10:21:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:00 INFO - '_': '/tools/buildbot/bin/python'} 10:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:21:00 INFO - Cleaning up... 10:21:00 INFO - Return code: 0 10:21:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:00 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:21:00 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 10:21:00 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 10:21:00 INFO - Using env: {'DISPLAY': ':0', 10:21:00 INFO - 'HOME': '/home/cltbld', 10:21:00 INFO - 'LANG': 'en_US.UTF-8', 10:21:00 INFO - 'LANGUAGE': 'en_US:en', 10:21:00 INFO - 'LOGNAME': 'cltbld', 10:21:00 INFO - 'MAIL': '/var/mail/cltbld', 10:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:00 INFO - 'MOZ_NO_REMOTE': '1', 10:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:00 INFO - 'NO_EM_RESTART': '1', 10:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:00 INFO - 'PWD': '/builds/slave/test', 10:21:00 INFO - 'SHELL': '/bin/bash', 10:21:00 INFO - 'SHLVL': '1', 10:21:00 INFO - 'TERM': 'linux', 10:21:00 INFO - 'TMOUT': '86400', 10:21:00 INFO - 'USER': 'cltbld', 10:21:00 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:00 INFO - '_': '/tools/buildbot/bin/python'} 10:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:21:00 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 10:21:00 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 10:21:00 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 10:21:00 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 10:21:00 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 10:21:00 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 10:21:02 INFO - Downloading blobuploader-1.2.4.tar.gz 10:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:21:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:21:02 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 10:21:02 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 10:21:02 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 10:21:02 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 10:21:02 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 10:21:02 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 10:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:21:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:21:03 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 10:21:03 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 10:21:03 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 10:21:03 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 10:21:03 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 10:21:03 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 10:21:03 INFO - Downloading docopt-0.6.1.tar.gz 10:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:21:03 INFO - Installing collected packages: blobuploader, requests, docopt 10:21:03 INFO - Running setup.py install for blobuploader 10:21:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:21:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:21:03 INFO - Running setup.py install for requests 10:21:03 INFO - Running setup.py install for docopt 10:21:04 INFO - Successfully installed blobuploader requests docopt 10:21:04 INFO - Cleaning up... 10:21:04 INFO - Return code: 0 10:21:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:04 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:21:04 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 10:21:04 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 10:21:04 INFO - Using env: {'DISPLAY': ':0', 10:21:04 INFO - 'HOME': '/home/cltbld', 10:21:04 INFO - 'LANG': 'en_US.UTF-8', 10:21:04 INFO - 'LANGUAGE': 'en_US:en', 10:21:04 INFO - 'LOGNAME': 'cltbld', 10:21:04 INFO - 'MAIL': '/var/mail/cltbld', 10:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:04 INFO - 'MOZ_NO_REMOTE': '1', 10:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:04 INFO - 'NO_EM_RESTART': '1', 10:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:04 INFO - 'PWD': '/builds/slave/test', 10:21:04 INFO - 'SHELL': '/bin/bash', 10:21:04 INFO - 'SHLVL': '1', 10:21:04 INFO - 'TERM': 'linux', 10:21:04 INFO - 'TMOUT': '86400', 10:21:04 INFO - 'USER': 'cltbld', 10:21:04 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:04 INFO - '_': '/tools/buildbot/bin/python'} 10:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:04 INFO - Running setup.py (path:/tmp/pip-hqP6OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:04 INFO - Running setup.py (path:/tmp/pip-cQLSGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:04 INFO - Running setup.py (path:/tmp/pip-2hTyg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:04 INFO - Running setup.py (path:/tmp/pip-CcdwBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:04 INFO - Running setup.py (path:/tmp/pip-ANNcS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:04 INFO - Running setup.py (path:/tmp/pip-K9YDSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:04 INFO - Running setup.py (path:/tmp/pip-cx0_HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:04 INFO - Running setup.py (path:/tmp/pip-e0JqtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:04 INFO - Running setup.py (path:/tmp/pip-CbOj0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:04 INFO - Running setup.py (path:/tmp/pip-hRgfgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:05 INFO - Running setup.py (path:/tmp/pip-I5IrEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:05 INFO - Running setup.py (path:/tmp/pip-5CgBcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:05 INFO - Running setup.py (path:/tmp/pip-T86F4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:05 INFO - Running setup.py (path:/tmp/pip-UTOppv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:05 INFO - Running setup.py (path:/tmp/pip-3tVF8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:05 INFO - Running setup.py (path:/tmp/pip-zi1xrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:05 INFO - Running setup.py (path:/tmp/pip-bHJQc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:21:05 INFO - Running setup.py install for manifestparser 10:21:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:21:05 INFO - Running setup.py install for mozcrash 10:21:05 INFO - Running setup.py install for mozdebug 10:21:05 INFO - Running setup.py install for mozdevice 10:21:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:21:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:21:05 INFO - Running setup.py install for mozfile 10:21:06 INFO - Running setup.py install for mozhttpd 10:21:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Running setup.py install for mozinfo 10:21:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Running setup.py install for mozInstall 10:21:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Running setup.py install for mozleak 10:21:06 INFO - Running setup.py install for mozlog 10:21:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Running setup.py install for moznetwork 10:21:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Running setup.py install for mozprocess 10:21:06 INFO - Running setup.py install for mozprofile 10:21:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:21:06 INFO - Running setup.py install for mozrunner 10:21:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:21:07 INFO - Running setup.py install for mozscreenshot 10:21:07 INFO - Running setup.py install for moztest 10:21:07 INFO - Running setup.py install for mozversion 10:21:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:21:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:21:07 INFO - Cleaning up... 10:21:07 INFO - Return code: 0 10:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21:07 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')]} 10:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:07 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')]} 10:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:07 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:21:07 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 10:21:07 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 10:21:07 INFO - Using env: {'DISPLAY': ':0', 10:21:07 INFO - 'HOME': '/home/cltbld', 10:21:07 INFO - 'LANG': 'en_US.UTF-8', 10:21:07 INFO - 'LANGUAGE': 'en_US:en', 10:21:07 INFO - 'LOGNAME': 'cltbld', 10:21:07 INFO - 'MAIL': '/var/mail/cltbld', 10:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:07 INFO - 'MOZ_NO_REMOTE': '1', 10:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:07 INFO - 'NO_EM_RESTART': '1', 10:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:07 INFO - 'PWD': '/builds/slave/test', 10:21:07 INFO - 'SHELL': '/bin/bash', 10:21:07 INFO - 'SHLVL': '1', 10:21:07 INFO - 'TERM': 'linux', 10:21:07 INFO - 'TMOUT': '86400', 10:21:07 INFO - 'USER': 'cltbld', 10:21:07 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:07 INFO - '_': '/tools/buildbot/bin/python'} 10:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:21:07 INFO - Running setup.py (path:/tmp/pip-5JKMuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:21:07 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)) 10:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:21:07 INFO - Running setup.py (path:/tmp/pip-QfJ3lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:21:07 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)) 10:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:21:07 INFO - Running setup.py (path:/tmp/pip-qo0UIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:21:07 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)) 10:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:21:07 INFO - Running setup.py (path:/tmp/pip-vhytWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:21:07 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)) 10:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:21:07 INFO - Running setup.py (path:/tmp/pip-dHvsAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:21:07 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)) 10:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:21:07 INFO - Running setup.py (path:/tmp/pip-dZPNxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:21:08 INFO - Running setup.py (path:/tmp/pip-fYkQg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:21:08 INFO - Running setup.py (path:/tmp/pip-HNKBUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:21:08 INFO - Running setup.py (path:/tmp/pip-_cIZFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:21:08 INFO - Running setup.py (path:/tmp/pip-dpASfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:21:08 INFO - Running setup.py (path:/tmp/pip-a1p5uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:21:08 INFO - Running setup.py (path:/tmp/pip-Pf8MMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:21:08 INFO - Running setup.py (path:/tmp/pip-l9mLpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:21:08 INFO - Running setup.py (path:/tmp/pip-n4grqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:08 INFO - Running setup.py (path:/tmp/pip-M8caZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:21:08 INFO - Running setup.py (path:/tmp/pip-hNCNin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:21:08 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)) 10:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:21:08 INFO - Running setup.py (path:/tmp/pip-7q7HF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:21:08 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)) 10:21:08 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)) 10:21:08 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)) 10:21:08 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)) 10:21:08 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)) 10:21:08 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)) 10:21:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:21:08 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 10:21:08 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 10:21:08 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 10:21:08 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 10:21:08 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 10:21:08 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 10:21:10 INFO - Downloading blessings-1.6.tar.gz 10:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:21:10 INFO - Installing collected packages: blessings 10:21:10 INFO - Running setup.py install for blessings 10:21:10 INFO - Successfully installed blessings 10:21:10 INFO - Cleaning up... 10:21:10 INFO - Return code: 0 10:21:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:11 INFO - Reading from file tmpfile_stdout 10:21:11 INFO - Current package versions: 10:21:11 INFO - argparse == 1.2.1 10:21:11 INFO - blessings == 1.6 10:21:11 INFO - blobuploader == 1.2.4 10:21:11 INFO - docopt == 0.6.1 10:21:11 INFO - functools32 == 3.2.3-2 10:21:11 INFO - jsonschema == 2.5.1 10:21:11 INFO - manifestparser == 1.1 10:21:11 INFO - mozInstall == 1.12 10:21:11 INFO - mozcrash == 0.17 10:21:11 INFO - mozdebug == 0.1 10:21:11 INFO - mozdevice == 0.48 10:21:11 INFO - mozfile == 1.2 10:21:11 INFO - mozhttpd == 0.7 10:21:11 INFO - mozinfo == 0.9 10:21:11 INFO - mozleak == 0.1 10:21:11 INFO - mozlog == 3.4 10:21:11 INFO - moznetwork == 0.27 10:21:11 INFO - mozprocess == 0.23 10:21:11 INFO - mozprofile == 0.28 10:21:11 INFO - mozrunner == 6.12 10:21:11 INFO - mozscreenshot == 0.1 10:21:11 INFO - mozsystemmonitor == 0.3 10:21:11 INFO - moztest == 0.7 10:21:11 INFO - mozversion == 1.4 10:21:11 INFO - psutil == 3.1.1 10:21:11 INFO - requests == 1.2.3 10:21:11 INFO - wsgiref == 0.1.2 10:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:11 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:21:11 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 10:21:11 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 10:21:11 INFO - Using env: {'DISPLAY': ':0', 10:21:11 INFO - 'HOME': '/home/cltbld', 10:21:11 INFO - 'LANG': 'en_US.UTF-8', 10:21:11 INFO - 'LANGUAGE': 'en_US:en', 10:21:11 INFO - 'LOGNAME': 'cltbld', 10:21:11 INFO - 'MAIL': '/var/mail/cltbld', 10:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:11 INFO - 'MOZ_NO_REMOTE': '1', 10:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:11 INFO - 'NO_EM_RESTART': '1', 10:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:11 INFO - 'PWD': '/builds/slave/test', 10:21:11 INFO - 'SHELL': '/bin/bash', 10:21:11 INFO - 'SHLVL': '1', 10:21:11 INFO - 'TERM': 'linux', 10:21:11 INFO - 'TMOUT': '86400', 10:21:11 INFO - 'USER': 'cltbld', 10:21:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:11 INFO - '_': '/tools/buildbot/bin/python'} 10:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 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)) 10:21:11 INFO - Cleaning up... 10:21:11 INFO - Return code: 0 10:21:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:21: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')]} 10:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21: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')]} 10:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:21:11 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 0x7f2800c1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a10790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, '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': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', '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 10:21:11 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 10:21:11 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 10:21:11 INFO - Using env: {'DISPLAY': ':0', 10:21:11 INFO - 'HOME': '/home/cltbld', 10:21:11 INFO - 'LANG': 'en_US.UTF-8', 10:21:11 INFO - 'LANGUAGE': 'en_US:en', 10:21:11 INFO - 'LOGNAME': 'cltbld', 10:21:11 INFO - 'MAIL': '/var/mail/cltbld', 10:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:11 INFO - 'MOZ_NO_REMOTE': '1', 10:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:11 INFO - 'NO_EM_RESTART': '1', 10:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:11 INFO - 'PWD': '/builds/slave/test', 10:21:11 INFO - 'SHELL': '/bin/bash', 10:21:11 INFO - 'SHLVL': '1', 10:21:11 INFO - 'TERM': 'linux', 10:21:11 INFO - 'TMOUT': '86400', 10:21:11 INFO - 'USER': 'cltbld', 10:21:11 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:11 INFO - '_': '/tools/buildbot/bin/python'} 10:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:21:11 INFO - Cleaning up... 10:21:11 INFO - Return code: 0 10:21:11 INFO - Running post-action listener: _resource_record_post_action 10:21:11 INFO - Running post-action listener: _start_resource_monitoring 10:21:11 INFO - Starting resource monitoring. 10:21:11 INFO - [mozharness: 2016-10-14 17:21:11.680335Z] Finished create-virtualenv step (success) 10:21:11 INFO - [mozharness: 2016-10-14 17:21:11.680919Z] Running install step. 10:21:11 INFO - Running pre-action listener: _resource_record_pre_action 10:21:11 INFO - Running main action method: install 10:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:21:11 INFO - Reading from file tmpfile_stdout 10:21:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:21:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:21:11 INFO - Reading from file tmpfile_stdout 10:21:11 INFO - Output received: 10:21:11 INFO - Usage: mozinstall [options] installer 10:21:11 INFO - Options: 10:21:11 INFO - -h, --help show this help message and exit 10:21:11 INFO - -d DEST, --destination=DEST 10:21:11 INFO - Directory to install application into. [default: 10:21:11 INFO - "/builds/slave/test"] 10:21:11 INFO - --app=APP Application being installed. [default: firefox] 10:21:11 INFO - mkdir: /builds/slave/test/build/application 10:21:11 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'] 10:21:11 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 10:21:28 INFO - Reading from file tmpfile_stdout 10:21:28 INFO - Output received: 10:21:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:21:28 INFO - Running post-action listener: _resource_record_post_action 10:21:28 INFO - [mozharness: 2016-10-14 17:21:28.955821Z] Finished install step (success) 10:21:28 INFO - [mozharness: 2016-10-14 17:21:28.956068Z] Running run-tests step. 10:21:28 INFO - Running pre-action listener: _resource_record_pre_action 10:21:28 INFO - Running main action method: run_tests 10:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:21:28 INFO - Python 2.7.3 10:21:28 INFO - Return code: 0 10:21:28 INFO - grabbing minidump binary from tooltool 10:21: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')]} 10:21:28 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 0x1a0d930>, '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 0x1a0e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0ecc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:21:28 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 10:21:28 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 10:21:28 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 10:21:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:21:29 INFO - Return code: 0 10:21:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:21:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:21:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:21:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:21:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 10:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 10:21:29 INFO - Using env: {'DISPLAY': ':0', 10:21:29 INFO - 'HOME': '/home/cltbld', 10:21:29 INFO - 'LANG': 'en_US.UTF-8', 10:21:29 INFO - 'LANGUAGE': 'en_US:en', 10:21:29 INFO - 'LOGNAME': 'cltbld', 10:21:29 INFO - 'MAIL': '/var/mail/cltbld', 10:21:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:21:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:21:29 INFO - 'MOZ_NO_REMOTE': '1', 10:21:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:21:29 INFO - 'NO_EM_RESTART': '1', 10:21:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:21:29 INFO - 'PWD': '/builds/slave/test', 10:21:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:21:29 INFO - 'SHELL': '/bin/bash', 10:21:29 INFO - 'SHLVL': '1', 10:21:29 INFO - 'TERM': 'linux', 10:21:29 INFO - 'TMOUT': '86400', 10:21:29 INFO - 'USER': 'cltbld', 10:21:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317', 10:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:21:29 INFO - '_': '/tools/buildbot/bin/python'} 10:21:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 10:21:29 INFO - mozversion application_buildid: 20161014073004 10:21:29 INFO - mozversion application_changeset: cb2dd5a34dd7b374500fedd72fe19df13c9a7a4d 10:21:29 INFO - mozversion application_display_name: Nightly 10:21:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:21:29 INFO - mozversion application_name: Firefox 10:21:29 INFO - mozversion application_remotingname: firefox 10:21:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:21:29 INFO - mozversion application_vendor: Mozilla 10:21:29 INFO - mozversion application_version: 52.0a1 10:21:29 INFO - mozversion platform_buildid: 20161014073004 10:21:29 INFO - mozversion platform_changeset: cb2dd5a34dd7b374500fedd72fe19df13c9a7a4d 10:21:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:21:29 INFO - mozversion platform_version: 52.0a1 10:21:29 INFO - using testdate: 1476465689 10:21:29 INFO - actual date: 1476465689 10:21:29 INFO - starting webserver on 'localhost:34768' 10:21:29 INFO - SUITE-START | Running 2 tests 10:21:29 INFO - TEST-START | dromaeo_css 10:21:29 INFO - operating with platform_type : linux_ 10:21:29 INFO - Initialising browser for dromaeo_css test... 10:21:29 INFO - TEST-INFO | started process 21915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTh6yt/profile http://localhost:34768/getInfo.html) 10:21:33 INFO - PROCESS | 21915 | __metrics Screen width/height:1600/1200 10:21:33 INFO - PROCESS | 21915 | colorDepth:24 10:21:33 INFO - PROCESS | 21915 | Browser inner width/height: 1024/697 10:21:33 INFO - PROCESS | 21915 | __metrics 10:21:33 INFO - PROCESS | 21915 | 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" 10:21:33 INFO - PROCESS | 21915 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:21:34 INFO - PROCESS | 21915 | console.error: PushService: 10:21:34 INFO - PROCESS | 21915 | stateChangeProcessEnqueue: Error transitioning state 10:21:34 INFO - PROCESS | 21915 | UnknownError 10:21:34 INFO - TEST-INFO | 21915: exit 0 10:21:34 INFO - Browser initialized. 10:21:34 INFO - Running cycle 1/1 for dromaeo_css test... 10:21:34 INFO - TEST-INFO | started process 22000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeTh6yt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:47 INFO - PROCESS | 22000 | RSS: Main: 171433984 10:21:47 INFO - PROCESS | 22000 | 10:22:38 INFO - PROCESS | 22000 | 1476465758780 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] 10:24:49 INFO - PROCESS | 22000 | Cycle 1(1): loaded http://localhost:34768/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34768/tests/dromaeo/cssquery-ext.html) 10:24:50 INFO - PROCESS | 22000 | RSS: Main: 277819392 10:24:50 INFO - PROCESS | 22000 | 10:27:53 INFO - PROCESS | 22000 | Cycle 1(1): loaded http://localhost:34768/tests/dromaeo/cssquery-ext.html (next: http://localhost:34768/tests/dromaeo/cssquery-jquery.html) 10:27:54 INFO - PROCESS | 22000 | RSS: Main: 274362368 10:27:54 INFO - PROCESS | 22000 | 10:30:55 INFO - PROCESS | 22000 | Cycle 1(1): loaded http://localhost:34768/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34768/tests/dromaeo/cssquery-mootools.html) 10:30:56 INFO - PROCESS | 22000 | RSS: Main: 213557248 10:30:56 INFO - PROCESS | 22000 | 10:33:58 INFO - PROCESS | 22000 | Cycle 1(1): loaded http://localhost:34768/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34768/tests/dromaeo/cssquery-prototype.html) 10:33:59 INFO - PROCESS | 22000 | RSS: Main: 211951616 10:33:59 INFO - PROCESS | 22000 | 10:37:02 INFO - PROCESS | 22000 | Cycle 1(1): loaded http://localhost:34768/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34768/tests/dromaeo/cssquery-yui.html) 10:37:02 INFO - PROCESS | 22000 | RSS: Main: 214294528 10:37:02 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | Cycle 1(1): loaded http://localhost:34768/tests/dromaeo/cssquery-yui.html (next: http://localhost:34768/tests/dromaeo/cssquery-dojo.html) 10:40:05 INFO - PROCESS | 22000 | RSS: Main: 312266752 10:40:05 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | __start_tp_report 10:40:05 INFO - PROCESS | 22000 | _x_x_mozilla_page_load 10:40:05 INFO - PROCESS | 22000 | _x_x_mozilla_page_load_details 10:40:05 INFO - PROCESS | 22000 | |i|pagename|runs| 10:40:05 INFO - PROCESS | 22000 | |0;dojo.html;2988.7459565936897;3024.6219222597174;3055.5722198892154;3062.433449811785;3073.216329835893;5184.481551844823;5229.947700522994;5300.761465734042;5315.096433606286;5387.703676297802;5279.155335146377;5325.600579956509;5442.537384322328;5444.537214336786;5471.50756431921;4694.554017368345;4703.6237101032;4753.595944344717;4783.234682450809;4808.302796094564;4879.097366987119;4884;4933.7286449245275;4935;4996.750162491879;4669.463011753658;4705.858824235278;4858.951410485885;4911.631627627924;4937.456879743226;4757.357756702835;4813.085513752376;4870.756462176877;4897.902041959176;4958.454569997298;4863.8297659582095;4867.148249056401;4867.537583929521;4875.536824001714;4927.137750893615;5324.094903866313;5379.085555455582;5388.595855310868;5390.353157621111;5394.514493695547;5461.9453805462235;5529.087700529408;5564.860878478071;5641.379448260688;5642.21009058728;5689.743961521742;5707.001274776898;5709.9714501427225;5710.514606258473;5768.74040668171;5296.046711591912;5304.045271851027;5306.734663266821;5310.920336194921;5371.4897084776885;5622.746976386073;5670.234518339971;5671.631343962629;5693.117566777073;5781.971090144607;5537.584681148849;5578.44215578447;5628.183913332544;5628.409017053233;5717.22817419643;5660.066089095253;5705.74324155414;5724.484796368347;5729.541636669056;5735.483806457439;5647.124695672095;5706.058500347396;5708;5712.200291959129;5715.457031581993;5434.076207044812;5476.2333273341765;5480.588955828329;5521.199426083195;5530.225768392428;4278.850240241577;4317.352397140454;4343;4355.760433176206;4398.868033958986;3888.261230366278;3903.33643280643;3942.6254505821903;3954.940675889864;4001.55982841893;5372.140457526777;5421.132618780976;5424.267723857229;5424.972875135599;5471.042567550663;5458.017556839807;5517.61376703635;5665.66006039639;5719.999000175036;5732.082866741302;5358.598105142052;5442.156465747816;5451.400345961941;5452.04589196889;5456.290682211366;4963.057019166346;4970.776315065831;4976.651634385558;4976.676516026447;5028.723420211923;5848.093545500455;5859.121131830259;5876.059830427112;5913.201717768046;5919.970400147971;5505.201745746765;5551.028570000153;5720.771169153354;5793.826185214281;5794.391588883275;5839.182514447895;5841.094630332305;5849.356570777296;5898.292204935436;5901.026330655393;5623.550115990629;5626.24045753818;5634.915476267941;5635.267415235993;5639.492445679908;5445.237666726741;5486.972565137308;5725.541956643375;5767.106098554731;5806.564507662027;5621.718914054362;5667.4615911488345;5669.404712505293;5708.4862362387585;5731.885362292647;5574.609777315549;5624.353199382123;5625.296837895263;5628.887422251614;5653.038983372754;5280.4455532170105;5361.490658387447;5399.163129714743;5598.552115830806;5604.887902242014;5438.755256013568;5513.724313784375;5515.69663668486;5515.889682206413;5574.749136288958;5408.594355423437;5413.404525502113;5415.350157981067;5416.593755468277;5419.295491586068 10:40:05 INFO - PROCESS | 22000 | |1;ext.html;553.700082218888;568.4230506036373;601.7322291580247;602.1118849696695;609.3784339973224;30506.389872202544;39638.80180599097;40243.99999999996;40334.59665403345;40350.59649403505;41426.61454010982;41895;42013;42037.15925681492;42079;7960.52236865787;8776.824463510742;8928;8933.59798809052;8937.329700272474;7874.5668988205625;10529;10794.676159715182;10794.946025269863;11058.447077646126;10475.161987041056;10483.68548943533;10502.947485262563;10533.683989480327;10535.10451611614;7953.562554059525;10734.677959661183;10808.945955270252;10824.512896919658;10831.566737330497;7912.960435197845;10075.647352342632;10412.84380734282;10464.63373781914;10781.460926953621;40711.796441017905;40737.59262407397;40898.386524202164;41034.1793164138;41092;3168.318811455525;3242.633303308948;3308.6360500344945;3875.302445559798;3922.5881282465502;30213;30634;30854;32831.6716832831;33574.1606459838;4388.802503887333;4396.670249731251;4411.228035093878;4411.470623525198;4472.619827314682;335008;337322;338487;338656;339664;58354.70822645944;58707.70646146742;58723;58735.41264587385;58807;34373.48439773406;35364.469532957024;35422.64577354245;60662.327144014125;60997.695011525546;14036.649083772783;14132.364043617856;14137.929310353382;14142.36359363831;14144.85855141456;9357.438553686665;9512.33413661037;10475.895241047645;10538.420386878795;10562;16316.347346106022;16473.83526164747;17977.730334044998;18540.907295463705;18610.720839187423;6709.228438729511;6987.406070484066;7139.857202855914;7145.964270178616;7357.742479013209;908.418612088264;1010.686687126993;1035.063267742694;1040.8750949885912;1052.5000624703205;31523;31588.52617210744;31601.20996975094;31654.52518212229;32248;1030.8093002794358;1054.7415883108688;1071.3786004117594;1087.9564817407215;1131.3438205840594;16003;16626.25181866819;16666.916650417683;16804.83195168057;16831.83168168327;153356;506769;508359;509157;509336.4398136124;54140;54640.726796365765;54738.45261547413;54791.72604136954;54793;1165.6969188011178;1192.6779769462196;1249.2129958126322;1295.8121072444442;1308.8560258371572;29351.412971740872;32121.35757284888;32289;32387.51418728674;32589.348213035133;47299.76350118227;47852.104402773155;47855.14679784251;47855.65010449235;48011.75994120007;350898;354024;354683;354715;354767;25104.748952510243;25325.873370633028;25710.742892570834;26493.867530662224;26882.32794180161;42759;43011.78494107509;43136.78431607822;43157.13685726331;43626.78186609047;36390.454143187344;37204.62795372012;37225.627743722216;37420.6257937428;38671.6132838668;37156;37217.81391093027;37658.62341376551;38033.80983095067;38866.61133388743;37265.919475299605;37673.811630942764;37999.810000949816;38059.2388152241;38091.42862857115;31362.215944600655;32348.676513234568;33294.83352583222;33457.16357090995;33517.497237541946;26116;26691.466170676867;26714.732852672;26810.19569412921;27151.185464436097 10:40:05 INFO - PROCESS | 22000 | |2;jquery.html;361.8480238299914;372.8545867111825;376.992514858379;388.9027743064234;400.7735629369406;14405.20771357575;18493.260269589216;19256.711149332772;19356.806431935678;20616.17535298586;18374.448766536992;19427.32004379847;19574;19578.608427831434;19621.215151393964;5484.451554844513;5765.250517432749;5767.971160144193;5768.653880767147;5769.249997500319;5556.222128901957;5618.606697531174;5685.488306052454;5734.082546792514;5742.4831765141125;5696.943030569703;5697.145428185764;5704.65772053676;5707.029804933171;5707.1153971134545;5498.752556134984;5644.520215781664;5671.262735844314;5674.347450043216;5709.543236541088;5049.368828896388;5059.671121377099;5065.974670126662;5067.442581316052;5068.771905264235;23007.539849202924;23158.189463368868;23182.7681723184;23320.183793567314;23517.88241058801;2371.762823717632;2619.5022945640458;2940.250236189779;2973.108067579739;3006.939861202786;13750.449982000808;14259.287035648176;14857.805571802115;14987.625309367353;15076.396944122222;1862.1434140295346;1873.0468361233327;1928.9131989060386;1943.1353047893692;1988.6122206169803;71848.6407567964;73988.63005684991;75961.62019189924;77715.00564949181;86811.13188868093;10168.847467287997;10585.311954722918;10597.894021059845;10648.361098334124;10746.73133171677;14666.56000319992;14670.926645366704;14755.852441475663;14765.557033289018;14769.11385316863;6151.169592105009;6166.229221347332;6808.591484510846;7482.3639990601405;7628.8855667165035;6842.247352791189;6929.341712537301;7058.576485410892;7074.858502830018;7096.858062838817;4420.7126536775;4554.908901822011;4624.838130665478;4648.442186937589;4681.6722829401615;1814.0748218408708;1883.9905800471183;1898.686716691758;1919.280269898788;1923.538350795799;836.8661014237692;924.930630202724;939.5443210043123;958.4297343080856;992.3797626483448;18368.816311836978;19797;19810.40568782939;19988.50028749264;20229.595408091755;918.8621706743908;944.8063147054837;951.3198063384713;955.5938726041404;978.554757585297;9888.307818452638;11008.39453830047;11106.944465277622;11144.33134011962;11185.552577896955;441262;442457;445937;447171;449105;86788.56605716932;86966.56516717502;87233;87313.56343218243;87551;977.0424983516194;1024.9436281004616;1039.7972395382828;1041.416806588313;1047.5757318286107;16658.916705416395;16772.664546708755;17408.21663025192;17875.28498860031;18178.636427271114;33807;41719.37420938749;42609.147817044104;43324.783376082916;44103.77948110239;53684;59963;62481.875906205416;63205.367946321785;64545;7628;7916.525008499509;8235.094139644754;8378.53918034514;8399.916000839914;11309.830352544554;12845.293508857103;12893.484260629844;13392.799108013192;13403.463861445824;11507.194496385508;11526.481308340977;11543;11737.530498779954;12140.210886292363;10901.509432075418;11035.779284414106;11234.269772464764;11386.829197562209;11417.429128543707;11541.922453958032;11707.88292117068;11833.230839995373;11967.589237067394;12112.636620901387;7345.522541034816;7350.77947661571;7531.585762783099;7720.227977202235;8604.39769216174;10563.313384629975;11737.941310293394;11864.169508134348;11899.464524096264;12261.75476490483 10:40:05 INFO - PROCESS | 22000 | |3;mootools.html;1272.8090786382036;1422.025912250109;1456.373759283508;1528.7859699642052;1720.8021077576075;7838.64726087326;8514.744557663273;8852.114788521145;8866.069062748407;9052.411593246434;8906.688265910694;8987;8988.415752976069;8990.157017811349;8997.235235005017;2216.468047668556;2240.820734341257;2243.674667173259;2247.2359397804744;2248.921287754929;2183.3122566391617;2204.9779502204933;2267.1044937249776;2267.331137314488;2269.7616750241236;2214.8449608527408;2215.6565732311437;2234.5084081502123;2238.876861772602;2255.2670382125793;2180.4875854174256;2215.504534439255;2216.9224077157382;2223.5108276179217;2228.1310288987306;2164.101897712447;2168.6313326734335;2170.7395112586432;2173.1633321171303;2173.7826217378292;8905.643774249022;8942;8969.910300896972;8972.371933964625;9193;5038.773255203525;5166.457521960216;5174.197999310075;5177.326947496839;5180.430152683201;3091.9550996061253;3217.501287300472;3221.468457704476;3272.296456261915;3281.917952051194;1019.8827134879509;1035.342557476008;1038.8182068138121;1040.1782591752506;1068.3910171202417;12378.44297006637;12411.627651170389;12538.68653283666;12546.435410406553;12561.560345387868;4155.542890282067;4223.619874211336;4339.652827773771;4361.956380436219;4364;9972.10251077392;9976.05227503386;9979.301448898508;9979.650712225037;9986.101250887456;5022.321986531844;5053.570446512014;5064.772085256172;5067.771950262247;5073.8731531712;4216.768077755692;4229.323308270662;4699.459562150328;4706.058788242365;4717.339572459859;3616.52985111939;3666.175110600094;3749.2876353492748;3763.6048214937587;3808.619138086169;1047.1675018360422;1065.0574241795912;1065.7016035510069;1072.9624463143753;1076.4187338836941;909.2680392284143;935.8036697793942;938.887333519982;962.7785609309898;1000.314784372707;5676.262085928885;5733.971330143323;5934.851628709231;6003.5797494174985;6150.415710507495;938.9061093890556;944.2870632672426;957.712686194139;960.4189465373348;973.5278389980854;3828.1386687995537;3936.6653834423823;4045.3122969095325;4100.384942258625;4149.626533611929;10514.316569422963;10788.622398216025;11102.555897764;11154.609588664358;11302.943485282522;11187.832182517268;11197.944010279896;11208.66374008781;11236.831447528293;11259.887401126047;8142;8229.670813167526;8386.161383861565;8424.452410593414;8452;5936.614120082181;5980.162777211281;6062.878742425215;6065.2418447694035;6269.811905642838;10141.847872281774;10390.58437662485;10422.947885260828;10559.102476289601;10565.735856603646;9988.450635215133;10422.843657345298;10426.165906727596;10647.733806654896;10707.143428525544;7312.670929808065;7511.737089201852;7917.960410197912;8088.8786668198845;8094.352451803959;8328.333733301442;8524.531150786766;8615.741527754177;8874.112588741074;8882.200601945857;7290.5625662460425;7673.884891726517;7785.260400261966;7950;8001.159878212704;7395.149557800922;7415.369693575891;7451.627418628938;7458.738944137146;7829.765107046797;6922;7038.648067596702;7053.506254562337;7055.506114571931;7058.188308344606;5145.819896303611;5157.406898206755;5281.392639846466;5377.865553361197;5437.265969094122;5319.494648008433;5398.9190162146815;5424.593155513273;5450.727463626724;5456.017916775018 10:40:05 INFO - PROCESS | 22000 | |4;prototype.html;297.8704263645313;305.42427524117033;312.96400913894894;315.99052028439144;319.31984872222165;5321.3348331458565;5331.280277162582;5370.248165256862;5370.89258214836;5377.838664840051;5184.533391994729;5221.895562088756;5234.555062819655;5249.501297376743;5279.155335146377;3821.21665058663;3908.2965066288057;3927.9214415711667;3983.820728067244;3984.1434091670285;3979.8010099495054;3988.8205030773684;3988.9401658974994;4027.9798601006955;4071.7808794207226;3995.2009598080353;3998.6801055915603;4003.6378536663365;4010.6189911958463;4021.4369988201674;3829.8659546915865;3870.8838734838;3974.463447434588;4044.757314561136;4054.1891621675486;3546.184377593168;3546.3261980223674;3555.928881422383;3556.626554211822;3580.15866271426;5092.490750924915;5115.155999260118;5137.6403651744395;5185.559227465632;5211.478852114796;4495.168393847149;4627.9074418511445;4664.72011679297;4673;4680.3681502997;5410.5401040911565;5430.59270554706;5434.619576629638;5439.755211015514;5440.972795136038;3815.1225218199693;3949.98025009876;3959.227950549644;3966.719136496526;3969.7419667721506;5700.828975130711;5702.6293290935955;5725.570582206351;5740.799072032501;5745.655260684331;4034.91930161401;4039.384246301503;4048.9392659110135;4051.6353528182603;4054;4091.6702071826776;4095.2014357200655;4100.7334523255895;4105.7331273467125;4114.382842573638;4479.417675702138;4641.2109941310055;4654.697444666086;4700.365450664117;4729.314249433813;5539.612227144061;5558.110702287615;5591.378500234886;5611.691356975324;5617.859553511195;1414.5190635184088;1423.672555312284;1424.4088703188268;1424.7293014327245;1435.3350113867864;903.1690844423147;946.9857952130724;956.416585882611;958.6117622362954;960.8222478841436;5125.948740512547;5175;5276.3932147802725;5343.893122137535;5389.9191512127345;5669.971650141723;5696.3449203341315;5698.572607054488;5715.342735585461;5734.455226753452;5195.376554813371;5353.7055461949185;5364.463553644604;5382.91925621116;5384.165454354503;2980.6274215723033;2989.282572182704;2998.7001299870276;3000.7599392048583;3028.303490197267;5778.162166485836;5822.505087067562;5835.270591176103;5844;5855.853603659857;5520.503154716095;5683.6466484773355;5765.913511297334;5807.941920580824;5822.621529600562;5889.352171261158;5908.172855800191;5923.229980102559;5934.970325148347;5939.851503712442;5400.783968641211;5629.915551266652;5731.684757338219;5797.768089276382;5812.052962257691;5588.776448941997;5606.299212598426;5627.831165065055;5635.239242702182;5644.8306550803545;5856.385079566755;5868.151532267322;5905.202797622266;5976.342602313829;5986.760529578943;3893.2213557288087;3965.385365268388;3969.7419667721506;3971.305021621147;3990.4812374392304;5736.397678243724;5739.044392138136;5746.5402767779315;5751.396103409082;5757.424257574209;5611.80358687444;5634.661920284796;5673.687947162945;5679.062954612443;5687.744051517609;5308.867278318073;5502.972485137549;5542.251796007487;5543.223948647274;5560.97219513916;5448.447192550104;5450.155225939986;5486.643368181215;5514.172874068921;5540.556755459635;5303.257543943774;5326.2010698394;5443.646162999393;5487.996881138435;5508.476694713996;5394.379646340721;5395.70323632204;5436.8640783979135;5452.26394436746;5483.245361484446 10:40:05 INFO - PROCESS | 22000 | |5;yui.html;716.7348081209954;725.8620862036213;767.5701607100025;774.1987043410072;796.3310818912113;15846.207689615516;16877.74683379747;16932.576685582866;16965.660686786257;17001.31994720211;15428.3828646854;15605.453809116683;15623.453179138733;15636.84363156368;15647.765283520755;663.6880666086931;678.0202607232526;781.9843603127935;793.2820797178548;804.7143264141233;826.4132465949153;827.5200383777425;830.8919840420767;832.50881979632;834.1158372125536;854.2738672128703;857.5455008845322;866.1511718515858;867.2195024477958;867.3364875869964;847.2120927537388;848.9915100849005;849.2399302624117;849.3841964575695;849.5709666618349;509.796081567376;522.681164489661;604.7671646416118;618.1531302116085;624.7032659486753;14628.853711462856;14633.41466341345;14633.926830365781;14641.41434342625;14648;13622.659433514142;13998.440062397493;14307.14157150564;14519;14555.345009474599;12987.155834870704;13081.738365232737;13210.471581136742;13392.397342119531;13830.308484575731;4338.522762496123;4420.160169567772;4455.131249406367;4511.909761804745;4621.838235661769;79063.6046819768;79737;81093.59453202755;83145.16854831495;83286;11333.376664283378;11337.829932551018;11396.430178491208;11401.258918170292;11842.88157118435;21604.675929861063;21731.782682173292;21846;21885.234016809653;21934;8183.386246031571;8210.917890821134;8499.532525711022;8553.74338769838;8705.173008564303;3675.8162091895833;4129.8967525811495;4370.169667763115;4387.670924680661;4490.371348011281;3378.8986330410125;3528.68241858234;3534.4698295255403;3535.9469607955903;3539.3629146753315;595.8480587450173;606.5178183344252;611.3458599298708;627.2660986645635;628.6573817269508;614.2690198663576;616.1497133955113;630.1555915073823;631.8957372033655;647.4917190005823;9023.774405639911;9156.221721153777;9321.673741419017;9513;9617.422954622745;618.6891958534869;630.2625927664643;638.9936100639027;645.8117064601156;660.5577491370495;4327.199468098412;4383.364412160283;4431.224535706238;4480.910381792346;4496.64026877849;119496;120814;122114.3894280523;122143.3892830548;126948;106904.68810926055;107031.46484267528;107439;107685.46157269164;112050.43974780237;75808;91896;94200.52899735594;95232;98400.01599984051;9385.296102792181;9431.764205894633;9774.560144793359;9979.550920208752;10017.749556261151;44070.559294406645;44291.33562996622;46655;53257;53720;71975;72227;73022.49083919491;74528.62735686287;77042;11519.53921843117;11844.289342639124;11979.880201197877;12003.339816310187;12089;12982.675433114247;13382.330883455594;13409.32953352309;13429.328533573478;13510.189388636712;13064.412101455648;13409.798853017017;13470.797938031134;13490.797638035241;13623.86376136226;12554.43505042257;12916.93541532324;13385.531506397228;13597.713932345547;13621.727565448833;12231.75536489283;13103.868961310265;13934.034416825956;14067.507637232648;14096.859031409555;10474.890152173251;10743.89256107429;10906.236563440483;11010.944945275543;11559.248648837798;10118.544665489924;10158.695239142837;10192.439415832201;11169.609063683058;11491.712707182052 10:40:05 INFO - PROCESS | 22000 | __end_tp_report 10:40:05 INFO - PROCESS | 22000 | __start_cc_report 10:40:05 INFO - PROCESS | 22000 | _x_x_mozilla_cycle_collect,1093 10:40:05 INFO - PROCESS | 22000 | __end_cc_report 10:40:05 INFO - PROCESS | 22000 | __startTimestamp1476466805811__endTimestamp 10:40:05 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | ------- Summary: start ------- 10:40:05 INFO - PROCESS | 22000 | Number of tests: 6 10:40:05 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | [#0] dojo.html Cycles:165 Average:5279.99 Median:5452.05 stddev:592.39 (10.9%) stddev-sans-first:566.28 10:40:05 INFO - PROCESS | 22000 | Values: 2988.7 3024.6 3055.6 3062.4 3073.2 5184.5 5229.9 5300.8 5315.1 5387.7 5279.2 5325.6 5442.5 5444.5 5471.5 4694.6 4703.6 4753.6 4783.2 4808.3 4879.1 4884.0 4933.7 4935.0 4996.8 4669.5 4705.9 4859.0 4911.6 4937.5 4757.4 4813.1 4870.8 4897.9 4958.5 4863.8 4867.1 4867.5 4875.5 4927.1 5324.1 5379.1 5388.6 5390.4 5394.5 5461.9 5529.1 5564.9 5641.4 5642.2 5689.7 5707.0 5710.0 5710.5 5768.7 5296.0 5304.0 5306.7 5310.9 5371.5 5622.7 5670.2 5671.6 5693.1 5782.0 5537.6 5578.4 5628.2 5628.4 5717.2 5660.1 5705.7 5724.5 5729.5 5735.5 5647.1 5706.1 5708.0 5712.2 5715.5 5434.1 5476.2 5480.6 5521.2 5530.2 4278.9 4317.4 4343.0 4355.8 4398.9 3888.3 3903.3 3942.6 3954.9 4001.6 5372.1 5421.1 5424.3 5425.0 5471.0 5458.0 5517.6 5665.7 5720.0 5732.1 5358.6 5442.2 5451.4 5452.0 5456.3 4963.1 4970.8 4976.7 4976.7 5028.7 5848.1 5859.1 5876.1 5913.2 5920.0 5505.2 5551.0 5720.8 5793.8 5794.4 5839.2 5841.1 5849.4 5898.3 5901.0 5623.6 5626.2 5634.9 5635.3 5639.5 5445.2 5487.0 5725.5 5767.1 5806.6 5621.7 5667.5 5669.4 5708.5 5731.9 5574.6 5624.4 5625.3 5628.9 5653.0 5280.4 5361.5 5399.2 5598.6 5604.9 5438.8 5513.7 5515.7 5515.9 5574.7 5408.6 5413.4 5415.4 5416.6 5419.3 10:40:05 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | [#1] ext.html Cycles:180 Average:53331.77 Median:193131.23 stddev:102660.66 (53.2%) stddev-sans-first:102872.17 10:40:05 INFO - PROCESS | 22000 | Values: 553.7 568.4 601.7 602.1 609.4 30506.4 39638.8 40244.0 40334.6 40350.6 41426.6 41895.0 42013.0 42037.2 42079.0 7960.5 8776.8 8928.0 8933.6 8937.3 7874.6 10529.0 10794.7 10794.9 11058.4 10475.2 10483.7 10502.9 10533.7 10535.1 7953.6 10734.7 10808.9 10824.5 10831.6 7913.0 10075.6 10412.8 10464.6 10781.5 40711.8 40737.6 40898.4 41034.2 41092.0 3168.3 3242.6 3308.6 3875.3 3922.6 30213.0 30634.0 30854.0 32831.7 33574.2 4388.8 4396.7 4411.2 4411.5 4472.6 335008.0 337322.0 338487.0 338656.0 339664.0 58354.7 58707.7 58723.0 58735.4 58807.0 34373.5 35364.5 35422.6 60662.3 60997.7 14036.6 14132.4 14137.9 14142.4 14144.9 9357.4 9512.3 10475.9 10538.4 10562.0 16316.3 16473.8 17977.7 18540.9 18610.7 6709.2 6987.4 7139.9 7146.0 7357.7 908.4 1010.7 1035.1 1040.9 1052.5 31523.0 31588.5 31601.2 31654.5 32248.0 1030.8 1054.7 1071.4 1088.0 1131.3 16003.0 16626.3 16666.9 16804.8 16831.8 153356.0 506769.0 508359.0 509157.0 509336.4 54140.0 54640.7 54738.5 54791.7 54793.0 1165.7 1192.7 1249.2 1295.8 1308.9 29351.4 32121.4 32289.0 32387.5 32589.3 47299.8 47852.1 47855.1 47855.7 48011.8 350898.0 354024.0 354683.0 354715.0 354767.0 25104.7 25325.9 25710.7 26493.9 26882.3 42759.0 43011.8 43136.8 43157.1 43626.8 36390.5 37204.6 37225.6 37420.6 38671.6 37156.0 37217.8 37658.6 38033.8 38866.6 37265.9 37673.8 37999.8 38059.2 38091.4 31362.2 32348.7 33294.8 33457.2 33517.5 26116.0 26691.5 26714.7 26810.2 27151.2 10:40:05 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | [#2] jquery.html Cycles:180 Average:27536.18 Median:374.92 stddev:73544.34 (19615.8%) stddev-sans-first:73722.34 10:40:05 INFO - PROCESS | 22000 | Values: 361.8 372.9 377.0 388.9 400.8 14405.2 18493.3 19256.7 19356.8 20616.2 18374.4 19427.3 19574.0 19578.6 19621.2 5484.5 5765.3 5768.0 5768.7 5769.2 5556.2 5618.6 5685.5 5734.1 5742.5 5696.9 5697.1 5704.7 5707.0 5707.1 5498.8 5644.5 5671.3 5674.3 5709.5 5049.4 5059.7 5066.0 5067.4 5068.8 23007.5 23158.2 23182.8 23320.2 23517.9 2371.8 2619.5 2940.3 2973.1 3006.9 13750.4 14259.3 14857.8 14987.6 15076.4 1862.1 1873.0 1928.9 1943.1 1988.6 71848.6 73988.6 75961.6 77715.0 86811.1 10168.8 10585.3 10597.9 10648.4 10746.7 14666.6 14670.9 14755.9 14765.6 14769.1 6151.2 6166.2 6808.6 7482.4 7628.9 6842.2 6929.3 7058.6 7074.9 7096.9 4420.7 4554.9 4624.8 4648.4 4681.7 1814.1 1884.0 1898.7 1919.3 1923.5 836.9 924.9 939.5 958.4 992.4 18368.8 19797.0 19810.4 19988.5 20229.6 918.9 944.8 951.3 955.6 978.6 9888.3 11008.4 11106.9 11144.3 11185.6 441262.0 442457.0 445937.0 447171.0 449105.0 86788.6 86966.6 87233.0 87313.6 87551.0 977.0 1024.9 1039.8 1041.4 1047.6 16658.9 16772.7 17408.2 17875.3 18178.6 33807.0 41719.4 42609.1 43324.8 44103.8 53684.0 59963.0 62481.9 63205.4 64545.0 7628.0 7916.5 8235.1 8378.5 8399.9 11309.8 12845.3 12893.5 13392.8 13403.5 11507.2 11526.5 11543.0 11737.5 12140.2 10901.5 11035.8 11234.3 11386.8 11417.4 11541.9 11707.9 11833.2 11967.6 12112.6 7345.5 7350.8 7531.6 7720.2 8604.4 10563.3 11737.9 11864.2 11899.5 12261.8 10:40:05 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | [#3] mootools.html Cycles:180 Average:5787.00 Median:5030.55 stddev:3389.40 (67.4%) stddev-sans-first:3381.92 10:40:05 INFO - PROCESS | 22000 | Values: 1272.8 1422.0 1456.4 1528.8 1720.8 7838.6 8514.7 8852.1 8866.1 9052.4 8906.7 8987.0 8988.4 8990.2 8997.2 2216.5 2240.8 2243.7 2247.2 2248.9 2183.3 2205.0 2267.1 2267.3 2269.8 2214.8 2215.7 2234.5 2238.9 2255.3 2180.5 2215.5 2216.9 2223.5 2228.1 2164.1 2168.6 2170.7 2173.2 2173.8 8905.6 8942.0 8969.9 8972.4 9193.0 5038.8 5166.5 5174.2 5177.3 5180.4 3092.0 3217.5 3221.5 3272.3 3281.9 1019.9 1035.3 1038.8 1040.2 1068.4 12378.4 12411.6 12538.7 12546.4 12561.6 4155.5 4223.6 4339.7 4362.0 4364.0 9972.1 9976.1 9979.3 9979.7 9986.1 5022.3 5053.6 5064.8 5067.8 5073.9 4216.8 4229.3 4699.5 4706.1 4717.3 3616.5 3666.2 3749.3 3763.6 3808.6 1047.2 1065.1 1065.7 1073.0 1076.4 909.3 935.8 938.9 962.8 1000.3 5676.3 5734.0 5934.9 6003.6 6150.4 938.9 944.3 957.7 960.4 973.5 3828.1 3936.7 4045.3 4100.4 4149.6 10514.3 10788.6 11102.6 11154.6 11302.9 11187.8 11197.9 11208.7 11236.8 11259.9 8142.0 8229.7 8386.2 8424.5 8452.0 5936.6 5980.2 6062.9 6065.2 6269.8 10141.8 10390.6 10422.9 10559.1 10565.7 9988.5 10422.8 10426.2 10647.7 10707.1 7312.7 7511.7 7918.0 8088.9 8094.4 8328.3 8524.5 8615.7 8874.1 8882.2 7290.6 7673.9 7785.3 7950.0 8001.2 7395.1 7415.4 7451.6 7458.7 7829.8 6922.0 7038.6 7053.5 7055.5 7058.2 5145.8 5157.4 5281.4 5377.9 5437.3 5319.5 5398.9 5424.6 5450.7 5456.0 10:40:05 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | [#4] prototype.html Cycles:180 Average:4642.40 Median:5359.08 stddev:1385.47 (25.9%) stddev-sans-first:1350.44 10:40:05 INFO - PROCESS | 22000 | Values: 297.9 305.4 313.0 316.0 319.3 5321.3 5331.3 5370.2 5370.9 5377.8 5184.5 5221.9 5234.6 5249.5 5279.2 3821.2 3908.3 3927.9 3983.8 3984.1 3979.8 3988.8 3988.9 4028.0 4071.8 3995.2 3998.7 4003.6 4010.6 4021.4 3829.9 3870.9 3974.5 4044.8 4054.2 3546.2 3546.3 3555.9 3556.6 3580.2 5092.5 5115.2 5137.6 5185.6 5211.5 4495.2 4627.9 4664.7 4673.0 4680.4 5410.5 5430.6 5434.6 5439.8 5441.0 3815.1 3950.0 3959.2 3966.7 3969.7 5700.8 5702.6 5725.6 5740.8 5745.7 4034.9 4039.4 4048.9 4051.6 4054.0 4091.7 4095.2 4100.7 4105.7 4114.4 4479.4 4641.2 4654.7 4700.4 4729.3 5539.6 5558.1 5591.4 5611.7 5617.9 1414.5 1423.7 1424.4 1424.7 1435.3 903.2 947.0 956.4 958.6 960.8 5125.9 5175.0 5276.4 5343.9 5389.9 5670.0 5696.3 5698.6 5715.3 5734.5 5195.4 5353.7 5364.5 5382.9 5384.2 2980.6 2989.3 2998.7 3000.8 3028.3 5778.2 5822.5 5835.3 5844.0 5855.9 5520.5 5683.6 5765.9 5807.9 5822.6 5889.4 5908.2 5923.2 5935.0 5939.9 5400.8 5629.9 5731.7 5797.8 5812.1 5588.8 5606.3 5627.8 5635.2 5644.8 5856.4 5868.2 5905.2 5976.3 5986.8 3893.2 3965.4 3969.7 3971.3 3990.5 5736.4 5739.0 5746.5 5751.4 5757.4 5611.8 5634.7 5673.7 5679.1 5687.7 5308.9 5503.0 5542.3 5543.2 5561.0 5448.4 5450.2 5486.6 5514.2 5540.6 5303.3 5326.2 5443.6 5488.0 5508.5 5394.4 5395.7 5436.9 5452.3 5483.2 10:40:05 INFO - PROCESS | 22000 | 10:40:05 INFO - PROCESS | 22000 | [#5] yui.html Cycles:180 Average:21396.11 Median:4376.77 stddev:31761.07 (725.7%) stddev-sans-first:31812.22 10:40:05 INFO - PROCESS | 22000 | Values: 716.7 725.9 767.6 774.2 796.3 15846.2 16877.7 16932.6 16965.7 17001.3 15428.4 15605.5 15623.5 15636.8 15647.8 663.7 678.0 782.0 793.3 804.7 826.4 827.5 830.9 832.5 834.1 854.3 857.5 866.2 867.2 867.3 847.2 849.0 849.2 849.4 849.6 509.8 522.7 604.8 618.2 624.7 14628.9 14633.4 14633.9 14641.4 14648.0 13622.7 13998.4 14307.1 14519.0 14555.3 12987.2 13081.7 13210.5 13392.4 13830.3 4338.5 4420.2 4455.1 4511.9 4621.8 79063.6 79737.0 81093.6 83145.2 83286.0 11333.4 11337.8 11396.4 11401.3 11842.9 21604.7 21731.8 21846.0 21885.2 21934.0 8183.4 8210.9 8499.5 8553.7 8705.2 3675.8 4129.9 4370.2 4387.7 4490.4 3378.9 3528.7 3534.5 3535.9 3539.4 595.8 606.5 611.3 627.3 628.7 614.3 616.1 630.2 631.9 647.5 9023.8 9156.2 9321.7 9513.0 9617.4 618.7 630.3 639.0 645.8 660.6 4327.2 4383.4 4431.2 4480.9 4496.6 119496.0 120814.0 122114.4 122143.4 126948.0 106904.7 107031.5 107439.0 107685.5 112050.4 75808.0 91896.0 94200.5 95232.0 98400.0 9385.3 9431.8 9774.6 9979.6 10017.7 44070.6 44291.3 46655.0 53257.0 53720.0 71975.0 72227.0 73022.5 74528.6 77042.0 11519.5 11844.3 11979.9 12003.3 12089.0 12982.7 13382.3 13409.3 13429.3 13510.2 13064.4 13409.8 13470.8 13490.8 13623.9 12554.4 12916.9 13385.5 13597.7 13621.7 12231.8 13103.9 13934.0 14067.5 14096.9 10474.9 10743.9 10906.2 11010.9 11559.2 10118.5 10158.7 10192.4 11169.6 11491.7 10:40:05 INFO - PROCESS | 22000 | -------- Summary: end -------- 10:40:05 INFO - PROCESS | 22000 | 10:40:06 INFO - TEST-INFO | 22000: exit 0 10:40:06 INFO - TEST-OK | dromaeo_css | took 1117540ms 10:40:06 INFO - TEST-START | kraken 10:40:06 INFO - operating with platform_type : linux_ 10:40:06 INFO - Initialising browser for kraken test... 10:40:06 INFO - TEST-INFO | started process 22308 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2QI5yH/profile http://localhost:34768/getInfo.html) 10:40:10 INFO - PROCESS | 22308 | __metrics Screen width/height:1600/1200 10:40:10 INFO - PROCESS | 22308 | colorDepth:24 10:40:10 INFO - PROCESS | 22308 | Browser inner width/height: 1024/697 10:40:10 INFO - PROCESS | 22308 | __metrics 10:40:11 INFO - PROCESS | 22308 | 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" 10:40:11 INFO - PROCESS | 22308 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:40:11 INFO - PROCESS | 22308 | console.error: PushService: 10:40:11 INFO - PROCESS | 22308 | stateChangeProcessEnqueue: Error transitioning state 10:40:11 INFO - PROCESS | 22308 | UnknownError 10:40:12 INFO - TEST-INFO | 22308: exit 0 10:40:12 INFO - Browser initialized. 10:40:12 INFO - Running cycle 1/1 for kraken test... 10:40:12 INFO - TEST-INFO | started process 22388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2QI5yH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:24 INFO - PROCESS | 22388 | RSS: Main: 172003328 10:40:24 INFO - PROCESS | 22388 | 10:40:27 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34768/tests/kraken/driver.html?testName=audio-beat-detection) 10:40:27 INFO - PROCESS | 22388 | RSS: Main: 229298176 10:40:27 INFO - PROCESS | 22388 | 10:40:30 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34768/tests/kraken/driver.html?testName=audio-dft) 10:40:31 INFO - PROCESS | 22388 | RSS: Main: 215707648 10:40:31 INFO - PROCESS | 22388 | 10:40:34 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34768/tests/kraken/driver.html?testName=audio-fft) 10:40:34 INFO - PROCESS | 22388 | RSS: Main: 297443328 10:40:34 INFO - PROCESS | 22388 | 10:40:37 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34768/tests/kraken/driver.html?testName=audio-oscillator) 10:40:37 INFO - PROCESS | 22388 | RSS: Main: 206082048 10:40:37 INFO - PROCESS | 22388 | 10:40:39 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34768/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:40:40 INFO - PROCESS | 22388 | RSS: Main: 211562496 10:40:40 INFO - PROCESS | 22388 | 10:40:43 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34768/tests/kraken/driver.html?testName=imaging-darkroom) 10:40:43 INFO - PROCESS | 22388 | RSS: Main: 248164352 10:40:43 INFO - PROCESS | 22388 | 10:40:47 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34768/tests/kraken/driver.html?testName=imaging-desaturate) 10:40:47 INFO - PROCESS | 22388 | RSS: Main: 246882304 10:40:47 INFO - PROCESS | 22388 | 10:40:50 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34768/tests/kraken/driver.html?testName=json-parse-financial) 10:40:51 INFO - PROCESS | 22388 | RSS: Main: 246472704 10:40:51 INFO - PROCESS | 22388 | 10:40:52 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34768/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:40:53 INFO - PROCESS | 22388 | RSS: Main: 208744448 10:40:53 INFO - PROCESS | 22388 | 10:40:54 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34768/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:40:55 INFO - PROCESS | 22388 | RSS: Main: 215707648 10:40:55 INFO - PROCESS | 22388 | 10:40:57 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34768/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:40:58 INFO - PROCESS | 22388 | RSS: Main: 224976896 10:40:58 INFO - PROCESS | 22388 | 10:41:00 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:41:01 INFO - PROCESS | 22388 | RSS: Main: 234041344 10:41:01 INFO - PROCESS | 22388 | 10:41:04 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:41:04 INFO - PROCESS | 22388 | RSS: Main: 230936576 10:41:04 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | Cycle 1(1): loaded http://localhost:34768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34768/tests/kraken/driver.html?testName=ai-astar) 10:41:06 INFO - PROCESS | 22388 | RSS: Main: 281128960 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | __start_tp_report 10:41:06 INFO - PROCESS | 22388 | _x_x_mozilla_page_load 10:41:06 INFO - PROCESS | 22388 | _x_x_mozilla_page_load_details 10:41:06 INFO - PROCESS | 22388 | |i|pagename|runs| 10:41:06 INFO - PROCESS | 22388 | |0;ai-astar;103;112;111;111;115;112;110;111;111;110 10:41:06 INFO - PROCESS | 22388 | |1;audio-beat-detection;154;129;122;165;124;121;122;128;158;130 10:41:06 INFO - PROCESS | 22388 | |2;audio-dft;162;161;162;161;161;161;161;161;163;162 10:41:06 INFO - PROCESS | 22388 | |3;audio-fft;76;77;77;110;77;75;76;75;96;75 10:41:06 INFO - PROCESS | 22388 | |4;audio-oscillator;82;81;104;82;82;83;100;82;82;119 10:41:06 INFO - PROCESS | 22388 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;118;117;117 10:41:06 INFO - PROCESS | 22388 | |6;imaging-darkroom;147;146;146;146;146;146;164;145;145;146 10:41:06 INFO - PROCESS | 22388 | |7;imaging-desaturate;85;85;85;84;85;85;85;85;85;84 10:41:06 INFO - PROCESS | 22388 | |8;json-parse-financial;52;51;51;51;50;52;58;52;53;52 10:41:06 INFO - PROCESS | 22388 | |9;json-stringify-tinderbox;60;59;58;59;59;58;59;59;59;60 10:41:06 INFO - PROCESS | 22388 | |10;stanford-crypto-aes;81;80;79;90;86;79;79;85;80;85 10:41:06 INFO - PROCESS | 22388 | |11;stanford-crypto-ccm;135;133;128;133;132;133;130;133;170;141 10:41:06 INFO - PROCESS | 22388 | |12;stanford-crypto-pbkdf2;168;168;169;168;168;168;168;175;175;177 10:41:06 INFO - PROCESS | 22388 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;66;67;66;66;65 10:41:06 INFO - PROCESS | 22388 | __end_tp_report 10:41:06 INFO - PROCESS | 22388 | __start_cc_report 10:41:06 INFO - PROCESS | 22388 | _x_x_mozilla_cycle_collect,1660 10:41:06 INFO - PROCESS | 22388 | __end_cc_report 10:41:06 INFO - PROCESS | 22388 | __startTimestamp1476466866804__endTimestamp 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | ------- Summary: start ------- 10:41:06 INFO - PROCESS | 22388 | Number of tests: 14 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:3.03 (2.7%) stddev-sans-first:1.51 10:41:06 INFO - PROCESS | 22388 | Values: 103.0 112.0 111.0 111.0 115.0 112.0 110.0 111.0 111.0 110.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:129.50 stddev:16.85 (13.0%) stddev-sans-first:16.45 10:41:06 INFO - PROCESS | 22388 | Values: 154.0 129.0 122.0 165.0 124.0 121.0 122.0 128.0 158.0 130.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 10:41:06 INFO - PROCESS | 22388 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 161.0 161.0 163.0 162.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.50 stddev:11.88 (15.5%) stddev-sans-first:12.44 10:41:06 INFO - PROCESS | 22388 | Values: 76.0 77.0 77.0 110.0 77.0 75.0 76.0 75.0 96.0 75.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:82.00 stddev:13.28 (16.2%) stddev-sans-first:13.79 10:41:06 INFO - PROCESS | 22388 | Values: 82.0 81.0 104.0 82.0 82.0 83.0 100.0 82.0 82.0 119.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 10:41:06 INFO - PROCESS | 22388 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 118.0 117.0 117.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:146.00 stddev:5.76 (3.9%) stddev-sans-first:6.10 10:41:06 INFO - PROCESS | 22388 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 164.0 145.0 145.0 146.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 10:41:06 INFO - PROCESS | 22388 | Values: 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 84.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:2.20 (4.2%) stddev-sans-first:2.33 10:41:06 INFO - PROCESS | 22388 | Values: 52.0 51.0 51.0 51.0 50.0 52.0 58.0 52.0 53.0 52.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 10:41:06 INFO - PROCESS | 22388 | Values: 60.0 59.0 58.0 59.0 59.0 58.0 59.0 59.0 59.0 60.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:3.84 (4.6%) stddev-sans-first:4.03 10:41:06 INFO - PROCESS | 22388 | Values: 81.0 80.0 79.0 90.0 86.0 79.0 79.0 85.0 80.0 85.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:133.00 stddev:12.15 (9.1%) stddev-sans-first:12.86 10:41:06 INFO - PROCESS | 22388 | Values: 135.0 133.0 128.0 133.0 132.0 133.0 130.0 133.0 170.0 141.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:168.50 stddev:3.69 (2.2%) stddev-sans-first:3.81 10:41:06 INFO - PROCESS | 22388 | Values: 168.0 168.0 169.0 168.0 168.0 168.0 168.0 175.0 175.0 177.0 10:41:06 INFO - PROCESS | 22388 | 10:41:06 INFO - PROCESS | 22388 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 10:41:06 INFO - PROCESS | 22388 | Values: 66.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 66.0 65.0 10:41:06 INFO - PROCESS | 22388 | -------- Summary: end -------- 10:41:06 INFO - PROCESS | 22388 | 10:41:08 INFO - TEST-INFO | 22388: exit 0 10:41:08 INFO - TEST-OK | kraken | took 61283ms 10:41:08 INFO - SUITE-END | took 1178s 10:41:08 INFO - Completed test suite (00:19:39) 10:41:08 INFO - javascript benchmark 10:41:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2988.7459565936897, 3024.6219222597174, 3055.5722198892154, 3062.433449811785, 3073.216329835893, 5184.481551844823, 5229.947700522994, 5300.761465734042, 5315.096433606286, 5387.703676297802, 5279.155335146377, 5325.600579956509, 5442.537384322328, 5444.537214336786, 5471.50756431921, 4694.554017368345, 4703.6237101032, 4753.595944344717, 4783.234682450809, 4808.302796094564, 4879.097366987119, 4884.0, 4933.7286449245275, 4935.0, 4996.750162491879, 4669.463011753658, 4705.858824235278, 4858.951410485885, 4911.631627627924, 4937.456879743226, 4757.357756702835, 4813.085513752376, 4870.756462176877, 4897.902041959176, 4958.454569997298, 4863.8297659582095, 4867.148249056401, 4867.537583929521, 4875.536824001714, 4927.137750893615, 5324.094903866313, 5379.085555455582, 5388.595855310868, 5390.353157621111, 5394.514493695547, 5461.9453805462235, 5529.087700529408, 5564.860878478071, 5641.379448260688, 5642.21009058728, 5689.743961521742, 5707.001274776898, 5709.9714501427225, 5710.514606258473, 5768.74040668171, 5296.046711591912, 5304.045271851027, 5306.734663266821, 5310.920336194921, 5371.4897084776885, 5622.746976386073, 5670.234518339971, 5671.631343962629, 5693.117566777073, 5781.971090144607, 5537.584681148849, 5578.44215578447, 5628.183913332544, 5628.409017053233, 5717.22817419643, 5660.066089095253, 5705.74324155414, 5724.484796368347, 5729.541636669056, 5735.483806457439, 5647.124695672095, 5706.058500347396, 5708.0, 5712.200291959129, 5715.457031581993, 5434.076207044812, 5476.2333273341765, 5480.588955828329, 5521.199426083195, 5530.225768392428, 4278.850240241577, 4317.352397140454, 4343.0, 4355.760433176206, 4398.868033958986, 3888.261230366278, 3903.33643280643, 3942.6254505821903, 3954.940675889864, 4001.55982841893, 5372.140457526777, 5421.132618780976, 5424.267723857229, 5424.972875135599, 5471.042567550663, 5458.017556839807, 5517.61376703635, 5665.66006039639, 5719.999000175036, 5732.082866741302, 5358.598105142052, 5442.156465747816, 5451.400345961941, 5452.04589196889, 5456.290682211366, 4963.057019166346, 4970.776315065831, 4976.651634385558, 4976.676516026447, 5028.723420211923, 5848.093545500455, 5859.121131830259, 5876.059830427112, 5913.201717768046, 5919.970400147971, 5505.201745746765, 5551.028570000153, 5720.771169153354, 5793.826185214281, 5794.391588883275, 5839.182514447895, 5841.094630332305, 5849.356570777296, 5898.292204935436, 5901.026330655393, 5623.550115990629, 5626.24045753818, 5634.915476267941, 5635.267415235993, 5639.492445679908, 5445.237666726741, 5486.972565137308, 5725.541956643375, 5767.106098554731, 5806.564507662027, 5621.718914054362, 5667.4615911488345, 5669.404712505293, 5708.4862362387585, 5731.885362292647, 5574.609777315549, 5624.353199382123, 5625.296837895263, 5628.887422251614, 5653.038983372754, 5280.4455532170105, 5361.490658387447, 5399.163129714743, 5598.552115830806, 5604.887902242014, 5438.755256013568, 5513.724313784375, 5515.69663668486, 5515.889682206413, 5574.749136288958, 5408.594355423437, 5413.404525502113, 5415.350157981067, 5416.593755468277, 5419.295491586068], "value": 5240.20905989267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.700082218888, 568.4230506036373, 601.7322291580247, 602.1118849696695, 609.3784339973224, 30506.389872202544, 39638.80180599097, 40243.99999999996, 40334.59665403345, 40350.59649403505, 41426.61454010982, 41895.0, 42013.0, 42037.15925681492, 42079.0, 7960.52236865787, 8776.824463510742, 8928.0, 8933.59798809052, 8937.329700272474, 7874.5668988205625, 10529.0, 10794.676159715182, 10794.946025269863, 11058.447077646126, 10475.161987041056, 10483.68548943533, 10502.947485262563, 10533.683989480327, 10535.10451611614, 7953.562554059525, 10734.677959661183, 10808.945955270252, 10824.512896919658, 10831.566737330497, 7912.960435197845, 10075.647352342632, 10412.84380734282, 10464.63373781914, 10781.460926953621, 40711.796441017905, 40737.59262407397, 40898.386524202164, 41034.1793164138, 41092.0, 3168.318811455525, 3242.633303308948, 3308.6360500344945, 3875.302445559798, 3922.5881282465502, 30213.0, 30634.0, 30854.0, 32831.6716832831, 33574.1606459838, 4388.802503887333, 4396.670249731251, 4411.228035093878, 4411.470623525198, 4472.619827314682, 335008.0, 337322.0, 338487.0, 338656.0, 339664.0, 58354.70822645944, 58707.70646146742, 58723.0, 58735.41264587385, 58807.0, 34373.48439773406, 35364.469532957024, 35422.64577354245, 60662.327144014125, 60997.695011525546, 14036.649083772783, 14132.364043617856, 14137.929310353382, 14142.36359363831, 14144.85855141456, 9357.438553686665, 9512.33413661037, 10475.895241047645, 10538.420386878795, 10562.0, 16316.347346106022, 16473.83526164747, 17977.730334044998, 18540.907295463705, 18610.720839187423, 6709.228438729511, 6987.406070484066, 7139.857202855914, 7145.964270178616, 7357.742479013209, 908.418612088264, 1010.686687126993, 1035.063267742694, 1040.8750949885912, 1052.5000624703205, 31523.0, 31588.52617210744, 31601.20996975094, 31654.52518212229, 32248.0, 1030.8093002794358, 1054.7415883108688, 1071.3786004117594, 1087.9564817407215, 1131.3438205840594, 16003.0, 16626.25181866819, 16666.916650417683, 16804.83195168057, 16831.83168168327, 153356.0, 506769.0, 508359.0, 509157.0, 509336.4398136124, 54140.0, 54640.726796365765, 54738.45261547413, 54791.72604136954, 54793.0, 1165.6969188011178, 1192.6779769462196, 1249.2129958126322, 1295.8121072444442, 1308.8560258371572, 29351.412971740872, 32121.35757284888, 32289.0, 32387.51418728674, 32589.348213035133, 47299.76350118227, 47852.104402773155, 47855.14679784251, 47855.65010449235, 48011.75994120007, 350898.0, 354024.0, 354683.0, 354715.0, 354767.0, 25104.748952510243, 25325.873370633028, 25710.742892570834, 26493.867530662224, 26882.32794180161, 42759.0, 43011.78494107509, 43136.78431607822, 43157.13685726331, 43626.78186609047, 36390.454143187344, 37204.62795372012, 37225.627743722216, 37420.6257937428, 38671.6132838668, 37156.0, 37217.81391093027, 37658.62341376551, 38033.80983095067, 38866.61133388743, 37265.919475299605, 37673.811630942764, 37999.810000949816, 38059.2388152241, 38091.42862857115, 31362.215944600655, 32348.676513234568, 33294.83352583222, 33457.16357090995, 33517.497237541946, 26116.0, 26691.466170676867, 26714.732852672, 26810.19569412921, 27151.185464436097], "value": 19118.55041916809, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8480238299914, 372.8545867111825, 376.992514858379, 388.9027743064234, 400.7735629369406, 14405.20771357575, 18493.260269589216, 19256.711149332772, 19356.806431935678, 20616.17535298586, 18374.448766536992, 19427.32004379847, 19574.0, 19578.608427831434, 19621.215151393964, 5484.451554844513, 5765.250517432749, 5767.971160144193, 5768.653880767147, 5769.249997500319, 5556.222128901957, 5618.606697531174, 5685.488306052454, 5734.082546792514, 5742.4831765141125, 5696.943030569703, 5697.145428185764, 5704.65772053676, 5707.029804933171, 5707.1153971134545, 5498.752556134984, 5644.520215781664, 5671.262735844314, 5674.347450043216, 5709.543236541088, 5049.368828896388, 5059.671121377099, 5065.974670126662, 5067.442581316052, 5068.771905264235, 23007.539849202924, 23158.189463368868, 23182.7681723184, 23320.183793567314, 23517.88241058801, 2371.762823717632, 2619.5022945640458, 2940.250236189779, 2973.108067579739, 3006.939861202786, 13750.449982000808, 14259.287035648176, 14857.805571802115, 14987.625309367353, 15076.396944122222, 1862.1434140295346, 1873.0468361233327, 1928.9131989060386, 1943.1353047893692, 1988.6122206169803, 71848.6407567964, 73988.63005684991, 75961.62019189924, 77715.00564949181, 86811.13188868093, 10168.847467287997, 10585.311954722918, 10597.894021059845, 10648.361098334124, 10746.73133171677, 14666.56000319992, 14670.926645366704, 14755.852441475663, 14765.557033289018, 14769.11385316863, 6151.169592105009, 6166.229221347332, 6808.591484510846, 7482.3639990601405, 7628.8855667165035, 6842.247352791189, 6929.341712537301, 7058.576485410892, 7074.858502830018, 7096.858062838817, 4420.7126536775, 4554.908901822011, 4624.838130665478, 4648.442186937589, 4681.6722829401615, 1814.0748218408708, 1883.9905800471183, 1898.686716691758, 1919.280269898788, 1923.538350795799, 836.8661014237692, 924.930630202724, 939.5443210043123, 958.4297343080856, 992.3797626483448, 18368.816311836978, 19797.0, 19810.40568782939, 19988.50028749264, 20229.595408091755, 918.8621706743908, 944.8063147054837, 951.3198063384713, 955.5938726041404, 978.554757585297, 9888.307818452638, 11008.39453830047, 11106.944465277622, 11144.33134011962, 11185.552577896955, 441262.0, 442457.0, 445937.0, 447171.0, 449105.0, 86788.56605716932, 86966.56516717502, 87233.0, 87313.56343218243, 87551.0, 977.0424983516194, 1024.9436281004616, 1039.7972395382828, 1041.416806588313, 1047.5757318286107, 16658.916705416395, 16772.664546708755, 17408.21663025192, 17875.28498860031, 18178.636427271114, 33807.0, 41719.37420938749, 42609.147817044104, 43324.783376082916, 44103.77948110239, 53684.0, 59963.0, 62481.875906205416, 63205.367946321785, 64545.0, 7628.0, 7916.525008499509, 8235.094139644754, 8378.53918034514, 8399.916000839914, 11309.830352544554, 12845.293508857103, 12893.484260629844, 13392.799108013192, 13403.463861445824, 11507.194496385508, 11526.481308340977, 11543.0, 11737.530498779954, 12140.210886292363, 10901.509432075418, 11035.779284414106, 11234.269772464764, 11386.829197562209, 11417.429128543707, 11541.922453958032, 11707.88292117068, 11833.230839995373, 11967.589237067394, 12112.636620901387, 7345.522541034816, 7350.77947661571, 7531.585762783099, 7720.227977202235, 8604.39769216174, 10563.313384629975, 11737.941310293394, 11864.169508134348, 11899.464524096264, 12261.75476490483], "value": 9075.513092220635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.8090786382036, 1422.025912250109, 1456.373759283508, 1528.7859699642052, 1720.8021077576075, 7838.64726087326, 8514.744557663273, 8852.114788521145, 8866.069062748407, 9052.411593246434, 8906.688265910694, 8987.0, 8988.415752976069, 8990.157017811349, 8997.235235005017, 2216.468047668556, 2240.820734341257, 2243.674667173259, 2247.2359397804744, 2248.921287754929, 2183.3122566391617, 2204.9779502204933, 2267.1044937249776, 2267.331137314488, 2269.7616750241236, 2214.8449608527408, 2215.6565732311437, 2234.5084081502123, 2238.876861772602, 2255.2670382125793, 2180.4875854174256, 2215.504534439255, 2216.9224077157382, 2223.5108276179217, 2228.1310288987306, 2164.101897712447, 2168.6313326734335, 2170.7395112586432, 2173.1633321171303, 2173.7826217378292, 8905.643774249022, 8942.0, 8969.910300896972, 8972.371933964625, 9193.0, 5038.773255203525, 5166.457521960216, 5174.197999310075, 5177.326947496839, 5180.430152683201, 3091.9550996061253, 3217.501287300472, 3221.468457704476, 3272.296456261915, 3281.917952051194, 1019.8827134879509, 1035.342557476008, 1038.8182068138121, 1040.1782591752506, 1068.3910171202417, 12378.44297006637, 12411.627651170389, 12538.68653283666, 12546.435410406553, 12561.560345387868, 4155.542890282067, 4223.619874211336, 4339.652827773771, 4361.956380436219, 4364.0, 9972.10251077392, 9976.05227503386, 9979.301448898508, 9979.650712225037, 9986.101250887456, 5022.321986531844, 5053.570446512014, 5064.772085256172, 5067.771950262247, 5073.8731531712, 4216.768077755692, 4229.323308270662, 4699.459562150328, 4706.058788242365, 4717.339572459859, 3616.52985111939, 3666.175110600094, 3749.2876353492748, 3763.6048214937587, 3808.619138086169, 1047.1675018360422, 1065.0574241795912, 1065.7016035510069, 1072.9624463143753, 1076.4187338836941, 909.2680392284143, 935.8036697793942, 938.887333519982, 962.7785609309898, 1000.314784372707, 5676.262085928885, 5733.971330143323, 5934.851628709231, 6003.5797494174985, 6150.415710507495, 938.9061093890556, 944.2870632672426, 957.712686194139, 960.4189465373348, 973.5278389980854, 3828.1386687995537, 3936.6653834423823, 4045.3122969095325, 4100.384942258625, 4149.626533611929, 10514.316569422963, 10788.622398216025, 11102.555897764, 11154.609588664358, 11302.943485282522, 11187.832182517268, 11197.944010279896, 11208.66374008781, 11236.831447528293, 11259.887401126047, 8142.0, 8229.670813167526, 8386.161383861565, 8424.452410593414, 8452.0, 5936.614120082181, 5980.162777211281, 6062.878742425215, 6065.2418447694035, 6269.811905642838, 10141.847872281774, 10390.58437662485, 10422.947885260828, 10559.102476289601, 10565.735856603646, 9988.450635215133, 10422.843657345298, 10426.165906727596, 10647.733806654896, 10707.143428525544, 7312.670929808065, 7511.737089201852, 7917.960410197912, 8088.8786668198845, 8094.352451803959, 8328.333733301442, 8524.531150786766, 8615.741527754177, 8874.112588741074, 8882.200601945857, 7290.5625662460425, 7673.884891726517, 7785.260400261966, 7950.0, 8001.159878212704, 7395.149557800922, 7415.369693575891, 7451.627418628938, 7458.738944137146, 7829.765107046797, 6922.0, 7038.648067596702, 7053.506254562337, 7055.506114571931, 7058.188308344606, 5145.819896303611, 5157.406898206755, 5281.392639846466, 5377.865553361197, 5437.265969094122, 5319.494648008433, 5398.9190162146815, 5424.593155513273, 5450.727463626724, 5456.017916775018], "value": 4559.704643395484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.8704263645313, 305.42427524117033, 312.96400913894894, 315.99052028439144, 319.31984872222165, 5321.3348331458565, 5331.280277162582, 5370.248165256862, 5370.89258214836, 5377.838664840051, 5184.533391994729, 5221.895562088756, 5234.555062819655, 5249.501297376743, 5279.155335146377, 3821.21665058663, 3908.2965066288057, 3927.9214415711667, 3983.820728067244, 3984.1434091670285, 3979.8010099495054, 3988.8205030773684, 3988.9401658974994, 4027.9798601006955, 4071.7808794207226, 3995.2009598080353, 3998.6801055915603, 4003.6378536663365, 4010.6189911958463, 4021.4369988201674, 3829.8659546915865, 3870.8838734838, 3974.463447434588, 4044.757314561136, 4054.1891621675486, 3546.184377593168, 3546.3261980223674, 3555.928881422383, 3556.626554211822, 3580.15866271426, 5092.490750924915, 5115.155999260118, 5137.6403651744395, 5185.559227465632, 5211.478852114796, 4495.168393847149, 4627.9074418511445, 4664.72011679297, 4673.0, 4680.3681502997, 5410.5401040911565, 5430.59270554706, 5434.619576629638, 5439.755211015514, 5440.972795136038, 3815.1225218199693, 3949.98025009876, 3959.227950549644, 3966.719136496526, 3969.7419667721506, 5700.828975130711, 5702.6293290935955, 5725.570582206351, 5740.799072032501, 5745.655260684331, 4034.91930161401, 4039.384246301503, 4048.9392659110135, 4051.6353528182603, 4054.0, 4091.6702071826776, 4095.2014357200655, 4100.7334523255895, 4105.7331273467125, 4114.382842573638, 4479.417675702138, 4641.2109941310055, 4654.697444666086, 4700.365450664117, 4729.314249433813, 5539.612227144061, 5558.110702287615, 5591.378500234886, 5611.691356975324, 5617.859553511195, 1414.5190635184088, 1423.672555312284, 1424.4088703188268, 1424.7293014327245, 1435.3350113867864, 903.1690844423147, 946.9857952130724, 956.416585882611, 958.6117622362954, 960.8222478841436, 5125.948740512547, 5175.0, 5276.3932147802725, 5343.893122137535, 5389.9191512127345, 5669.971650141723, 5696.3449203341315, 5698.572607054488, 5715.342735585461, 5734.455226753452, 5195.376554813371, 5353.7055461949185, 5364.463553644604, 5382.91925621116, 5384.165454354503, 2980.6274215723033, 2989.282572182704, 2998.7001299870276, 3000.7599392048583, 3028.303490197267, 5778.162166485836, 5822.505087067562, 5835.270591176103, 5844.0, 5855.853603659857, 5520.503154716095, 5683.6466484773355, 5765.913511297334, 5807.941920580824, 5822.621529600562, 5889.352171261158, 5908.172855800191, 5923.229980102559, 5934.970325148347, 5939.851503712442, 5400.783968641211, 5629.915551266652, 5731.684757338219, 5797.768089276382, 5812.052962257691, 5588.776448941997, 5606.299212598426, 5627.831165065055, 5635.239242702182, 5644.8306550803545, 5856.385079566755, 5868.151532267322, 5905.202797622266, 5976.342602313829, 5986.760529578943, 3893.2213557288087, 3965.385365268388, 3969.7419667721506, 3971.305021621147, 3990.4812374392304, 5736.397678243724, 5739.044392138136, 5746.5402767779315, 5751.396103409082, 5757.424257574209, 5611.80358687444, 5634.661920284796, 5673.687947162945, 5679.062954612443, 5687.744051517609, 5308.867278318073, 5502.972485137549, 5542.251796007487, 5543.223948647274, 5560.97219513916, 5448.447192550104, 5450.155225939986, 5486.643368181215, 5514.172874068921, 5540.556755459635, 5303.257543943774, 5326.2010698394, 5443.646162999393, 5487.996881138435, 5508.476694713996, 5394.379646340721, 5395.70323632204, 5436.8640783979135, 5452.26394436746, 5483.245361484446], "value": 4196.902381416791, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7348081209954, 725.8620862036213, 767.5701607100025, 774.1987043410072, 796.3310818912113, 15846.207689615516, 16877.74683379747, 16932.576685582866, 16965.660686786257, 17001.31994720211, 15428.3828646854, 15605.453809116683, 15623.453179138733, 15636.84363156368, 15647.765283520755, 663.6880666086931, 678.0202607232526, 781.9843603127935, 793.2820797178548, 804.7143264141233, 826.4132465949153, 827.5200383777425, 830.8919840420767, 832.50881979632, 834.1158372125536, 854.2738672128703, 857.5455008845322, 866.1511718515858, 867.2195024477958, 867.3364875869964, 847.2120927537388, 848.9915100849005, 849.2399302624117, 849.3841964575695, 849.5709666618349, 509.796081567376, 522.681164489661, 604.7671646416118, 618.1531302116085, 624.7032659486753, 14628.853711462856, 14633.41466341345, 14633.926830365781, 14641.41434342625, 14648.0, 13622.659433514142, 13998.440062397493, 14307.14157150564, 14519.0, 14555.345009474599, 12987.155834870704, 13081.738365232737, 13210.471581136742, 13392.397342119531, 13830.308484575731, 4338.522762496123, 4420.160169567772, 4455.131249406367, 4511.909761804745, 4621.838235661769, 79063.6046819768, 79737.0, 81093.59453202755, 83145.16854831495, 83286.0, 11333.376664283378, 11337.829932551018, 11396.430178491208, 11401.258918170292, 11842.88157118435, 21604.675929861063, 21731.782682173292, 21846.0, 21885.234016809653, 21934.0, 8183.386246031571, 8210.917890821134, 8499.532525711022, 8553.74338769838, 8705.173008564303, 3675.8162091895833, 4129.8967525811495, 4370.169667763115, 4387.670924680661, 4490.371348011281, 3378.8986330410125, 3528.68241858234, 3534.4698295255403, 3535.9469607955903, 3539.3629146753315, 595.8480587450173, 606.5178183344252, 611.3458599298708, 627.2660986645635, 628.6573817269508, 614.2690198663576, 616.1497133955113, 630.1555915073823, 631.8957372033655, 647.4917190005823, 9023.774405639911, 9156.221721153777, 9321.673741419017, 9513.0, 9617.422954622745, 618.6891958534869, 630.2625927664643, 638.9936100639027, 645.8117064601156, 660.5577491370495, 4327.199468098412, 4383.364412160283, 4431.224535706238, 4480.910381792346, 4496.64026877849, 119496.0, 120814.0, 122114.3894280523, 122143.3892830548, 126948.0, 106904.68810926055, 107031.46484267528, 107439.0, 107685.46157269164, 112050.43974780237, 75808.0, 91896.0, 94200.52899735594, 95232.0, 98400.01599984051, 9385.296102792181, 9431.764205894633, 9774.560144793359, 9979.550920208752, 10017.749556261151, 44070.559294406645, 44291.33562996622, 46655.0, 53257.0, 53720.0, 71975.0, 72227.0, 73022.49083919491, 74528.62735686287, 77042.0, 11519.53921843117, 11844.289342639124, 11979.880201197877, 12003.339816310187, 12089.0, 12982.675433114247, 13382.330883455594, 13409.32953352309, 13429.328533573478, 13510.189388636712, 13064.412101455648, 13409.798853017017, 13470.797938031134, 13490.797638035241, 13623.86376136226, 12554.43505042257, 12916.93541532324, 13385.531506397228, 13597.713932345547, 13621.727565448833, 12231.75536489283, 13103.868961310265, 13934.034416825956, 14067.507637232648, 14096.859031409555, 10474.890152173251, 10743.89256107429, 10906.236563440483, 11010.944945275543, 11559.248648837798, 10118.544665489924, 10158.695239142837, 10192.439415832201, 11169.609063683058, 11491.712707182052], "value": 7490.417678126618, "unit": "score"}], "name": "dromaeo_css", "value": 7120.575485673004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 111.0, 115.0, 112.0, 110.0, 111.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 122.0, 165.0, 124.0, 121.0, 122.0, 128.0, 158.0, 130.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 163.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 110.0, 77.0, 75.0, 76.0, 75.0, 96.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 104.0, 82.0, 82.0, 83.0, 100.0, 82.0, 82.0, 119.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 164.0, 145.0, 145.0, 146.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 50.0, 52.0, 58.0, 52.0, 53.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 58.0, 59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 90.0, 86.0, 79.0, 79.0, 85.0, 80.0, 85.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 128.0, 133.0, 132.0, 133.0, 130.0, 133.0, 170.0, 141.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 169.0, 168.0, 168.0, 168.0, 168.0, 175.0, 175.0, 177.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1494.8000000000002, "alertThreshold": 2.0}]} 10:41:08 INFO - Return code: 0 10:41:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:41:08 INFO - # TBPL SUCCESS # 10:41:08 INFO - Running post-action listener: _resource_record_post_action 10:41:08 INFO - [mozharness: 2016-10-14 17:41:08.606184Z] Finished run-tests step (success) 10:41:08 INFO - Running post-run listener: _resource_record_post_run 10:41:08 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392355840; Read time: 12; Write time: 272720 10:41:08 INFO - TinderboxPrint: CPU usage
13.0% 10:41:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:41:08 INFO - TinderboxPrint: I/O write bytes / time
392,355,840 / 272,720 10:41:08 INFO - TinderboxPrint: CPU idle
8,297.1 (86.9%) 10:41:08 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 10:41:08 INFO - TinderboxPrint: Swap in / out
0 / 0 10:41:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103628800; Read time: 0; Write time: 84168 10:41:08 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288727040; Read time: 0; Write time: 188552 10:41:09 INFO - Running post-run listener: _upload_blobber_files 10:41:09 INFO - Blob upload gear active. 10:41:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:41:09 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 10:41:09 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:41:09 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:41:09 INFO - (blobuploader) - INFO - Open directory for files ... 10:41:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:41:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:41:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:10 INFO - (blobuploader) - INFO - Done attempting. 10:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:41:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:13 INFO - (blobuploader) - INFO - Done attempting. 10:41:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:41:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:41:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:41:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:41:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:41:14 INFO - (blobuploader) - INFO - Done attempting. 10:41:14 INFO - (blobuploader) - INFO - Iteration through files over. 10:41:14 INFO - Return code: 0 10:41:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:41:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:41:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/796f8158fbaf46ce36b166ee7dd2bec44f4aaced90aa8288285e5c732ab1c633f7f6515c699f262ecd447f6690037343639ebcadd4927cfd7da5c80138309777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7c427bbf9d1555c00ddbddb5dd9cfd30eed8f34a7f675c32d77cf4c433ee474eebe490ce0b2a72da6583ed8c5da462989691cfe552058a96e48e579610b8b96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be8d34582fdeec5b853994df7e5c0c5a6855c2c703b5c762c6a80a68de46dc62dbbd817a986b09dddd76336ad6f18d69df60c68d479614a5caf90f41e3dbb87"} 10:41:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:41:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:41:14 INFO - Contents: 10:41:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/796f8158fbaf46ce36b166ee7dd2bec44f4aaced90aa8288285e5c732ab1c633f7f6515c699f262ecd447f6690037343639ebcadd4927cfd7da5c80138309777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7c427bbf9d1555c00ddbddb5dd9cfd30eed8f34a7f675c32d77cf4c433ee474eebe490ce0b2a72da6583ed8c5da462989691cfe552058a96e48e579610b8b96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be8d34582fdeec5b853994df7e5c0c5a6855c2c703b5c762c6a80a68de46dc62dbbd817a986b09dddd76336ad6f18d69df60c68d479614a5caf90f41e3dbb87"} 10:41:14 INFO - Running post-run listener: copy_logs_to_upload_dir 10:41:14 INFO - Copying logs to upload dir... 10:41:14 INFO - mkdir: /builds/slave/test/build/upload/logs 10:41:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.898043 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-14 10:41:14.348857) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:41:14.352450) ========= 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=31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/796f8158fbaf46ce36b166ee7dd2bec44f4aaced90aa8288285e5c732ab1c633f7f6515c699f262ecd447f6690037343639ebcadd4927cfd7da5c80138309777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7c427bbf9d1555c00ddbddb5dd9cfd30eed8f34a7f675c32d77cf4c433ee474eebe490ce0b2a72da6583ed8c5da462989691cfe552058a96e48e579610b8b96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be8d34582fdeec5b853994df7e5c0c5a6855c2c703b5c762c6a80a68de46dc62dbbd817a986b09dddd76336ad6f18d69df60c68d479614a5caf90f41e3dbb87"} build_url:https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/JO2rB2G5QFe3PNM47ehcTg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/796f8158fbaf46ce36b166ee7dd2bec44f4aaced90aa8288285e5c732ab1c633f7f6515c699f262ecd447f6690037343639ebcadd4927cfd7da5c80138309777", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c7c427bbf9d1555c00ddbddb5dd9cfd30eed8f34a7f675c32d77cf4c433ee474eebe490ce0b2a72da6583ed8c5da462989691cfe552058a96e48e579610b8b96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be8d34582fdeec5b853994df7e5c0c5a6855c2c703b5c762c6a80a68de46dc62dbbd817a986b09dddd76336ad6f18d69df60c68d479614a5caf90f41e3dbb87"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:41:14.384666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:41:14.385079) ========= 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=31acecf42b6a79ec49471d4a000001bb-1476465632.891889-1081484317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:41:14.466164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:41:14.466488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:41:14.466793) ========= ========= Total master_lag: 0.19 =========