builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0283 starttime: 1472330025.66 results: success (0) buildid: 20160827105213 builduid: 856d608892144123b0d518d75e509696 revision: 125b052639cb1879d4a593c715d244c551129118 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:45.663439) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:45.663897) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:45.664193) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:45.838783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:45.839084) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9KjGnPdsV5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-27 13:33:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-08-27 13:33:46 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.439938 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:46.304871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:46.305220) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9KjGnPdsV5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.041281 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:46.367740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-27 13:33:46.368106) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 125b052639cb1879d4a593c715d244c551129118 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 125b052639cb1879d4a593c715d244c551129118 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9KjGnPdsV5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-27 13:33:46,453 truncating revision to first 12 chars 2016-08-27 13:33:46,453 Setting DEBUG logging. 2016-08-27 13:33:46,453 attempt 1/10 2016-08-27 13:33:46,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/125b052639cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 13:33:47,789 unpacking tar archive at: fx-team-125b052639cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.583342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-27 13:33:47.970761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:47.971084) ========= script_repo_revision: 125b052639cb1879d4a593c715d244c551129118 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:47.971470) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:47.971740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 13:33:47.988744) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-27 13:33:47.989120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9KjGnPdsV5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:33:48 INFO - MultiFileLogger online at 20160827 13:33:48 in /builds/slave/test 13:33:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:33:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:33:48 INFO - {'append_to_log': False, 13:33:48 INFO - 'base_work_dir': '/builds/slave/test', 13:33:48 INFO - 'blob_upload_branch': 'Fx-Team', 13:33:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:33:48 INFO - 'branch': 'Fx-Team', 13:33:48 INFO - 'buildbot_json_path': 'buildprops.json', 13:33:48 INFO - 'config_files': ('talos/mac_config.py',), 13:33:48 INFO - 'default_actions': ('clobber', 13:33:48 INFO - 'read-buildbot-config', 13:33:48 INFO - 'download-and-extract', 13:33:48 INFO - 'populate-webroot', 13:33:48 INFO - 'create-virtualenv', 13:33:48 INFO - 'install', 13:33:48 INFO - 'run-tests'), 13:33:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:33:48 INFO - 'download_minidump_stackwalk': True, 13:33:48 INFO - 'download_symbols': 'ondemand', 13:33:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:33:48 INFO - 'tooltool.py': '/tools/tooltool.py', 13:33:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:33:48 INFO - '/tools/misc-python/virtualenv.py')}, 13:33:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:33:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:33:48 INFO - 'installer_path': 'installer.exe', 13:33:48 INFO - 'log_level': 'info', 13:33:48 INFO - 'log_name': 'talos', 13:33:48 INFO - 'log_to_console': True, 13:33:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:33:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:33:48 INFO - 'opt_config_files': (), 13:33:48 INFO - 'pip_index': False, 13:33:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:33:48 INFO - 'cmd': ('bash', 13:33:48 INFO - '-c', 13:33:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:33:48 INFO - 'enabled': True, 13:33:48 INFO - 'halt_on_failure': False, 13:33:48 INFO - 'name': 'check_screen_resolution'},), 13:33:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:33:48 INFO - 'cmd': ('bash', 13:33:48 INFO - '-c', 13:33:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:33:48 INFO - 'enabled': True, 13:33:48 INFO - 'halt_on_failure': False, 13:33:48 INFO - 'name': 'check_screen_resolution'},), 13:33:48 INFO - 'run_cmd_checks_enabled': True, 13:33:48 INFO - 'sps_profile': False, 13:33:48 INFO - 'sps_profile_interval': 0, 13:33:48 INFO - 'suite': 'dromaeojs', 13:33:48 INFO - 'system_bits': '32', 13:33:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:33:48 INFO - 'title': 't-yosemite-r7-0283', 13:33:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:33:48 INFO - 'use_talos_json': True, 13:33:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:33:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:33:48 INFO - 'work_dir': 'build'} 13:33:48 INFO - [mozharness: 2016-08-27 20:33:48.175665Z] Running clobber step. 13:33:48 INFO - Running pre-action listener: _resource_record_pre_action 13:33:48 INFO - Running main action method: clobber 13:33:48 INFO - rmtree: /builds/slave/test/build 13:33:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:33:50 INFO - Running post-action listener: _resource_record_post_action 13:33:50 INFO - [mozharness: 2016-08-27 20:33:50.262474Z] Finished clobber step (success) 13:33:50 INFO - [mozharness: 2016-08-27 20:33:50.262599Z] Running read-buildbot-config step. 13:33:50 INFO - Running pre-action listener: _resource_record_pre_action 13:33:50 INFO - Running main action method: read_buildbot_config 13:33:50 INFO - Using buildbot properties: 13:33:50 INFO - { 13:33:50 INFO - "project": "", 13:33:50 INFO - "product": "firefox", 13:33:50 INFO - "script_repo_revision": "production", 13:33:50 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 13:33:50 INFO - "repository": "", 13:33:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 13:33:50 INFO - "buildid": "20160827105213", 13:33:50 INFO - "pgo_build": "False", 13:33:50 INFO - "basedir": "/builds/slave/test", 13:33:50 INFO - "buildnumber": 133, 13:33:50 INFO - "slavename": "t-yosemite-r7-0283", 13:33:50 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:33:50 INFO - "platform": "yosemite_r7", 13:33:50 INFO - "scheduler": "tests-fx-team-macosx64-talos", 13:33:50 INFO - "branch": "fx-team", 13:33:50 INFO - "repo_path": "integration/fx-team", 13:33:50 INFO - "revision": "125b052639cb1879d4a593c715d244c551129118", 13:33:50 INFO - "stage_platform": "macosx64", 13:33:50 INFO - "builduid": "856d608892144123b0d518d75e509696", 13:33:50 INFO - "slavebuilddir": "test" 13:33:50 INFO - } 13:33:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:33:50 INFO - Running post-action listener: _resource_record_post_action 13:33:50 INFO - [mozharness: 2016-08-27 20:33:50.265631Z] Finished read-buildbot-config step (success) 13:33:50 INFO - [mozharness: 2016-08-27 20:33:50.265730Z] Running download-and-extract step. 13:33:50 INFO - Running pre-action listener: _resource_record_pre_action 13:33:50 INFO - Running main action method: download_and_extract 13:33:50 INFO - mkdir: /builds/slave/test/build/tests 13:33:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:50 INFO - trying https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:33:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:33:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 13:33:51 INFO - Downloaded 1199 bytes. 13:33:51 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:33:51 INFO - Using the following test package requirements: 13:33:51 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:33:51 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:33:51 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:33:51 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:33:51 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:33:51 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:33:51 INFO - u'jsshell-mac.zip'], 13:33:51 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:33:51 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:33:51 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:33:51 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:33:51 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:33:51 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:33:51 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:33:51 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:33:51 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:33:51 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:33:51 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:33:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:33:51 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')]} 13:33:51 INFO - trying https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:33:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:33:52 INFO - Downloaded 16369444 bytes. 13:33:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:33:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:33:59 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')]} 13:33:59 INFO - trying https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:33:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:33:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:34:00 INFO - Downloaded 16369444 bytes. 13:34:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:34: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')]} 13:34:07 INFO - trying https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:34:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:34:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:34:08 INFO - Downloaded 14413998 bytes. 13:34:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 13:34:08 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')]} 13:34:08 INFO - trying https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:34:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 13:34:11 INFO - Downloaded 111545990 bytes. 13:34:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:34:11 INFO - mkdir: /builds/slave/test/properties 13:34:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:34:11 INFO - Writing to file /builds/slave/test/properties/build_url 13:34:11 INFO - Contents: 13:34:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:34:12 INFO - Running post-action listener: _resource_record_post_action 13:34:12 INFO - Running post-action listener: set_extra_try_arguments 13:34:12 INFO - [mozharness: 2016-08-27 20:34:12.406387Z] Finished download-and-extract step (success) 13:34:12 INFO - [mozharness: 2016-08-27 20:34:12.406510Z] Running populate-webroot step. 13:34:12 INFO - Running pre-action listener: _resource_record_pre_action 13:34:12 INFO - Running main action method: populate_webroot 13:34:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:34:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:34:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:34:12 INFO - '--tppagecycles', 13:34:12 INFO - '7'], 13:34:12 INFO - 'tests': ['tsvgm']}}, 13:34:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:34:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:34:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:34:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:34:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:12 INFO - 'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:34:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:34:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:12 INFO - 'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['damp', 'tps']}, 13:34:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:12 INFO - 'tests': ['damp', 'tps']}, 13:34:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['dromaeo_dom']}, 13:34:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:34:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['basic_compositor_video']}, 13:34:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:34:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['a11yr', 13:34:12 INFO - 'ts_paint', 13:34:12 INFO - 'tpaint', 13:34:12 INFO - 'sessionrestore', 13:34:12 INFO - 'sessionrestore_no_auto_restore', 13:34:12 INFO - 'tabpaint']}, 13:34:12 INFO - 'other-e10s': {'tests': ['a11yr', 13:34:12 INFO - 'ts_paint', 13:34:12 INFO - 'tpaint', 13:34:12 INFO - 'sessionrestore', 13:34:12 INFO - 'sessionrestore_no_auto_restore', 13:34:12 INFO - 'tabpaint']}, 13:34:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:34:12 INFO - 'ts_paint', 13:34:12 INFO - 'tpaint', 13:34:12 INFO - 'sessionrestore', 13:34:12 INFO - 'sessionrestore_no_auto_restore', 13:34:12 INFO - 'tabpaint']}, 13:34:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:34:12 INFO - 'ts_paint', 13:34:12 INFO - 'tpaint', 13:34:12 INFO - 'sessionrestore', 13:34:12 INFO - 'sessionrestore_no_auto_restore', 13:34:12 INFO - 'tabpaint']}, 13:34:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['a11yr', 13:34:12 INFO - 'ts_paint', 13:34:12 INFO - 'tpaint', 13:34:12 INFO - 'sessionrestore', 13:34:12 INFO - 'sessionrestore_no_auto_restore', 13:34:12 INFO - 'tabpaint']}, 13:34:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['a11yr', 13:34:12 INFO - 'ts_paint', 13:34:12 INFO - 'tpaint', 13:34:12 INFO - 'sessionrestore', 13:34:12 INFO - 'sessionrestore_no_auto_restore', 13:34:12 INFO - 'tabpaint']}, 13:34:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['tsvgx', 13:34:12 INFO - 'tsvgr_opacity', 13:34:12 INFO - 'tart', 13:34:12 INFO - 'tscrollx', 13:34:12 INFO - 'cart']}, 13:34:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:34:12 INFO - 'tsvgr_opacity', 13:34:12 INFO - 'tart', 13:34:12 INFO - 'tscrollx', 13:34:12 INFO - 'cart']}, 13:34:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:12 INFO - 'talos_options': ['--disable-e10s'], 13:34:12 INFO - 'tests': ['tp5o']}, 13:34:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:12 INFO - 'tests': ['tp5o']}, 13:34:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:12 INFO - 'talos_options': ['--disable-e10s', 13:34:12 INFO - '--xperf_path', 13:34:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:12 INFO - 'tests': ['tp5n']}, 13:34:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:34:12 INFO - 'talos_options': ['--xperf_path', 13:34:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:34:12 INFO - 'tests': ['tp5n']}}, 13:34:12 INFO - 'talos.zip': {'path': '', 13:34:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:34:12 INFO - Running post-action listener: _resource_record_post_action 13:34:12 INFO - [mozharness: 2016-08-27 20:34:12.425494Z] Finished populate-webroot step (success) 13:34:12 INFO - [mozharness: 2016-08-27 20:34:12.425629Z] Running create-virtualenv step. 13:34:12 INFO - Running pre-action listener: _resource_record_pre_action 13:34:12 INFO - Running main action method: create_virtualenv 13:34:12 INFO - Creating virtualenv /builds/slave/test/build/venv 13:34:12 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 13:34:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:34:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:34:12 INFO - Using real prefix '/tools/python27' 13:34:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:34:13 INFO - Installing distribute.............................................................................................................................................................................................done. 13:34:16 INFO - Installing pip.................done. 13:34:16 INFO - Return code: 0 13:34:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:34:16 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')]} 13:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:16 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')]} 13:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:16 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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:16 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 13:34:16 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 13:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:16 INFO - 'HOME': '/Users/cltbld', 13:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:16 INFO - 'LOGNAME': 'cltbld', 13:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:16 INFO - 'MOZ_NO_REMOTE': '1', 13:34:16 INFO - 'NO_EM_RESTART': '1', 13:34:16 INFO - 'PAGER': '/bin/cat', 13:34:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:16 INFO - 'PWD': '/builds/slave/test', 13:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:16 INFO - 'SHELL': '/bin/bash', 13:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:16 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:16 INFO - 'USER': 'cltbld', 13:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:16 INFO - 'XPC_FLAGS': '0x0', 13:34:16 INFO - 'XPC_SERVICE_NAME': '0', 13:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:16 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 13:34:16 INFO - Cleaning up... 13:34:16 INFO - Return code: 0 13:34:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:34:16 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')]} 13:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:16 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')]} 13:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:16 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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:16 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 13:34:16 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 13:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:16 INFO - 'HOME': '/Users/cltbld', 13:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:16 INFO - 'LOGNAME': 'cltbld', 13:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:16 INFO - 'MOZ_NO_REMOTE': '1', 13:34:16 INFO - 'NO_EM_RESTART': '1', 13:34:16 INFO - 'PAGER': '/bin/cat', 13:34:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:16 INFO - 'PWD': '/builds/slave/test', 13:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:16 INFO - 'SHELL': '/bin/bash', 13:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:16 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:16 INFO - 'USER': 'cltbld', 13:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:16 INFO - 'XPC_FLAGS': '0x0', 13:34:16 INFO - 'XPC_SERVICE_NAME': '0', 13:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:16 INFO - Downloading/unpacking psutil>=3.1.1 13:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:34:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:34:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:34:20 INFO - Installing collected packages: psutil 13:34:20 INFO - Running setup.py install for psutil 13:34:20 INFO - building 'psutil._psutil_osx' extension 13:34:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:34:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:34:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:34:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:34:20 INFO - building 'psutil._psutil_posix' extension 13:34:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:34:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:34:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:34:20 INFO - ^ 13:34:21 INFO - 1 warning generated. 13:34:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:34:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:34:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:34:21 INFO - Successfully installed psutil 13:34:21 INFO - Cleaning up... 13:34:21 INFO - Return code: 0 13:34:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:21 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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:21 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 13:34:21 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 13:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:21 INFO - 'HOME': '/Users/cltbld', 13:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:21 INFO - 'LOGNAME': 'cltbld', 13:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:21 INFO - 'MOZ_NO_REMOTE': '1', 13:34:21 INFO - 'NO_EM_RESTART': '1', 13:34:21 INFO - 'PAGER': '/bin/cat', 13:34:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:21 INFO - 'PWD': '/builds/slave/test', 13:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:21 INFO - 'SHELL': '/bin/bash', 13:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:21 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:21 INFO - 'USER': 'cltbld', 13:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:21 INFO - 'XPC_FLAGS': '0x0', 13:34:21 INFO - 'XPC_SERVICE_NAME': '0', 13:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:34:21 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 13:34:21 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 13:34:21 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 13:34:21 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 13:34:21 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 13:34:21 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 13:34:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:34:24 INFO - Installing collected packages: mozsystemmonitor 13:34:24 INFO - Running setup.py install for mozsystemmonitor 13:34:24 INFO - Successfully installed mozsystemmonitor 13:34:24 INFO - Cleaning up... 13:34:24 INFO - Return code: 0 13:34:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:24 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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:24 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 13:34:24 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 13:34:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:24 INFO - 'HOME': '/Users/cltbld', 13:34:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:24 INFO - 'LOGNAME': 'cltbld', 13:34:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:24 INFO - 'MOZ_NO_REMOTE': '1', 13:34:24 INFO - 'NO_EM_RESTART': '1', 13:34:24 INFO - 'PAGER': '/bin/cat', 13:34:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:24 INFO - 'PWD': '/builds/slave/test', 13:34:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:24 INFO - 'SHELL': '/bin/bash', 13:34:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:24 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:24 INFO - 'USER': 'cltbld', 13:34:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:24 INFO - 'XPC_FLAGS': '0x0', 13:34:24 INFO - 'XPC_SERVICE_NAME': '0', 13:34:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:24 INFO - Downloading/unpacking jsonschema==2.5.1 13:34:24 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 13:34:24 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 13:34:24 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 13:34:24 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 13:34:24 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 13:34:24 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 13:34:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:34:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:27 INFO - Downloading functools32-3.2.3-2.tar.gz 13:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:34:27 INFO - warning: no files found matching '*.txt' 13:34:27 INFO - no previously-included directories found matching 'build' 13:34:27 INFO - no previously-included directories found matching 'dist' 13:34:27 INFO - no previously-included directories found matching '.git*' 13:34:27 INFO - Installing collected packages: jsonschema, functools32 13:34:27 INFO - Running setup.py install for functools32 13:34:27 INFO - warning: no files found matching '*.txt' 13:34:27 INFO - no previously-included directories found matching 'build' 13:34:27 INFO - no previously-included directories found matching 'dist' 13:34:27 INFO - no previously-included directories found matching '.git*' 13:34:27 INFO - Successfully installed jsonschema functools32 13:34:27 INFO - Cleaning up... 13:34:27 INFO - Return code: 0 13:34:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:27 INFO - 'HOME': '/Users/cltbld', 13:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:27 INFO - 'LOGNAME': 'cltbld', 13:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:27 INFO - 'MOZ_NO_REMOTE': '1', 13:34:27 INFO - 'NO_EM_RESTART': '1', 13:34:27 INFO - 'PAGER': '/bin/cat', 13:34:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:27 INFO - 'PWD': '/builds/slave/test', 13:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:27 INFO - 'SHELL': '/bin/bash', 13:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:27 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:27 INFO - 'USER': 'cltbld', 13:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:27 INFO - 'XPC_FLAGS': '0x0', 13:34:27 INFO - 'XPC_SERVICE_NAME': '0', 13:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:34:28 INFO - Cleaning up... 13:34:28 INFO - Return code: 0 13:34:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:34: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')]} 13:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34: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')]} 13:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:28 INFO - 'HOME': '/Users/cltbld', 13:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:28 INFO - 'LOGNAME': 'cltbld', 13:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:28 INFO - 'MOZ_NO_REMOTE': '1', 13:34:28 INFO - 'NO_EM_RESTART': '1', 13:34:28 INFO - 'PAGER': '/bin/cat', 13:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:28 INFO - 'PWD': '/builds/slave/test', 13:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:28 INFO - 'SHELL': '/bin/bash', 13:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:28 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:28 INFO - 'USER': 'cltbld', 13:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:28 INFO - 'XPC_FLAGS': '0x0', 13:34:28 INFO - 'XPC_SERVICE_NAME': '0', 13:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:28 INFO - Downloading/unpacking blobuploader==1.2.4 13:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:30 INFO - Downloading blobuploader-1.2.4.tar.gz 13:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:34:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:34:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:34:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:34:31 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 13:34:31 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 13:34:31 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 13:34:31 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 13:34:31 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 13:34:31 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 13:34:31 INFO - Downloading docopt-0.6.1.tar.gz 13:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:34:32 INFO - Installing collected packages: blobuploader, requests, docopt 13:34:32 INFO - Running setup.py install for blobuploader 13:34:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:34:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:34:32 INFO - Running setup.py install for requests 13:34:32 INFO - Running setup.py install for docopt 13:34:32 INFO - Successfully installed blobuploader requests docopt 13:34:32 INFO - Cleaning up... 13:34:32 INFO - Return code: 0 13:34:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:32 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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:32 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 13:34:32 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 13:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:32 INFO - 'HOME': '/Users/cltbld', 13:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:32 INFO - 'LOGNAME': 'cltbld', 13:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:32 INFO - 'MOZ_NO_REMOTE': '1', 13:34:32 INFO - 'NO_EM_RESTART': '1', 13:34:32 INFO - 'PAGER': '/bin/cat', 13:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:32 INFO - 'PWD': '/builds/slave/test', 13:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:32 INFO - 'SHELL': '/bin/bash', 13:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:32 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:32 INFO - 'USER': 'cltbld', 13:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:32 INFO - 'XPC_FLAGS': '0x0', 13:34:32 INFO - 'XPC_SERVICE_NAME': '0', 13:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:34:33 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-0644F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:34:33 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-dX7tf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:34:33 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-psST6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:34:33 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-cKyo9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:34:33 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-S0qbLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:34:33 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-o_jE5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:34:33 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-eeXNsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:34:33 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-aiZtTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-QWlsm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-MvLHYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-fcJOTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-crPtlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-pD41wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-uvmWYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-lfn0_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-bFDf51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:34:34 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-M9TJLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:34:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:34:34 INFO - Running setup.py install for manifestparser 13:34:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:34:35 INFO - Running setup.py install for mozcrash 13:34:35 INFO - Running setup.py install for mozdebug 13:34:35 INFO - Running setup.py install for mozdevice 13:34:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:34:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:34:35 INFO - Running setup.py install for mozfile 13:34:35 INFO - Running setup.py install for mozhttpd 13:34:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:34:35 INFO - Running setup.py install for mozinfo 13:34:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:34:35 INFO - Running setup.py install for mozInstall 13:34:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Running setup.py install for mozleak 13:34:36 INFO - Running setup.py install for mozlog 13:34:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Running setup.py install for moznetwork 13:34:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Running setup.py install for mozprocess 13:34:36 INFO - Running setup.py install for mozprofile 13:34:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:34:36 INFO - Running setup.py install for mozrunner 13:34:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:34:37 INFO - Running setup.py install for mozscreenshot 13:34:37 INFO - Running setup.py install for moztest 13:34:37 INFO - Running setup.py install for mozversion 13:34:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:34:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:34:37 INFO - Cleaning up... 13:34:37 INFO - Return code: 0 13:34:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34:37 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')]} 13:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:37 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')]} 13:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:37 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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:37 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 13:34:37 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 13:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:37 INFO - 'HOME': '/Users/cltbld', 13:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:37 INFO - 'LOGNAME': 'cltbld', 13:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:37 INFO - 'MOZ_NO_REMOTE': '1', 13:34:37 INFO - 'NO_EM_RESTART': '1', 13:34:37 INFO - 'PAGER': '/bin/cat', 13:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:37 INFO - 'PWD': '/builds/slave/test', 13:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:37 INFO - 'SHELL': '/bin/bash', 13:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:37 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:37 INFO - 'USER': 'cltbld', 13:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:37 INFO - 'XPC_FLAGS': '0x0', 13:34:37 INFO - 'XPC_SERVICE_NAME': '0', 13:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:34:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-vp2IgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:34:37 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)) 13:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:34:37 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-fDbBG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-f84y3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-zFgFBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-BKNL2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Yxximt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-R760yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-VcW3Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-ReLUuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-cB6Gcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-39V94F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:34:38 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)) 13:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:34:38 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-hHZNIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:34:39 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)) 13:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:34:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-CnFAmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:34:39 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)) 13:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:34:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-bntbOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:34:39 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)) 13:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-q6z7zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:34:39 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)) 13:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:34:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-izqFo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:34:39 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)) 13:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:34:39 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-UBckVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:34:39 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)) 13:34:39 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)) 13:34:39 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)) 13:34:39 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)) 13:34:39 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)) 13:34:39 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)) 13:34:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:34:39 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 13:34:39 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 13:34:39 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 13:34:39 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 13:34:39 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 13:34:39 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 13:34:42 INFO - Downloading blessings-1.6.tar.gz 13:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:34:42 INFO - Installing collected packages: blessings 13:34:42 INFO - Running setup.py install for blessings 13:34:42 INFO - Successfully installed blessings 13:34:42 INFO - Cleaning up... 13:34:42 INFO - Return code: 0 13:34:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:34:42 INFO - Reading from file tmpfile_stdout 13:34:42 INFO - Current package versions: 13:34:42 INFO - blessings == 1.6 13:34:42 INFO - blobuploader == 1.2.4 13:34:42 INFO - docopt == 0.6.1 13:34:42 INFO - functools32 == 3.2.3-2 13:34:42 INFO - jsonschema == 2.5.1 13:34:42 INFO - manifestparser == 1.1 13:34:42 INFO - mozInstall == 1.12 13:34:42 INFO - mozcrash == 0.17 13:34:42 INFO - mozdebug == 0.1 13:34:42 INFO - mozdevice == 0.48 13:34:42 INFO - mozfile == 1.2 13:34:42 INFO - mozhttpd == 0.7 13:34:42 INFO - mozinfo == 0.9 13:34:42 INFO - mozleak == 0.1 13:34:42 INFO - mozlog == 3.3 13:34:42 INFO - moznetwork == 0.27 13:34:42 INFO - mozprocess == 0.23 13:34:42 INFO - mozprofile == 0.28 13:34:42 INFO - mozrunner == 6.12 13:34:42 INFO - mozscreenshot == 0.1 13:34:42 INFO - mozsystemmonitor == 0.3 13:34:42 INFO - moztest == 0.7 13:34:42 INFO - mozversion == 1.4 13:34:42 INFO - psutil == 3.1.1 13:34:42 INFO - requests == 1.2.3 13:34:42 INFO - wsgiref == 0.1.2 13:34:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:42 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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:42 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 13:34:42 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 13:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:42 INFO - 'HOME': '/Users/cltbld', 13:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:42 INFO - 'LOGNAME': 'cltbld', 13:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:42 INFO - 'MOZ_NO_REMOTE': '1', 13:34:42 INFO - 'NO_EM_RESTART': '1', 13:34:42 INFO - 'PAGER': '/bin/cat', 13:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:42 INFO - 'PWD': '/builds/slave/test', 13:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:42 INFO - 'SHELL': '/bin/bash', 13:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:42 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:42 INFO - 'USER': 'cltbld', 13:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:42 INFO - 'XPC_FLAGS': '0x0', 13:34:42 INFO - 'XPC_SERVICE_NAME': '0', 13:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 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)) 13:34:42 INFO - Cleaning up... 13:34:42 INFO - Return code: 0 13:34:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:34:42 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 0x10e322a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3b7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa753cc11f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:34:42 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 13:34:42 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 13:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:42 INFO - 'HOME': '/Users/cltbld', 13:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:42 INFO - 'LOGNAME': 'cltbld', 13:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:42 INFO - 'MOZ_NO_REMOTE': '1', 13:34:42 INFO - 'NO_EM_RESTART': '1', 13:34:42 INFO - 'PAGER': '/bin/cat', 13:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:42 INFO - 'PWD': '/builds/slave/test', 13:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:42 INFO - 'SHELL': '/bin/bash', 13:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:34:42 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:42 INFO - 'USER': 'cltbld', 13:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:42 INFO - 'XPC_FLAGS': '0x0', 13:34:42 INFO - 'XPC_SERVICE_NAME': '0', 13:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:34:43 INFO - Cleaning up... 13:34:43 INFO - Return code: 0 13:34:43 INFO - Running post-action listener: _resource_record_post_action 13:34:43 INFO - Running post-action listener: _start_resource_monitoring 13:34:43 INFO - Starting resource monitoring. 13:34:43 INFO - [mozharness: 2016-08-27 20:34:43.283331Z] Finished create-virtualenv step (success) 13:34:43 INFO - [mozharness: 2016-08-27 20:34:43.284412Z] Running install step. 13:34:43 INFO - Running pre-action listener: _resource_record_pre_action 13:34:43 INFO - Running main action method: install 13:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:34:43 INFO - Reading from file tmpfile_stdout 13:34:43 INFO - Detecting whether we're running mozinstall >=1.0... 13:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:34:43 INFO - Reading from file tmpfile_stdout 13:34:43 INFO - Output received: 13:34:43 INFO - Usage: mozinstall [options] installer 13:34:43 INFO - Options: 13:34:43 INFO - -h, --help show this help message and exit 13:34:43 INFO - -d DEST, --destination=DEST 13:34:43 INFO - Directory to install application into. [default: 13:34:43 INFO - "/builds/slave/test"] 13:34:43 INFO - --app=APP Application being installed. [default: firefox] 13:34:43 INFO - mkdir: /builds/slave/test/build/application 13:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:35:17 INFO - Reading from file tmpfile_stdout 13:35:17 INFO - Output received: 13:35:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:35:17 INFO - Running post-action listener: _resource_record_post_action 13:35:17 INFO - [mozharness: 2016-08-27 20:35:17.533889Z] Finished install step (success) 13:35:17 INFO - [mozharness: 2016-08-27 20:35:17.534055Z] Running run-tests step. 13:35:17 INFO - Running pre-action listener: _resource_record_pre_action 13:35:17 INFO - Running main action method: run_tests 13:35:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:35:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:35:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:35:17 INFO - 2016-08-27 13:35:17.548 screenresolution[1649:10823] starting screenresolution argv=screenresolution get 13:35:17 INFO - 2016-08-27 13:35:17.551 screenresolution[1649:10823] Display 0: 1600x1200x32@60 13:35:17 INFO - 2016-08-27 13:35:17.557 screenresolution[1650:10826] starting screenresolution argv=screenresolution list 13:35:17 INFO - Available Modes on Display 0 13:35:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:35:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:35:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:35:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:35:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:35:17 INFO - Intel Iris: 13:35:17 INFO - Chipset Model: Intel Iris 13:35:17 INFO - Type: GPU 13:35:17 INFO - Bus: Built-In 13:35:17 INFO - VRAM (Dynamic, Max): 1536 MB 13:35:17 INFO - Vendor: Intel (0x8086) 13:35:17 INFO - Device ID: 0x0a2e 13:35:17 INFO - Revision ID: 0x0009 13:35:17 INFO - Displays: 13:35:17 INFO - Display: 13:35:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:35:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:35:17 INFO - Display Serial Number: 1600x1200 60 13:35:17 INFO - Main Display: Yes 13:35:17 INFO - Mirror: Off 13:35:17 INFO - Online: Yes 13:35:17 INFO - Rotation: Supported 13:35:17 INFO - Return code: 0 13:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:35:17 INFO - Python 2.7.3 13:35:17 INFO - Return code: 0 13:35:17 INFO - grabbing minidump binary from tooltool 13:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:35:17 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/macosx64/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 0x10e286d30>, '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 0x10dfebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e27eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:35:17 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:35:17 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:35:17 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:35:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:35:17 INFO - Return code: 0 13:35:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:35:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:35:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:35:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:35:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--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 13:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0283 --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 13:35:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9KjGnPdsV5/Render', 13:35:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:35:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:35:17 INFO - 'HOME': '/Users/cltbld', 13:35:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:35:17 INFO - 'LOGNAME': 'cltbld', 13:35:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:35:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:35:17 INFO - 'MOZ_NO_REMOTE': '1', 13:35:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:35:17 INFO - 'NO_EM_RESTART': '1', 13:35:17 INFO - 'PAGER': '/bin/cat', 13:35:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:35:17 INFO - 'PWD': '/builds/slave/test', 13:35:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:35:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:35:17 INFO - 'SHELL': '/bin/bash', 13:35:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners', 13:35:17 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 13:35:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:35:17 INFO - 'USER': 'cltbld', 13:35:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:35:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:35:17 INFO - 'XPC_FLAGS': '0x0', 13:35:17 INFO - 'XPC_SERVICE_NAME': '0', 13:35:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:35:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--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 13:35:18 INFO - mozversion application_buildid: 20160827105213 13:35:18 INFO - mozversion application_changeset: 125b052639cb1879d4a593c715d244c551129118 13:35:18 INFO - mozversion application_display_name: Nightly 13:35:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:35:18 INFO - mozversion application_name: Firefox 13:35:18 INFO - mozversion application_remotingname: firefox 13:35:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:35:18 INFO - mozversion application_vendor: Mozilla 13:35:18 INFO - mozversion application_version: 51.0a1 13:35:18 INFO - mozversion platform_buildid: 20160827105213 13:35:18 INFO - mozversion platform_changeset: 125b052639cb1879d4a593c715d244c551129118 13:35:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:35:18 INFO - mozversion platform_version: 51.0a1 13:35:18 INFO - using testdate: 1472330118 13:35:18 INFO - actual date: 1472330118 13:35:18 INFO - starting webserver on 'localhost:49268' 13:35:18 INFO - SUITE-START | Running 2 tests 13:35:18 INFO - TEST-START | dromaeo_css 13:35:18 INFO - operating with platform_type : mac_ 13:35:18 INFO - Initialising browser for dromaeo_css test... 13:35:18 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmp1wRQ7I/profile http://localhost:49268/getInfo.html) 13:35:20 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 13:35:20 INFO - PROCESS | 1660 | colorDepth:24 13:35:20 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 13:35:20 INFO - PROCESS | 1660 | __metrics 13:35:20 INFO - PROCESS | 1660 | 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" 13:35:20 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:35:21 INFO - TEST-INFO | 1660: exit 0 13:35:21 INFO - Browser initialized. 13:35:21 INFO - Running cycle 1/1 for dromaeo_css test... 13:35:21 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmp1wRQ7I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:35:33 INFO - PROCESS | 1663 | RSS: Main: 234356736 13:35:33 INFO - PROCESS | 1663 | 13:36:24 INFO - PROCESS | 1663 | 1472330184574 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] 13:38:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 13:38:37 INFO - PROCESS | 1663 | RSS: Main: 370184192 13:38:37 INFO - PROCESS | 1663 | 13:41:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 13:41:41 INFO - PROCESS | 1663 | RSS: Main: 375377920 13:41:41 INFO - PROCESS | 1663 | 13:44:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 13:44:44 INFO - PROCESS | 1663 | RSS: Main: 363704320 13:44:44 INFO - PROCESS | 1663 | 13:47:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 13:47:46 INFO - PROCESS | 1663 | RSS: Main: 346656768 13:47:46 INFO - PROCESS | 1663 | 13:50:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 13:50:50 INFO - PROCESS | 1663 | RSS: Main: 327409664 13:50:50 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 13:53:54 INFO - PROCESS | 1663 | RSS: Main: 417873920 13:53:54 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | __start_tp_report 13:53:54 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 13:53:54 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 13:53:54 INFO - PROCESS | 1663 | |i|pagename|runs| 13:53:54 INFO - PROCESS | 1663 | |0;dojo.html;3248.999999999999;3258.59267591551;3285.490748933916;3304.0913748719113;3341.599008119026;5495.697736624484;5580.748866301016;5589.888202235953;5617.325920889494;5659.547236221108;5578.9163162552495;5634.9718251408685;5639.746211420485;5643.435656434354;5669.0646043402785;5079.1873300272055;5112.8977420451565;5143.408508021569;5191.039657663345;5204.609654275925;5170.560502357285;5227.607929405291;5238.659487133325;5241.2400201970695;5247.895042099156;5130.71781052042;5141.126008578532;5159.097157997336;5166.405863325709;5169.1987741899875;5236.266922630834;5249.5012973767625;5254.737263136828;5264.815731449419;5320.9467905320835;5042.495750424965;5042.974785126051;5051.040302342543;5168.664036837594;5168.689878607295;5586.804461843816;5608.186812912146;5629.183768353607;5659.886802263973;5716.371199168088;6154.076888466721;6158.599691020069;6175.938240617581;6178.38216178383;6202.34875338092;6015.037593984942;6088.695565221766;6109.8601770527275;6203.844903877394;6209.689515524251;5722.7424765885635;5732.541396688255;5774.393688662672;5779.739911703899;5799.94200057994;6242.687865606701;6244.781432649836;6244.812655620339;6266.342034086447;6266.467350275278;5925.34821169671;6020.307664618625;6054.7880824171825;6063.090536419572;6066.878662426815;6120.479759220516;6126.663033533109;6170.784022559189;6197.287311959092;6199.597026193283;6052.7965452392245;6099.817005489843;6139.079138129317;6146.78486252979;6151.7539298428455;6027.48766354856;6093.025115981422;6114.847128821815;6145.293291271561;6148.754049838046;4865.756712164449;4897.877553061202;4927.827526036572;4950.8762280943265;4964.180910149785;4350.434443522385;4351.543087975717;4355.912881742411;4390.670699697535;4405.845795397146;5496.1755736639825;5534.280543529316;5620.971895140498;5625.212470254168;5655.1517272409465;6102.877942441126;6139.062858969425;6157.107219453154;6157.261128664589;6165.784197553064;5617.831465056055;5625.46558076982;5634.5210657093785;5637.43625637433;5678.119891416754;5312.9734351328;5359.276497672842;5375.220593014069;5375.865603359869;5407.78368865241;6156.784512542129;6182.474489668429;6215.223097112861;6230.937690623217;6256.217972753406;6198.597091189058;6224.37756224374;6232.158658581034;6241.157443745036;6247.656378899204;6220.533459990609;6289.622622642656;6290.308066112632;6292.370762923671;6305.211848518935;5973.253343332083;6044;6057.333693293822;6058.0610005449225;6084.756609735561;6179.598326108789;6187.071939209155;6187.381261873777;6188.319284878569;6194.721237544411;6033.18551995475;6042.3655516170165;6050.485708714633;6057.363976782551;6106.084087386927;5851.707414629166;5937.287525496795;5941.851453713692;5998.970005150121;6036.63780173191;5658.434156584309;5810;5856.736446859816;5872.119182122716;5886.381929897299;6014.097885317237;6028.33688294296;6041.75832966694;6061.030235162353;6066.120412540069;5674.943250567441;5787.421257874179;5787.536997040311;5848.035074212878;5861.120831875252 13:53:54 INFO - PROCESS | 1663 | |1;ext.html;461.88914660481487;478.18469509486306;530.7028064284003;534.6257619666233;540.2868213957577;30413;38365;40161.594344197925;40181;40227.39658905112;42029.78985105078;42564.574354256445;42603.78698106513;42610.14779704404;42628.78685606568;9697.563609637584;9899.15857152143;9902.306838521306;9904.158146557515;9922.3054386193;9647.276454265922;9725.416475011521;9733.805323893517;9740.366876153063;9762.26782991275;9736.902630973706;9791.804163916717;9805.215582753399;9823.95088024559;9849.65526206583;9648.131668149865;9702.27232957531;9706.70879873605;9724;9737.853932191023;9627.037296270388;9721.70834874955;9730.562124704406;9732.659356922544;9734;39394.21211575781;39691.00772480682;39745.40381894245;39794.403083953766;39810.800945995084;3298.5876765404323;3398.1334759636134;3403.404404229275;3783.003279859871;4098.077932465201;30334.696653033407;30845.07464776038;30917.84541077303;31905.361892762015;31951.840240798647;2933.722371873694;2933.7506311963507;2951.099914526069;2957.275467510452;3053.618297712786;464241;464400.67799660785;465657;467018.6649066733;467070;56375.43624563702;56630.716846415504;56658.150127748115;56691;56695;34241.65758342435;34771.82614086964;34823.995240547156;35974.28051439009;58847.70576147178;16397.91801041011;16580.58548536296;16583;16592.83407165937;16607.169641518118;12789.744205115845;12883;12901.354932253349;12902.225866448043;12913.548025819051;18568.535786605175;18786.342478013205;18803.059847007597;18814.52963675919;18827.34104306343;7282.890756638654;7330.780076597711;7989.520628762293;8004.079530854026;8070.838583228303;855.4995327733221;923.8337099322187;1089.3137323486312;1089.5641743302583;1152.2280072351546;29466.852665736533;29857.10428687143;30062;30612.846935765177;30856.382872342427;1007.2345017786389;1027.465717826726;1044.6291566493937;1081.3187691754301;1164.3246916788241;14970.40118395252;15496.147711875956;15581.454649087227;15628.609284767972;15984.280707368196;657275.6996730355;666006;666256;666551;667731;56114.158287625716;56743.865122697316;56819.43180568224;56820.71589642108;56845.71577142088;1158.5655379232787;1216.0636310041396;1234.9814752778716;1262.3498898067503;1320.2672516753103;28493.857530712216;30495.695043049287;30504.84747576248;31263.68736312699;31476.37047259088;54638.72680636571;55442.168367473714;55449.72275138598;55530;55659.72170139123;613453;621028;621331;621843;622596;41144.79427602843;41748.3737743928;42390.728278151706;42435.36346954737;42456.78771606122;46092.30861537012;46304.53695463002;47015.76492117518;47293.527064728914;47653.28520072132;37111;38854.445822166796;38932;39899.60100398959;39908.80045599753;38779.80610097044;39067.804660976515;39864.60135398609;40259.19481610293;40424;29808;37437.62562374341;38172;38661;38806.61193388143;33171.33657326888;33833.25672948159;34218.315633687685;34405.82797085999;34475.482867757506;22891.65662515097;25231;25279.11523096683;25376.64077417528;25928 13:53:54 INFO - PROCESS | 1663 | |2;jquery.html;352.2374060159754;373.1939011734653;377.09121018345775;383.1130931892669;404.4014858010145;15284.617884552892;15919.76120358194;20649.380518584447;20677.96610169493;20787.896060519714;20486.18055277787;20728.963551822388;20889.627315597838;21083.894580527074;21093;5727.169560413738;5822.592418530705;6070.2715674118945;6095.695215239242;6096.573239873211;6082.60463069899;6124.540659450537;6134.049222370518;6139.109829074781;6142.723577439026;3866.8646597369097;5272.971770504753;6787.287334829846;6790.151231096113;6824.761133360334;6517.608943463408;6600.339966003409;6750.459963202957;6764.053032575468;6770.796876093725;5874.853128671774;5879.8530036749;5881.470667639933;5881.970590147064;5886.381929897342;13134.474621015148;13180.6704832379;13238.205707657475;13310.733785324335;13480.123791953492;2406.566817972764;2452.411421258885;2580.8580528070947;2594.0272397850804;2865.4698880707138;9902.851457228075;9929.106380425725;9993.900060999369;10312.381257124522;10462.215333849992;1823.4711933539259;1824.8905065695967;1862.4178601097412;1927.681932481139;1970.5664753754152;118052;124359;126251;126745.36627316804;128525.99999999907;10997.34015959045;11387.37369444672;11427.714307142222;11479.4260286987;11677.357745324089;14355.856441435451;14361.712765744836;14366.85633143676;14389.28053597316;14393.712125757636;7961.641726122339;8193.549354785424;8213.178682131738;8356.958215208884;8364.53995030267;8045.988502874281;8086.555239461886;8086.9191308086165;8241.95879020601;8252.628631711588;3613.403788374941;4362.476502819619;4375.943306645871;4391.6486681065435;4537.977310113428;1537.6386549160939;1673.6903073758135;1675.2354565164715;1914.0428038680272;1918.7313776071362;640.9294977552465;781.894444250019;838.7651457591884;846.4582667093065;1045.3988956350129;18721.90639046796;20565.177392904414;20671.4832129195;20677.896610517153;20759.792402076087;822.8642274024719;842.5576572299469;925.4406325341686;932.6595792535676;1005.7485628592851;10415.531301091469;10860.945695271632;10878.836817447745;10903.563857445772;10908.181886358554;537834;572963;576231;591705.0829491736;592191;134241;134700;134884;135053;137533.31233343968;958.2573505533268;964.36352007676;979.7599588100818;980.1570649241646;980.8283550378655;17448.302067917142;17703.557411064827;18149;18228;18468.44594662162;54538.181927271915;55910.72044639751;56356.43643563676;56406;58140;79004;81949;83112.58443707743;84012.73980890414;85447;7591.848163036819;7809.843803124019;8063.596820159086;8094.473859199134;8319.542425166674;9154.67958621445;12161;12569.937150314556;12936.223826570436;12948.870511295143;10802.297850639683;11017.283876548;11233.438328083726;11273.661790146309;11335.319880807177;10648.520816563429;10797.676069717922;10906.90930906903;11099.778004440028;11232.66302010941;7769;11162.44187790591;11314.773704526027;11606.70983225426;11622.535098595961;7803.804904877424;7826.882596760939;7980.680772769024;8219.356128774389;8290.212429819157;8097.623404021213;9797.608095676378;10927.945360273467;11347.319160850375;11385.487653055798 13:53:54 INFO - PROCESS | 1663 | |3;mootools.html;1311.8819306262435;1541.4373753579944;1721.7331313646382;1888.11258708407;1945.4747218251064;8347.499150050993;8907.866382004275;8917.68788092417;8936.374453788238;9019.278457723383;7799.727009554666;8021.117677055534;8418.494890306585;8635.352348573851;8705.390622656416;2347.4037654395006;2395.077895010416;2395.9161429349974;2396.4607963208227;2402.2793162051403;2004.9398518044409;2119.2794449887037;2310.9831674063444;2367.254314890804;2417.347316224618;2372.4424760181428;2385.272491889973;2399.6160614301716;2401.579723548372;2409.5060512594964;2367.7040369953756;2369.5142495788323;2381.30942026812;2381.7737314954966;2403.651470536762;2342.6954495915593;2377.38188071101;2397.0891061396733;2397.568437681217;2405.9639105413435;8781.034086250507;8891.911080889173;8896.822063558757;8900.465972041698;8910.064443233432;5235.685858848443;5382.569394448435;5394.703291318976;5406.837529931084;5409.648372855751;3477.8087205203706;3505.8597656093725;3550.9112272193142;3559.003479025877;3571.785692858411;1045.1743122932874;1049.9527521261484;1051.6266725312557;1067.5622994572266;1074.3822302176202;11543.884561154366;11626.593069242621;11629.302241865431;11646.359450230233;11648.94175529117;4543.659225558096;4696.88257793551;4805.927911081337;4813.7352445615825;4818.807247710122;9886.752831179278;9901.158401535806;9903.108720215072;9906;9911.405315681082;5390.434004429557;5391.757370918318;5392.110301800159;5393.056215162331;5402.567794576425;4415.977920110379;4563.475200352002;4787.904241915142;4898.926516102261;4948.975255123773;3853.96146038536;3864.265789499986;3973.2450834341385;3995;4008.2584721826556;1088.542812018954;1276.3809552367095;1279.9488020479077;1290.541857640524;1295.1969778737243;859.5315553023618;873.921347078766;894.2354287084579;944.8015916657579;966.4925913895261;5727.31272247333;5980;6069.332373438918;6072.726727297282;6161.476274516626;418.738288569644;440.6452805491546;442.111356174086;444.95327990560526;450.86474057782533;3969.3847453644153;3995.260876737813;4047.8785636430953;4049.7772622505454;4133.46264985556;8911.821763564822;10709.78580428387;10728.356298622108;10739.731506712395;10744.623938162127;10678.145748340114;10680.198985076151;10681.465926703633;10692.358458492516;10696.679099627023;7908.248716371935;8076.71731489395;8121.390895682847;8236.341092712688;8238.958805206055;5815.156802263564;5863;5914.4381283777975;6014.188084608521;6032.3967603239325;9989.700308990741;10006.8498972514;10030.699079027641;10046.598136074475;10086.949565252127;9899.109080182818;10069.345492542961;10180.49097545105;10232.283740138417;10297.07326340633;6871.690773915086;7101.715931362688;7197.280271972761;7435.776926692208;7893.960530197542;8125.3905957052275;8223.753287401387;8329.29201017896;8340.87488687658;8349.874751878848;7289.635518223961;7393.778186654409;7416.851662966818;7417.406607471282;7420.777376678492;7148.964255178691;7218.242084581043;7261.745838895613;7286.1985181631035;7382.298681625237;6866;6910.723571057101;6987.510874238755;6998.720051197895;7000.089988301488;4308.37528558351;4452.799624016862;4848;4868.269759536098;5054.09026375256;4014.6988975826343;4901.656884018084;4998.825041123543;5073.492650734897;5169.896602068013 13:53:54 INFO - PROCESS | 1663 | |4;prototype.html;291.2224360956247;300.0563228645908;305.1714594874914;306.8189768036859;307.8214635511403;4415.492218394886;4663.790129444174;5072.923906141411;5191.896162076756;5331;4547.340635607843;4548.79530421131;4853.660243782937;5116.309298244736;5178.420581722573;4036.0515278909434;4036.275514028034;4071.1857628474277;4091.1817636472824;4112.383142528614;3624.112092537332;3951.3206887073025;4049.5950404959417;4077.408775727518;4096.918061638766;3829.425586162084;4029.501708940461;4035.3139966205667;4042.4744783178144;4113.609207125318;4047.271491131595;4050.7569545827346;4067.877963661095;4087.202995415895;4105.302098643223;3548.8935331940083;3571.892713258872;3574.5889222739456;3576.5886923003927;3589.6769290763955;4389.582989615981;4830.830920917786;5176.663516871391;5235.356145146715;5251.894962100775;3701.68535674468;3872.0446174681606;4081.8571350002903;4247.8300867965245;4376.365427013097;5125.615578831603;5272.841814745525;5506.972465137689;5662;5666.121751128581;3148.181472817084;3410.6077801052948;3484.529588505545;3909.4722212501233;3909.8045097745;4664.906701865943;4880.511948805127;5200.505951934598;5630.071038278679;5856.150858125633;3604.6575575320303;3945.743526670757;3976.9602303977167;3990.920181596352;3991.1818077294665;3759.793211373346;3999.080211551301;4037.152198038386;4064.902476331374;4072.5112986441222;3894.7926142895794;4494.5730155635165;4597.08058388317;4639.953600463952;4707;4707.411573553306;5599.972000139973;5601.663900166003;5656.632318899341;5676.735876870815;1275.0819410024767;1370.6915943912738;1387.3826147364325;1388.194846988744;1388.7430825297351;676.539952832069;776.7320274505287;805.3315747929205;813.8535063688593;914.264017465933;4367.27939889921;4842.297866809293;5079.034983353151;5170.689758614495;5209.296744939385;4952.727599981963;5631.873625274961;5637.802676906371;5660.603757736919;5674.290713660793;4965.602751779849;5101.566366858784;5206.661566998133;5246.7638956247065;5294.808668049735;2789.9442011159663;3012.4335345620157;3032.3625242369317;3033.4084853453364;3052.435299469605;5165.974170129125;5780.393058728857;5896.9655468863175;6066.696665166724;6072.39276072398;5237.857285628593;5945.7109013030295;5965.075413310944;5984.371640977722;6001.819945401645;6030.62285120334;6033.5173186145;6035.314285143157;6049.516038716804;6056.0317896683755;5014.724190169576;5423.430539793265;5740.560261888597;5794.362620111869;5795.333536643171;4753.1444340019125;5393.7033463159905;5676.679142701566;5692.288463942007;5712.34308054579;5212.452692467236;5679.5172410345585;5707.543396528351;5962.791302304398;5991.921454138297;3204.8077115373153;3744.457053727249;3781.2248489059125;3822.6941844651806;3825.693944484379;5302.469753024821;5763.567732420169;5777.306723193244;5782.5373970081455;5782.739776710142;4444.511103778646;5210.739463026909;5574.9442505574425;5595.5803314752375;5609.074502707008;4634.420697412824;5393.568514518751;5605.990921634145;5663.801766938137;5669.31968163823;4370.737755734666;4660.883477913079;5545.778168873361;5545.916811247754;5582.888342233214;5522.100897029092;5587.469190426903;5661.264035675335;5697.515711164598;5730.770769169353;4566.990524169355;5548.195511650869;5554.389017208185;5571.526420254324;5586.525145362527 13:53:54 INFO - PROCESS | 1663 | |5;yui.html;711.7081996381484;732.4726197138059;765.992340076599;810.7324582887641;814.1573471457041;15641.843581564195;16234.431794887181;16256.268467918942;16300.347986080573;16303.592410189736;14230;14321.785173222384;14332.928335358334;14350.641233969156;14734.18961957092;666.9833254168636;688.5386790850142;842.1914961636805;843.4854738609444;866.9003064647583;855.448235887852;859.6475445067524;861.4745005546612;861.6984055580529;867.8611422172454;914.5701520285488;914.9176574108329;914.9817003659923;914.9908500915005;919.5034681272105;699.3950233048428;897.1253028297423;913.7578541686426;920.0845159066738;933.2953620016912;695.5513693667607;695.8086526205284;698.8392669686001;699.2832346844525;700.4991431126768;14859.182744949023;14908.925455372762;14908.95637305389;14921.701565968728;14931.701365972729;14062;14238.572842814732;14301.356438960272;14338.068025578305;14368.928155359261;12959.28723920184;12976.286304253263;13161.868381316255;13311.334433278298;13715.862841371558;4519.548045195487;4582.770861456914;4625.930611040837;4658.34783130362;4679.812807487697;119693;123980;124181.37909310395;124411;124455;11122.61070862516;11218.102551795837;11398.544058237578;11583.362915039585;11822.940885295518;17278.913605432143;23038.884805575864;23059;23069.88465057664;23254.5582713816;7857.410694197843;7910.683572657029;7920;7990.12108668046;8161.714339998071;4292.12011537634;4324.308110702273;4343.153085148366;4501.18978583858;4613.446386433649;3495.2310491691787;3638.1632224588493;3641.5266015417824;3642.763220390666;3645.3438381091128;630.8328293002359;650.7527139686983;651.9869602607921;653.6796969485014;654.9181352330959;491.43484992258476;583.4690431707211;603.5202014398476;635.1584150999944;648.8864448721455;8000;8465.280451161598;8825.205731484197;8897.199252067345;8964.820703585892;471.1613328275675;550.3395924890068;618.3908849782961;633.3603060908515;674.9493787965922;4196.307609244441;4388.802503887333;4453.51011388747;4494.438195225597;4523.525029871882;88119.67820482698;111265;139347;145974.02337696243;147695;117508;119617.40191299161;120581.39709301398;122288;125091.37454312852;97675;101995;105187;105478.47260763648;108094.91905081006;7116.644167791486;8673.609687564202;8759.343049271203;8839.116088391109;8880.86678699807;42784.71645850629;53046.93906121779;53792.46207538031;56010;57058.42941570531;71275;81234.59382703049;85807.14192857992;88290.1170988282;90269.54865225632;11459.885401146215;11506.76986460283;11562.248453850472;11653.76692466163;12205.633830985085;12697.492100316253;12755.234685918875;13252.536161234311;14618.853811462175;15395.76906346428;13828.624786426766;13920.234387108807;13960.511382101578;14459.710805784036;14665.780013300022;14007.08953917992;14027.929860351041;14091.577252682437;14278.643033924234;14290;11016.339019658526;13418.261995590336;13633;13780.379882905092;13847.446102155802;11126.944365278121;11457.770844582896;11612;11912;12093.455794489446;10642.89357106419;11109.00018998294;11267.323960562393;11542.19204655666;11701.356425396685 13:53:54 INFO - PROCESS | 1663 | __end_tp_report 13:53:54 INFO - PROCESS | 1663 | __start_cc_report 13:53:54 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1203 13:53:54 INFO - PROCESS | 1663 | __end_cc_report 13:53:54 INFO - PROCESS | 1663 | __startTimestamp1472331234645__endTimestamp 13:53:54 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | ------- Summary: start ------- 13:53:54 INFO - PROCESS | 1663 | Number of tests: 6 13:53:54 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5678.76 Median:5856.74 stddev:627.17 (10.7%) stddev-sans-first:599.43 13:53:54 INFO - PROCESS | 1663 | Values: 3249.0 3258.6 3285.5 3304.1 3341.6 5495.7 5580.7 5589.9 5617.3 5659.5 5578.9 5635.0 5639.7 5643.4 5669.1 5079.2 5112.9 5143.4 5191.0 5204.6 5170.6 5227.6 5238.7 5241.2 5247.9 5130.7 5141.1 5159.1 5166.4 5169.2 5236.3 5249.5 5254.7 5264.8 5320.9 5042.5 5043.0 5051.0 5168.7 5168.7 5586.8 5608.2 5629.2 5659.9 5716.4 6154.1 6158.6 6175.9 6178.4 6202.3 6015.0 6088.7 6109.9 6203.8 6209.7 5722.7 5732.5 5774.4 5779.7 5799.9 6242.7 6244.8 6244.8 6266.3 6266.5 5925.3 6020.3 6054.8 6063.1 6066.9 6120.5 6126.7 6170.8 6197.3 6199.6 6052.8 6099.8 6139.1 6146.8 6151.8 6027.5 6093.0 6114.8 6145.3 6148.8 4865.8 4897.9 4927.8 4950.9 4964.2 4350.4 4351.5 4355.9 4390.7 4405.8 5496.2 5534.3 5621.0 5625.2 5655.2 6102.9 6139.1 6157.1 6157.3 6165.8 5617.8 5625.5 5634.5 5637.4 5678.1 5313.0 5359.3 5375.2 5375.9 5407.8 6156.8 6182.5 6215.2 6230.9 6256.2 6198.6 6224.4 6232.2 6241.2 6247.7 6220.5 6289.6 6290.3 6292.4 6305.2 5973.3 6044.0 6057.3 6058.1 6084.8 6179.6 6187.1 6187.4 6188.3 6194.7 6033.2 6042.4 6050.5 6057.4 6106.1 5851.7 5937.3 5941.9 5999.0 6036.6 5658.4 5810.0 5856.7 5872.1 5886.4 6014.1 6028.3 6041.8 6061.0 6066.1 5674.9 5787.4 5787.5 5848.0 5861.1 13:53:54 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:71233.95 Median:40035.20 stddev:157773.86 (394.1%) stddev-sans-first:158126.98 13:53:54 INFO - PROCESS | 1663 | Values: 461.9 478.2 530.7 534.6 540.3 30413.0 38365.0 40161.6 40181.0 40227.4 42029.8 42564.6 42603.8 42610.1 42628.8 9697.6 9899.2 9902.3 9904.2 9922.3 9647.3 9725.4 9733.8 9740.4 9762.3 9736.9 9791.8 9805.2 9824.0 9849.7 9648.1 9702.3 9706.7 9724.0 9737.9 9627.0 9721.7 9730.6 9732.7 9734.0 39394.2 39691.0 39745.4 39794.4 39810.8 3298.6 3398.1 3403.4 3783.0 4098.1 30334.7 30845.1 30917.8 31905.4 31951.8 2933.7 2933.8 2951.1 2957.3 3053.6 464241.0 464400.7 465657.0 467018.7 467070.0 56375.4 56630.7 56658.2 56691.0 56695.0 34241.7 34771.8 34824.0 35974.3 58847.7 16397.9 16580.6 16583.0 16592.8 16607.2 12789.7 12883.0 12901.4 12902.2 12913.5 18568.5 18786.3 18803.1 18814.5 18827.3 7282.9 7330.8 7989.5 8004.1 8070.8 855.5 923.8 1089.3 1089.6 1152.2 29466.9 29857.1 30062.0 30612.8 30856.4 1007.2 1027.5 1044.6 1081.3 1164.3 14970.4 15496.1 15581.5 15628.6 15984.3 657275.7 666006.0 666256.0 666551.0 667731.0 56114.2 56743.9 56819.4 56820.7 56845.7 1158.6 1216.1 1235.0 1262.3 1320.3 28493.9 30495.7 30504.8 31263.7 31476.4 54638.7 55442.2 55449.7 55530.0 55659.7 613453.0 621028.0 621331.0 621843.0 622596.0 41144.8 41748.4 42390.7 42435.4 42456.8 46092.3 46304.5 47015.8 47293.5 47653.3 37111.0 38854.4 38932.0 39899.6 39908.8 38779.8 39067.8 39864.6 40259.2 40424.0 29808.0 37437.6 38172.0 38661.0 38806.6 33171.3 33833.3 34218.3 34405.8 34475.5 22891.7 25231.0 25279.1 25376.6 25928.0 13:53:54 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34513.18 Median:1982.82 stddev:96655.38 (4874.6%) stddev-sans-first:96892.49 13:53:54 INFO - PROCESS | 1663 | Values: 352.2 373.2 377.1 383.1 404.4 15284.6 15919.8 20649.4 20678.0 20787.9 20486.2 20729.0 20889.6 21083.9 21093.0 5727.2 5822.6 6070.3 6095.7 6096.6 6082.6 6124.5 6134.0 6139.1 6142.7 3866.9 5273.0 6787.3 6790.2 6824.8 6517.6 6600.3 6750.5 6764.1 6770.8 5874.9 5879.9 5881.5 5882.0 5886.4 13134.5 13180.7 13238.2 13310.7 13480.1 2406.6 2452.4 2580.9 2594.0 2865.5 9902.9 9929.1 9993.9 10312.4 10462.2 1823.5 1824.9 1862.4 1927.7 1970.6 118052.0 124359.0 126251.0 126745.4 128526.0 10997.3 11387.4 11427.7 11479.4 11677.4 14355.9 14361.7 14366.9 14389.3 14393.7 7961.6 8193.5 8213.2 8357.0 8364.5 8046.0 8086.6 8086.9 8242.0 8252.6 3613.4 4362.5 4375.9 4391.6 4538.0 1537.6 1673.7 1675.2 1914.0 1918.7 640.9 781.9 838.8 846.5 1045.4 18721.9 20565.2 20671.5 20677.9 20759.8 822.9 842.6 925.4 932.7 1005.7 10415.5 10860.9 10878.8 10903.6 10908.2 537834.0 572963.0 576231.0 591705.1 592191.0 134241.0 134700.0 134884.0 135053.0 137533.3 958.3 964.4 979.8 980.2 980.8 17448.3 17703.6 18149.0 18228.0 18468.4 54538.2 55910.7 56356.4 56406.0 58140.0 79004.0 81949.0 83112.6 84012.7 85447.0 7591.8 7809.8 8063.6 8094.5 8319.5 9154.7 12161.0 12569.9 12936.2 12948.9 10802.3 11017.3 11233.4 11273.7 11335.3 10648.5 10797.7 10906.9 11099.8 11232.7 7769.0 11162.4 11314.8 11606.7 11622.5 7803.8 7826.9 7980.7 8219.4 8290.2 8097.6 9797.6 10927.9 11347.3 11385.5 13:53:54 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5676.94 Median:4809.83 stddev:3198.35 (66.5%) stddev-sans-first:3190.49 13:53:54 INFO - PROCESS | 1663 | Values: 1311.9 1541.4 1721.7 1888.1 1945.5 8347.5 8907.9 8917.7 8936.4 9019.3 7799.7 8021.1 8418.5 8635.4 8705.4 2347.4 2395.1 2395.9 2396.5 2402.3 2004.9 2119.3 2311.0 2367.3 2417.3 2372.4 2385.3 2399.6 2401.6 2409.5 2367.7 2369.5 2381.3 2381.8 2403.7 2342.7 2377.4 2397.1 2397.6 2406.0 8781.0 8891.9 8896.8 8900.5 8910.1 5235.7 5382.6 5394.7 5406.8 5409.6 3477.8 3505.9 3550.9 3559.0 3571.8 1045.2 1050.0 1051.6 1067.6 1074.4 11543.9 11626.6 11629.3 11646.4 11648.9 4543.7 4696.9 4805.9 4813.7 4818.8 9886.8 9901.2 9903.1 9906.0 9911.4 5390.4 5391.8 5392.1 5393.1 5402.6 4416.0 4563.5 4787.9 4898.9 4949.0 3854.0 3864.3 3973.2 3995.0 4008.3 1088.5 1276.4 1279.9 1290.5 1295.2 859.5 873.9 894.2 944.8 966.5 5727.3 5980.0 6069.3 6072.7 6161.5 418.7 440.6 442.1 445.0 450.9 3969.4 3995.3 4047.9 4049.8 4133.5 8911.8 10709.8 10728.4 10739.7 10744.6 10678.1 10680.2 10681.5 10692.4 10696.7 7908.2 8076.7 8121.4 8236.3 8239.0 5815.2 5863.0 5914.4 6014.2 6032.4 9989.7 10006.8 10030.7 10046.6 10086.9 9899.1 10069.3 10180.5 10232.3 10297.1 6871.7 7101.7 7197.3 7435.8 7894.0 8125.4 8223.8 8329.3 8340.9 8349.9 7289.6 7393.8 7416.9 7417.4 7420.8 7149.0 7218.2 7261.7 7286.2 7382.3 6866.0 6910.7 6987.5 6998.7 7000.1 4308.4 4452.8 4848.0 4868.3 5054.1 4014.7 4901.7 4998.8 5073.5 5169.9 13:53:54 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4505.07 Median:5043.82 stddev:1391.12 (27.6%) stddev-sans-first:1358.59 13:53:54 INFO - PROCESS | 1663 | Values: 291.2 300.1 305.2 306.8 307.8 4415.5 4663.8 5072.9 5191.9 5331.0 4547.3 4548.8 4853.7 5116.3 5178.4 4036.1 4036.3 4071.2 4091.2 4112.4 3624.1 3951.3 4049.6 4077.4 4096.9 3829.4 4029.5 4035.3 4042.5 4113.6 4047.3 4050.8 4067.9 4087.2 4105.3 3548.9 3571.9 3574.6 3576.6 3589.7 4389.6 4830.8 5176.7 5235.4 5251.9 3701.7 3872.0 4081.9 4247.8 4376.4 5125.6 5272.8 5507.0 5662.0 5666.1 3148.2 3410.6 3484.5 3909.5 3909.8 4664.9 4880.5 5200.5 5630.1 5856.2 3604.7 3945.7 3977.0 3990.9 3991.2 3759.8 3999.1 4037.2 4064.9 4072.5 3894.8 4494.6 4597.1 4640.0 4707.0 4707.4 5600.0 5601.7 5656.6 5676.7 1275.1 1370.7 1387.4 1388.2 1388.7 676.5 776.7 805.3 813.9 914.3 4367.3 4842.3 5079.0 5170.7 5209.3 4952.7 5631.9 5637.8 5660.6 5674.3 4965.6 5101.6 5206.7 5246.8 5294.8 2789.9 3012.4 3032.4 3033.4 3052.4 5166.0 5780.4 5897.0 6066.7 6072.4 5237.9 5945.7 5965.1 5984.4 6001.8 6030.6 6033.5 6035.3 6049.5 6056.0 5014.7 5423.4 5740.6 5794.4 5795.3 4753.1 5393.7 5676.7 5692.3 5712.3 5212.5 5679.5 5707.5 5962.8 5991.9 3204.8 3744.5 3781.2 3822.7 3825.7 5302.5 5763.6 5777.3 5782.5 5782.7 4444.5 5210.7 5574.9 5595.6 5609.1 4634.4 5393.6 5606.0 5663.8 5669.3 4370.7 4660.9 5545.8 5545.9 5582.9 5522.1 5587.5 5661.3 5697.5 5730.8 4567.0 5548.2 5554.4 5571.5 5586.5 13:53:54 INFO - PROCESS | 1663 | 13:53:54 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:23759.33 Median:3642.14 stddev:37285.15 (1023.7%) stddev-sans-first:37349.58 13:53:54 INFO - PROCESS | 1663 | Values: 711.7 732.5 766.0 810.7 814.2 15641.8 16234.4 16256.3 16300.3 16303.6 14230.0 14321.8 14332.9 14350.6 14734.2 667.0 688.5 842.2 843.5 866.9 855.4 859.6 861.5 861.7 867.9 914.6 914.9 915.0 915.0 919.5 699.4 897.1 913.8 920.1 933.3 695.6 695.8 698.8 699.3 700.5 14859.2 14908.9 14909.0 14921.7 14931.7 14062.0 14238.6 14301.4 14338.1 14368.9 12959.3 12976.3 13161.9 13311.3 13715.9 4519.5 4582.8 4625.9 4658.3 4679.8 119693.0 123980.0 124181.4 124411.0 124455.0 11122.6 11218.1 11398.5 11583.4 11822.9 17278.9 23038.9 23059.0 23069.9 23254.6 7857.4 7910.7 7920.0 7990.1 8161.7 4292.1 4324.3 4343.2 4501.2 4613.4 3495.2 3638.2 3641.5 3642.8 3645.3 630.8 650.8 652.0 653.7 654.9 491.4 583.5 603.5 635.2 648.9 8000.0 8465.3 8825.2 8897.2 8964.8 471.2 550.3 618.4 633.4 674.9 4196.3 4388.8 4453.5 4494.4 4523.5 88119.7 111265.0 139347.0 145974.0 147695.0 117508.0 119617.4 120581.4 122288.0 125091.4 97675.0 101995.0 105187.0 105478.5 108094.9 7116.6 8673.6 8759.3 8839.1 8880.9 42784.7 53046.9 53792.5 56010.0 57058.4 71275.0 81234.6 85807.1 88290.1 90269.5 11459.9 11506.8 11562.2 11653.8 12205.6 12697.5 12755.2 13252.5 14618.9 15395.8 13828.6 13920.2 13960.5 14459.7 14665.8 14007.1 14027.9 14091.6 14278.6 14290.0 11016.3 13418.3 13633.0 13780.4 13847.4 11126.9 11457.8 11612.0 11912.0 12093.5 10642.9 11109.0 11267.3 11542.2 11701.4 13:53:54 INFO - PROCESS | 1663 | -------- Summary: end -------- 13:53:54 INFO - PROCESS | 1663 | 13:53:55 INFO - TEST-INFO | 1663: exit 0 13:53:55 INFO - TEST-OK | dromaeo_css | took 1117125ms 13:53:55 INFO - TEST-START | kraken 13:53:55 INFO - operating with platform_type : mac_ 13:53:55 INFO - Initialising browser for kraken test... 13:53:55 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmp59mRzj/profile http://localhost:49268/getInfo.html) 13:53:57 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 13:53:57 INFO - PROCESS | 1668 | colorDepth:24 13:53:57 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 13:53:57 INFO - PROCESS | 1668 | __metrics 13:53:57 INFO - PROCESS | 1668 | 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" 13:53:57 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:53:58 INFO - TEST-INFO | 1668: exit 0 13:53:58 INFO - Browser initialized. 13:53:58 INFO - Running cycle 1/1 for kraken test... 13:53:58 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmp59mRzj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:54:10 INFO - PROCESS | 1669 | RSS: Main: 234934272 13:54:10 INFO - PROCESS | 1669 | 13:54:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 13:54:13 INFO - PROCESS | 1669 | RSS: Main: 293765120 13:54:13 INFO - PROCESS | 1669 | 13:54:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 13:54:17 INFO - PROCESS | 1669 | RSS: Main: 290398208 13:54:17 INFO - PROCESS | 1669 | 13:54:20 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 13:54:21 INFO - PROCESS | 1669 | RSS: Main: 377913344 13:54:21 INFO - PROCESS | 1669 | 13:54:23 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 13:54:23 INFO - PROCESS | 1669 | RSS: Main: 281731072 13:54:23 INFO - PROCESS | 1669 | 13:54:25 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:54:26 INFO - PROCESS | 1669 | RSS: Main: 283598848 13:54:26 INFO - PROCESS | 1669 | 13:54:29 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 13:54:29 INFO - PROCESS | 1669 | RSS: Main: 321548288 13:54:29 INFO - PROCESS | 1669 | 13:54:32 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 13:54:33 INFO - PROCESS | 1669 | RSS: Main: 323719168 13:54:33 INFO - PROCESS | 1669 | 13:54:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 13:54:36 INFO - PROCESS | 1669 | RSS: Main: 320643072 13:54:36 INFO - PROCESS | 1669 | 13:54:38 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:54:38 INFO - PROCESS | 1669 | RSS: Main: 297390080 13:54:38 INFO - PROCESS | 1669 | 13:54:40 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:54:41 INFO - PROCESS | 1669 | RSS: Main: 302854144 13:54:41 INFO - PROCESS | 1669 | 13:54:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:54:44 INFO - PROCESS | 1669 | RSS: Main: 302874624 13:54:44 INFO - PROCESS | 1669 | 13:54:47 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:54:47 INFO - PROCESS | 1669 | RSS: Main: 319287296 13:54:47 INFO - PROCESS | 1669 | 13:54:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:54:51 INFO - PROCESS | 1669 | RSS: Main: 315338752 13:54:51 INFO - PROCESS | 1669 | 13:54:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 13:54:53 INFO - PROCESS | 1669 | RSS: Main: 359112704 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | __start_tp_report 13:54:53 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 13:54:53 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 13:54:53 INFO - PROCESS | 1669 | |i|pagename|runs| 13:54:53 INFO - PROCESS | 1669 | |0;ai-astar;115;93;148;166;166;112;110;115;157;114 13:54:53 INFO - PROCESS | 1669 | |1;audio-beat-detection;145;109;139;196;139;128;129;108;171;106 13:54:53 INFO - PROCESS | 1669 | |2;audio-dft;184;186;182;181;189;181;182;181;177;182 13:54:53 INFO - PROCESS | 1669 | |3;audio-fft;72;76;75;149;59;58;60;67;140;57 13:54:53 INFO - PROCESS | 1669 | |4;audio-oscillator;81;82;133;71;70;76;119;69;69;118 13:54:53 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;86;84;86;83;86;84;85;83;85;83 13:54:53 INFO - PROCESS | 1669 | |6;imaging-darkroom;93;93;93;93;92;92;93;92;92;94 13:54:53 INFO - PROCESS | 1669 | |7;imaging-desaturate;84;86;85;87;86;91;127;83;84;87 13:54:53 INFO - PROCESS | 1669 | |8;json-parse-financial;54;55;54;54;54;55;54;54;54;54 13:54:53 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;68;74;73;77;75;72;70;71;71;72 13:54:53 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;86;85;87;84;98;107;86;86;86;86 13:54:53 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;137;139;137;138;137;138;137;133;178;141 13:54:53 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;169;167;173;169;168;170;167;170;168;167 13:54:53 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;65;67;68;67;67;70;66;66;67;66 13:54:53 INFO - PROCESS | 1669 | __end_tp_report 13:54:53 INFO - PROCESS | 1669 | __start_cc_report 13:54:53 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,2038 13:54:53 INFO - PROCESS | 1669 | __end_cc_report 13:54:53 INFO - PROCESS | 1669 | __startTimestamp1472331293179__endTimestamp 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | ------- Summary: start ------- 13:54:53 INFO - PROCESS | 1669 | Number of tests: 14 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:129.60 Median:152.50 stddev:26.75 (17.5%) stddev-sans-first:27.85 13:54:53 INFO - PROCESS | 1669 | Values: 115.0 93.0 148.0 166.0 166.0 112.0 110.0 115.0 157.0 114.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:139.00 stddev:28.75 (20.7%) stddev-sans-first:30.35 13:54:53 INFO - PROCESS | 1669 | Values: 145.0 109.0 139.0 196.0 139.0 128.0 129.0 108.0 171.0 106.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:182.50 Median:182.00 stddev:3.24 (1.8%) stddev-sans-first:3.39 13:54:53 INFO - PROCESS | 1669 | Values: 184.0 186.0 182.0 181.0 189.0 181.0 182.0 181.0 177.0 182.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:81.30 Median:63.50 stddev:34.11 (53.7%) stddev-sans-first:36.01 13:54:53 INFO - PROCESS | 1669 | Values: 72.0 76.0 75.0 149.0 59.0 58.0 60.0 67.0 140.0 57.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:70.50 stddev:24.59 (34.9%) stddev-sans-first:25.92 13:54:53 INFO - PROCESS | 1669 | Values: 81.0 82.0 133.0 71.0 70.0 76.0 119.0 69.0 69.0 118.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:84.50 Median:85.00 stddev:1.27 (1.5%) stddev-sans-first:1.22 13:54:53 INFO - PROCESS | 1669 | Values: 86.0 84.0 86.0 83.0 86.0 84.0 85.0 83.0 85.0 83.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 13:54:53 INFO - PROCESS | 1669 | Values: 93.0 93.0 93.0 93.0 92.0 92.0 93.0 92.0 92.0 94.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:90.00 Median:86.00 stddev:13.19 (15.3%) stddev-sans-first:13.81 13:54:53 INFO - PROCESS | 1669 | Values: 84.0 86.0 85.0 87.0 86.0 91.0 127.0 83.0 84.0 87.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 13:54:53 INFO - PROCESS | 1669 | Values: 54.0 55.0 54.0 54.0 54.0 55.0 54.0 54.0 54.0 54.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:72.50 stddev:2.58 (3.6%) stddev-sans-first:2.22 13:54:53 INFO - PROCESS | 1669 | Values: 68.0 74.0 73.0 77.0 75.0 72.0 70.0 71.0 71.0 72.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:86.00 stddev:7.42 (8.6%) stddev-sans-first:7.78 13:54:53 INFO - PROCESS | 1669 | Values: 86.0 85.0 87.0 84.0 98.0 107.0 86.0 86.0 86.0 86.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:138.00 stddev:12.98 (9.4%) stddev-sans-first:13.67 13:54:53 INFO - PROCESS | 1669 | Values: 137.0 139.0 137.0 138.0 137.0 138.0 137.0 133.0 178.0 141.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 13:54:53 INFO - PROCESS | 1669 | Values: 169.0 167.0 173.0 169.0 168.0 170.0 167.0 170.0 168.0 167.0 13:54:53 INFO - PROCESS | 1669 | 13:54:53 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.37 (2.0%) stddev-sans-first:1.27 13:54:53 INFO - PROCESS | 1669 | Values: 65.0 67.0 68.0 67.0 67.0 70.0 66.0 66.0 67.0 66.0 13:54:53 INFO - PROCESS | 1669 | -------- Summary: end -------- 13:54:53 INFO - PROCESS | 1669 | 13:54:54 INFO - TEST-INFO | 1669: exit 0 13:54:54 INFO - TEST-OK | kraken | took 58822ms 13:54:54 INFO - SUITE-END | took 1175s 13:54:54 INFO - Completed test suite (00:19:36) 13:54:54 INFO - javascript benchmark 13:54:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.999999999999, 3258.59267591551, 3285.490748933916, 3304.0913748719113, 3341.599008119026, 5495.697736624484, 5580.748866301016, 5589.888202235953, 5617.325920889494, 5659.547236221108, 5578.9163162552495, 5634.9718251408685, 5639.746211420485, 5643.435656434354, 5669.0646043402785, 5079.1873300272055, 5112.8977420451565, 5143.408508021569, 5191.039657663345, 5204.609654275925, 5170.560502357285, 5227.607929405291, 5238.659487133325, 5241.2400201970695, 5247.895042099156, 5130.71781052042, 5141.126008578532, 5159.097157997336, 5166.405863325709, 5169.1987741899875, 5236.266922630834, 5249.5012973767625, 5254.737263136828, 5264.815731449419, 5320.9467905320835, 5042.495750424965, 5042.974785126051, 5051.040302342543, 5168.664036837594, 5168.689878607295, 5586.804461843816, 5608.186812912146, 5629.183768353607, 5659.886802263973, 5716.371199168088, 6154.076888466721, 6158.599691020069, 6175.938240617581, 6178.38216178383, 6202.34875338092, 6015.037593984942, 6088.695565221766, 6109.8601770527275, 6203.844903877394, 6209.689515524251, 5722.7424765885635, 5732.541396688255, 5774.393688662672, 5779.739911703899, 5799.94200057994, 6242.687865606701, 6244.781432649836, 6244.812655620339, 6266.342034086447, 6266.467350275278, 5925.34821169671, 6020.307664618625, 6054.7880824171825, 6063.090536419572, 6066.878662426815, 6120.479759220516, 6126.663033533109, 6170.784022559189, 6197.287311959092, 6199.597026193283, 6052.7965452392245, 6099.817005489843, 6139.079138129317, 6146.78486252979, 6151.7539298428455, 6027.48766354856, 6093.025115981422, 6114.847128821815, 6145.293291271561, 6148.754049838046, 4865.756712164449, 4897.877553061202, 4927.827526036572, 4950.8762280943265, 4964.180910149785, 4350.434443522385, 4351.543087975717, 4355.912881742411, 4390.670699697535, 4405.845795397146, 5496.1755736639825, 5534.280543529316, 5620.971895140498, 5625.212470254168, 5655.1517272409465, 6102.877942441126, 6139.062858969425, 6157.107219453154, 6157.261128664589, 6165.784197553064, 5617.831465056055, 5625.46558076982, 5634.5210657093785, 5637.43625637433, 5678.119891416754, 5312.9734351328, 5359.276497672842, 5375.220593014069, 5375.865603359869, 5407.78368865241, 6156.784512542129, 6182.474489668429, 6215.223097112861, 6230.937690623217, 6256.217972753406, 6198.597091189058, 6224.37756224374, 6232.158658581034, 6241.157443745036, 6247.656378899204, 6220.533459990609, 6289.622622642656, 6290.308066112632, 6292.370762923671, 6305.211848518935, 5973.253343332083, 6044.0, 6057.333693293822, 6058.0610005449225, 6084.756609735561, 6179.598326108789, 6187.071939209155, 6187.381261873777, 6188.319284878569, 6194.721237544411, 6033.18551995475, 6042.3655516170165, 6050.485708714633, 6057.363976782551, 6106.084087386927, 5851.707414629166, 5937.287525496795, 5941.851453713692, 5998.970005150121, 6036.63780173191, 5658.434156584309, 5810.0, 5856.736446859816, 5872.119182122716, 5886.381929897299, 6014.097885317237, 6028.33688294296, 6041.75832966694, 6061.030235162353, 6066.120412540069, 5674.943250567441, 5787.421257874179, 5787.536997040311, 5848.035074212878, 5861.120831875252], "value": 5637.56081309797, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.88914660481487, 478.18469509486306, 530.7028064284003, 534.6257619666233, 540.2868213957577, 30413.0, 38365.0, 40161.594344197925, 40181.0, 40227.39658905112, 42029.78985105078, 42564.574354256445, 42603.78698106513, 42610.14779704404, 42628.78685606568, 9697.563609637584, 9899.15857152143, 9902.306838521306, 9904.158146557515, 9922.3054386193, 9647.276454265922, 9725.416475011521, 9733.805323893517, 9740.366876153063, 9762.26782991275, 9736.902630973706, 9791.804163916717, 9805.215582753399, 9823.95088024559, 9849.65526206583, 9648.131668149865, 9702.27232957531, 9706.70879873605, 9724.0, 9737.853932191023, 9627.037296270388, 9721.70834874955, 9730.562124704406, 9732.659356922544, 9734.0, 39394.21211575781, 39691.00772480682, 39745.40381894245, 39794.403083953766, 39810.800945995084, 3298.5876765404323, 3398.1334759636134, 3403.404404229275, 3783.003279859871, 4098.077932465201, 30334.696653033407, 30845.07464776038, 30917.84541077303, 31905.361892762015, 31951.840240798647, 2933.722371873694, 2933.7506311963507, 2951.099914526069, 2957.275467510452, 3053.618297712786, 464241.0, 464400.67799660785, 465657.0, 467018.6649066733, 467070.0, 56375.43624563702, 56630.716846415504, 56658.150127748115, 56691.0, 56695.0, 34241.65758342435, 34771.82614086964, 34823.995240547156, 35974.28051439009, 58847.70576147178, 16397.91801041011, 16580.58548536296, 16583.0, 16592.83407165937, 16607.169641518118, 12789.744205115845, 12883.0, 12901.354932253349, 12902.225866448043, 12913.548025819051, 18568.535786605175, 18786.342478013205, 18803.059847007597, 18814.52963675919, 18827.34104306343, 7282.890756638654, 7330.780076597711, 7989.520628762293, 8004.079530854026, 8070.838583228303, 855.4995327733221, 923.8337099322187, 1089.3137323486312, 1089.5641743302583, 1152.2280072351546, 29466.852665736533, 29857.10428687143, 30062.0, 30612.846935765177, 30856.382872342427, 1007.2345017786389, 1027.465717826726, 1044.6291566493937, 1081.3187691754301, 1164.3246916788241, 14970.40118395252, 15496.147711875956, 15581.454649087227, 15628.609284767972, 15984.280707368196, 657275.6996730355, 666006.0, 666256.0, 666551.0, 667731.0, 56114.158287625716, 56743.865122697316, 56819.43180568224, 56820.71589642108, 56845.71577142088, 1158.5655379232787, 1216.0636310041396, 1234.9814752778716, 1262.3498898067503, 1320.2672516753103, 28493.857530712216, 30495.695043049287, 30504.84747576248, 31263.68736312699, 31476.37047259088, 54638.72680636571, 55442.168367473714, 55449.72275138598, 55530.0, 55659.72170139123, 613453.0, 621028.0, 621331.0, 621843.0, 622596.0, 41144.79427602843, 41748.3737743928, 42390.728278151706, 42435.36346954737, 42456.78771606122, 46092.30861537012, 46304.53695463002, 47015.76492117518, 47293.527064728914, 47653.28520072132, 37111.0, 38854.445822166796, 38932.0, 39899.60100398959, 39908.80045599753, 38779.80610097044, 39067.804660976515, 39864.60135398609, 40259.19481610293, 40424.0, 29808.0, 37437.62562374341, 38172.0, 38661.0, 38806.61193388143, 33171.33657326888, 33833.25672948159, 34218.315633687685, 34405.82797085999, 34475.482867757506, 22891.65662515097, 25231.0, 25279.11523096683, 25376.64077417528, 25928.0], "value": 20035.684489436353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.2374060159754, 373.1939011734653, 377.09121018345775, 383.1130931892669, 404.4014858010145, 15284.617884552892, 15919.76120358194, 20649.380518584447, 20677.96610169493, 20787.896060519714, 20486.18055277787, 20728.963551822388, 20889.627315597838, 21083.894580527074, 21093.0, 5727.169560413738, 5822.592418530705, 6070.2715674118945, 6095.695215239242, 6096.573239873211, 6082.60463069899, 6124.540659450537, 6134.049222370518, 6139.109829074781, 6142.723577439026, 3866.8646597369097, 5272.971770504753, 6787.287334829846, 6790.151231096113, 6824.761133360334, 6517.608943463408, 6600.339966003409, 6750.459963202957, 6764.053032575468, 6770.796876093725, 5874.853128671774, 5879.8530036749, 5881.470667639933, 5881.970590147064, 5886.381929897342, 13134.474621015148, 13180.6704832379, 13238.205707657475, 13310.733785324335, 13480.123791953492, 2406.566817972764, 2452.411421258885, 2580.8580528070947, 2594.0272397850804, 2865.4698880707138, 9902.851457228075, 9929.106380425725, 9993.900060999369, 10312.381257124522, 10462.215333849992, 1823.4711933539259, 1824.8905065695967, 1862.4178601097412, 1927.681932481139, 1970.5664753754152, 118052.0, 124359.0, 126251.0, 126745.36627316804, 128525.99999999907, 10997.34015959045, 11387.37369444672, 11427.714307142222, 11479.4260286987, 11677.357745324089, 14355.856441435451, 14361.712765744836, 14366.85633143676, 14389.28053597316, 14393.712125757636, 7961.641726122339, 8193.549354785424, 8213.178682131738, 8356.958215208884, 8364.53995030267, 8045.988502874281, 8086.555239461886, 8086.9191308086165, 8241.95879020601, 8252.628631711588, 3613.403788374941, 4362.476502819619, 4375.943306645871, 4391.6486681065435, 4537.977310113428, 1537.6386549160939, 1673.6903073758135, 1675.2354565164715, 1914.0428038680272, 1918.7313776071362, 640.9294977552465, 781.894444250019, 838.7651457591884, 846.4582667093065, 1045.3988956350129, 18721.90639046796, 20565.177392904414, 20671.4832129195, 20677.896610517153, 20759.792402076087, 822.8642274024719, 842.5576572299469, 925.4406325341686, 932.6595792535676, 1005.7485628592851, 10415.531301091469, 10860.945695271632, 10878.836817447745, 10903.563857445772, 10908.181886358554, 537834.0, 572963.0, 576231.0, 591705.0829491736, 592191.0, 134241.0, 134700.0, 134884.0, 135053.0, 137533.31233343968, 958.2573505533268, 964.36352007676, 979.7599588100818, 980.1570649241646, 980.8283550378655, 17448.302067917142, 17703.557411064827, 18149.0, 18228.0, 18468.44594662162, 54538.181927271915, 55910.72044639751, 56356.43643563676, 56406.0, 58140.0, 79004.0, 81949.0, 83112.58443707743, 84012.73980890414, 85447.0, 7591.848163036819, 7809.843803124019, 8063.596820159086, 8094.473859199134, 8319.542425166674, 9154.67958621445, 12161.0, 12569.937150314556, 12936.223826570436, 12948.870511295143, 10802.297850639683, 11017.283876548, 11233.438328083726, 11273.661790146309, 11335.319880807177, 10648.520816563429, 10797.676069717922, 10906.90930906903, 11099.778004440028, 11232.66302010941, 7769.0, 11162.44187790591, 11314.773704526027, 11606.70983225426, 11622.535098595961, 7803.804904877424, 7826.882596760939, 7980.680772769024, 8219.356128774389, 8290.212429819157, 8097.623404021213, 9797.608095676378, 10927.945360273467, 11347.319160850375, 11385.487653055798], "value": 9349.934129043979, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.8819306262435, 1541.4373753579944, 1721.7331313646382, 1888.11258708407, 1945.4747218251064, 8347.499150050993, 8907.866382004275, 8917.68788092417, 8936.374453788238, 9019.278457723383, 7799.727009554666, 8021.117677055534, 8418.494890306585, 8635.352348573851, 8705.390622656416, 2347.4037654395006, 2395.077895010416, 2395.9161429349974, 2396.4607963208227, 2402.2793162051403, 2004.9398518044409, 2119.2794449887037, 2310.9831674063444, 2367.254314890804, 2417.347316224618, 2372.4424760181428, 2385.272491889973, 2399.6160614301716, 2401.579723548372, 2409.5060512594964, 2367.7040369953756, 2369.5142495788323, 2381.30942026812, 2381.7737314954966, 2403.651470536762, 2342.6954495915593, 2377.38188071101, 2397.0891061396733, 2397.568437681217, 2405.9639105413435, 8781.034086250507, 8891.911080889173, 8896.822063558757, 8900.465972041698, 8910.064443233432, 5235.685858848443, 5382.569394448435, 5394.703291318976, 5406.837529931084, 5409.648372855751, 3477.8087205203706, 3505.8597656093725, 3550.9112272193142, 3559.003479025877, 3571.785692858411, 1045.1743122932874, 1049.9527521261484, 1051.6266725312557, 1067.5622994572266, 1074.3822302176202, 11543.884561154366, 11626.593069242621, 11629.302241865431, 11646.359450230233, 11648.94175529117, 4543.659225558096, 4696.88257793551, 4805.927911081337, 4813.7352445615825, 4818.807247710122, 9886.752831179278, 9901.158401535806, 9903.108720215072, 9906.0, 9911.405315681082, 5390.434004429557, 5391.757370918318, 5392.110301800159, 5393.056215162331, 5402.567794576425, 4415.977920110379, 4563.475200352002, 4787.904241915142, 4898.926516102261, 4948.975255123773, 3853.96146038536, 3864.265789499986, 3973.2450834341385, 3995.0, 4008.2584721826556, 1088.542812018954, 1276.3809552367095, 1279.9488020479077, 1290.541857640524, 1295.1969778737243, 859.5315553023618, 873.921347078766, 894.2354287084579, 944.8015916657579, 966.4925913895261, 5727.31272247333, 5980.0, 6069.332373438918, 6072.726727297282, 6161.476274516626, 418.738288569644, 440.6452805491546, 442.111356174086, 444.95327990560526, 450.86474057782533, 3969.3847453644153, 3995.260876737813, 4047.8785636430953, 4049.7772622505454, 4133.46264985556, 8911.821763564822, 10709.78580428387, 10728.356298622108, 10739.731506712395, 10744.623938162127, 10678.145748340114, 10680.198985076151, 10681.465926703633, 10692.358458492516, 10696.679099627023, 7908.248716371935, 8076.71731489395, 8121.390895682847, 8236.341092712688, 8238.958805206055, 5815.156802263564, 5863.0, 5914.4381283777975, 6014.188084608521, 6032.3967603239325, 9989.700308990741, 10006.8498972514, 10030.699079027641, 10046.598136074475, 10086.949565252127, 9899.109080182818, 10069.345492542961, 10180.49097545105, 10232.283740138417, 10297.07326340633, 6871.690773915086, 7101.715931362688, 7197.280271972761, 7435.776926692208, 7893.960530197542, 8125.3905957052275, 8223.753287401387, 8329.29201017896, 8340.87488687658, 8349.874751878848, 7289.635518223961, 7393.778186654409, 7416.851662966818, 7417.406607471282, 7420.777376678492, 7148.964255178691, 7218.242084581043, 7261.745838895613, 7286.1985181631035, 7382.298681625237, 6866.0, 6910.723571057101, 6987.510874238755, 6998.720051197895, 7000.089988301488, 4308.37528558351, 4452.799624016862, 4848.0, 4868.269759536098, 5054.09026375256, 4014.6988975826343, 4901.656884018084, 4998.825041123543, 5073.492650734897, 5169.896602068013], "value": 4486.233810152182, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.2224360956247, 300.0563228645908, 305.1714594874914, 306.8189768036859, 307.8214635511403, 4415.492218394886, 4663.790129444174, 5072.923906141411, 5191.896162076756, 5331.0, 4547.340635607843, 4548.79530421131, 4853.660243782937, 5116.309298244736, 5178.420581722573, 4036.0515278909434, 4036.275514028034, 4071.1857628474277, 4091.1817636472824, 4112.383142528614, 3624.112092537332, 3951.3206887073025, 4049.5950404959417, 4077.408775727518, 4096.918061638766, 3829.425586162084, 4029.501708940461, 4035.3139966205667, 4042.4744783178144, 4113.609207125318, 4047.271491131595, 4050.7569545827346, 4067.877963661095, 4087.202995415895, 4105.302098643223, 3548.8935331940083, 3571.892713258872, 3574.5889222739456, 3576.5886923003927, 3589.6769290763955, 4389.582989615981, 4830.830920917786, 5176.663516871391, 5235.356145146715, 5251.894962100775, 3701.68535674468, 3872.0446174681606, 4081.8571350002903, 4247.8300867965245, 4376.365427013097, 5125.615578831603, 5272.841814745525, 5506.972465137689, 5662.0, 5666.121751128581, 3148.181472817084, 3410.6077801052948, 3484.529588505545, 3909.4722212501233, 3909.8045097745, 4664.906701865943, 4880.511948805127, 5200.505951934598, 5630.071038278679, 5856.150858125633, 3604.6575575320303, 3945.743526670757, 3976.9602303977167, 3990.920181596352, 3991.1818077294665, 3759.793211373346, 3999.080211551301, 4037.152198038386, 4064.902476331374, 4072.5112986441222, 3894.7926142895794, 4494.5730155635165, 4597.08058388317, 4639.953600463952, 4707.0, 4707.411573553306, 5599.972000139973, 5601.663900166003, 5656.632318899341, 5676.735876870815, 1275.0819410024767, 1370.6915943912738, 1387.3826147364325, 1388.194846988744, 1388.7430825297351, 676.539952832069, 776.7320274505287, 805.3315747929205, 813.8535063688593, 914.264017465933, 4367.27939889921, 4842.297866809293, 5079.034983353151, 5170.689758614495, 5209.296744939385, 4952.727599981963, 5631.873625274961, 5637.802676906371, 5660.603757736919, 5674.290713660793, 4965.602751779849, 5101.566366858784, 5206.661566998133, 5246.7638956247065, 5294.808668049735, 2789.9442011159663, 3012.4335345620157, 3032.3625242369317, 3033.4084853453364, 3052.435299469605, 5165.974170129125, 5780.393058728857, 5896.9655468863175, 6066.696665166724, 6072.39276072398, 5237.857285628593, 5945.7109013030295, 5965.075413310944, 5984.371640977722, 6001.819945401645, 6030.62285120334, 6033.5173186145, 6035.314285143157, 6049.516038716804, 6056.0317896683755, 5014.724190169576, 5423.430539793265, 5740.560261888597, 5794.362620111869, 5795.333536643171, 4753.1444340019125, 5393.7033463159905, 5676.679142701566, 5692.288463942007, 5712.34308054579, 5212.452692467236, 5679.5172410345585, 5707.543396528351, 5962.791302304398, 5991.921454138297, 3204.8077115373153, 3744.457053727249, 3781.2248489059125, 3822.6941844651806, 3825.693944484379, 5302.469753024821, 5763.567732420169, 5777.306723193244, 5782.5373970081455, 5782.739776710142, 4444.511103778646, 5210.739463026909, 5574.9442505574425, 5595.5803314752375, 5609.074502707008, 4634.420697412824, 5393.568514518751, 5605.990921634145, 5663.801766938137, 5669.31968163823, 4370.737755734666, 4660.883477913079, 5545.778168873361, 5545.916811247754, 5582.888342233214, 5522.100897029092, 5587.469190426903, 5661.264035675335, 5697.515711164598, 5730.770769169353, 4566.990524169355, 5548.195511650869, 5554.389017208185, 5571.526420254324, 5586.525145362527], "value": 4057.654331670831, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.7081996381484, 732.4726197138059, 765.992340076599, 810.7324582887641, 814.1573471457041, 15641.843581564195, 16234.431794887181, 16256.268467918942, 16300.347986080573, 16303.592410189736, 14230.0, 14321.785173222384, 14332.928335358334, 14350.641233969156, 14734.18961957092, 666.9833254168636, 688.5386790850142, 842.1914961636805, 843.4854738609444, 866.9003064647583, 855.448235887852, 859.6475445067524, 861.4745005546612, 861.6984055580529, 867.8611422172454, 914.5701520285488, 914.9176574108329, 914.9817003659923, 914.9908500915005, 919.5034681272105, 699.3950233048428, 897.1253028297423, 913.7578541686426, 920.0845159066738, 933.2953620016912, 695.5513693667607, 695.8086526205284, 698.8392669686001, 699.2832346844525, 700.4991431126768, 14859.182744949023, 14908.925455372762, 14908.95637305389, 14921.701565968728, 14931.701365972729, 14062.0, 14238.572842814732, 14301.356438960272, 14338.068025578305, 14368.928155359261, 12959.28723920184, 12976.286304253263, 13161.868381316255, 13311.334433278298, 13715.862841371558, 4519.548045195487, 4582.770861456914, 4625.930611040837, 4658.34783130362, 4679.812807487697, 119693.0, 123980.0, 124181.37909310395, 124411.0, 124455.0, 11122.61070862516, 11218.102551795837, 11398.544058237578, 11583.362915039585, 11822.940885295518, 17278.913605432143, 23038.884805575864, 23059.0, 23069.88465057664, 23254.5582713816, 7857.410694197843, 7910.683572657029, 7920.0, 7990.12108668046, 8161.714339998071, 4292.12011537634, 4324.308110702273, 4343.153085148366, 4501.18978583858, 4613.446386433649, 3495.2310491691787, 3638.1632224588493, 3641.5266015417824, 3642.763220390666, 3645.3438381091128, 630.8328293002359, 650.7527139686983, 651.9869602607921, 653.6796969485014, 654.9181352330959, 491.43484992258476, 583.4690431707211, 603.5202014398476, 635.1584150999944, 648.8864448721455, 8000.0, 8465.280451161598, 8825.205731484197, 8897.199252067345, 8964.820703585892, 471.1613328275675, 550.3395924890068, 618.3908849782961, 633.3603060908515, 674.9493787965922, 4196.307609244441, 4388.802503887333, 4453.51011388747, 4494.438195225597, 4523.525029871882, 88119.67820482698, 111265.0, 139347.0, 145974.02337696243, 147695.0, 117508.0, 119617.40191299161, 120581.39709301398, 122288.0, 125091.37454312852, 97675.0, 101995.0, 105187.0, 105478.47260763648, 108094.91905081006, 7116.644167791486, 8673.609687564202, 8759.343049271203, 8839.116088391109, 8880.86678699807, 42784.71645850629, 53046.93906121779, 53792.46207538031, 56010.0, 57058.42941570531, 71275.0, 81234.59382703049, 85807.14192857992, 88290.1170988282, 90269.54865225632, 11459.885401146215, 11506.76986460283, 11562.248453850472, 11653.76692466163, 12205.633830985085, 12697.492100316253, 12755.234685918875, 13252.536161234311, 14618.853811462175, 15395.76906346428, 13828.624786426766, 13920.234387108807, 13960.511382101578, 14459.710805784036, 14665.780013300022, 14007.08953917992, 14027.929860351041, 14091.577252682437, 14278.643033924234, 14290.0, 11016.339019658526, 13418.261995590336, 13633.0, 13780.379882905092, 13847.446102155802, 11126.944365278121, 11457.770844582896, 11612.0, 11912.0, 12093.455794489446, 10642.89357106419, 11109.00018998294, 11267.323960562393, 11542.19204655666, 11701.356425396685], "value": 7735.387226088527, "unit": "score"}], "name": "dromaeo_css", "value": 7278.887727486906, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 93.0, 148.0, 166.0, 166.0, 112.0, 110.0, 115.0, 157.0, 114.0], "value": 129.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 139.0, 196.0, 139.0, 128.0, 129.0, 108.0, 171.0, 106.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 182.0, 181.0, 189.0, 181.0, 182.0, 181.0, 177.0, 182.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 75.0, 149.0, 59.0, 58.0, 60.0, 67.0, 140.0, 57.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 133.0, 71.0, 70.0, 76.0, 119.0, 69.0, 69.0, 118.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 83.0, 86.0, 84.0, 85.0, 83.0, 85.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 92.0, 92.0, 93.0, 92.0, 92.0, 94.0], "value": 92.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 87.0, 86.0, 91.0, 127.0, 83.0, 84.0, 87.0], "value": 90.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 73.0, 77.0, 75.0, 72.0, 70.0, 71.0, 71.0, 72.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 84.0, 98.0, 107.0, 86.0, 86.0, 86.0, 86.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 137.0, 138.0, 137.0, 138.0, 137.0, 133.0, 178.0, 141.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 173.0, 169.0, 168.0, 170.0, 167.0, 170.0, 168.0, 167.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 68.0, 67.0, 67.0, 70.0, 66.0, 66.0, 67.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1479.2, "alertThreshold": 2.0}]} 13:54:54 INFO - Return code: 0 13:54:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:54:54 INFO - # TBPL SUCCESS # 13:54:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:54:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:54:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:54:54 INFO - 2016-08-27 13:54:54.494 screenresolution[1673:13145] starting screenresolution argv=screenresolution get 13:54:54 INFO - 2016-08-27 13:54:54.496 screenresolution[1673:13145] Display 0: 1600x1200x32@60 13:54:54 INFO - 2016-08-27 13:54:54.502 screenresolution[1674:13148] starting screenresolution argv=screenresolution list 13:54:54 INFO - Available Modes on Display 0 13:54:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:54:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:54:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:54:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:54:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:54:54 INFO - Intel Iris: 13:54:54 INFO - Chipset Model: Intel Iris 13:54:54 INFO - Type: GPU 13:54:54 INFO - Bus: Built-In 13:54:54 INFO - VRAM (Dynamic, Max): 1536 MB 13:54:54 INFO - Vendor: Intel (0x8086) 13:54:54 INFO - Device ID: 0x0a2e 13:54:54 INFO - Revision ID: 0x0009 13:54:54 INFO - Displays: 13:54:54 INFO - Display: 13:54:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:54:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:54:54 INFO - Display Serial Number: 1600x1200 60 13:54:54 INFO - Main Display: Yes 13:54:54 INFO - Mirror: Off 13:54:54 INFO - Online: Yes 13:54:54 INFO - Rotation: Supported 13:54:54 INFO - Return code: 0 13:54:54 INFO - Running post-action listener: _resource_record_post_action 13:54:54 INFO - [mozharness: 2016-08-27 20:54:54.744854Z] Finished run-tests step (success) 13:54:54 INFO - Running post-run listener: _resource_record_post_run 13:54:54 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 31882240; Write bytes: 706547200; Read time: 193; Write time: 1973 13:54:54 INFO - TinderboxPrint: CPU usage
53.4% 13:54:54 INFO - TinderboxPrint: I/O read bytes / time
31,882,240 / 193 13:54:54 INFO - TinderboxPrint: I/O write bytes / time
706,547,200 / 1,973 13:54:54 INFO - TinderboxPrint: CPU idle
2,256.1 (46.6%) 13:54:54 INFO - TinderboxPrint: CPU system
964.2 (19.9%) 13:54:54 INFO - TinderboxPrint: CPU user
1,625.3 (33.5%) 13:54:54 INFO - TinderboxPrint: Swap in / out
433,643,520 / 0 13:54:54 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 405049856; Write bytes: 398800384; Read time: 29760; Write time: 821 13:54:54 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 29162496; Write bytes: 295143424; Read time: 171; Write time: 1112 13:54:55 INFO - Running post-run listener: _upload_blobber_files 13:54:55 INFO - Blob upload gear active. 13:54:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:54:55 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 13:54:55 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:54:55 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:54:55 INFO - Traceback (most recent call last): 13:54:55 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 13:54:55 INFO - main() 13:54:55 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 13:54:55 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 13:54:55 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 13:54:55 INFO - return set(response.json().get('whitelist', [])) 13:54:55 INFO - File "/builds/slave/test/build/venv/lib/python2.7/site-packages/requests/models.py", line 651, in json 13:54:55 INFO - return json.loads(self.text or self.content, **kwargs) 13:54:55 INFO - File "/tools/python27/lib/python2.7/json/__init__.py", line 326, in loads 13:54:55 INFO - return _default_decoder.decode(s) 13:54:55 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 366, in decode 13:54:55 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 13:54:55 INFO - File "/tools/python27/lib/python2.7/json/decoder.py", line 384, in raw_decode 13:54:55 INFO - raise ValueError("No JSON object could be decoded") 13:54:55 INFO - ValueError: No JSON object could be decoded 13:54:55 ERROR - Return code: 1 13:54:55 INFO - Setting buildbot property blobber_files to {} 13:54:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:54:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:54:55 INFO - Contents: 13:54:55 INFO - blobber_files:{} 13:54:55 INFO - Running post-run listener: copy_logs_to_upload_dir 13:54:55 INFO - Copying logs to upload dir... 13:54:55 INFO - mkdir: /builds/slave/test/build/upload/logs 13:54:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.664147 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-08-27 13:54:55.695485) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 13:54:55.699444) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9KjGnPdsV5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/Il47hrIsTGqoOrjs1XO8Pg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 13:54:55.733267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 13:54:55.733625) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9KjGnPdsV5/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.FOhCdYhFed/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005197 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 13:54:55.781909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 13:54:55.782245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 13:54:55.782579) ========= ========= Total master_lag: 0.17 =========