builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0219 starttime: 1471366682.81 results: success (0) buildid: 20160816084717 builduid: d2069b27b44848c7841e95d115c838fa revision: c03162882f8158363e769dec7605c65662b773e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:02.809103) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:02.809516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:02.809807) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:02.837920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:02.838309) ========= 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.ijCS41V5MA/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.jFZW9buryK/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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-16 09:58:02-- 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% 65.0M=0s 2016-08-16 09:58:02 (65.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:02.969245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:02.969594) ========= 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.ijCS41V5MA/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.jFZW9buryK/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.025875 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:03.018547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 09:58:03.018955) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c03162882f8158363e769dec7605c65662b773e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev c03162882f8158363e769dec7605c65662b773e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ijCS41V5MA/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.jFZW9buryK/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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-16 09:58:03,105 truncating revision to first 12 chars 2016-08-16 09:58:03,105 Setting DEBUG logging. 2016-08-16 09:58:03,105 attempt 1/10 2016-08-16 09:58:03,105 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c03162882f81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 09:58:04,615 unpacking tar archive at: autoland-c03162882f81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.799363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 09:58:04.840923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:04.841260) ========= script_repo_revision: c03162882f8158363e769dec7605c65662b773e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:04.841705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:04.841980) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 09:58:04.860076) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-16 09:58:04.860396) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ijCS41V5MA/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.jFZW9buryK/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:05 INFO - MultiFileLogger online at 20160816 09:58:05 in /builds/slave/test 09:58:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 09:58:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:05 INFO - {'append_to_log': False, 09:58:05 INFO - 'base_work_dir': '/builds/slave/test', 09:58:05 INFO - 'blob_upload_branch': 'Autoland', 09:58:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:05 INFO - 'branch': 'Autoland', 09:58:05 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:05 INFO - 'config_files': ('talos/mac_config.py',), 09:58:05 INFO - 'default_actions': ('clobber', 09:58:05 INFO - 'read-buildbot-config', 09:58:05 INFO - 'download-and-extract', 09:58:05 INFO - 'populate-webroot', 09:58:05 INFO - 'create-virtualenv', 09:58:05 INFO - 'install', 09:58:05 INFO - 'run-tests'), 09:58:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:05 INFO - 'download_minidump_stackwalk': True, 09:58:05 INFO - 'download_symbols': 'ondemand', 09:58:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:05 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:05 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:05 INFO - 'installer_path': 'installer.exe', 09:58:05 INFO - 'log_level': 'info', 09:58:05 INFO - 'log_name': 'talos', 09:58:05 INFO - 'log_to_console': True, 09:58:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:58:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:58:05 INFO - 'opt_config_files': (), 09:58:05 INFO - 'pip_index': False, 09:58:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:58:05 INFO - 'cmd': ('bash', 09:58:05 INFO - '-c', 09:58:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:58:05 INFO - 'enabled': True, 09:58:05 INFO - 'halt_on_failure': False, 09:58:05 INFO - 'name': 'check_screen_resolution'},), 09:58:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:58:05 INFO - 'cmd': ('bash', 09:58:05 INFO - '-c', 09:58:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:58:05 INFO - 'enabled': True, 09:58:05 INFO - 'halt_on_failure': False, 09:58:05 INFO - 'name': 'check_screen_resolution'},), 09:58:05 INFO - 'run_cmd_checks_enabled': True, 09:58:05 INFO - 'sps_profile': False, 09:58:05 INFO - 'sps_profile_interval': 0, 09:58:05 INFO - 'suite': 'dromaeojs-e10s', 09:58:05 INFO - 'system_bits': '32', 09:58:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:05 INFO - 'title': 't-yosemite-r7-0219', 09:58:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:05 INFO - 'use_talos_json': True, 09:58:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:05 INFO - 'work_dir': 'build'} 09:58:05 INFO - [mozharness: 2016-08-16 16:58:05.059293Z] Running clobber step. 09:58:05 INFO - Running pre-action listener: _resource_record_pre_action 09:58:05 INFO - Running main action method: clobber 09:58:05 INFO - rmtree: /builds/slave/test/build 09:58:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:58:07 INFO - Running post-action listener: _resource_record_post_action 09:58:07 INFO - [mozharness: 2016-08-16 16:58:07.366245Z] Finished clobber step (success) 09:58:07 INFO - [mozharness: 2016-08-16 16:58:07.366387Z] Running read-buildbot-config step. 09:58:07 INFO - Running pre-action listener: _resource_record_pre_action 09:58:07 INFO - Running main action method: read_buildbot_config 09:58:07 INFO - Using buildbot properties: 09:58:07 INFO - { 09:58:07 INFO - "project": "", 09:58:07 INFO - "product": "firefox", 09:58:07 INFO - "script_repo_revision": "production", 09:58:07 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 09:58:07 INFO - "repository": "", 09:58:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 09:58:07 INFO - "buildid": "20160816084717", 09:58:07 INFO - "pgo_build": "False", 09:58:07 INFO - "basedir": "/builds/slave/test", 09:58:07 INFO - "buildnumber": 126, 09:58:07 INFO - "slavename": "t-yosemite-r7-0219", 09:58:07 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:58:07 INFO - "platform": "yosemite_r7", 09:58:07 INFO - "scheduler": "tests-autoland-macosx64-talos", 09:58:07 INFO - "branch": "autoland", 09:58:07 INFO - "repo_path": "integration/autoland", 09:58:07 INFO - "revision": "c03162882f8158363e769dec7605c65662b773e8", 09:58:07 INFO - "stage_platform": "macosx64", 09:58:07 INFO - "builduid": "d2069b27b44848c7841e95d115c838fa", 09:58:07 INFO - "slavebuilddir": "test" 09:58:07 INFO - } 09:58:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 09:58:07 INFO - Running post-action listener: _resource_record_post_action 09:58:07 INFO - [mozharness: 2016-08-16 16:58:07.369628Z] Finished read-buildbot-config step (success) 09:58:07 INFO - [mozharness: 2016-08-16 16:58:07.369749Z] Running download-and-extract step. 09:58:07 INFO - Running pre-action listener: _resource_record_pre_action 09:58:07 INFO - Running main action method: download_and_extract 09:58:07 INFO - mkdir: /builds/slave/test/build/tests 09:58: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')]} 09:58:07 INFO - trying https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 09:58:07 INFO - Downloading https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:08 INFO - Downloaded 1199 bytes. 09:58:08 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 09:58:08 INFO - Using the following test package requirements: 09:58:08 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:58:08 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:58:08 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 09:58:08 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:58:08 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 09:58:08 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:58:08 INFO - u'jsshell-mac.zip'], 09:58:08 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:58:08 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 09:58:08 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 09:58:08 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:58:08 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 09:58:08 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:58:08 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 09:58:08 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:58:08 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 09:58:08 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 09:58:08 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 09:58:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:58: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')]} 09:58:08 INFO - trying https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:58:08 INFO - Downloading https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:09 INFO - Downloaded 16333585 bytes. 09:58:09 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:58:16 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 09:58: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')]} 09:58:16 INFO - trying https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 09:58:16 INFO - Downloading https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:17 INFO - Downloaded 16333585 bytes. 09:58:17 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 09:58:23 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')]} 09:58:23 INFO - trying https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 09:58:23 INFO - Downloading https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:24 INFO - Downloaded 14413719 bytes. 09:58:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 09:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:25 INFO - trying https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:58:25 INFO - Downloading https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 09:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/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 09:58:27 INFO - Downloaded 111041683 bytes. 09:58:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:58:27 INFO - mkdir: /builds/slave/test/properties 09:58:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:27 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:27 INFO - Contents: 09:58:27 INFO - build_url:https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 09:58:28 INFO - Running post-action listener: _resource_record_post_action 09:58:28 INFO - Running post-action listener: set_extra_try_arguments 09:58:28 INFO - [mozharness: 2016-08-16 16:58:28.700580Z] Finished download-and-extract step (success) 09:58:28 INFO - [mozharness: 2016-08-16 16:58:28.700683Z] Running populate-webroot step. 09:58:28 INFO - Running pre-action listener: _resource_record_pre_action 09:58:28 INFO - Running main action method: populate_webroot 09:58:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:28 INFO - '--tppagecycles', 09:58:28 INFO - '7'], 09:58:28 INFO - 'tests': ['tsvgm']}}, 09:58:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['damp', 'tps']}, 09:58:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'tests': ['damp', 'tps']}, 09:58:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['dromaeo_dom']}, 09:58:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['basic_compositor_video']}, 09:58:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:58:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['a11yr', 09:58:28 INFO - 'ts_paint', 09:58:28 INFO - 'tpaint', 09:58:28 INFO - 'sessionrestore', 09:58:28 INFO - 'sessionrestore_no_auto_restore', 09:58:28 INFO - 'tabpaint']}, 09:58:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['tsvgx', 09:58:28 INFO - 'tsvgr_opacity', 09:58:28 INFO - 'tart', 09:58:28 INFO - 'tscrollx', 09:58:28 INFO - 'cart']}, 09:58:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:28 INFO - 'tsvgr_opacity', 09:58:28 INFO - 'tart', 09:58:28 INFO - 'tscrollx', 09:58:28 INFO - 'cart']}, 09:58:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--disable-e10s'], 09:58:28 INFO - 'tests': ['tp5o']}, 09:58:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'tests': ['tp5o']}, 09:58:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--disable-e10s', 09:58:28 INFO - '--xperf_path', 09:58:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:28 INFO - 'tests': ['tp5n']}, 09:58:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:28 INFO - 'talos_options': ['--xperf_path', 09:58:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:28 INFO - 'tests': ['tp5n']}}, 09:58:28 INFO - 'talos.zip': {'path': '', 09:58:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:28 INFO - Running post-action listener: _resource_record_post_action 09:58:28 INFO - [mozharness: 2016-08-16 16:58:28.718947Z] Finished populate-webroot step (success) 09:58:28 INFO - [mozharness: 2016-08-16 16:58:28.719088Z] Running create-virtualenv step. 09:58:28 INFO - Running pre-action listener: _resource_record_pre_action 09:58:28 INFO - Running main action method: create_virtualenv 09:58:28 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:28 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 09:58:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:28 INFO - Using real prefix '/tools/python27' 09:58:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:32 INFO - Installing pip.................done. 09:58:32 INFO - Return code: 0 09:58:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:32 INFO - 'HOME': '/Users/cltbld', 09:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:32 INFO - 'LOGNAME': 'cltbld', 09:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:32 INFO - 'MOZ_NO_REMOTE': '1', 09:58:32 INFO - 'NO_EM_RESTART': '1', 09:58:32 INFO - 'PAGER': '/bin/cat', 09:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:32 INFO - 'PWD': '/builds/slave/test', 09:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:32 INFO - 'SHELL': '/bin/bash', 09:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:32 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:32 INFO - 'USER': 'cltbld', 09:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:32 INFO - 'XPC_FLAGS': '0x0', 09:58:32 INFO - 'XPC_SERVICE_NAME': '0', 09:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:32 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 09:58:32 INFO - Cleaning up... 09:58:32 INFO - Return code: 0 09:58:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:32 INFO - 'HOME': '/Users/cltbld', 09:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:32 INFO - 'LOGNAME': 'cltbld', 09:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:32 INFO - 'MOZ_NO_REMOTE': '1', 09:58:32 INFO - 'NO_EM_RESTART': '1', 09:58:32 INFO - 'PAGER': '/bin/cat', 09:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:32 INFO - 'PWD': '/builds/slave/test', 09:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:32 INFO - 'SHELL': '/bin/bash', 09:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:32 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:32 INFO - 'USER': 'cltbld', 09:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:32 INFO - 'XPC_FLAGS': '0x0', 09:58:32 INFO - 'XPC_SERVICE_NAME': '0', 09:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:32 INFO - Downloading/unpacking psutil>=3.1.1 09:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:35 INFO - Installing collected packages: psutil 09:58:35 INFO - Running setup.py install for psutil 09:58:35 INFO - building 'psutil._psutil_osx' extension 09:58:35 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 09:58:36 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 09:58:36 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 09:58:36 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 09:58:36 INFO - building 'psutil._psutil_posix' extension 09:58:36 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 09:58:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:58:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:58:36 INFO - ^ 09:58:36 INFO - 1 warning generated. 09:58:36 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 09:58:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:36 INFO - Successfully installed psutil 09:58:36 INFO - Cleaning up... 09:58:37 INFO - Return code: 0 09:58:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:37 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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:37 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 09:58:37 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 09:58:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:37 INFO - 'HOME': '/Users/cltbld', 09:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:37 INFO - 'LOGNAME': 'cltbld', 09:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:37 INFO - 'MOZ_NO_REMOTE': '1', 09:58:37 INFO - 'NO_EM_RESTART': '1', 09:58:37 INFO - 'PAGER': '/bin/cat', 09:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:37 INFO - 'PWD': '/builds/slave/test', 09:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:37 INFO - 'SHELL': '/bin/bash', 09:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:37 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:37 INFO - 'USER': 'cltbld', 09:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:37 INFO - 'XPC_FLAGS': '0x0', 09:58:37 INFO - 'XPC_SERVICE_NAME': '0', 09:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:39 INFO - Installing collected packages: mozsystemmonitor 09:58:39 INFO - Running setup.py install for mozsystemmonitor 09:58:39 INFO - Successfully installed mozsystemmonitor 09:58:39 INFO - Cleaning up... 09:58:40 INFO - Return code: 0 09:58:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:40 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 09:58:40 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 09:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:40 INFO - 'HOME': '/Users/cltbld', 09:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:40 INFO - 'LOGNAME': 'cltbld', 09:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:40 INFO - 'MOZ_NO_REMOTE': '1', 09:58:40 INFO - 'NO_EM_RESTART': '1', 09:58:40 INFO - 'PAGER': '/bin/cat', 09:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:40 INFO - 'PWD': '/builds/slave/test', 09:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:40 INFO - 'SHELL': '/bin/bash', 09:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:40 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:40 INFO - 'USER': 'cltbld', 09:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:40 INFO - 'XPC_FLAGS': '0x0', 09:58:40 INFO - 'XPC_SERVICE_NAME': '0', 09:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:40 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:40 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 09:58:40 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 09:58:40 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 09:58:40 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 09:58:40 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 09:58:40 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 09:58:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:42 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 09:58:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:43 INFO - warning: no files found matching '*.txt' 09:58:43 INFO - no previously-included directories found matching 'build' 09:58:43 INFO - no previously-included directories found matching 'dist' 09:58:43 INFO - no previously-included directories found matching '.git*' 09:58:43 INFO - Installing collected packages: jsonschema, functools32 09:58:43 INFO - Running setup.py install for functools32 09:58:43 INFO - warning: no files found matching '*.txt' 09:58:43 INFO - no previously-included directories found matching 'build' 09:58:43 INFO - no previously-included directories found matching 'dist' 09:58:43 INFO - no previously-included directories found matching '.git*' 09:58:43 INFO - Successfully installed jsonschema functools32 09:58:43 INFO - Cleaning up... 09:58:43 INFO - Return code: 0 09:58:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:43 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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:43 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 09:58:43 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 09:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:43 INFO - 'HOME': '/Users/cltbld', 09:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:43 INFO - 'LOGNAME': 'cltbld', 09:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:43 INFO - 'MOZ_NO_REMOTE': '1', 09:58:43 INFO - 'NO_EM_RESTART': '1', 09:58:43 INFO - 'PAGER': '/bin/cat', 09:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:43 INFO - 'PWD': '/builds/slave/test', 09:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:43 INFO - 'SHELL': '/bin/bash', 09:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:43 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:43 INFO - 'USER': 'cltbld', 09:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:43 INFO - 'XPC_FLAGS': '0x0', 09:58:43 INFO - 'XPC_SERVICE_NAME': '0', 09:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:58:43 INFO - Cleaning up... 09:58:43 INFO - Return code: 0 09:58:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:43 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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:43 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 09:58:43 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 09:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:43 INFO - 'HOME': '/Users/cltbld', 09:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:43 INFO - 'LOGNAME': 'cltbld', 09:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:43 INFO - 'MOZ_NO_REMOTE': '1', 09:58:43 INFO - 'NO_EM_RESTART': '1', 09:58:43 INFO - 'PAGER': '/bin/cat', 09:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:43 INFO - 'PWD': '/builds/slave/test', 09:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:43 INFO - 'SHELL': '/bin/bash', 09:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:43 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:43 INFO - 'USER': 'cltbld', 09:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:43 INFO - 'XPC_FLAGS': '0x0', 09:58:43 INFO - 'XPC_SERVICE_NAME': '0', 09:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:44 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 09:58:44 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 09:58:44 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 09:58:44 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 09:58:44 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 09:58:44 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 09:58:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:46 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 09:58:46 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 09:58:46 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 09:58:46 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 09:58:46 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 09:58:46 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 09:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 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 09:58:47 INFO - Downloading docopt-0.6.1.tar.gz 09:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:47 INFO - Running setup.py install for blobuploader 09:58:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:48 INFO - Running setup.py install for requests 09:58:48 INFO - Running setup.py install for docopt 09:58:48 INFO - Successfully installed blobuploader requests docopt 09:58:48 INFO - Cleaning up... 09:58:48 INFO - Return code: 0 09:58:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:48 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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:48 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 09:58:48 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 09:58:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:48 INFO - 'HOME': '/Users/cltbld', 09:58:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:48 INFO - 'LOGNAME': 'cltbld', 09:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:48 INFO - 'MOZ_NO_REMOTE': '1', 09:58:48 INFO - 'NO_EM_RESTART': '1', 09:58:48 INFO - 'PAGER': '/bin/cat', 09:58:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:48 INFO - 'PWD': '/builds/slave/test', 09:58:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:48 INFO - 'SHELL': '/bin/bash', 09:58:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:48 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:48 INFO - 'USER': 'cltbld', 09:58:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:48 INFO - 'XPC_FLAGS': '0x0', 09:58:48 INFO - 'XPC_SERVICE_NAME': '0', 09:58:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-qVyxtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-DmYRyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-2onyGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-k_hzxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-cVtC9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-W2wBnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-SW9Y4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-EwvUyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-tP3rJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-e7h4WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-cupQrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-0JG5vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-0fJW6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-M6X1C7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-nVfRUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-WRMUOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-qnkpgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:50 INFO - Running setup.py install for manifestparser 09:58:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:50 INFO - Running setup.py install for mozcrash 09:58:51 INFO - Running setup.py install for mozdebug 09:58:51 INFO - Running setup.py install for mozdevice 09:58:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozfile 09:58:51 INFO - Running setup.py install for mozhttpd 09:58:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozinfo 09:58:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozInstall 09:58:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:51 INFO - Running setup.py install for mozleak 09:58:52 INFO - Running setup.py install for mozlog 09:58:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:52 INFO - Running setup.py install for moznetwork 09:58:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:52 INFO - Running setup.py install for mozprocess 09:58:52 INFO - Running setup.py install for mozprofile 09:58:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:52 INFO - Running setup.py install for mozrunner 09:58:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:52 INFO - Running setup.py install for mozscreenshot 09:58:53 INFO - Running setup.py install for moztest 09:58:53 INFO - Running setup.py install for mozversion 09:58:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:53 INFO - Cleaning up... 09:58:53 INFO - Return code: 0 09:58:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:53 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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:53 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 09:58:53 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 09:58:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:53 INFO - 'HOME': '/Users/cltbld', 09:58:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:53 INFO - 'LOGNAME': 'cltbld', 09:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:53 INFO - 'MOZ_NO_REMOTE': '1', 09:58:53 INFO - 'NO_EM_RESTART': '1', 09:58:53 INFO - 'PAGER': '/bin/cat', 09:58:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:53 INFO - 'PWD': '/builds/slave/test', 09:58:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:53 INFO - 'SHELL': '/bin/bash', 09:58:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:53 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:53 INFO - 'USER': 'cltbld', 09:58:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:53 INFO - 'XPC_FLAGS': '0x0', 09:58:53 INFO - 'XPC_SERVICE_NAME': '0', 09:58:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-QmB_wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:53 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)) 09:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-a7BLvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:53 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)) 09:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-__0sql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:53 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)) 09:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:53 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-MDECqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-UevW85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-hwylwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-qZFM3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-MvCCLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-85NgDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-8B5nBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-aCJAZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-9C8Qvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:54 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)) 09:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Kyyh8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:55 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)) 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-yCQE6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:55 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)) 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-JaeXd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:55 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)) 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-ceW9GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:55 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)) 09:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-tCOUwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 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)) 09:58:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:57 INFO - Downloading blessings-1.6.tar.gz 09:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:57 INFO - Installing collected packages: blessings 09:58:57 INFO - Running setup.py install for blessings 09:58:58 INFO - Successfully installed blessings 09:58:58 INFO - Cleaning up... 09:58:58 INFO - Return code: 0 09:58:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:58 INFO - Reading from file tmpfile_stdout 09:58:58 INFO - Current package versions: 09:58:58 INFO - blessings == 1.6 09:58:58 INFO - blobuploader == 1.2.4 09:58:58 INFO - docopt == 0.6.1 09:58:58 INFO - functools32 == 3.2.3-2 09:58:58 INFO - jsonschema == 2.5.1 09:58:58 INFO - manifestparser == 1.1 09:58:58 INFO - mozInstall == 1.12 09:58:58 INFO - mozcrash == 0.17 09:58:58 INFO - mozdebug == 0.1 09:58:58 INFO - mozdevice == 0.48 09:58:58 INFO - mozfile == 1.2 09:58:58 INFO - mozhttpd == 0.7 09:58:58 INFO - mozinfo == 0.9 09:58:58 INFO - mozleak == 0.1 09:58:58 INFO - mozlog == 3.3 09:58:58 INFO - moznetwork == 0.27 09:58:58 INFO - mozprocess == 0.23 09:58:58 INFO - mozprofile == 0.28 09:58:58 INFO - mozrunner == 6.12 09:58:58 INFO - mozscreenshot == 0.1 09:58:58 INFO - mozsystemmonitor == 0.3 09:58:58 INFO - moztest == 0.7 09:58:58 INFO - mozversion == 1.4 09:58:58 INFO - psutil == 3.1.1 09:58:58 INFO - requests == 1.2.3 09:58:58 INFO - wsgiref == 0.1.2 09:58:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:58 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')]} 09:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:58 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')]} 09:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:58 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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:58 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 09:58:58 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 09:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:58 INFO - 'HOME': '/Users/cltbld', 09:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:58 INFO - 'LOGNAME': 'cltbld', 09:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:58 INFO - 'MOZ_NO_REMOTE': '1', 09:58:58 INFO - 'NO_EM_RESTART': '1', 09:58:58 INFO - 'PAGER': '/bin/cat', 09:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:58 INFO - 'PWD': '/builds/slave/test', 09:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:58 INFO - 'SHELL': '/bin/bash', 09:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:58 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:58 INFO - 'USER': 'cltbld', 09:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:58 INFO - 'XPC_FLAGS': '0x0', 09:58:58 INFO - 'XPC_SERVICE_NAME': '0', 09:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 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)) 09:58:59 INFO - Cleaning up... 09:58:59 INFO - Return code: 0 09:58:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:59 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 0x106a05a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a9a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae114cd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, '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.ijCS41V5MA/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.jFZW9buryK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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 09:58:59 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 09:58:59 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 09:58:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:58:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:59 INFO - 'HOME': '/Users/cltbld', 09:58:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:59 INFO - 'LOGNAME': 'cltbld', 09:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:59 INFO - 'MOZ_NO_REMOTE': '1', 09:58:59 INFO - 'NO_EM_RESTART': '1', 09:58:59 INFO - 'PAGER': '/bin/cat', 09:58:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:59 INFO - 'PWD': '/builds/slave/test', 09:58:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:59 INFO - 'SHELL': '/bin/bash', 09:58:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:58:59 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:58:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:59 INFO - 'USER': 'cltbld', 09:58:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:59 INFO - 'XPC_FLAGS': '0x0', 09:58:59 INFO - 'XPC_SERVICE_NAME': '0', 09:58:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:59 INFO - Cleaning up... 09:58:59 INFO - Return code: 0 09:58:59 INFO - Running post-action listener: _resource_record_post_action 09:58:59 INFO - Running post-action listener: _start_resource_monitoring 09:58:59 INFO - Starting resource monitoring. 09:58:59 INFO - [mozharness: 2016-08-16 16:58:59.381692Z] Finished create-virtualenv step (success) 09:58:59 INFO - [mozharness: 2016-08-16 16:58:59.382658Z] Running install step. 09:58:59 INFO - Running pre-action listener: _resource_record_pre_action 09:58:59 INFO - Running main action method: install 09:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:59 INFO - Reading from file tmpfile_stdout 09:58:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:59 INFO - Reading from file tmpfile_stdout 09:58:59 INFO - Output received: 09:58:59 INFO - Usage: mozinstall [options] installer 09:58:59 INFO - Options: 09:58:59 INFO - -h, --help show this help message and exit 09:58:59 INFO - -d DEST, --destination=DEST 09:58:59 INFO - Directory to install application into. [default: 09:58:59 INFO - "/builds/slave/test"] 09:58:59 INFO - --app=APP Application being installed. [default: firefox] 09:58:59 INFO - mkdir: /builds/slave/test/build/application 09:58:59 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'] 09:58:59 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 09:59:34 INFO - Reading from file tmpfile_stdout 09:59:34 INFO - Output received: 09:59:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:59:34 INFO - Running post-action listener: _resource_record_post_action 09:59:34 INFO - [mozharness: 2016-08-16 16:59:34.407396Z] Finished install step (success) 09:59:34 INFO - [mozharness: 2016-08-16 16:59:34.407554Z] Running run-tests step. 09:59:34 INFO - Running pre-action listener: _resource_record_pre_action 09:59:34 INFO - Running main action method: run_tests 09:59:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:59:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:59:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:59:34 INFO - 2016-08-16 09:59:34.421 screenresolution[1637:7332] starting screenresolution argv=screenresolution get 09:59:34 INFO - 2016-08-16 09:59:34.424 screenresolution[1637:7332] Display 0: 1600x1200x32@60 09:59:34 INFO - 2016-08-16 09:59:34.430 screenresolution[1638:7336] starting screenresolution argv=screenresolution list 09:59:34 INFO - Available Modes on Display 0 09:59:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:59:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:59:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:59:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:59:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:59:34 INFO - Intel Iris: 09:59:34 INFO - Chipset Model: Intel Iris 09:59:34 INFO - Type: GPU 09:59:34 INFO - Bus: Built-In 09:59:34 INFO - VRAM (Dynamic, Max): 1536 MB 09:59:34 INFO - Vendor: Intel (0x8086) 09:59:34 INFO - Device ID: 0x0a2e 09:59:34 INFO - Revision ID: 0x0009 09:59:34 INFO - Displays: 09:59:34 INFO - Display: 09:59:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:59:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:59:34 INFO - Display Serial Number: 1600x1200 60 09:59:34 INFO - Main Display: Yes 09:59:34 INFO - Mirror: Off 09:59:34 INFO - Online: Yes 09:59:34 INFO - Rotation: Supported 09:59:34 INFO - Return code: 0 09:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:34 INFO - Python 2.7.3 09:59:34 INFO - Return code: 0 09:59:34 INFO - grabbing minidump binary from tooltool 09:59:34 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')]} 09:59:34 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 0x106969d30>, '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 0x1066cedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106961b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:34 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 09:59:34 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 09:59:34 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 09:59:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:34 INFO - Return code: 0 09:59:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:59:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:59:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0219 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:59:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ijCS41V5MA/Render', 09:59:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:34 INFO - 'HOME': '/Users/cltbld', 09:59:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:34 INFO - 'LOGNAME': 'cltbld', 09:59:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:34 INFO - 'MOZ_NO_REMOTE': '1', 09:59:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:34 INFO - 'NO_EM_RESTART': '1', 09:59:34 INFO - 'PAGER': '/bin/cat', 09:59:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:34 INFO - 'PWD': '/builds/slave/test', 09:59:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:34 INFO - 'SHELL': '/bin/bash', 09:59:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jFZW9buryK/Listeners', 09:59:34 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 09:59:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:34 INFO - 'USER': 'cltbld', 09:59:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:34 INFO - 'XPC_FLAGS': '0x0', 09:59:34 INFO - 'XPC_SERVICE_NAME': '0', 09:59:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:59:35 INFO - mozversion application_buildid: 20160816084717 09:59:35 INFO - mozversion application_changeset: c03162882f8158363e769dec7605c65662b773e8 09:59:35 INFO - mozversion application_display_name: Nightly 09:59:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:35 INFO - mozversion application_name: Firefox 09:59:35 INFO - mozversion application_remotingname: firefox 09:59:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:59:35 INFO - mozversion application_vendor: Mozilla 09:59:35 INFO - mozversion application_version: 51.0a1 09:59:35 INFO - mozversion platform_buildid: 20160816084717 09:59:35 INFO - mozversion platform_changeset: c03162882f8158363e769dec7605c65662b773e8 09:59:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:59:35 INFO - mozversion platform_version: 51.0a1 09:59:35 INFO - using testdate: 1471366775 09:59:35 INFO - actual date: 1471366775 09:59:35 INFO - starting webserver on 'localhost:49262' 09:59:35 INFO - SUITE-START | Running 2 tests 09:59:35 INFO - TEST-START | dromaeo_css 09:59:35 INFO - operating with platform_type : mac_ 09:59:35 INFO - Initialising browser for dromaeo_css test... 09:59:35 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp_xkz14/profile http://localhost:49262/getInfo.html) 09:59:38 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 09:59:38 INFO - PROCESS | 1648 | colorDepth:24 09:59:38 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 09:59:38 INFO - PROCESS | 1648 | __metrics 09:59:38 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 09:59:38 INFO - TEST-INFO | 1648: exit 0 09:59:38 INFO - Browser initialized. 09:59:38 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:38 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp_xkz14/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:51 INFO - PROCESS | 1652 | RSS: Main: 239464448 09:59:51 INFO - PROCESS | 1652 | 10:00:40 INFO - PROCESS | 1652 | 1471366840749 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:02:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 10:02:54 INFO - PROCESS | 1652 | RSS: Main: 254853120 10:02:54 INFO - PROCESS | 1652 | 10:05:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 10:05:57 INFO - PROCESS | 1652 | RSS: Main: 266608640 10:05:57 INFO - PROCESS | 1652 | 10:08:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 10:09:00 INFO - PROCESS | 1652 | RSS: Main: 271413248 10:09:00 INFO - PROCESS | 1652 | 10:12:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 10:12:02 INFO - PROCESS | 1652 | RSS: Main: 270675968 10:12:02 INFO - PROCESS | 1652 | 10:15:05 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 10:15:06 INFO - PROCESS | 1652 | RSS: Main: 277057536 10:15:06 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 10:18:08 INFO - PROCESS | 1652 | RSS: Main: 279683072 10:18:08 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | __start_tp_report 10:18:08 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:18:08 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:18:08 INFO - PROCESS | 1652 | |i|pagename|runs| 10:18:08 INFO - PROCESS | 1652 | |0;dojo.html;2566.5765148750456;3426.640202778708;3436.55324807775;3446.8448919798607;3474.2530355973468;4612.632311285595;5721.284839395075;5753.050746626806;5764.6541207527525;5781.364049954502;5720.942790572093;5784.768609255625;5814.854628634275;5847.327557330908;5873.853153671161;5233.084210263208;5331.760070796804;5334.066538355792;5377.354717433894;5420.7018613976215;5337.4662533746705;5357.973210133963;5361.98122356751;5389.299391079154;5395.946040539603;5175.741212939338;5207.6354655174155;5265.262863199156;5375.3280839895015;5401.70290634015;5292.259083728281;5296.417394086648;5297.867553311159;5301.602379821529;5323.946760532383;5184.403793563751;5192.6105542084115;5261.342332208474;5294.126469132589;5371.221172929903;5574.275344205268;5845.035569131088;5858;5887.411258874121;5948.7323070461935;6234.251889773211;6279.309275979638;6292.811215663537;6310.1796766420075;6345.42891139795;6195.101710252034;6333.461655759266;6338.492920566344;6339.0808332791485;6342.556021078526;5342.5993050521365;5558.305211848519;5963.970180149072;6008.519318454601;6066.211392518944;6373.298937116913;6429.742810287629;6443.67781610927;6455.419012288917;6456.806295811133;6126.417990290915;6196.783112591038;6210.782622608277;6251.59364641306;6270.529710271657;6190.380961903774;6231.283402408691;6233.096201050822;6236.095766113979;6299.811005669837;6226.968865155736;6277.748890044347;6297.937020629735;6328.082428047999;6335.588186767845;6145.016797312409;6269.843253918689;6291.779787707408;6306.873862522724;6328.841778955563;4304.4834619845815;4978.377702787152;5013.273075404119;5042.747862606929;5049.444561098277;4525.52481989393;4577.862664120015;4589.862304130881;4598.172328980749;4616.6075883550275;5871.089981052944;5941.465268125889;5986.012307969137;5989.071693887455;6001.4298641628975;6186.628802271878;6205.565610407228;6250.093736408196;6329.430351268408;6332.430081292706;5882.852928676817;5945.256842894638;5958.702064896738;5985.281766187998;6029.939700602938;5546.362168350692;5565.387807341189;5572.804951826666;5574.749136288877;5581;6275.592086514362;6346.524010699124;6366.681665916778;6474;6474.741010359533;6305.369463053658;6313.494920406449;6326.177596912372;6343.619382837044;6354.428101470705;5531.158562849304;5583.581231407579;5992.550558708202;6113.755449782137;6500.934990650033;6151.446369826737;6180.752769889334;6205.193324867739;6290.014713484681;6317.30509643948;6251.593646412968;6308;6324.462420694109;6336.271328797247;6336.7148478319505;6141.539384546088;6152.415520525543;6158.568900176944;6162.168107305456;6181.721822518088;6104.298005729221;6123.282621474203;6140.232470941132;6177.938220617736;6185.443310101932;5971.104334349709;5996.490298324691;6177.876442471215;6186.1339412483185;6209.5032397409;5802.622829516068;6171.981623032329;6226.46771719424;6238.438540531374;6248.343923887926;5954.46409823118;6098.878022439615;6125.84596676928;6174.9073763892675;6176.66028368444 10:18:08 INFO - PROCESS | 1652 | |1;ext.html;486.82431926896544;514.2851436503261;535.9732013399329;548.3091304955755;566.1790403914325;37682.24635507288;39760.8071757847;39895.80052099739;39925;39938.800305998426;40727.79636101823;41289.38065929006;41365;41423.58576414235;41432.58567414325;9619.615215391394;9725.367851089692;9758.170555502791;9760.609575616967;9783.119519243266;8061.919380806205;8708.564571771418;9349.626014959393;9674.661386851461;9682.225421966226;9637.22902167825;9699.127078562928;9702.9514852426;9718;9755.365901216433;9658.372205806636;9693.854592181158;9720.61117555297;9739.659111931049;9743.65897193602;9483.620655173785;9569.473678947656;9576.377535460173;9584.856227156599;9627;32222;39120.41319380212;39614.60385396138;39658.80170599157;39668.20663586712;2605.570080936643;3223.629282632504;3253.2842774589553;3433.124553238908;3442.6901578858024;28373.858130709214;29575.26061848471;29765.107046788413;29898.252543686365;30846.383072338653;3107.5183346581316;3124.9218769530717;3135.216195951012;3163;3215.2283451971593;516725;518099;526670;536810;634564;60132;60263;60796.696016519636;60856.391436085956;60958.78082438415;34133.31733365319;34654.133646658534;63166.684166578874;63512;63573.09976603279;16164.75752863708;16325.428609998831;16330.938488998177;16363.83636163647;16371.099589522453;12630.368481575884;12762.61712148637;12766.234025958473;12789.93605031969;12793.488260469478;15960.920195399181;18239.267269609365;18722.719159212622;18741.812581874008;18748.875067495723;8018.278354948083;8033.7991550210545;8044.718434854752;8046.798830029179;8140.226678465537;837.9245867871921;943.2218419803552;990.9099990011074;1099.571167244775;1145.4215621111287;29251.82992680269;29375.265618359714;29841;30370.69629303723;30471.23821904426;960.7406000379858;1060.2578195263347;1073.4686330266568;1097.6048622495896;1114.9609763658234;14783.926080369529;15309.6172595686;15402.768958465633;15496.767548486781;15587.376504939675;678300.6084969642;979381;989572;992795;995986;54388.184177237374;57326;57433;57895.8420831581;57980.130298045566;1377.5316392426423;1379.2414172205247;1409.6898682290084;1411.6400317918865;1420.6448387903024;26007.479850403266;29752.809887604253;29954.400911982073;30646.540301895042;30735.385292294475;41102.79448602857;47765.761171193924;48055.03889922252;48220.5177948216;48565.02869942652;436284;532988;533250;533490;535317;25775.711214438827;26328.605070924335;26480.735192647826;26574.468510629293;26777.598336024585;45697;45981.77009114933;46110.538894610625;46527.53472465232;47980.76009620069;28841.85579072091;36657;37029.88910332695;37488.878892387445;37669.05827354338;37653.87038388853;37709;38088.42867357047;38697.22605547817;38810.41784373293;38022.23955520929;38256.617433825304;38754.6124538751;38755.031124220994;38817.417738734504;31582.315183266313;32801.67198327986;33475.163120922174;33992.490112647836;34291.65708342985;20507;25107.49785004253;25368.492630146924;25627.87186064058;25646.743532565182 10:18:08 INFO - PROCESS | 1652 | |2;jquery.html;376.4785771706186;382.8698242597516;386.84332845197696;393.883804277738;406.55076140864344;20037.09833057512;20839.791602083973;22026.559468810636;22127.889360553214;22223.333300001006;17122.743158852627;20192.798072019275;21189.57620847582;21520.354389368305;21788.673169902464;5448.42791506892;5720.11338242573;6086.878262434749;6169.2596888373455;6169.722362493699;3923.7645741255474;5133.871653208662;6090.908636370458;6191.504679625642;6192.442680158785;6255.968720156393;6263.812085637438;6265.655388953605;6268.279147897982;6279.27788304344;5426.5116139547235;5560.277163968699;6044.939550604504;6173.074038894157;6252.906206406885;5820.854478638025;6028.156058151862;6035.245594300713;6092.147099406086;6116.663583502906;12066.577669781516;13427.19436833793;13679.31603419835;13752.862471375358;13883.097598656155;2117.12139462123;2151.2363111095647;2414;2445.8626738566472;2834.5323021701392;8111.43219974602;8303.584820758999;10195.949020254851;10294.3823370598;11673.883261167364;1538.9461368852149;1852.2776117314258;1893.3657224829699;1902.4292712186427;1931.690929451295;123703;130044.34977825145;130355;131451.34274328663;133172.33413832966;9771.804563908825;11340.773184536263;11448.370339631234;11557.133215008907;11943.940280298717;14526.273686315642;14716.632084197981;14738.968272221056;14744.63138421548;14788.630284242765;6752.93247067523;7093.503454758117;8573.828523429622;8606.612702428405;8646.654133834576;8468.66125354979;8570.871436928452;8578.356623253281;8713.912860871436;8743.91256087431;4508.368828364031;4600.4479462464715;4640.883977900579;4652.953085555723;4704.95295047052;1612.2019600297692;1632.8938618989728;1711.9144042797811;1791.3282519055354;1855.6659801235637;895.8163576466809;896.7758060484879;977.8973207813077;980.54404701814;1040.4381633917599;17745.822541774418;21527;22033.77966220317;22115.89420528967;22199.44501387478;815.3192084609418;915.3683958068912;932.5244125496046;945.8177278401997;956.1633570625703;11343.149263805248;11408.087353011739;11552.884471155181;11568.24806387582;11689.883101169049;222972;224465;225733;388800;597274;97262.51368743111;126383;128842;133143;134492;796.5579103597559;971.815355082532;994.3450985867606;994.3834822410007;996.1333639733479;19379.903100484407;19543.70684439763;19603.31388401399;19614.90192549028;19704;52389.21416178684;53279.467205329;53965.460345397616;54936.450635493136;55614;74088.62955685187;77747;79449.60275198588;80506.5974670123;82632.58683706544;6242.219722534684;7197.784066478014;7504.474686771873;7692.230776922263;7850.842983140419;11527.654170374566;13199.538016169388;13305.201687898758;13441.731165376834;13743.518976835763;10037.598496060076;11373.601923932623;11532.308061516336;11919.463624137108;11931;8062.919370806217;8961.283097352065;10921.890781092088;11497.491856026647;11995.700107497383;11565.942170289094;11725.530978760755;11728.76542469163;11741.706457338634;12112.576059837864;7004.229534751275;7268.309510596485;7445.478816482794;7591.620418978919;7825.060992680915;10717.089047431056;11417.31496110236;11570.247933884608;11578.247413918069;11901.464434100313 10:18:08 INFO - PROCESS | 1652 | |3;mootools.html;1340.5107135895396;1466.2668665667165;1509.0945432740357;1803.1885651456848;1873.4192400355882;7578.204288549706;8073.031236251658;8761.868571971418;9363.39137956034;9394;6977.720891164347;7502.249775022495;7927.365810735142;8958.776030599238;9324;2372.21716833445;2412.626042963335;2414.14297924237;2420.322309753272;2429.5626787178303;1996.1616121229047;2379.2148590965026;2426.2842461473906;2426.915057972971;2435.2815919303757;2409.8433601815827;2412.7345991940874;2420.4674971506242;2421.9394515137174;2431.3070774829175;2394.7006624171977;2406.0736616402723;2417.033186725306;2419.3104965084954;2425.0299880047946;2383.4398916254668;2398.2085911649115;2400.2199285232196;2405.314485371661;2416.0698131219433;9102.45385276879;9172.2203612693;9177.495237761921;9199.54002299889;9243.399179053407;5408.621396502246;5537.197106419547;5541.806036788693;5551.91737611166;5569.498745112959;3723.236736469017;3723.441483777428;3726.888193354204;3760.341434640159;3806.543214814212;1116.5031560955379;1122.2649164797072;1133.8015847226784;1138.618562781461;1793.9282428702836;12081.758364832742;12084.818727719092;12453.1905426147;12457.688557786129;12488.438020289108;3994.720369574102;4394.802233899418;4704.50602686713;4755.358026666356;4800.1119792838435;9271.582778774971;9530.714078577654;9533.523323833919;9542.90457095434;9550.331476796697;5372.167314066326;5374.408815030343;5377.7580008899695;5383.569314454834;5406.59450541211;4502.099580083996;4571.9314210286875;4970.403551573762;5018.247262910592;5051.570616497565;3778.3576791945434;3855.768653880776;3903.921921561553;3956.7625942443547;3966.1671049080014;1209.7459533497888;1218.939053047344;1221.267239656199;1226.8282440458343;1232.87671232876;776.856281587908;903.8689390038408;928.3687092776842;942.3262367407336;952.9231967876394;5836.387179346192;5904.7342869570975;6193.287771906198;6209.65846878417;6213.347598502182;393.53366260980255;437.6608128700219;443.33057083803044;459.7839015662633;461.28270539311694;4014.9397759033636;4041.6968727345566;4053.493313335833;4160.209560183555;4164.937525937053;8423.410361274775;11091.389973551371;11319.320840749582;11321.433928303552;11351.772964540663;9258.90741092594;11157.27477713946;11258.099352051817;11288.492017859051;11290.266132701512;7338.853222935511;8171.346292296602;8248.381371397169;8251.33989280856;8595.398322117517;5936.28764548257;6029;6045.425684559959;6073.30157031947;6163.322034576283;10153;10164.237682173718;10352.275340726077;10486.895131048592;10512.421816799844;10731.034206921415;10773.138148948223;10788.622398216025;10793.67618971432;10836.512356943798;6711.731530738716;7070.04554385172;7230.349268565644;7333.266673332624;7415.295546923034;8745.344099192458;8801.427907186013;8891.510377094424;8901.554922253732;8910.643574256957;7766.611669416619;7859.52842829432;7884.645190966535;7966.721164759206;8019.438639295427;7549.698012079455;7681.961590192013;7682.231776822273;7736.187700291388;7766.922330776846;7198.676059577437;7250.528715633467;7255.4921155518605;7323.560586364835;7325.523840950321;4929;5059.46875578059;5153.433122356463;5243.265942767939;5312.548433383051;4031.6976226783695;5129.153689641167;5159;5166.173412254021;5313.787448502017 10:18:08 INFO - PROCESS | 1652 | |4;prototype.html;261.3218697480039;302.7774585679525;307.73227292255734;316.6896441487344;316.7893350921636;4708.69393489423;5517.531009864157;5520.806771762989;5624.606277560572;5736.971315143423;5055.469175736541;5643.106256682886;5653.519450846673;5670.461306175917;5680.545556355492;3756.4365345198166;4346.282863327548;4349.43457350544;4361.411209486726;4366.19225443294;3974.18529201513;4229.725067870594;4305.031367942203;4386.605205531501;4387.780610969438;3838.2707285615643;4129.6696264298935;4204.960594111853;4227.471566054243;4254.9789649348995;4230.725002874834;4242.1727763086365;4250.893727656802;4255.3829694694405;4278.893027674302;3554.751167418282;3671.210689701727;3675.3016926784094;3675.7978311192874;3679.6136405677285;4679.74261415622;5455.236266922594;5476.890462190774;5490.533304669068;5526.744406806776;3812.4281357796276;3970.68234541236;4052.0882801369753;4812.590929770974;4900.828471003533;5489.972550137264;5952.9702351488395;5983.252093488314;5987.970060149672;5998.8500287492725;4094.467719196485;4128.876133715993;4161.292580261363;4172.374143878412;4210.305299625558;6217.911865423533;6323.841903952392;6363.459105975998;6367.204099487564;6405.391487808651;3749.8312575934146;3996.780177090288;4088.5298190707854;4115.753054816661;4205.663546916239;4258.978705106455;4268.40242366069;4274.038341373166;4290.570942905684;4297.505786834491;4896.951030489649;4969.850904472872;4970.627202959792;5000.2749601307605;5003.874903127451;5277.894442111136;5468;5669.291338582677;6070.998285282879;6082.787102451393;1122.5799363804792;1241.8696036916174;1249.8875101240933;1407.465163237963;1481.3704175725488;877.8288233794349;897.1701176411793;912.6623149434752;923.8013827027087;925.8518637018045;4259.74441533509;4510.368548403226;4531.281231261217;4636.976815115903;4750.5249475052215;4831.492693267227;5214.348206474191;5245.580353571705;5303.443138470482;5310.831617044244;4040.959590404117;4206.72656277341;4300.892477688083;4356.736546401571;4512.548745125461;2412.5295567364196;2500.2624225853415;2534.6451496790464;2612.4905643399734;2763.806533542673;4722.834700785525;4848.539388758062;5020.196768517019;5052;5375.381831089475;5301.966116607225;5315.388730295988;5333.373306151777;5357.276767636397;5760.308762948389;5989.610675306091;6311.810645680637;6412.35876412355;6435.646039467874;6454.644994525346;6018.585632376476;6240.812775616739;6260.7495700171485;6274.6548939808745;6288.339724329063;5347.438518955453;5903.486161838226;6048.818535443944;6150.477209437248;6157.476614487819;5591.776328946797;6408.711607977745;6412.807615771534;6423.486121110206;6429.903551446826;3881.456596076495;3930.705197110171;4005.9799701002476;4042.1511482588985;4059.4925634295714;5689.743961521659;5691.943080569141;6139.3553676863285;6170.938290617037;6202.937970620236;4773.785179666854;5349.358077030781;6023.969880150571;6026.819195423969;6036.3058248302;5919.763209471573;5938.673372964528;5981.192539007352;5983.350156404503;6000.759969601167;4627.838025669085;4893.804247830047;5852.092925596539;5902.557308201816;5921.674307912934;4383.846565370197;4924.236743304794;5140.588752899834;5538.778448862162;5885.73514191871;4792.400949881265;5087.796488140581;5382.761964748208;5594.4125866785025;5732.512736417451 10:18:08 INFO - PROCESS | 1652 | |5;yui.html;588.9911651325231;603.3031848215312;650.7234425369217;698.7763915547024;718.3463048625752;15250.313735881884;15941.760873586905;16067.357305707787;16082.678346433064;16107.597310067255;11433.885661143386;14166.787498187536;14427.134371937691;14427.495037673683;14464.421423143061;835.1773503099457;841.4488510025943;858.9871151932726;862.3446180902528;863.4560227056945;670.4334837062675;823.555280148719;853.9914600854005;854.1415877043562;857.1899554920602;896.2471523919907;905.4250550900193;906.2795077913075;910.008091180613;911.2482202183226;901;901.8466860633675;903.1014140929784;904.2494729374604;907.9954600227022;661.0678942690782;669.4945316286221;669.608279156689;670.8893032649607;671.8958561422987;13913.652158696012;15009.774853377208;15012.324445399983;15021.924890375587;15065.472708455261;14578.854211457856;14629.341679624442;14676.19280939548;14764.409423623043;15010.924945375313;11857.110716696283;12005.279683219034;12086.093542984223;12117.697057573543;12191;3784.432335149722;3842.51968503937;3845.5193100862393;3856.8842934711724;3976.0457490202434;102202.48898755533;110746;111147;116047.4197629015;117764;11289.604863829727;11379.487923043484;11411.714707132389;11631.88368116308;11951.820722689166;20075.899620502096;21279.042443089787;23465.765342346698;23476;23522.941467634;8176.877346839802;8290.792730181673;8385.268555492747;8481.575921203916;8495.957520212483;3621.2576421833987;4558.475775285885;4587.08258348325;4721.929171062437;4755.809767609257;3338.365710515043;3478.89563313101;3486.2504561519395;3496.021114088059;3504.491848681927;621.0994058615026;629.4366541944934;637.346719612401;648.4196644003684;650.4991156809231;507.4874376879378;579.6927628356977;599.7884273767054;625.0496859845731;634.8190765631773;8849.955750221336;8938.68714594986;9058.275337972946;9098.272138228926;9347.813043739086;599.6611914268511;629.4618101523223;630.3003665930813;634.5780056262533;652.3052948609716;3842.8462861485787;4304.80628371724;4307.906099558303;4614.400127983341;4628.143793398232;124123.75876241122;159893.2005339966;160893;161946.19026905025;168039;114059.42970285096;115654.42172789082;133755.33122334522;138000.30999844937;145598;71092.64453677699;96456;107497;108852.45573772081;114287;9132.767076444596;9192.862107068266;9226.98503164638;9443.338966272295;10137.89862101399;44507.55492445164;58639.827203454835;62323.376766233574;62637.37362626316;63101.36898631138;70622;73275;74492;86254.56872715596;95203;12970.546030888874;12983.221006739626;13280.601581952556;13303;13590.86409135896;14739.778903316674;14775.261236937895;14805.777913331092;14975.475858344906;15460.738400947634;12850.036247281305;13643.386047627682;13883.930580347034;14020.859791402363;14148.43406263738;12248.387580620754;13348.666283342995;13689;13728.45086196541;14397.928010359881;13348.666283342995;13439.193648381128;13716.862831371558;13741.793873091712;13946.930265348608;11175.161862860481;11275.605353812578;11536.78863719331;11639.243449175776;11853.111016673956;9065.456072635663;9772.85340719904;10219.335743176669;10961.671149865517;11745.765084698087 10:18:08 INFO - PROCESS | 1652 | __end_tp_report 10:18:08 INFO - PROCESS | 1652 | __start_cc_report 10:18:08 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,414 10:18:08 INFO - PROCESS | 1652 | __end_cc_report 10:18:08 INFO - PROCESS | 1652 | __startTimestamp1471367888930__endTimestamp 10:18:08 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:18:08 INFO - PROCESS | 1652 | Number of tests: 6 10:18:08 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5814.60 Median:6098.88 stddev:663.41 (10.9%) stddev-sans-first:614.57 10:18:08 INFO - PROCESS | 1652 | Values: 2566.6 3426.6 3436.6 3446.8 3474.3 4612.6 5721.3 5753.1 5764.7 5781.4 5720.9 5784.8 5814.9 5847.3 5873.9 5233.1 5331.8 5334.1 5377.4 5420.7 5337.5 5358.0 5362.0 5389.3 5395.9 5175.7 5207.6 5265.3 5375.3 5401.7 5292.3 5296.4 5297.9 5301.6 5323.9 5184.4 5192.6 5261.3 5294.1 5371.2 5574.3 5845.0 5858.0 5887.4 5948.7 6234.3 6279.3 6292.8 6310.2 6345.4 6195.1 6333.5 6338.5 6339.1 6342.6 5342.6 5558.3 5964.0 6008.5 6066.2 6373.3 6429.7 6443.7 6455.4 6456.8 6126.4 6196.8 6210.8 6251.6 6270.5 6190.4 6231.3 6233.1 6236.1 6299.8 6227.0 6277.7 6297.9 6328.1 6335.6 6145.0 6269.8 6291.8 6306.9 6328.8 4304.5 4978.4 5013.3 5042.7 5049.4 4525.5 4577.9 4589.9 4598.2 4616.6 5871.1 5941.5 5986.0 5989.1 6001.4 6186.6 6205.6 6250.1 6329.4 6332.4 5882.9 5945.3 5958.7 5985.3 6029.9 5546.4 5565.4 5572.8 5574.7 5581.0 6275.6 6346.5 6366.7 6474.0 6474.7 6305.4 6313.5 6326.2 6343.6 6354.4 5531.2 5583.6 5992.6 6113.8 6500.9 6151.4 6180.8 6205.2 6290.0 6317.3 6251.6 6308.0 6324.5 6336.3 6336.7 6141.5 6152.4 6158.6 6162.2 6181.7 6104.3 6123.3 6140.2 6177.9 6185.4 5971.1 5996.5 6177.9 6186.1 6209.5 5802.6 6172.0 6226.5 6238.4 6248.3 5954.5 6098.9 6125.8 6174.9 6176.7 10:18:08 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:77315.43 Median:39367.51 stddev:187339.11 (475.9%) stddev-sans-first:187775.83 10:18:08 INFO - PROCESS | 1652 | Values: 486.8 514.3 536.0 548.3 566.2 37682.2 39760.8 39895.8 39925.0 39938.8 40727.8 41289.4 41365.0 41423.6 41432.6 9619.6 9725.4 9758.2 9760.6 9783.1 8061.9 8708.6 9349.6 9674.7 9682.2 9637.2 9699.1 9703.0 9718.0 9755.4 9658.4 9693.9 9720.6 9739.7 9743.7 9483.6 9569.5 9576.4 9584.9 9627.0 32222.0 39120.4 39614.6 39658.8 39668.2 2605.6 3223.6 3253.3 3433.1 3442.7 28373.9 29575.3 29765.1 29898.3 30846.4 3107.5 3124.9 3135.2 3163.0 3215.2 516725.0 518099.0 526670.0 536810.0 634564.0 60132.0 60263.0 60796.7 60856.4 60958.8 34133.3 34654.1 63166.7 63512.0 63573.1 16164.8 16325.4 16330.9 16363.8 16371.1 12630.4 12762.6 12766.2 12789.9 12793.5 15960.9 18239.3 18722.7 18741.8 18748.9 8018.3 8033.8 8044.7 8046.8 8140.2 837.9 943.2 990.9 1099.6 1145.4 29251.8 29375.3 29841.0 30370.7 30471.2 960.7 1060.3 1073.5 1097.6 1115.0 14783.9 15309.6 15402.8 15496.8 15587.4 678300.6 979381.0 989572.0 992795.0 995986.0 54388.2 57326.0 57433.0 57895.8 57980.1 1377.5 1379.2 1409.7 1411.6 1420.6 26007.5 29752.8 29954.4 30646.5 30735.4 41102.8 47765.8 48055.0 48220.5 48565.0 436284.0 532988.0 533250.0 533490.0 535317.0 25775.7 26328.6 26480.7 26574.5 26777.6 45697.0 45981.8 46110.5 46527.5 47980.8 28841.9 36657.0 37029.9 37488.9 37669.1 37653.9 37709.0 38088.4 38697.2 38810.4 38022.2 38256.6 38754.6 38755.0 38817.4 31582.3 32801.7 33475.2 33992.5 34291.7 20507.0 25107.5 25368.5 25627.9 25646.7 10:18:08 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:27613.93 Median:2429.93 stddev:64622.89 (2659.5%) stddev-sans-first:64771.82 10:18:08 INFO - PROCESS | 1652 | Values: 376.5 382.9 386.8 393.9 406.6 20037.1 20839.8 22026.6 22127.9 22223.3 17122.7 20192.8 21189.6 21520.4 21788.7 5448.4 5720.1 6086.9 6169.3 6169.7 3923.8 5133.9 6090.9 6191.5 6192.4 6256.0 6263.8 6265.7 6268.3 6279.3 5426.5 5560.3 6044.9 6173.1 6252.9 5820.9 6028.2 6035.2 6092.1 6116.7 12066.6 13427.2 13679.3 13752.9 13883.1 2117.1 2151.2 2414.0 2445.9 2834.5 8111.4 8303.6 10195.9 10294.4 11673.9 1538.9 1852.3 1893.4 1902.4 1931.7 123703.0 130044.3 130355.0 131451.3 133172.3 9771.8 11340.8 11448.4 11557.1 11943.9 14526.3 14716.6 14739.0 14744.6 14788.6 6752.9 7093.5 8573.8 8606.6 8646.7 8468.7 8570.9 8578.4 8713.9 8743.9 4508.4 4600.4 4640.9 4653.0 4705.0 1612.2 1632.9 1711.9 1791.3 1855.7 895.8 896.8 977.9 980.5 1040.4 17745.8 21527.0 22033.8 22115.9 22199.4 815.3 915.4 932.5 945.8 956.2 11343.1 11408.1 11552.9 11568.2 11689.9 222972.0 224465.0 225733.0 388800.0 597274.0 97262.5 126383.0 128842.0 133143.0 134492.0 796.6 971.8 994.3 994.4 996.1 19379.9 19543.7 19603.3 19614.9 19704.0 52389.2 53279.5 53965.5 54936.5 55614.0 74088.6 77747.0 79449.6 80506.6 82632.6 6242.2 7197.8 7504.5 7692.2 7850.8 11527.7 13199.5 13305.2 13441.7 13743.5 10037.6 11373.6 11532.3 11919.5 11931.0 8062.9 8961.3 10921.9 11497.5 11995.7 11565.9 11725.5 11728.8 11741.7 12112.6 7004.2 7268.3 7445.5 7591.6 7825.1 10717.1 11417.3 11570.2 11578.2 11901.5 10:18:08 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5805.53 Median:4864.56 stddev:3306.67 (68.0%) stddev-sans-first:3298.92 10:18:08 INFO - PROCESS | 1652 | Values: 1340.5 1466.3 1509.1 1803.2 1873.4 7578.2 8073.0 8761.9 9363.4 9394.0 6977.7 7502.2 7927.4 8958.8 9324.0 2372.2 2412.6 2414.1 2420.3 2429.6 1996.2 2379.2 2426.3 2426.9 2435.3 2409.8 2412.7 2420.5 2421.9 2431.3 2394.7 2406.1 2417.0 2419.3 2425.0 2383.4 2398.2 2400.2 2405.3 2416.1 9102.5 9172.2 9177.5 9199.5 9243.4 5408.6 5537.2 5541.8 5551.9 5569.5 3723.2 3723.4 3726.9 3760.3 3806.5 1116.5 1122.3 1133.8 1138.6 1793.9 12081.8 12084.8 12453.2 12457.7 12488.4 3994.7 4394.8 4704.5 4755.4 4800.1 9271.6 9530.7 9533.5 9542.9 9550.3 5372.2 5374.4 5377.8 5383.6 5406.6 4502.1 4571.9 4970.4 5018.2 5051.6 3778.4 3855.8 3903.9 3956.8 3966.2 1209.7 1218.9 1221.3 1226.8 1232.9 776.9 903.9 928.4 942.3 952.9 5836.4 5904.7 6193.3 6209.7 6213.3 393.5 437.7 443.3 459.8 461.3 4014.9 4041.7 4053.5 4160.2 4164.9 8423.4 11091.4 11319.3 11321.4 11351.8 9258.9 11157.3 11258.1 11288.5 11290.3 7338.9 8171.3 8248.4 8251.3 8595.4 5936.3 6029.0 6045.4 6073.3 6163.3 10153.0 10164.2 10352.3 10486.9 10512.4 10731.0 10773.1 10788.6 10793.7 10836.5 6711.7 7070.0 7230.3 7333.3 7415.3 8745.3 8801.4 8891.5 8901.6 8910.6 7766.6 7859.5 7884.6 7966.7 8019.4 7549.7 7682.0 7682.2 7736.2 7766.9 7198.7 7250.5 7255.5 7323.6 7325.5 4929.0 5059.5 5153.4 5243.3 5312.5 4031.7 5129.2 5159.0 5166.2 5313.8 10:18:08 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4672.10 Median:5012.04 stddev:1472.41 (29.4%) stddev-sans-first:1438.84 10:18:08 INFO - PROCESS | 1652 | Values: 261.3 302.8 307.7 316.7 316.8 4708.7 5517.5 5520.8 5624.6 5737.0 5055.5 5643.1 5653.5 5670.5 5680.5 3756.4 4346.3 4349.4 4361.4 4366.2 3974.2 4229.7 4305.0 4386.6 4387.8 3838.3 4129.7 4205.0 4227.5 4255.0 4230.7 4242.2 4250.9 4255.4 4278.9 3554.8 3671.2 3675.3 3675.8 3679.6 4679.7 5455.2 5476.9 5490.5 5526.7 3812.4 3970.7 4052.1 4812.6 4900.8 5490.0 5953.0 5983.3 5988.0 5998.9 4094.5 4128.9 4161.3 4172.4 4210.3 6217.9 6323.8 6363.5 6367.2 6405.4 3749.8 3996.8 4088.5 4115.8 4205.7 4259.0 4268.4 4274.0 4290.6 4297.5 4897.0 4969.9 4970.6 5000.3 5003.9 5277.9 5468.0 5669.3 6071.0 6082.8 1122.6 1241.9 1249.9 1407.5 1481.4 877.8 897.2 912.7 923.8 925.9 4259.7 4510.4 4531.3 4637.0 4750.5 4831.5 5214.3 5245.6 5303.4 5310.8 4041.0 4206.7 4300.9 4356.7 4512.5 2412.5 2500.3 2534.6 2612.5 2763.8 4722.8 4848.5 5020.2 5052.0 5375.4 5302.0 5315.4 5333.4 5357.3 5760.3 5989.6 6311.8 6412.4 6435.6 6454.6 6018.6 6240.8 6260.7 6274.7 6288.3 5347.4 5903.5 6048.8 6150.5 6157.5 5591.8 6408.7 6412.8 6423.5 6429.9 3881.5 3930.7 4006.0 4042.2 4059.5 5689.7 5691.9 6139.4 6170.9 6202.9 4773.8 5349.4 6024.0 6026.8 6036.3 5919.8 5938.7 5981.2 5983.4 6000.8 4627.8 4893.8 5852.1 5902.6 5921.7 4383.8 4924.2 5140.6 5538.8 5885.7 4792.4 5087.8 5382.8 5594.4 5732.5 10:18:08 INFO - PROCESS | 1652 | 10:18:08 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24429.15 Median:3500.26 stddev:39345.39 (1124.1%) stddev-sans-first:39415.04 10:18:08 INFO - PROCESS | 1652 | Values: 589.0 603.3 650.7 698.8 718.3 15250.3 15941.8 16067.4 16082.7 16107.6 11433.9 14166.8 14427.1 14427.5 14464.4 835.2 841.4 859.0 862.3 863.5 670.4 823.6 854.0 854.1 857.2 896.2 905.4 906.3 910.0 911.2 901.0 901.8 903.1 904.2 908.0 661.1 669.5 669.6 670.9 671.9 13913.7 15009.8 15012.3 15021.9 15065.5 14578.9 14629.3 14676.2 14764.4 15010.9 11857.1 12005.3 12086.1 12117.7 12191.0 3784.4 3842.5 3845.5 3856.9 3976.0 102202.5 110746.0 111147.0 116047.4 117764.0 11289.6 11379.5 11411.7 11631.9 11951.8 20075.9 21279.0 23465.8 23476.0 23522.9 8176.9 8290.8 8385.3 8481.6 8496.0 3621.3 4558.5 4587.1 4721.9 4755.8 3338.4 3478.9 3486.3 3496.0 3504.5 621.1 629.4 637.3 648.4 650.5 507.5 579.7 599.8 625.0 634.8 8850.0 8938.7 9058.3 9098.3 9347.8 599.7 629.5 630.3 634.6 652.3 3842.8 4304.8 4307.9 4614.4 4628.1 124123.8 159893.2 160893.0 161946.2 168039.0 114059.4 115654.4 133755.3 138000.3 145598.0 71092.6 96456.0 107497.0 108852.5 114287.0 9132.8 9192.9 9227.0 9443.3 10137.9 44507.6 58639.8 62323.4 62637.4 63101.4 70622.0 73275.0 74492.0 86254.6 95203.0 12970.5 12983.2 13280.6 13303.0 13590.9 14739.8 14775.3 14805.8 14975.5 15460.7 12850.0 13643.4 13883.9 14020.9 14148.4 12248.4 13348.7 13689.0 13728.5 14397.9 13348.7 13439.2 13716.9 13741.8 13946.9 11175.2 11275.6 11536.8 11639.2 11853.1 9065.5 9772.9 10219.3 10961.7 11745.8 10:18:08 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:18:08 INFO - PROCESS | 1652 | 10:18:09 INFO - TEST-INFO | 1652: exit 0 10:18:09 INFO - TEST-OK | dromaeo_css | took 1114558ms 10:18:09 INFO - TEST-START | kraken 10:18:09 INFO - operating with platform_type : mac_ 10:18:09 INFO - Initialising browser for kraken test... 10:18:09 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp_ftxNa/profile http://localhost:49262/getInfo.html) 10:18:12 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 10:18:12 INFO - PROCESS | 1664 | colorDepth:24 10:18:12 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 10:18:12 INFO - PROCESS | 1664 | __metrics 10:18:12 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 10:18:12 INFO - TEST-INFO | 1664: exit 0 10:18:12 INFO - Browser initialized. 10:18:12 INFO - Running cycle 1/1 for kraken test... 10:18:12 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp_ftxNa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:25 INFO - PROCESS | 1666 | RSS: Main: 239280128 10:18:25 INFO - PROCESS | 1666 | 10:18:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:29 INFO - PROCESS | 1666 | RSS: Main: 252116992 10:18:29 INFO - PROCESS | 1666 | 10:18:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 10:18:32 INFO - PROCESS | 1666 | RSS: Main: 260898816 10:18:32 INFO - PROCESS | 1666 | 10:18:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 10:18:36 INFO - PROCESS | 1666 | RSS: Main: 263852032 10:18:36 INFO - PROCESS | 1666 | 10:18:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 10:18:39 INFO - PROCESS | 1666 | RSS: Main: 265158656 10:18:39 INFO - PROCESS | 1666 | 10:18:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:41 INFO - PROCESS | 1666 | RSS: Main: 266911744 10:18:41 INFO - PROCESS | 1666 | 10:18:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:45 INFO - PROCESS | 1666 | RSS: Main: 266936320 10:18:45 INFO - PROCESS | 1666 | 10:18:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:48 INFO - PROCESS | 1666 | RSS: Main: 267177984 10:18:48 INFO - PROCESS | 1666 | 10:18:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 10:18:52 INFO - PROCESS | 1666 | RSS: Main: 267304960 10:18:52 INFO - PROCESS | 1666 | 10:18:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:54 INFO - PROCESS | 1666 | RSS: Main: 267235328 10:18:54 INFO - PROCESS | 1666 | 10:18:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:57 INFO - PROCESS | 1666 | RSS: Main: 267300864 10:18:57 INFO - PROCESS | 1666 | 10:18:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:00 INFO - PROCESS | 1666 | RSS: Main: 267501568 10:19:00 INFO - PROCESS | 1666 | 10:19:03 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:03 INFO - PROCESS | 1666 | RSS: Main: 267640832 10:19:03 INFO - PROCESS | 1666 | 10:19:06 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:19:07 INFO - PROCESS | 1666 | RSS: Main: 267665408 10:19:07 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 10:19:09 INFO - PROCESS | 1666 | RSS: Main: 268517376 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | __start_tp_report 10:19:09 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 10:19:09 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 10:19:09 INFO - PROCESS | 1666 | |i|pagename|runs| 10:19:09 INFO - PROCESS | 1666 | |0;ai-astar;105;132;156;161;115;117;119;117;117;116 10:19:09 INFO - PROCESS | 1666 | |1;audio-beat-detection;144;117;175;195;111;130;125;118;147;130 10:19:09 INFO - PROCESS | 1666 | |2;audio-dft;205;211;258;274;196;200;195;198;193;192 10:19:09 INFO - PROCESS | 1666 | |3;audio-fft;72;82;97;167;58;60;62;76;139;50 10:19:09 INFO - PROCESS | 1666 | |4;audio-oscillator;71;74;122;77;64;117;97;56;97;151 10:19:09 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;136;119;89;94;90;84;137;88;89;88 10:19:09 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;101;96;94;97;94;96;99;93;95 10:19:09 INFO - PROCESS | 1666 | |7;imaging-desaturate;74;149;150;95;90;92;92;136;100;78 10:19:09 INFO - PROCESS | 1666 | |8;json-parse-financial;57;58;61;56;59;61;58;58;57;60 10:19:09 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;64;72;68;73;70;84;74;69;69;69 10:19:09 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;90;90;91;85;88;106;108;78;98;109 10:19:09 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;139;139;136;139;173;151;141;176;168;160 10:19:09 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;172;173;173;171;171;170;186;238;239;217 10:19:09 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;64;67;71;74;70;92;69;67;67;66 10:19:09 INFO - PROCESS | 1666 | __end_tp_report 10:19:09 INFO - PROCESS | 1666 | __start_cc_report 10:19:09 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1049 10:19:09 INFO - PROCESS | 1666 | __end_cc_report 10:19:09 INFO - PROCESS | 1666 | __startTimestamp1471367949494__endTimestamp 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | ------- Summary: start ------- 10:19:09 INFO - PROCESS | 1666 | Number of tests: 14 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:125.50 Median:118.00 stddev:18.60 (15.8%) stddev-sans-first:18.19 10:19:09 INFO - PROCESS | 1666 | Values: 105.0 132.0 156.0 161.0 115.0 117.0 119.0 117.0 117.0 116.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:137.00 stddev:27.05 (19.7%) stddev-sans-first:28.64 10:19:09 INFO - PROCESS | 1666 | Values: 144.0 117.0 175.0 195.0 111.0 130.0 125.0 118.0 147.0 130.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:212.20 Median:202.50 stddev:29.17 (14.4%) stddev-sans-first:30.82 10:19:09 INFO - PROCESS | 1666 | Values: 205.0 211.0 258.0 274.0 196.0 200.0 195.0 198.0 193.0 192.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:86.30 Median:67.00 stddev:38.20 (57.0%) stddev-sans-first:40.17 10:19:09 INFO - PROCESS | 1666 | Values: 72.0 82.0 97.0 167.0 58.0 60.0 62.0 76.0 139.0 50.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:72.50 stddev:30.04 (41.4%) stddev-sans-first:30.83 10:19:09 INFO - PROCESS | 1666 | Values: 71.0 74.0 122.0 77.0 64.0 117.0 97.0 56.0 97.0 151.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:88.50 stddev:20.89 (23.6%) stddev-sans-first:18.02 10:19:09 INFO - PROCESS | 1666 | Values: 136.0 119.0 89.0 94.0 90.0 84.0 137.0 88.0 89.0 88.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:95.50 stddev:2.45 (2.6%) stddev-sans-first:2.57 10:19:09 INFO - PROCESS | 1666 | Values: 95.0 101.0 96.0 94.0 97.0 94.0 96.0 99.0 93.0 95.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:105.60 Median:84.00 stddev:28.47 (33.9%) stddev-sans-first:27.81 10:19:09 INFO - PROCESS | 1666 | Values: 74.0 149.0 150.0 95.0 90.0 92.0 92.0 136.0 100.0 78.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:58.50 stddev:1.72 (2.9%) stddev-sans-first:1.73 10:19:09 INFO - PROCESS | 1666 | Values: 57.0 58.0 61.0 56.0 59.0 61.0 58.0 58.0 57.0 60.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.00 stddev:5.31 (7.5%) stddev-sans-first:4.95 10:19:09 INFO - PROCESS | 1666 | Values: 64.0 72.0 68.0 73.0 70.0 84.0 74.0 69.0 69.0 69.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:89.00 stddev:10.51 (11.8%) stddev-sans-first:11.03 10:19:09 INFO - PROCESS | 1666 | Values: 90.0 90.0 91.0 85.0 88.0 106.0 108.0 78.0 98.0 109.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:155.50 stddev:15.71 (10.1%) stddev-sans-first:15.92 10:19:09 INFO - PROCESS | 1666 | Values: 139.0 139.0 136.0 139.0 173.0 151.0 141.0 176.0 168.0 160.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.00 Median:179.50 stddev:28.80 (16.0%) stddev-sans-first:29.71 10:19:09 INFO - PROCESS | 1666 | Values: 172.0 173.0 173.0 171.0 171.0 170.0 186.0 238.0 239.0 217.0 10:19:09 INFO - PROCESS | 1666 | 10:19:09 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:69.50 stddev:8.00 (11.5%) stddev-sans-first:8.11 10:19:09 INFO - PROCESS | 1666 | Values: 64.0 67.0 71.0 74.0 70.0 92.0 69.0 67.0 67.0 66.0 10:19:09 INFO - PROCESS | 1666 | -------- Summary: end -------- 10:19:09 INFO - PROCESS | 1666 | 10:19:10 INFO - TEST-INFO | 1666: exit 0 10:19:10 INFO - TEST-OK | kraken | took 60743ms 10:19:10 INFO - SUITE-END | took 1175s 10:19:10 INFO - Completed test suite (00:19:35) 10:19:10 INFO - javascript benchmark 10:19:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7352.395561431427, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.5765148750456, 3426.640202778708, 3436.55324807775, 3446.8448919798607, 3474.2530355973468, 4612.632311285595, 5721.284839395075, 5753.050746626806, 5764.6541207527525, 5781.364049954502, 5720.942790572093, 5784.768609255625, 5814.854628634275, 5847.327557330908, 5873.853153671161, 5233.084210263208, 5331.760070796804, 5334.066538355792, 5377.354717433894, 5420.7018613976215, 5337.4662533746705, 5357.973210133963, 5361.98122356751, 5389.299391079154, 5395.946040539603, 5175.741212939338, 5207.6354655174155, 5265.262863199156, 5375.3280839895015, 5401.70290634015, 5292.259083728281, 5296.417394086648, 5297.867553311159, 5301.602379821529, 5323.946760532383, 5184.403793563751, 5192.6105542084115, 5261.342332208474, 5294.126469132589, 5371.221172929903, 5574.275344205268, 5845.035569131088, 5858.0, 5887.411258874121, 5948.7323070461935, 6234.251889773211, 6279.309275979638, 6292.811215663537, 6310.1796766420075, 6345.42891139795, 6195.101710252034, 6333.461655759266, 6338.492920566344, 6339.0808332791485, 6342.556021078526, 5342.5993050521365, 5558.305211848519, 5963.970180149072, 6008.519318454601, 6066.211392518944, 6373.298937116913, 6429.742810287629, 6443.67781610927, 6455.419012288917, 6456.806295811133, 6126.417990290915, 6196.783112591038, 6210.782622608277, 6251.59364641306, 6270.529710271657, 6190.380961903774, 6231.283402408691, 6233.096201050822, 6236.095766113979, 6299.811005669837, 6226.968865155736, 6277.748890044347, 6297.937020629735, 6328.082428047999, 6335.588186767845, 6145.016797312409, 6269.843253918689, 6291.779787707408, 6306.873862522724, 6328.841778955563, 4304.4834619845815, 4978.377702787152, 5013.273075404119, 5042.747862606929, 5049.444561098277, 4525.52481989393, 4577.862664120015, 4589.862304130881, 4598.172328980749, 4616.6075883550275, 5871.089981052944, 5941.465268125889, 5986.012307969137, 5989.071693887455, 6001.4298641628975, 6186.628802271878, 6205.565610407228, 6250.093736408196, 6329.430351268408, 6332.430081292706, 5882.852928676817, 5945.256842894638, 5958.702064896738, 5985.281766187998, 6029.939700602938, 5546.362168350692, 5565.387807341189, 5572.804951826666, 5574.749136288877, 5581.0, 6275.592086514362, 6346.524010699124, 6366.681665916778, 6474.0, 6474.741010359533, 6305.369463053658, 6313.494920406449, 6326.177596912372, 6343.619382837044, 6354.428101470705, 5531.158562849304, 5583.581231407579, 5992.550558708202, 6113.755449782137, 6500.934990650033, 6151.446369826737, 6180.752769889334, 6205.193324867739, 6290.014713484681, 6317.30509643948, 6251.593646412968, 6308.0, 6324.462420694109, 6336.271328797247, 6336.7148478319505, 6141.539384546088, 6152.415520525543, 6158.568900176944, 6162.168107305456, 6181.721822518088, 6104.298005729221, 6123.282621474203, 6140.232470941132, 6177.938220617736, 6185.443310101932, 5971.104334349709, 5996.490298324691, 6177.876442471215, 6186.1339412483185, 6209.5032397409, 5802.622829516068, 6171.981623032329, 6226.46771719424, 6238.438540531374, 6248.343923887926, 5954.46409823118, 6098.878022439615, 6125.84596676928, 6174.9073763892675, 6176.66028368444], "value": 5770.941422205542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.82431926896544, 514.2851436503261, 535.9732013399329, 548.3091304955755, 566.1790403914325, 37682.24635507288, 39760.8071757847, 39895.80052099739, 39925.0, 39938.800305998426, 40727.79636101823, 41289.38065929006, 41365.0, 41423.58576414235, 41432.58567414325, 9619.615215391394, 9725.367851089692, 9758.170555502791, 9760.609575616967, 9783.119519243266, 8061.919380806205, 8708.564571771418, 9349.626014959393, 9674.661386851461, 9682.225421966226, 9637.22902167825, 9699.127078562928, 9702.9514852426, 9718.0, 9755.365901216433, 9658.372205806636, 9693.854592181158, 9720.61117555297, 9739.659111931049, 9743.65897193602, 9483.620655173785, 9569.473678947656, 9576.377535460173, 9584.856227156599, 9627.0, 32222.0, 39120.41319380212, 39614.60385396138, 39658.80170599157, 39668.20663586712, 2605.570080936643, 3223.629282632504, 3253.2842774589553, 3433.124553238908, 3442.6901578858024, 28373.858130709214, 29575.26061848471, 29765.107046788413, 29898.252543686365, 30846.383072338653, 3107.5183346581316, 3124.9218769530717, 3135.216195951012, 3163.0, 3215.2283451971593, 516725.0, 518099.0, 526670.0, 536810.0, 634564.0, 60132.0, 60263.0, 60796.696016519636, 60856.391436085956, 60958.78082438415, 34133.31733365319, 34654.133646658534, 63166.684166578874, 63512.0, 63573.09976603279, 16164.75752863708, 16325.428609998831, 16330.938488998177, 16363.83636163647, 16371.099589522453, 12630.368481575884, 12762.61712148637, 12766.234025958473, 12789.93605031969, 12793.488260469478, 15960.920195399181, 18239.267269609365, 18722.719159212622, 18741.812581874008, 18748.875067495723, 8018.278354948083, 8033.7991550210545, 8044.718434854752, 8046.798830029179, 8140.226678465537, 837.9245867871921, 943.2218419803552, 990.9099990011074, 1099.571167244775, 1145.4215621111287, 29251.82992680269, 29375.265618359714, 29841.0, 30370.69629303723, 30471.23821904426, 960.7406000379858, 1060.2578195263347, 1073.4686330266568, 1097.6048622495896, 1114.9609763658234, 14783.926080369529, 15309.6172595686, 15402.768958465633, 15496.767548486781, 15587.376504939675, 678300.6084969642, 979381.0, 989572.0, 992795.0, 995986.0, 54388.184177237374, 57326.0, 57433.0, 57895.8420831581, 57980.130298045566, 1377.5316392426423, 1379.2414172205247, 1409.6898682290084, 1411.6400317918865, 1420.6448387903024, 26007.479850403266, 29752.809887604253, 29954.400911982073, 30646.540301895042, 30735.385292294475, 41102.79448602857, 47765.761171193924, 48055.03889922252, 48220.5177948216, 48565.02869942652, 436284.0, 532988.0, 533250.0, 533490.0, 535317.0, 25775.711214438827, 26328.605070924335, 26480.735192647826, 26574.468510629293, 26777.598336024585, 45697.0, 45981.77009114933, 46110.538894610625, 46527.53472465232, 47980.76009620069, 28841.85579072091, 36657.0, 37029.88910332695, 37488.878892387445, 37669.05827354338, 37653.87038388853, 37709.0, 38088.42867357047, 38697.22605547817, 38810.41784373293, 38022.23955520929, 38256.617433825304, 38754.6124538751, 38755.031124220994, 38817.417738734504, 31582.315183266313, 32801.67198327986, 33475.163120922174, 33992.490112647836, 34291.65708342985, 20507.0, 25107.49785004253, 25368.492630146924, 25627.87186064058, 25646.743532565182], "value": 19868.50086806416, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4785771706186, 382.8698242597516, 386.84332845197696, 393.883804277738, 406.55076140864344, 20037.09833057512, 20839.791602083973, 22026.559468810636, 22127.889360553214, 22223.333300001006, 17122.743158852627, 20192.798072019275, 21189.57620847582, 21520.354389368305, 21788.673169902464, 5448.42791506892, 5720.11338242573, 6086.878262434749, 6169.2596888373455, 6169.722362493699, 3923.7645741255474, 5133.871653208662, 6090.908636370458, 6191.504679625642, 6192.442680158785, 6255.968720156393, 6263.812085637438, 6265.655388953605, 6268.279147897982, 6279.27788304344, 5426.5116139547235, 5560.277163968699, 6044.939550604504, 6173.074038894157, 6252.906206406885, 5820.854478638025, 6028.156058151862, 6035.245594300713, 6092.147099406086, 6116.663583502906, 12066.577669781516, 13427.19436833793, 13679.31603419835, 13752.862471375358, 13883.097598656155, 2117.12139462123, 2151.2363111095647, 2414.0, 2445.8626738566472, 2834.5323021701392, 8111.43219974602, 8303.584820758999, 10195.949020254851, 10294.3823370598, 11673.883261167364, 1538.9461368852149, 1852.2776117314258, 1893.3657224829699, 1902.4292712186427, 1931.690929451295, 123703.0, 130044.34977825145, 130355.0, 131451.34274328663, 133172.33413832966, 9771.804563908825, 11340.773184536263, 11448.370339631234, 11557.133215008907, 11943.940280298717, 14526.273686315642, 14716.632084197981, 14738.968272221056, 14744.63138421548, 14788.630284242765, 6752.93247067523, 7093.503454758117, 8573.828523429622, 8606.612702428405, 8646.654133834576, 8468.66125354979, 8570.871436928452, 8578.356623253281, 8713.912860871436, 8743.91256087431, 4508.368828364031, 4600.4479462464715, 4640.883977900579, 4652.953085555723, 4704.95295047052, 1612.2019600297692, 1632.8938618989728, 1711.9144042797811, 1791.3282519055354, 1855.6659801235637, 895.8163576466809, 896.7758060484879, 977.8973207813077, 980.54404701814, 1040.4381633917599, 17745.822541774418, 21527.0, 22033.77966220317, 22115.89420528967, 22199.44501387478, 815.3192084609418, 915.3683958068912, 932.5244125496046, 945.8177278401997, 956.1633570625703, 11343.149263805248, 11408.087353011739, 11552.884471155181, 11568.24806387582, 11689.883101169049, 222972.0, 224465.0, 225733.0, 388800.0, 597274.0, 97262.51368743111, 126383.0, 128842.0, 133143.0, 134492.0, 796.5579103597559, 971.815355082532, 994.3450985867606, 994.3834822410007, 996.1333639733479, 19379.903100484407, 19543.70684439763, 19603.31388401399, 19614.90192549028, 19704.0, 52389.21416178684, 53279.467205329, 53965.460345397616, 54936.450635493136, 55614.0, 74088.62955685187, 77747.0, 79449.60275198588, 80506.5974670123, 82632.58683706544, 6242.219722534684, 7197.784066478014, 7504.474686771873, 7692.230776922263, 7850.842983140419, 11527.654170374566, 13199.538016169388, 13305.201687898758, 13441.731165376834, 13743.518976835763, 10037.598496060076, 11373.601923932623, 11532.308061516336, 11919.463624137108, 11931.0, 8062.919370806217, 8961.283097352065, 10921.890781092088, 11497.491856026647, 11995.700107497383, 11565.942170289094, 11725.530978760755, 11728.76542469163, 11741.706457338634, 12112.576059837864, 7004.229534751275, 7268.309510596485, 7445.478816482794, 7591.620418978919, 7825.060992680915, 10717.089047431056, 11417.31496110236, 11570.247933884608, 11578.247413918069, 11901.464434100313], "value": 9261.042601975687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.5107135895396, 1466.2668665667165, 1509.0945432740357, 1803.1885651456848, 1873.4192400355882, 7578.204288549706, 8073.031236251658, 8761.868571971418, 9363.39137956034, 9394.0, 6977.720891164347, 7502.249775022495, 7927.365810735142, 8958.776030599238, 9324.0, 2372.21716833445, 2412.626042963335, 2414.14297924237, 2420.322309753272, 2429.5626787178303, 1996.1616121229047, 2379.2148590965026, 2426.2842461473906, 2426.915057972971, 2435.2815919303757, 2409.8433601815827, 2412.7345991940874, 2420.4674971506242, 2421.9394515137174, 2431.3070774829175, 2394.7006624171977, 2406.0736616402723, 2417.033186725306, 2419.3104965084954, 2425.0299880047946, 2383.4398916254668, 2398.2085911649115, 2400.2199285232196, 2405.314485371661, 2416.0698131219433, 9102.45385276879, 9172.2203612693, 9177.495237761921, 9199.54002299889, 9243.399179053407, 5408.621396502246, 5537.197106419547, 5541.806036788693, 5551.91737611166, 5569.498745112959, 3723.236736469017, 3723.441483777428, 3726.888193354204, 3760.341434640159, 3806.543214814212, 1116.5031560955379, 1122.2649164797072, 1133.8015847226784, 1138.618562781461, 1793.9282428702836, 12081.758364832742, 12084.818727719092, 12453.1905426147, 12457.688557786129, 12488.438020289108, 3994.720369574102, 4394.802233899418, 4704.50602686713, 4755.358026666356, 4800.1119792838435, 9271.582778774971, 9530.714078577654, 9533.523323833919, 9542.90457095434, 9550.331476796697, 5372.167314066326, 5374.408815030343, 5377.7580008899695, 5383.569314454834, 5406.59450541211, 4502.099580083996, 4571.9314210286875, 4970.403551573762, 5018.247262910592, 5051.570616497565, 3778.3576791945434, 3855.768653880776, 3903.921921561553, 3956.7625942443547, 3966.1671049080014, 1209.7459533497888, 1218.939053047344, 1221.267239656199, 1226.8282440458343, 1232.87671232876, 776.856281587908, 903.8689390038408, 928.3687092776842, 942.3262367407336, 952.9231967876394, 5836.387179346192, 5904.7342869570975, 6193.287771906198, 6209.65846878417, 6213.347598502182, 393.53366260980255, 437.6608128700219, 443.33057083803044, 459.7839015662633, 461.28270539311694, 4014.9397759033636, 4041.6968727345566, 4053.493313335833, 4160.209560183555, 4164.937525937053, 8423.410361274775, 11091.389973551371, 11319.320840749582, 11321.433928303552, 11351.772964540663, 9258.90741092594, 11157.27477713946, 11258.099352051817, 11288.492017859051, 11290.266132701512, 7338.853222935511, 8171.346292296602, 8248.381371397169, 8251.33989280856, 8595.398322117517, 5936.28764548257, 6029.0, 6045.425684559959, 6073.30157031947, 6163.322034576283, 10153.0, 10164.237682173718, 10352.275340726077, 10486.895131048592, 10512.421816799844, 10731.034206921415, 10773.138148948223, 10788.622398216025, 10793.67618971432, 10836.512356943798, 6711.731530738716, 7070.04554385172, 7230.349268565644, 7333.266673332624, 7415.295546923034, 8745.344099192458, 8801.427907186013, 8891.510377094424, 8901.554922253732, 8910.643574256957, 7766.611669416619, 7859.52842829432, 7884.645190966535, 7966.721164759206, 8019.438639295427, 7549.698012079455, 7681.961590192013, 7682.231776822273, 7736.187700291388, 7766.922330776846, 7198.676059577437, 7250.528715633467, 7255.4921155518605, 7323.560586364835, 7325.523840950321, 4929.0, 5059.46875578059, 5153.433122356463, 5243.265942767939, 5312.548433383051, 4031.6976226783695, 5129.153689641167, 5159.0, 5166.173412254021, 5313.787448502017], "value": 4579.859299474999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.3218697480039, 302.7774585679525, 307.73227292255734, 316.6896441487344, 316.7893350921636, 4708.69393489423, 5517.531009864157, 5520.806771762989, 5624.606277560572, 5736.971315143423, 5055.469175736541, 5643.106256682886, 5653.519450846673, 5670.461306175917, 5680.545556355492, 3756.4365345198166, 4346.282863327548, 4349.43457350544, 4361.411209486726, 4366.19225443294, 3974.18529201513, 4229.725067870594, 4305.031367942203, 4386.605205531501, 4387.780610969438, 3838.2707285615643, 4129.6696264298935, 4204.960594111853, 4227.471566054243, 4254.9789649348995, 4230.725002874834, 4242.1727763086365, 4250.893727656802, 4255.3829694694405, 4278.893027674302, 3554.751167418282, 3671.210689701727, 3675.3016926784094, 3675.7978311192874, 3679.6136405677285, 4679.74261415622, 5455.236266922594, 5476.890462190774, 5490.533304669068, 5526.744406806776, 3812.4281357796276, 3970.68234541236, 4052.0882801369753, 4812.590929770974, 4900.828471003533, 5489.972550137264, 5952.9702351488395, 5983.252093488314, 5987.970060149672, 5998.8500287492725, 4094.467719196485, 4128.876133715993, 4161.292580261363, 4172.374143878412, 4210.305299625558, 6217.911865423533, 6323.841903952392, 6363.459105975998, 6367.204099487564, 6405.391487808651, 3749.8312575934146, 3996.780177090288, 4088.5298190707854, 4115.753054816661, 4205.663546916239, 4258.978705106455, 4268.40242366069, 4274.038341373166, 4290.570942905684, 4297.505786834491, 4896.951030489649, 4969.850904472872, 4970.627202959792, 5000.2749601307605, 5003.874903127451, 5277.894442111136, 5468.0, 5669.291338582677, 6070.998285282879, 6082.787102451393, 1122.5799363804792, 1241.8696036916174, 1249.8875101240933, 1407.465163237963, 1481.3704175725488, 877.8288233794349, 897.1701176411793, 912.6623149434752, 923.8013827027087, 925.8518637018045, 4259.74441533509, 4510.368548403226, 4531.281231261217, 4636.976815115903, 4750.5249475052215, 4831.492693267227, 5214.348206474191, 5245.580353571705, 5303.443138470482, 5310.831617044244, 4040.959590404117, 4206.72656277341, 4300.892477688083, 4356.736546401571, 4512.548745125461, 2412.5295567364196, 2500.2624225853415, 2534.6451496790464, 2612.4905643399734, 2763.806533542673, 4722.834700785525, 4848.539388758062, 5020.196768517019, 5052.0, 5375.381831089475, 5301.966116607225, 5315.388730295988, 5333.373306151777, 5357.276767636397, 5760.308762948389, 5989.610675306091, 6311.810645680637, 6412.35876412355, 6435.646039467874, 6454.644994525346, 6018.585632376476, 6240.812775616739, 6260.7495700171485, 6274.6548939808745, 6288.339724329063, 5347.438518955453, 5903.486161838226, 6048.818535443944, 6150.477209437248, 6157.476614487819, 5591.776328946797, 6408.711607977745, 6412.807615771534, 6423.486121110206, 6429.903551446826, 3881.456596076495, 3930.705197110171, 4005.9799701002476, 4042.1511482588985, 4059.4925634295714, 5689.743961521659, 5691.943080569141, 6139.3553676863285, 6170.938290617037, 6202.937970620236, 4773.785179666854, 5349.358077030781, 6023.969880150571, 6026.819195423969, 6036.3058248302, 5919.763209471573, 5938.673372964528, 5981.192539007352, 5983.350156404503, 6000.759969601167, 4627.838025669085, 4893.804247830047, 5852.092925596539, 5902.557308201816, 5921.674307912934, 4383.846565370197, 4924.236743304794, 5140.588752899834, 5538.778448862162, 5885.73514191871, 4792.400949881265, 5087.796488140581, 5382.761964748208, 5594.4125866785025, 5732.512736417451], "value": 4195.516882994792, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.9911651325231, 603.3031848215312, 650.7234425369217, 698.7763915547024, 718.3463048625752, 15250.313735881884, 15941.760873586905, 16067.357305707787, 16082.678346433064, 16107.597310067255, 11433.885661143386, 14166.787498187536, 14427.134371937691, 14427.495037673683, 14464.421423143061, 835.1773503099457, 841.4488510025943, 858.9871151932726, 862.3446180902528, 863.4560227056945, 670.4334837062675, 823.555280148719, 853.9914600854005, 854.1415877043562, 857.1899554920602, 896.2471523919907, 905.4250550900193, 906.2795077913075, 910.008091180613, 911.2482202183226, 901.0, 901.8466860633675, 903.1014140929784, 904.2494729374604, 907.9954600227022, 661.0678942690782, 669.4945316286221, 669.608279156689, 670.8893032649607, 671.8958561422987, 13913.652158696012, 15009.774853377208, 15012.324445399983, 15021.924890375587, 15065.472708455261, 14578.854211457856, 14629.341679624442, 14676.19280939548, 14764.409423623043, 15010.924945375313, 11857.110716696283, 12005.279683219034, 12086.093542984223, 12117.697057573543, 12191.0, 3784.432335149722, 3842.51968503937, 3845.5193100862393, 3856.8842934711724, 3976.0457490202434, 102202.48898755533, 110746.0, 111147.0, 116047.4197629015, 117764.0, 11289.604863829727, 11379.487923043484, 11411.714707132389, 11631.88368116308, 11951.820722689166, 20075.899620502096, 21279.042443089787, 23465.765342346698, 23476.0, 23522.941467634, 8176.877346839802, 8290.792730181673, 8385.268555492747, 8481.575921203916, 8495.957520212483, 3621.2576421833987, 4558.475775285885, 4587.08258348325, 4721.929171062437, 4755.809767609257, 3338.365710515043, 3478.89563313101, 3486.2504561519395, 3496.021114088059, 3504.491848681927, 621.0994058615026, 629.4366541944934, 637.346719612401, 648.4196644003684, 650.4991156809231, 507.4874376879378, 579.6927628356977, 599.7884273767054, 625.0496859845731, 634.8190765631773, 8849.955750221336, 8938.68714594986, 9058.275337972946, 9098.272138228926, 9347.813043739086, 599.6611914268511, 629.4618101523223, 630.3003665930813, 634.5780056262533, 652.3052948609716, 3842.8462861485787, 4304.80628371724, 4307.906099558303, 4614.400127983341, 4628.143793398232, 124123.75876241122, 159893.2005339966, 160893.0, 161946.19026905025, 168039.0, 114059.42970285096, 115654.42172789082, 133755.33122334522, 138000.30999844937, 145598.0, 71092.64453677699, 96456.0, 107497.0, 108852.45573772081, 114287.0, 9132.767076444596, 9192.862107068266, 9226.98503164638, 9443.338966272295, 10137.89862101399, 44507.55492445164, 58639.827203454835, 62323.376766233574, 62637.37362626316, 63101.36898631138, 70622.0, 73275.0, 74492.0, 86254.56872715596, 95203.0, 12970.546030888874, 12983.221006739626, 13280.601581952556, 13303.0, 13590.86409135896, 14739.778903316674, 14775.261236937895, 14805.777913331092, 14975.475858344906, 15460.738400947634, 12850.036247281305, 13643.386047627682, 13883.930580347034, 14020.859791402363, 14148.43406263738, 12248.387580620754, 13348.666283342995, 13689.0, 13728.45086196541, 14397.928010359881, 13348.666283342995, 13439.193648381128, 13716.862831371558, 13741.793873091712, 13946.930265348608, 11175.161862860481, 11275.605353812578, 11536.78863719331, 11639.243449175776, 11853.111016673956, 9065.456072635663, 9772.85340719904, 10219.335743176669, 10961.671149865517, 11745.765084698087], "value": 7741.407003981661, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 132.0, 156.0, 161.0, 115.0, 117.0, 119.0, 117.0, 117.0, 116.0], "value": 125.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 175.0, 195.0, 111.0, 130.0, 125.0, 118.0, 147.0, 130.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 211.0, 258.0, 274.0, 196.0, 200.0, 195.0, 198.0, 193.0, 192.0], "value": 212.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 82.0, 97.0, 167.0, 58.0, 60.0, 62.0, 76.0, 139.0, 50.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 122.0, 77.0, 64.0, 117.0, 97.0, 56.0, 97.0, 151.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 119.0, 89.0, 94.0, 90.0, 84.0, 137.0, 88.0, 89.0, 88.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 96.0, 94.0, 97.0, 94.0, 96.0, 99.0, 93.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 149.0, 150.0, 95.0, 90.0, 92.0, 92.0, 136.0, 100.0, 78.0], "value": 105.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 61.0, 56.0, 59.0, 61.0, 58.0, 58.0, 57.0, 60.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 68.0, 73.0, 70.0, 84.0, 74.0, 69.0, 69.0, 69.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 91.0, 85.0, 88.0, 106.0, 108.0, 78.0, 98.0, 109.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 136.0, 139.0, 173.0, 151.0, 141.0, 176.0, 168.0, 160.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 173.0, 171.0, 171.0, 170.0, 186.0, 238.0, 239.0, 217.0], "value": 191.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 71.0, 74.0, 70.0, 92.0, 69.0, 67.0, 67.0, 66.0], "value": 70.7, "unit": "score"}]}]} 10:19:10 INFO - Return code: 0 10:19:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:19:10 ERROR - # TBPL SUCCESS # 10:19:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:19:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:19:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:19:10 INFO - 2016-08-16 10:19:10.826 screenresolution[1671:10312] starting screenresolution argv=screenresolution get 10:19:10 INFO - 2016-08-16 10:19:10.828 screenresolution[1671:10312] Display 0: 1600x1200x32@60 10:19:10 INFO - 2016-08-16 10:19:10.834 screenresolution[1672:10315] starting screenresolution argv=screenresolution list 10:19:10 INFO - Available Modes on Display 0 10:19:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:19:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:19:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:19:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:19:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:19:11 INFO - Intel Iris: 10:19:11 INFO - Chipset Model: Intel Iris 10:19:11 INFO - Type: GPU 10:19:11 INFO - Bus: Built-In 10:19:11 INFO - VRAM (Dynamic, Max): 1536 MB 10:19:11 INFO - Vendor: Intel (0x8086) 10:19:11 INFO - Device ID: 0x0a2e 10:19:11 INFO - Revision ID: 0x0009 10:19:11 INFO - Displays: 10:19:11 INFO - Display: 10:19:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:19:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:19:11 INFO - Display Serial Number: 1600x1200 60 10:19:11 INFO - Main Display: Yes 10:19:11 INFO - Mirror: Off 10:19:11 INFO - Online: Yes 10:19:11 INFO - Rotation: Supported 10:19:11 INFO - Return code: 0 10:19:11 INFO - Running post-action listener: _resource_record_post_action 10:19:11 INFO - [mozharness: 2016-08-16 17:19:11.069689Z] Finished run-tests step (success) 10:19:11 INFO - Running post-run listener: _resource_record_post_run 10:19:11 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37184512; Write bytes: 705992192; Read time: 237; Write time: 1948 10:19:11 INFO - TinderboxPrint: CPU usage
54.3% 10:19:11 INFO - TinderboxPrint: I/O read bytes / time
37,184,512 / 237 10:19:11 INFO - TinderboxPrint: I/O write bytes / time
705,992,192 / 1,948 10:19:11 INFO - TinderboxPrint: CPU idle
2,212.8 (45.7%) 10:19:11 INFO - TinderboxPrint: CPU system
977.4 (20.2%) 10:19:11 INFO - TinderboxPrint: CPU user
1,655.4 (34.2%) 10:19:11 INFO - TinderboxPrint: Swap in / out
456,663,040 / 0 10:19:11 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 270336; Write bytes: 407320064; Read time: 4; Write time: 819 10:19:11 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34436096; Write bytes: 297070592; Read time: 215; Write time: 1122 10:19:11 INFO - Running post-run listener: _upload_blobber_files 10:19:11 INFO - Blob upload gear active. 10:19:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:19:12 INFO - (blobuploader) - INFO - Open directory for files ... 10:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:19:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:12 INFO - (blobuploader) - INFO - Done attempting. 10:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:19:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:13 INFO - (blobuploader) - INFO - Done attempting. 10:19:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:19:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:19:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:19:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:19:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:19:15 INFO - (blobuploader) - INFO - Done attempting. 10:19:15 INFO - (blobuploader) - INFO - Iteration through files over. 10:19:15 INFO - Return code: 0 10:19:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:19:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:19:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9be51d8de62f502626e07786f9295ee2cf28f5d187130b4bff9c770e30862062e72db650ed18753f293d11e989314883acd39897abaa7873730196988494ccfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a774a64026632490088b4e1b562c1bc8f8900f596e008d2275f8718e21d1f3a10482e682fb8721f70d133f1d87a450f267af66e35f8b03517ab95a05bb5f8438", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37110ebfcf69b4df9b9a2a597bc746018cbeb2b0887b430763d88aa3dbaa06db5c379893ae027056414a4ec77c20a1879872cd1b41e1dfdfa7d89c88203a8d29"} 10:19:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:15 INFO - Contents: 10:19:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9be51d8de62f502626e07786f9295ee2cf28f5d187130b4bff9c770e30862062e72db650ed18753f293d11e989314883acd39897abaa7873730196988494ccfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a774a64026632490088b4e1b562c1bc8f8900f596e008d2275f8718e21d1f3a10482e682fb8721f70d133f1d87a450f267af66e35f8b03517ab95a05bb5f8438", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37110ebfcf69b4df9b9a2a597bc746018cbeb2b0887b430763d88aa3dbaa06db5c379893ae027056414a4ec77c20a1879872cd1b41e1dfdfa7d89c88203a8d29"} 10:19:15 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:15 INFO - Copying logs to upload dir... 10:19:15 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.071283 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-16 10:19:15.968015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 10:19:15.971990) ========= 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.ijCS41V5MA/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.jFZW9buryK/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9be51d8de62f502626e07786f9295ee2cf28f5d187130b4bff9c770e30862062e72db650ed18753f293d11e989314883acd39897abaa7873730196988494ccfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a774a64026632490088b4e1b562c1bc8f8900f596e008d2275f8718e21d1f3a10482e682fb8721f70d133f1d87a450f267af66e35f8b03517ab95a05bb5f8438", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37110ebfcf69b4df9b9a2a597bc746018cbeb2b0887b430763d88aa3dbaa06db5c379893ae027056414a4ec77c20a1879872cd1b41e1dfdfa7d89c88203a8d29"} build_url:https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/OGy_Wk9FRxCQDzppmqcTBQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9be51d8de62f502626e07786f9295ee2cf28f5d187130b4bff9c770e30862062e72db650ed18753f293d11e989314883acd39897abaa7873730196988494ccfa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a774a64026632490088b4e1b562c1bc8f8900f596e008d2275f8718e21d1f3a10482e682fb8721f70d133f1d87a450f267af66e35f8b03517ab95a05bb5f8438", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/37110ebfcf69b4df9b9a2a597bc746018cbeb2b0887b430763d88aa3dbaa06db5c379893ae027056414a4ec77c20a1879872cd1b41e1dfdfa7d89c88203a8d29"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 10:19:16.004902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:19:16.005218) ========= 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.ijCS41V5MA/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.jFZW9buryK/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.005202 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:19:16.053293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 10:19:16.053607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 10:19:16.053928) ========= ========= Total master_lag: 0.17 =========