builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0247 starttime: 1486458594.68 results: success (0) buildid: 20170206235856 builduid: 27dde39d073d4fd89f33dc6998168a34 revision: 4116e3e124601c356950880ad01f015626b21345 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:54.676015) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:54.676381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:54.676652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:54.700917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:54.701201) ========= 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.jfXzFANat8/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.eOpS7KN3Jz/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 --2017-02-07 01:09:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2017-02-07 01:09:55 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.637094 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:55.368515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:55.368788) ========= 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.jfXzFANat8/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.eOpS7KN3Jz/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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.020279 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:55.443164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 01:09:55.443465) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4116e3e124601c356950880ad01f015626b21345 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4116e3e124601c356950880ad01f015626b21345 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jfXzFANat8/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.eOpS7KN3Jz/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 2017-02-07 01:09:55,537 truncating revision to first 12 chars 2017-02-07 01:09:55,537 Setting DEBUG logging. 2017-02-07 01:09:55,537 attempt 1/10 2017-02-07 01:09:55,537 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4116e3e12460?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 01:09:56,625 unpacking tar archive at: mozilla-aurora-4116e3e12460/testing/mozharness/ program finished with exit code 0 elapsedTime=1.344814 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 01:09:56.812044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:56.812351) ========= script_repo_revision: 4116e3e124601c356950880ad01f015626b21345 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:56.812744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:56.813023) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 01:09:56.832349) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-07 01:09:56.832615) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jfXzFANat8/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.eOpS7KN3Jz/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:09:57 INFO - MultiFileLogger online at 20170207 01:09:57 in /builds/slave/test 01:09:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:09:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:09:57 INFO - {'append_to_log': False, 01:09:57 INFO - 'base_work_dir': '/builds/slave/test', 01:09:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:09:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:09:57 INFO - 'branch': 'Mozilla-Aurora', 01:09:57 INFO - 'buildbot_json_path': 'buildprops.json', 01:09:57 INFO - 'config_files': ('talos/mac_config.py',), 01:09:57 INFO - 'default_actions': ('clobber', 01:09:57 INFO - 'read-buildbot-config', 01:09:57 INFO - 'download-and-extract', 01:09:57 INFO - 'populate-webroot', 01:09:57 INFO - 'create-virtualenv', 01:09:57 INFO - 'install', 01:09:57 INFO - 'run-tests'), 01:09:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:09:57 INFO - 'download_minidump_stackwalk': True, 01:09:57 INFO - 'download_symbols': 'ondemand', 01:09:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:09:57 INFO - 'tooltool.py': '/tools/tooltool.py', 01:09:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:09:57 INFO - '/tools/misc-python/virtualenv.py')}, 01:09:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:09:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:09:57 INFO - 'installer_path': 'installer.exe', 01:09:57 INFO - 'log_level': 'info', 01:09:57 INFO - 'log_name': 'talos', 01:09:57 INFO - 'log_to_console': True, 01:09:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:09:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:09:57 INFO - 'opt_config_files': (), 01:09:57 INFO - 'pip_index': False, 01:09:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:09:57 INFO - 'cmd': ('bash', 01:09:57 INFO - '-c', 01:09:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:09:57 INFO - 'enabled': True, 01:09:57 INFO - 'halt_on_failure': False, 01:09:57 INFO - 'name': 'check_screen_resolution'},), 01:09:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:09:57 INFO - 'cmd': ('bash', 01:09:57 INFO - '-c', 01:09:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:09:57 INFO - 'enabled': True, 01:09:57 INFO - 'halt_on_failure': False, 01:09:57 INFO - 'name': 'check_screen_resolution'},), 01:09:57 INFO - 'run_cmd_checks_enabled': True, 01:09:57 INFO - 'sps_profile': False, 01:09:57 INFO - 'sps_profile_interval': 0, 01:09:57 INFO - 'suite': 'dromaeojs-e10s', 01:09:57 INFO - 'system_bits': '32', 01:09:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:09:57 INFO - 'title': 't-yosemite-r7-0247', 01:09:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:09:57 INFO - 'use_talos_json': True, 01:09:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:09:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:09:57 INFO - 'work_dir': 'build'} 01:09:57 INFO - [mozharness: 2017-02-07 09:09:57.040949Z] Running clobber step. 01:09:57 INFO - Running pre-action listener: _resource_record_pre_action 01:09:57 INFO - Running main action method: clobber 01:09:57 INFO - rmtree: /builds/slave/test/build 01:09:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:09:58 INFO - Running post-action listener: _resource_record_post_action 01:09:58 INFO - [mozharness: 2017-02-07 09:09:58.042599Z] Finished clobber step (success) 01:09:58 INFO - [mozharness: 2017-02-07 09:09:58.042768Z] Running read-buildbot-config step. 01:09:58 INFO - Running pre-action listener: _resource_record_pre_action 01:09:58 INFO - Running main action method: read_buildbot_config 01:09:58 INFO - Using buildbot properties: 01:09:58 INFO - { 01:09:58 INFO - "project": "", 01:09:58 INFO - "product": "firefox", 01:09:58 INFO - "script_repo_revision": "production", 01:09:58 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:09:58 INFO - "repository": "", 01:09:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:09:58 INFO - "buildid": "20170206235856", 01:09:58 INFO - "pgo_build": "False", 01:09:58 INFO - "basedir": "/builds/slave/test", 01:09:58 INFO - "buildnumber": 80, 01:09:58 INFO - "slavename": "t-yosemite-r7-0247", 01:09:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:09:58 INFO - "platform": "yosemite_r7", 01:09:58 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:09:58 INFO - "branch": "mozilla-aurora", 01:09:58 INFO - "repo_path": "releases/mozilla-aurora", 01:09:58 INFO - "revision": "4116e3e124601c356950880ad01f015626b21345", 01:09:58 INFO - "stage_platform": "macosx64", 01:09:58 INFO - "builduid": "27dde39d073d4fd89f33dc6998168a34", 01:09:58 INFO - "slavebuilddir": "test" 01:09:58 INFO - } 01:09:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 01:09:58 INFO - Running post-action listener: _resource_record_post_action 01:09:58 INFO - [mozharness: 2017-02-07 09:09:58.046057Z] Finished read-buildbot-config step (success) 01:09:58 INFO - [mozharness: 2017-02-07 09:09:58.046158Z] Running download-and-extract step. 01:09:58 INFO - Running pre-action listener: _resource_record_pre_action 01:09:58 INFO - Running main action method: download_and_extract 01:09:58 INFO - mkdir: /builds/slave/test/build/tests 01:09: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')]} 01:09:58 INFO - trying https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 01:09:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 01:09:59 INFO - Downloaded 1199 bytes. 01:09:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 01:09:59 INFO - Using the following test package requirements: 01:09:59 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:09:59 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:09:59 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 01:09:59 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:09:59 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 01:09:59 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:09:59 INFO - u'jsshell-mac.zip'], 01:09:59 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:09:59 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 01:09:59 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 01:09:59 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:09:59 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 01:09:59 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:09:59 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 01:09:59 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:09:59 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 01:09:59 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 01:09:59 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 01:09:59 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:09:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:09:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:09:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:10:00 INFO - Expected file size: 16356829 01:10:00 INFO - Obtained file size: 16356829 01:10:07 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:10:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 01:10:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:10:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 01:10:08 INFO - Expected file size: 16356829 01:10:08 INFO - Obtained file size: 16356829 01:10:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 01:10:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:10:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 01:10:16 INFO - Expected file size: 14403485 01:10:16 INFO - Obtained file size: 14403485 01:10: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')]} 01:10:16 INFO - trying https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:10:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 01:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 01:10:18 INFO - Downloaded 73818639 bytes. 01:10:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:10:18 INFO - mkdir: /builds/slave/test/properties 01:10:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:10:18 INFO - Writing to file /builds/slave/test/properties/build_url 01:10:18 INFO - Contents: 01:10:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 01:10:19 INFO - Running post-action listener: _resource_record_post_action 01:10:19 INFO - Running post-action listener: set_extra_try_arguments 01:10:19 INFO - [mozharness: 2017-02-07 09:10:19.386829Z] Finished download-and-extract step (success) 01:10:19 INFO - [mozharness: 2017-02-07 09:10:19.386950Z] Running populate-webroot step. 01:10:19 INFO - Running pre-action listener: _resource_record_pre_action 01:10:19 INFO - Running main action method: populate_webroot 01:10:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:10:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:10:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:10:19 INFO - '--tppagecycles', 01:10:19 INFO - '7'], 01:10:19 INFO - 'tests': ['tsvgm']}}, 01:10:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:10:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:10:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:10:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:10:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:10:19 INFO - 'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:10:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:10:19 INFO - 'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['damp', 'tps']}, 01:10:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:10:19 INFO - 'tests': ['damp', 'tps']}, 01:10:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['dromaeo_dom']}, 01:10:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:10:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['basic_compositor_video']}, 01:10:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:10:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['a11yr', 01:10:19 INFO - 'ts_paint', 01:10:19 INFO - 'tpaint', 01:10:19 INFO - 'sessionrestore', 01:10:19 INFO - 'sessionrestore_no_auto_restore', 01:10:19 INFO - 'tabpaint']}, 01:10:19 INFO - 'other-e10s': {'tests': ['a11yr', 01:10:19 INFO - 'ts_paint', 01:10:19 INFO - 'tpaint', 01:10:19 INFO - 'sessionrestore', 01:10:19 INFO - 'sessionrestore_no_auto_restore', 01:10:19 INFO - 'tabpaint']}, 01:10:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:10:19 INFO - 'ts_paint', 01:10:19 INFO - 'tpaint', 01:10:19 INFO - 'sessionrestore', 01:10:19 INFO - 'sessionrestore_no_auto_restore', 01:10:19 INFO - 'tabpaint']}, 01:10:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:10:19 INFO - 'ts_paint', 01:10:19 INFO - 'tpaint', 01:10:19 INFO - 'sessionrestore', 01:10:19 INFO - 'sessionrestore_no_auto_restore', 01:10:19 INFO - 'tabpaint']}, 01:10:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['a11yr', 01:10:19 INFO - 'ts_paint', 01:10:19 INFO - 'tpaint', 01:10:19 INFO - 'sessionrestore', 01:10:19 INFO - 'sessionrestore_no_auto_restore', 01:10:19 INFO - 'tabpaint']}, 01:10:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['a11yr', 01:10:19 INFO - 'ts_paint', 01:10:19 INFO - 'tpaint', 01:10:19 INFO - 'sessionrestore', 01:10:19 INFO - 'sessionrestore_no_auto_restore', 01:10:19 INFO - 'tabpaint']}, 01:10:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['tsvgx', 01:10:19 INFO - 'tsvgr_opacity', 01:10:19 INFO - 'tart', 01:10:19 INFO - 'tscrollx', 01:10:19 INFO - 'cart', 01:10:19 INFO - 'tsvg_static']}, 01:10:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:10:19 INFO - 'tsvgr_opacity', 01:10:19 INFO - 'tart', 01:10:19 INFO - 'tscrollx', 01:10:19 INFO - 'cart', 01:10:19 INFO - 'tsvg_static']}, 01:10:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:10:19 INFO - 'talos_options': ['--disable-e10s'], 01:10:19 INFO - 'tests': ['tp5o']}, 01:10:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:10:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:10:19 INFO - 'talos_options': ['--disable-e10s', 01:10:19 INFO - '--xperf_path', 01:10:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:19 INFO - 'tests': ['tp5n']}, 01:10:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:10:19 INFO - 'talos_options': ['--xperf_path', 01:10:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:19 INFO - 'tests': ['tp5n']}}, 01:10:19 INFO - 'talos.zip': {'path': '', 01:10:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:10:19 INFO - Running post-action listener: _resource_record_post_action 01:10:19 INFO - [mozharness: 2017-02-07 09:10:19.405766Z] Finished populate-webroot step (success) 01:10:19 INFO - [mozharness: 2017-02-07 09:10:19.405878Z] Running create-virtualenv step. 01:10:19 INFO - Running pre-action listener: _resource_record_pre_action 01:10:19 INFO - Running main action method: create_virtualenv 01:10:19 INFO - Creating virtualenv /builds/slave/test/build/venv 01:10:19 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 01:10:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:10:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:10:19 INFO - Using real prefix '/tools/python27' 01:10:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:10:20 INFO - Installing distribute.............................................................................................................................................................................................done. 01:10:23 INFO - Installing pip.................done. 01:10:23 INFO - Return code: 0 01:10:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:10:23 INFO - Reading from file tmpfile_stdout 01:10:23 INFO - Output received: 01:10:23 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:10:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:10: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')]} 01:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:23 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:23 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 01:10:23 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 01:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:23 INFO - 'HOME': '/Users/cltbld', 01:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:23 INFO - 'LOGNAME': 'cltbld', 01:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:23 INFO - 'MOZ_NO_REMOTE': '1', 01:10:23 INFO - 'NO_EM_RESTART': '1', 01:10:23 INFO - 'PAGER': '/bin/cat', 01:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:23 INFO - 'PWD': '/builds/slave/test', 01:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:23 INFO - 'SHELL': '/bin/bash', 01:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:23 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:23 INFO - 'USER': 'cltbld', 01:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:23 INFO - 'XPC_FLAGS': '0x0', 01:10:23 INFO - 'XPC_SERVICE_NAME': '0', 01:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:23 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 01:10:23 INFO - Cleaning up... 01:10:23 INFO - Return code: 0 01:10:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:10: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')]} 01:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:23 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:23 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 01:10:23 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 01:10:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:23 INFO - 'HOME': '/Users/cltbld', 01:10:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:23 INFO - 'LOGNAME': 'cltbld', 01:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:23 INFO - 'MOZ_NO_REMOTE': '1', 01:10:23 INFO - 'NO_EM_RESTART': '1', 01:10:23 INFO - 'PAGER': '/bin/cat', 01:10:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:23 INFO - 'PWD': '/builds/slave/test', 01:10:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:23 INFO - 'SHELL': '/bin/bash', 01:10:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:23 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:23 INFO - 'USER': 'cltbld', 01:10:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:23 INFO - 'XPC_FLAGS': '0x0', 01:10:23 INFO - 'XPC_SERVICE_NAME': '0', 01:10:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:23 INFO - Downloading/unpacking psutil>=3.1.1 01:10:23 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 01:10:23 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 01:10:23 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 01:10:23 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 01:10:23 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 01:10:23 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 01:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:10:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:27 INFO - Installing collected packages: psutil 01:10:27 INFO - Running setup.py install for psutil 01:10:27 INFO - building 'psutil._psutil_osx' extension 01:10:27 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 01:10:28 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 01:10:28 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 01:10:28 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 01:10:28 INFO - building 'psutil._psutil_posix' extension 01:10:28 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 01:10:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:10:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:10:28 INFO - ^ 01:10:28 INFO - 1 warning generated. 01:10:28 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 01:10:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:28 INFO - Successfully installed psutil 01:10:28 INFO - Cleaning up... 01:10:28 INFO - Return code: 0 01:10:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:28 INFO - 'HOME': '/Users/cltbld', 01:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:28 INFO - 'LOGNAME': 'cltbld', 01:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:28 INFO - 'MOZ_NO_REMOTE': '1', 01:10:28 INFO - 'NO_EM_RESTART': '1', 01:10:28 INFO - 'PAGER': '/bin/cat', 01:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:28 INFO - 'PWD': '/builds/slave/test', 01:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:28 INFO - 'SHELL': '/bin/bash', 01:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:28 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:28 INFO - 'USER': 'cltbld', 01:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:28 INFO - 'XPC_FLAGS': '0x0', 01:10:28 INFO - 'XPC_SERVICE_NAME': '0', 01:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:10:31 INFO - Installing collected packages: mozsystemmonitor 01:10:31 INFO - Running setup.py install for mozsystemmonitor 01:10:31 INFO - Successfully installed mozsystemmonitor 01:10:31 INFO - Cleaning up... 01:10:31 INFO - Return code: 0 01:10:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:31 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:31 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 01:10:31 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 01:10:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:31 INFO - 'HOME': '/Users/cltbld', 01:10:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:31 INFO - 'LOGNAME': 'cltbld', 01:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:31 INFO - 'MOZ_NO_REMOTE': '1', 01:10:31 INFO - 'NO_EM_RESTART': '1', 01:10:31 INFO - 'PAGER': '/bin/cat', 01:10:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:31 INFO - 'PWD': '/builds/slave/test', 01:10:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:31 INFO - 'SHELL': '/bin/bash', 01:10:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:31 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:31 INFO - 'USER': 'cltbld', 01:10:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:31 INFO - 'XPC_FLAGS': '0x0', 01:10:31 INFO - 'XPC_SERVICE_NAME': '0', 01:10:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:32 INFO - Downloading/unpacking jsonschema==2.5.1 01:10: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 01:10: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 01:10: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 01:10: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 01:10: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 01:10: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 01:10:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:10:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:10:34 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 01:10:34 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 01:10:34 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 01:10:34 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 01:10:34 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 01:10:34 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 01:10:35 INFO - Downloading functools32-3.2.3-2.tar.gz 01:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:10:35 INFO - warning: no files found matching '*.txt' 01:10:35 INFO - no previously-included directories found matching 'build' 01:10:35 INFO - no previously-included directories found matching 'dist' 01:10:35 INFO - no previously-included directories found matching '.git*' 01:10:35 INFO - Installing collected packages: jsonschema, functools32 01:10:35 INFO - Running setup.py install for functools32 01:10:35 INFO - warning: no files found matching '*.txt' 01:10:35 INFO - no previously-included directories found matching 'build' 01:10:35 INFO - no previously-included directories found matching 'dist' 01:10:35 INFO - no previously-included directories found matching '.git*' 01:10:35 INFO - Successfully installed jsonschema functools32 01:10:35 INFO - Cleaning up... 01:10:35 INFO - Return code: 0 01:10:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:35 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:35 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 01:10:35 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 01:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:35 INFO - 'HOME': '/Users/cltbld', 01:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:35 INFO - 'LOGNAME': 'cltbld', 01:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:35 INFO - 'MOZ_NO_REMOTE': '1', 01:10:35 INFO - 'NO_EM_RESTART': '1', 01:10:35 INFO - 'PAGER': '/bin/cat', 01:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:35 INFO - 'PWD': '/builds/slave/test', 01:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:35 INFO - 'SHELL': '/bin/bash', 01:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:35 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:35 INFO - 'USER': 'cltbld', 01:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:35 INFO - 'XPC_FLAGS': '0x0', 01:10:35 INFO - 'XPC_SERVICE_NAME': '0', 01:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:10:35 INFO - Cleaning up... 01:10:35 INFO - Return code: 0 01:10:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:35 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:35 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 01:10:35 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 01:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:35 INFO - 'HOME': '/Users/cltbld', 01:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:35 INFO - 'LOGNAME': 'cltbld', 01:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:35 INFO - 'MOZ_NO_REMOTE': '1', 01:10:35 INFO - 'NO_EM_RESTART': '1', 01:10:35 INFO - 'PAGER': '/bin/cat', 01:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:35 INFO - 'PWD': '/builds/slave/test', 01:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:35 INFO - 'SHELL': '/bin/bash', 01:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:35 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:35 INFO - 'USER': 'cltbld', 01:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:35 INFO - 'XPC_FLAGS': '0x0', 01:10:35 INFO - 'XPC_SERVICE_NAME': '0', 01:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:35 INFO - Downloading/unpacking blobuploader==1.2.4 01:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:38 INFO - Downloading blobuploader-1.2.4.tar.gz 01:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:10:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:38 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 01:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:10:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:39 INFO - Downloading docopt-0.6.1.tar.gz 01:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:10:39 INFO - Installing collected packages: blobuploader, requests, docopt 01:10:39 INFO - Running setup.py install for blobuploader 01:10:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:10:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:10:40 INFO - Running setup.py install for requests 01:10:40 INFO - Running setup.py install for docopt 01:10:40 INFO - Successfully installed blobuploader requests docopt 01:10:40 INFO - Cleaning up... 01:10:40 INFO - Return code: 0 01:10:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10: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')]} 01:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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')]} 01:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:40 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:40 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 01:10:40 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 01:10:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:40 INFO - 'HOME': '/Users/cltbld', 01:10:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:40 INFO - 'LOGNAME': 'cltbld', 01:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:40 INFO - 'MOZ_NO_REMOTE': '1', 01:10:40 INFO - 'NO_EM_RESTART': '1', 01:10:40 INFO - 'PAGER': '/bin/cat', 01:10:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:40 INFO - 'PWD': '/builds/slave/test', 01:10:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:40 INFO - 'SHELL': '/bin/bash', 01:10:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:40 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:40 INFO - 'USER': 'cltbld', 01:10:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:40 INFO - 'XPC_FLAGS': '0x0', 01:10:40 INFO - 'XPC_SERVICE_NAME': '0', 01:10:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-3ZkYjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-rOEw7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-FfLQY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-cr8xdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-eNqanu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-wpEolC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-3Yuh6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-99w4Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:41 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-PGlT6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-vX7vbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-Jwvda3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-cTIMbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-I_Gwvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-Q2otpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-rqJP5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-IKZQaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:42 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-bLJI03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:10:42 INFO - Running setup.py install for manifestparser 01:10:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:10:43 INFO - Running setup.py install for mozcrash 01:10:43 INFO - Running setup.py install for mozdebug 01:10:43 INFO - Running setup.py install for mozdevice 01:10:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:10:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:10:43 INFO - Running setup.py install for mozfile 01:10:43 INFO - Running setup.py install for mozhttpd 01:10:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:10:43 INFO - Running setup.py install for mozinfo 01:10:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:10:43 INFO - Running setup.py install for mozInstall 01:10:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozleak 01:10:44 INFO - Running setup.py install for mozlog 01:10:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for moznetwork 01:10:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozprocess 01:10:44 INFO - Running setup.py install for mozprofile 01:10:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozrunner 01:10:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:10:44 INFO - Running setup.py install for mozscreenshot 01:10:45 INFO - Running setup.py install for moztest 01:10:45 INFO - Running setup.py install for mozversion 01:10:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:10:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:10:45 INFO - Cleaning up... 01:10:45 INFO - Return code: 0 01:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:45 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:45 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 01:10:45 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 01:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:45 INFO - 'HOME': '/Users/cltbld', 01:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:45 INFO - 'LOGNAME': 'cltbld', 01:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:45 INFO - 'MOZ_NO_REMOTE': '1', 01:10:45 INFO - 'NO_EM_RESTART': '1', 01:10:45 INFO - 'PAGER': '/bin/cat', 01:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:45 INFO - 'PWD': '/builds/slave/test', 01:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:45 INFO - 'SHELL': '/bin/bash', 01:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:45 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:45 INFO - 'USER': 'cltbld', 01:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:45 INFO - 'XPC_FLAGS': '0x0', 01:10:45 INFO - 'XPC_SERVICE_NAME': '0', 01:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-HBeRRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:45 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)) 01:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-0XODKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:45 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-p_cWe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-92dhcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-gukopj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-WtN2ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-jSDyO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-W_LyYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-3JainG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-OZHFPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-qP2QVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:46 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:46 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-XeWfWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 01:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:47 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-WZyEEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:47 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)) 01:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:47 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-5ckepS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:47 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-n07njg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:47 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)) 01:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:47 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-55xexU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 01:10:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:47 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-6QAs3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:47 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)) 01:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:10:47 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)) 01:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:10:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:10: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 01:10: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 01:10: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 01:10: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 01:10: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 01:10: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 01:10:50 INFO - Downloading blessings-1.6.tar.gz 01:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:10:50 INFO - Installing collected packages: blessings 01:10:50 INFO - Running setup.py install for blessings 01:10:50 INFO - Successfully installed blessings 01:10:50 INFO - Cleaning up... 01:10:50 INFO - Return code: 0 01:10:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:10:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:50 INFO - Reading from file tmpfile_stdout 01:10:50 INFO - Current package versions: 01:10:50 INFO - blessings == 1.6 01:10:50 INFO - blobuploader == 1.2.4 01:10:50 INFO - docopt == 0.6.1 01:10:50 INFO - functools32 == 3.2.3-2 01:10:50 INFO - jsonschema == 2.5.1 01:10:50 INFO - manifestparser == 1.1 01:10:50 INFO - mozInstall == 1.12 01:10:50 INFO - mozcrash == 1.0 01:10:50 INFO - mozdebug == 0.1 01:10:50 INFO - mozdevice == 0.49 01:10:50 INFO - mozfile == 1.2 01:10:50 INFO - mozhttpd == 0.7 01:10:50 INFO - mozinfo == 0.9 01:10:50 INFO - mozleak == 0.1 01:10:50 INFO - mozlog == 3.4 01:10:50 INFO - moznetwork == 0.27 01:10:50 INFO - mozprocess == 0.24 01:10:50 INFO - mozprofile == 0.28 01:10:50 INFO - mozrunner == 6.13 01:10:50 INFO - mozscreenshot == 0.1 01:10:50 INFO - mozsystemmonitor == 0.3 01:10:50 INFO - moztest == 0.8 01:10:50 INFO - mozversion == 1.4 01:10:50 INFO - psutil == 3.1.1 01:10:50 INFO - requests == 1.2.3 01:10:50 INFO - wsgiref == 0.1.2 01:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:50 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:50 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 01:10:50 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 01:10:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:50 INFO - 'HOME': '/Users/cltbld', 01:10:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:50 INFO - 'LOGNAME': 'cltbld', 01:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:50 INFO - 'MOZ_NO_REMOTE': '1', 01:10:50 INFO - 'NO_EM_RESTART': '1', 01:10:50 INFO - 'PAGER': '/bin/cat', 01:10:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:50 INFO - 'PWD': '/builds/slave/test', 01:10:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:50 INFO - 'SHELL': '/bin/bash', 01:10:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:50 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:50 INFO - 'USER': 'cltbld', 01:10:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:50 INFO - 'XPC_FLAGS': '0x0', 01:10:50 INFO - 'XPC_SERVICE_NAME': '0', 01:10:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 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)) 01:10:51 INFO - Cleaning up... 01:10:51 INFO - Return code: 0 01:10:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:10:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:51 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 0x101fb0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fb3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8222473800>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, '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.jfXzFANat8/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.eOpS7KN3Jz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 01:10:51 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 01:10:51 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 01:10:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:10:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:51 INFO - 'HOME': '/Users/cltbld', 01:10:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:51 INFO - 'LOGNAME': 'cltbld', 01:10:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:51 INFO - 'MOZ_NO_REMOTE': '1', 01:10:51 INFO - 'NO_EM_RESTART': '1', 01:10:51 INFO - 'PAGER': '/bin/cat', 01:10:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:51 INFO - 'PWD': '/builds/slave/test', 01:10:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:51 INFO - 'SHELL': '/bin/bash', 01:10:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:10:51 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:10:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:51 INFO - 'USER': 'cltbld', 01:10:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:51 INFO - 'XPC_FLAGS': '0x0', 01:10:51 INFO - 'XPC_SERVICE_NAME': '0', 01:10:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:10:51 INFO - Cleaning up... 01:10:51 INFO - Return code: 0 01:10:51 INFO - Running post-action listener: _resource_record_post_action 01:10:51 INFO - Running post-action listener: _start_resource_monitoring 01:10:51 INFO - Starting resource monitoring. 01:10:51 INFO - [mozharness: 2017-02-07 09:10:51.357271Z] Finished create-virtualenv step (success) 01:10:51 INFO - [mozharness: 2017-02-07 09:10:51.358119Z] Running install step. 01:10:51 INFO - Running pre-action listener: _resource_record_pre_action 01:10:51 INFO - Running main action method: install 01:10:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:51 INFO - Reading from file tmpfile_stdout 01:10:51 INFO - Detecting whether we're running mozinstall >=1.0... 01:10:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:10:51 INFO - Reading from file tmpfile_stdout 01:10:51 INFO - Output received: 01:10:51 INFO - Usage: mozinstall [options] installer 01:10:51 INFO - Options: 01:10:51 INFO - -h, --help show this help message and exit 01:10:51 INFO - -d DEST, --destination=DEST 01:10:51 INFO - Directory to install application into. [default: 01:10:51 INFO - "/builds/slave/test"] 01:10:51 INFO - --app=APP Application being installed. [default: firefox] 01:10:51 INFO - mkdir: /builds/slave/test/build/application 01:10:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:11:12 INFO - Reading from file tmpfile_stdout 01:11:12 INFO - Output received: 01:11:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:11:12 INFO - Running post-action listener: _resource_record_post_action 01:11:12 INFO - [mozharness: 2017-02-07 09:11:12.123056Z] Finished install step (success) 01:11:12 INFO - [mozharness: 2017-02-07 09:11:12.123185Z] Running run-tests step. 01:11:12 INFO - Running pre-action listener: _resource_record_pre_action 01:11:12 INFO - Running main action method: run_tests 01:11:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:11:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:11:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:11:12 INFO - 2017-02-07 01:11:12.138 screenresolution[2244:18518] starting screenresolution argv=screenresolution get 01:11:12 INFO - 2017-02-07 01:11:12.140 screenresolution[2244:18518] Display 0: 1600x1200x32@60 01:11:12 INFO - 2017-02-07 01:11:12.146 screenresolution[2245:18520] starting screenresolution argv=screenresolution list 01:11:12 INFO - Available Modes on Display 0 01:11:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:11:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:11:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:11:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:11:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:11:12 INFO - Intel Iris: 01:11:12 INFO - Chipset Model: Intel Iris 01:11:12 INFO - Type: GPU 01:11:12 INFO - Bus: Built-In 01:11:12 INFO - VRAM (Dynamic, Max): 1536 MB 01:11:12 INFO - Vendor: Intel (0x8086) 01:11:12 INFO - Device ID: 0x0a2e 01:11:12 INFO - Revision ID: 0x0009 01:11:12 INFO - Displays: 01:11:12 INFO - Display: 01:11:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:11:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:11:12 INFO - Display Serial Number: 1600x1200 60 01:11:12 INFO - Main Display: Yes 01:11:12 INFO - Mirror: Off 01:11:12 INFO - Online: Yes 01:11:12 INFO - Rotation: Supported 01:11:12 INFO - Return code: 0 01:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:11:12 INFO - Python 2.7.3 01:11:12 INFO - Return code: 0 01:11:12 INFO - grabbing minidump binary from tooltool 01:11:12 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')]} 01:11:12 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 0x101d8ed30>, '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 0x101cb5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d83be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:11:12 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 01:11:12 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 01:11:12 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 01:11:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:11:12 INFO - Return code: 0 01:11:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:11:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:11:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:11:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:11:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:11:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 01:11:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0247 --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 01:11:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jfXzFANat8/Render', 01:11:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:12 INFO - 'HOME': '/Users/cltbld', 01:11:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:12 INFO - 'LOGNAME': 'cltbld', 01:11:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:11:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:11:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:12 INFO - 'MOZ_NO_REMOTE': '1', 01:11:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:11:12 INFO - 'NO_EM_RESTART': '1', 01:11:12 INFO - 'PAGER': '/bin/cat', 01:11:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:12 INFO - 'PWD': '/builds/slave/test', 01:11:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:11:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:12 INFO - 'SHELL': '/bin/bash', 01:11:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eOpS7KN3Jz/Listeners', 01:11:12 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 01:11:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:12 INFO - 'USER': 'cltbld', 01:11:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:12 INFO - 'XPC_FLAGS': '0x0', 01:11:12 INFO - 'XPC_SERVICE_NAME': '0', 01:11:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 01:11:12 INFO - mozversion application_buildid: 20170206235856 01:11:12 INFO - mozversion application_changeset: 4116e3e124601c356950880ad01f015626b21345 01:11:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:11:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:11:12 INFO - mozversion application_name: Firefox 01:11:12 INFO - mozversion application_remotingname: firefox-dev 01:11:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:11:12 INFO - mozversion application_vendor: Mozilla 01:11:12 INFO - mozversion application_version: 53.0a2 01:11:12 INFO - mozversion platform_buildid: 20170206235856 01:11:12 INFO - mozversion platform_changeset: 4116e3e124601c356950880ad01f015626b21345 01:11:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:11:12 INFO - mozversion platform_version: 53.0a2 01:11:12 INFO - using testdate: 1486458672 01:11:12 INFO - actual date: 1486458672 01:11:12 INFO - starting webserver on 'localhost:49594' 01:11:12 INFO - SUITE-START | Running 2 tests 01:11:12 INFO - TEST-START | dromaeo_css 01:11:12 INFO - operating with platform_type : mac_ 01:11:12 INFO - Initialising browser for dromaeo_css test... 01:11:12 INFO - TEST-INFO | started process 2255 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpfAz7dk/profile http://localhost:49594/getInfo.html) 01:11:15 INFO - PROCESS | 2255 | 2017-02-07 01:11:15.336 plugin-container[2257:18682] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9043, name = 'com.apple.tsm.portname' 01:11:15 INFO - PROCESS | 2255 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:11:15 INFO - PROCESS | 2255 | 2017-02-07 01:11:15.339 plugin-container[2257:18682] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950f, name = 'com.apple.CFPasteboardClient' 01:11:15 INFO - PROCESS | 2255 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:11:15 INFO - PROCESS | 2255 | 2017-02-07 01:11:15.339 plugin-container[2257:18682] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:11:15 INFO - PROCESS | 2255 | __metrics Screen width/height:1600/1200 01:11:15 INFO - PROCESS | 2255 | colorDepth:24 01:11:15 INFO - PROCESS | 2255 | Browser inner width/height: 1024/689 01:11:15 INFO - PROCESS | 2255 | __metrics 01:11:15 ERROR - PROCESS | 2255 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 01:11:15 INFO - PROCESS | 2255 | 1486458675507 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpfAz7dk/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpfAz7dk/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpfAz7dk/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpfAz7dk/profile/extensions/talos-powers@TalosPowersService.js:55:9 01:11:16 INFO - TEST-INFO | 2255: exit 0 01:11:16 INFO - Browser initialized. 01:11:16 INFO - Running cycle 1/1 for dromaeo_css test... 01:11:16 INFO - TEST-INFO | started process 2258 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpfAz7dk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:11:18 INFO - PROCESS | 2258 | 2017-02-07 01:11:18.812 plugin-container[2259:18811] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4947, name = 'com.apple.tsm.portname' 01:11:18 INFO - PROCESS | 2258 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:11:18 INFO - PROCESS | 2258 | 2017-02-07 01:11:18.814 plugin-container[2259:18811] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x892f, name = 'com.apple.CFPasteboardClient' 01:11:18 INFO - PROCESS | 2258 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:11:18 INFO - PROCESS | 2258 | 2017-02-07 01:11:18.814 plugin-container[2259:18811] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:11:28 INFO - PROCESS | 2258 | RSS: Main: 218947584 01:11:28 INFO - PROCESS | 2258 | 01:14:30 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49594/tests/dromaeo/cssquery-ext.html) 01:14:32 INFO - PROCESS | 2258 | RSS: Main: 235773952 01:14:32 INFO - PROCESS | 2258 | 01:16:16 INFO - PROCESS | 2258 | ************************* 01:16:16 INFO - PROCESS | 2258 | A coding exception was thrown and uncaught in a Task. 01:16:16 INFO - PROCESS | 2258 | 01:16:16 ERROR - PROCESS | 2258 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:16:16 INFO - PROCESS | 2258 | Full stack: 01:16:16 INFO - PROCESS | 2258 | ************************* 01:17:34 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-ext.html (next: http://localhost:49594/tests/dromaeo/cssquery-jquery.html) 01:17:35 INFO - PROCESS | 2258 | RSS: Main: 246362112 01:17:35 INFO - PROCESS | 2258 | 01:20:37 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49594/tests/dromaeo/cssquery-mootools.html) 01:20:38 INFO - PROCESS | 2258 | RSS: Main: 253288448 01:20:38 INFO - PROCESS | 2258 | 01:23:40 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49594/tests/dromaeo/cssquery-prototype.html) 01:23:40 INFO - PROCESS | 2258 | RSS: Main: 249626624 01:23:40 INFO - PROCESS | 2258 | 01:26:43 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49594/tests/dromaeo/cssquery-yui.html) 01:26:44 INFO - PROCESS | 2258 | RSS: Main: 253710336 01:26:44 INFO - PROCESS | 2258 | 01:29:46 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:49594/tests/dromaeo/cssquery-yui.html (next: http://localhost:49594/tests/dromaeo/cssquery-dojo.html) 01:29:46 INFO - PROCESS | 2258 | RSS: Main: 255119360 01:29:46 INFO - PROCESS | 2258 | 01:29:46 INFO - PROCESS | 2258 | __start_tp_report 01:29:46 INFO - PROCESS | 2258 | _x_x_mozilla_page_load 01:29:46 INFO - PROCESS | 2258 | _x_x_mozilla_page_load_details 01:29:46 INFO - PROCESS | 2258 | |i|pagename|runs| 01:29:47 INFO - PROCESS | 2258 | |0;dojo.html;3301.4222511060557;3312.0891754767435;3332.1503016730762;3338.1153994191527;3344.665533446655;4527.4340707411575;5514.751836167372;5571.0807716726795;5615.241942337783;5642.492175704186;4631;4813.181759100952;5584.720763961806;5639.520640745532;5683;5124.231365295208;5155.072087024334;5185.274061631375;5208.2968799212185;5230.6600070995455;4236.512801027875;5173.198154286091;5228.058949389108;5258.106121959257;5279.472052794728;4728.881777955544;4795.784189711471;5103.055934652101;5107.565856902168;5214.582833373321;5140.66585671932;5147.768350424221;5170.146925757245;5211.42674305826;5271.262023316739;5082.720450375228;5125.641205115643;5131.87170320745;5148.330717006803;5161.406438259611;5491.533219676332;5559.110542313251;5592.636478628876;5713.800016999385;5725.885482290331;6089.939100608982;6105.908411373833;6112;6122.367660829195;6141.662208578527;5512.6968016759065;6129.328227221949;6142.744345496893;6149.631022138686;6158.353372895871;5733.827985160452;5770.336411312669;5779.624324418942;5791.507721843648;5792.478676919098;6120.264288666148;6143.542582966849;6202.379762023852;6242.063690446469;6244.937550624527;6055.545834062463;6104.664243466652;6107.8473038173515;6108.1143234230785;6109.14471973924;6160.043179273884;6170.907436388457;6178.227721534809;6203.534734894901;6218.9378106219265;5400.568849254951;5538.6399884007415;6057.42454466825;6137.601055931439;6174.166487524217;6093.969530152321;6138.38839838597;6145.784897528565;6146.862830376305;6148.985417406078;4919.852404427873;4928.802847886044;4932.506749325039;4954.677945933503;4961.032598643302;4324.524302326741;4332.956670433318;4374.12517496502;4387.3418987151545;4409.294512877988;5745.080787074132;5760.481556659921;5807.128930660435;5868.647881127146;5896.528277737771;6208.782692605737;6257.092721555349;6260.624362538262;6283.8114856554375;6290.528210384239;5325.307709997753;5603.887922241533;5647.463490968352;5661.9808434481365;5838.065909454467;4112.547619761884;5417.322834645669;5432.266644003088;5455.672659640434;5491.862703432366;6286.717097730613;6289.7169627366875;6294.937050629435;6298.937010629835;6302.212223472066;5755.453231942959;6079.392060793885;6118.284172697687;6167.537434692326;6249.656268905072;5097.949020509747;6138.324784273816;6166.383361663977;6230;6230.15892854477;6056.121862330026;6086.330503644507;6093.786717465045;6099.878002440015;6116.082587611894;4756.857294281177;6058.485028772604;6065.059915713072;6128.417800308964;6155.230596175478;5964.224650795369;5979.13302571116;6013.909791353046;6074.514038876968;6124.356942521149;6009.609375390585;6020.90968635462;6037;6038.607490513103;6050.122732203894;5651.745671444877;5898.1152827076285;5903.350631430625;5912.793052243151;5927.051671732502;4904.803807847647;5132.3327967364;5677.914831277451;5883.911741323969;6017.096066705621;5889.970550147222;5892.9116063258225;5905.350411454822;5910.881782364415;5915.970420147872 01:29:47 INFO - PROCESS | 2258 | |1;ext.html;450.99323510147343;455.5512819872427;478.21572620901725;484.3872501285876;490.9018196360729;31341.373172536565;41447.585524144786;41497.79251103744;43526;43574.56425435745;42455;43254;43262.78368608152;43293.7835310823;43404.34893476601;8329.20872517113;9061.275097992162;9384.343095983284;9405.57674904631;9412.199963003153;8383.245507904287;11133.7216569586;11387.715307117347;11393.316401015965;11502.827457588142;11261.66215013551;11274.661760147168;11283.887161128407;11291.943540282287;11355.545778168864;11210.159238057138;11210.551577936872;11285.830712539277;11287;11298.039666628347;11145.442727863656;11237.325760454318;11251.83122253167;11252.831207531894;11272.830907536394;39535.8023209885;39811.20377592461;39836.60163398358;39976.000599984945;39988;3999.42008408782;4005.178938317638;4085.6527195188446;4088.5707000765087;4132.090939993197;24695;29173.708262917313;29205.977790777433;29237.561436578257;29746.85126574375;3010.6151170461612;3117.8285194314303;3368.8147151906637;3395.3548825723283;3403.421418358885;422527.8873605643;463540;471102;482997;483401;53003.469965300625;65247.347526525074;65465;65477;65788.68422631617;68946.65526672335;69091;69330.30669693339;69336.306636934;69510;16497.83502164987;16637.91681041587;16710.4151354702;16715.498535043967;16725.749113763304;11121.110311175087;11314.547418103348;12647.683807904692;12775.61673149807;12910.354482275849;17603.73594396085;18150.727739083923;18681.252749890125;18705.906470467562;18711.71932421015;5333.519983201453;6410.8076757697345;6432.292447830735;6483.805485835433;6506.284308726036;889.9555022248861;894.7315805258396;896.9820603587891;900.7342833864026;922.7001224601897;28964.855175723987;30430.984129519944;30770.076897693107;30790.53814192789;30793.538096928565;1025.9127974122284;1047.8166320893813;1074.5970261152067;1106.756513567014;1107.3245320354577;14213.360398782079;15963.04221746699;15996.280167392495;16303.592410189603;16304.918475407785;594527;594554;595857;596857;597969;61836.38163618396;61960;62104;62247;62280;1430.2920054573053;1449.521657852927;1459.321415541757;1460.1968917095555;1462.8317743459638;29184.124476265744;29651.85174074116;30389.69610303869;30926;30969.535456968613;52482.47517524776;62646.68676656587;64309;64464.033039503505;64640;589886;597421;600718;603007;603520;34825.65174348224;45341.77329113333;46070.76964615155;46533.3020004707;46773.53226467828;48117.5188248127;49241;49662.25506617476;50324.49675503198;50694.49305507045;39764.03584190235;40476;41912;41924.16151676889;41972.129507660386;40686.982825428415;40883.182336353704;40960;41620;42257.154856902074;39956.60043399645;40142.1971560573;40978.38532421956;41002.58997410107;42798.57201427946;27797;32723.509147362332;36034.819825900704;36339.81830090833;36850.07874803151;26696.19911402661;26736.866315668296;26743.598846017714;26851.060212893237;27019 01:29:47 INFO - PROCESS | 2258 | |2;jquery.html;340.6372213592525;357.43703666724906;387.89720724008123;396.6549102281015;417.99263774303915;19453.31913383032;21301.893490532566;21461.67807482889;21640.458988525275;21671.3498595042;20903.163873445083;21115.47211319718;21219.151233950623;21383.465413364673;21711.891440542815;5079.568236699885;5664.26364572605;5825.097109947965;5903.203067585885;5911.763529458816;4175.457190565222;4395.450568678915;5802.622829516089;5865.85335366615;6354.428101470867;6631.867362652744;6689.331066893296;6765.5602385845;6781.050652908572;6795.7621483248095;6497.220333559956;6691.565048271871;6720.83197920051;6727.428168605675;6741.4269787067915;5699.430056994309;5787.479126878601;5894.440028197358;5897.439743224387;5914.467697907209;26063;26357.472850543072;26712.73287267122;26871.462570748474;27242.182734517995;2819.8167119137192;2835.3478699898933;2835.432913417325;2837.75879050281;2967.332350221183;12732.554360597334;16839.494815155565;16886.408975685914;17622.50208732259;17634.030128342936;1917.2618541861345;1942.2036964844488;1953.90230488475;2010.336588925651;2012.5069358007236;161413;161789;165358;166287.3371266296;166739.3326066736;19199.90400047991;24043.278701638978;24110.638340424906;24310.27069187892;24326;41703;41799.7910010448;42117;42904.356434653506;42952.78523607362;8274.29668478186;8586.484810911365;8807.911920880837;8875.556222188994;8951.820963580692;8550.529720865412;8554.743357699279;8571.357148213785;8657.567121643893;8687.218150366498;4835.105505481497;4839.516048395132;4856.247281671346;4865.172920603506;4919.458859525449;1677.7651128841972;1762.9118544072744;1764.126757255167;2026.3515674984158;2076.397844625072;853.6542700206427;995.3331268050424;1013.3565186106875;1051.9474026298808;1055.667464748617;19988.50028749293;20327.695084573745;20473.07871145802;20559.691604625943;20942.95285235732;990.222675199979;1002.6891663584312;1006.2905651515664;1037.8806437259811;1046.6075221791828;9920.40477571348;10782.35305881634;10820.89179108199;10840.349579025284;10841.970012848768;658571;662890;669922;673166;683434;139967;140727.88908166386;144419.27790360982;144530;145064;980.2109302011806;989.3470309595632;1002.6190047781942;1006.3861044762689;1007.5868893753526;14730.557924591852;17036;17784.555386114935;18306.26774928988;18427.539311516783;52217.694557636365;56579.15131273116;56701;57614;58277;75348.24651753412;75811;78523.60738196272;79231.60384198272;79979.60010199912;5931.525477961666;7502.474826762293;7502.587357695379;7543.341479382605;7667.233276672288;10356.019175607686;12497.750044999231;12775.872241277468;12840.229586224856;12951.352432378155;10745.731356716145;10840.132789376989;11075.72310692239;11175.944120279346;11202.775944481227;8435.746927592181;8613.22480976715;8929.285657147542;10918.181136414642;11173.329600224013;10068.496575171359;10807.459627018461;11018;11128.554857805597;11325.773484530428;7447.590382529013;7449.068866391701;7494.376968061353;7585.962070189614;7682.462227644011;6483.643399613066;10770.192235582519;10803.945980270048;11058.281211721212;11306.604268850551 01:29:47 INFO - PROCESS | 2258 | |3;mootools.html;1325.7679906016451;1335.472488367095;1441.9041528438397;1455.4251070827024;1459.956201313961;7357.264273572647;7375.926240737591;7482.588457634828;7717.6912923483;8026.9197308026905;7937.920620793805;8144.10414854367;8218.424710270283;8341;8352.958235208815;2260.626996545572;2316.698829152208;2323.7095363079616;2329.1731435340466;2341.8711970841596;1935.332310352926;2059.1969132038516;2127.7340332458443;2302.631578947369;2320.7331156916916;1822.9726554101699;2305.043406986099;2310.5378924215142;2315.9652605210936;2316.3514216019457;2271.3640180749417;2276.7495575486764;2286.4055345610095;2297.4945511987503;2305.227748704178;1950.317388913883;2312.1098377124927;2327.627579587275;2335.614623587106;2336.953260934789;8421.115782842835;8423.452475589067;8471.70349037787;8480.915190848136;8487.702930397469;5010.69935803853;5149.897002059938;5180.119379705459;5181.5077567631015;5189.169732842727;3463.8614455421753;3517.3668739626855;3521.2781379817334;3577.946330805014;3588.138846676805;1210.9697257568544;1224.3510939202238;1255.755127750089;1273.2805964629954;1280.180684362009;10711.785764284748;10824.18818588601;10900.618478353219;10907.29102608328;10959.342439453658;3463.6363181866045;4713.929291060636;4737.3841400618385;4760.071786001697;4776.689515181502;8317.584120794058;9461.952690236505;9512.143907048261;9519.857202141973;9524.904750952403;5183.2743415921805;5251.789928402897;5264.552513036435;5266.578673706094;5270.49930256625;4017.4576432181866;4643.419572553431;4779.5220477951925;4792.904141917142;4799.952000479951;3882.223555288897;3904.824282907276;3945.3292940200236;4001.779902105354;4028.71798974069;992.9056739609725;1208.6736581123048;1242.7328124453286;1285.4536821850677;1292.877176668215;879.569011184515;885.0972008551241;885.8361203177433;898.7169041751828;904.1184844776291;4430.291153415438;4750.786214620351;5226.45122262157;5432.728363581805;5442;816.9094259164083;945.4374647084974;986.659602437158;1006.9244806639531;1028.9967281900088;3301.5047742838287;3367;3661.9267614647556;3678.429843374281;3700.1119731264303;8202.646563316986;9864.358816677037;9986.251031172691;10047.447390393452;10064.892861785198;9800.950995244979;9931.50342482873;9934.900650993543;9945.30382873192;9957.502124893726;7425.962870185723;7790.182030886675;7791.727289544839;7889.250521200592;7900.170482099296;5497.697626630574;5525.917111243254;5564.91652625219;5682.06245969427;5693.032184528723;7480.738174163878;8811.471311721061;9021.729348119567;9339.299552533452;9401;7554.2823431773895;9151.816963660556;9329.067093290616;9374.437533747998;9378.812423751624;7171.318724721144;7311.23232060626;7312.049433573601;7320.816979575553;7331.753601887585;7740.651670674946;7814.53112813233;7914.366850652049;7918.168592297726;7926.920730792849;5810.7094645266725;7100.680469378787;7118.683043636944;7260.600666963368;7275.672594733355;7019.29807019294;7020.7893763187185;7022.683979221049;7155.391791697556;7166.856662866818;6270.717817698123;6290.0879372491645;6346.90479642815;6349.460295874902;6355;3844;4584.220682483919;4833;4893.290472881484;4918.2376731606655;4718.245080787057;4763.4522029967;4826.348442960156;4910.680805747615;4948.901021979468 01:29:47 INFO - PROCESS | 2258 | |4;prototype.html;347.4978655842309;348.5451485811017;360.7384646131555;361.39466393790394;369.31492082187526;4782.613042217757;5218.21726740989;5294.311739473863;5302.363716354033;5306.310179676646;5232.424433312342;5238.319018527595;5250.789968401269;5276.709780962045;5459.533196420272;3045.4365942300633;3824.9043773905596;4160.230357383879;4163.271427500191;4179.519355274137;3396.439587468077;3503.5795704515494;3930.7028680535354;4056.5132184137797;4107.322291821846;3583.5486627915734;4100.466939297887;4110.732802367851;4145.917081658365;4152.98251928278;3393.5418718473184;3855.094052897553;4110.876673699764;4162.43807086044;4167.729097608646;3207.3104282579357;3537.4340105582983;3549.458814622208;3614.4216925291826;3641.963580364189;4619.95380046202;4662.808480014388;4721.126591580534;5021.69869807809;5078.187490001619;4713.717176969359;4725.802501836628;4734.360861283752;4737.715737055788;4774.806298425394;5156.561692256163;5549.334079910396;5571.4428557144365;5582.441755824426;5587.407588837203;3265.7224135948472;3448.74134439918;3744.606816284278;3764.153065560227;3826.617338266179;5514.834554963318;5548.500634942834;5713;5874.1776151338845;5928.754961458099;3439.9828000860334;3529.7529172957647;3547.8048707320827;3804.2581696568905;3845.7115716321387;3354.7316214702764;3421.9828900855337;3453.4129198036394;3887.552931412867;3911.4523966644692;4034.9596504034585;4509.797059132281;4526.615237704832;4542.727436353829;4567.6802623816675;4215.494140703074;5363.785448582013;5558.360788509373;5587.888242235133;5603.506439634405;1041.8958104189671;1172.3962159487871;1245.682351000489;1256.4408838066972;1265.7088869559868;736.924090827398;810.2828996338283;864.3085531574715;872.9781755456038;874.728834061443;4042.8180731867137;4472.955270447319;4666.440027196758;4734.431868175841;4952.752362381866;4730.95918897842;5106.872328191825;5298.81454149103;5506.174073888868;5507.972460137674;4260.829566817354;4504.2793153095345;4544.613707834805;4733.668643195012;4970.90058198834;2379.773921477457;2825.488363725438;2835.702251263629;2858.7130295763304;2859.828410295389;5366.872956679141;5450.809221677222;5551.8889622208135;5632.690202038845;5642.492175704207;5285.497877701612;5320.654157479751;5489.917651235235;5526.673598336451;5556.416576259435;4848.296996935424;4892.559669629751;5278.551323137576;5623.072193088176;5630.943690563124;5088.211327244283;5090.981803639213;5439.401665816836;5470.890582188414;5493.725313734218;4977.751112444435;5318.596098496888;5331.29475014861;5374.7581358839725;5380.892382152413;4886.780094895809;5441.29263195782;5629.549636029026;5655;5720.170575266647;3390.0846771372085;3599.8660421966997;3808.3335416301484;3834.32899242637;3850.9037274068373;5061.974690126526;5703.5722320826935;5724.45261858469;5736.971315143564;5746.396628353963;4730.361401210793;5400.783968641211;5438.428964958623;5531.8893622126525;5549.1676248563035;4505.197920831693;5511.200875872896;5525.972370138124;5528.75120619565;5535.916961245665;4518.209313370213;5362.329708786402;5439.456054394687;5461.34463864323;5476.3702174250475;5170.43125256229;5488.545535433033;5509.201165830852;5533.418991005887;5556.16657501378;4764;5145.584964134893;5381.757820898148;5410.513053825174;5478.233047373451 01:29:47 INFO - PROCESS | 2258 | |5;yui.html;699.6361891816256;713.77516082434;747.5552046532313;780.2938340801574;825.7729124490764;14528.636784080403;15336.923315383407;15345.386184552619;15364.539063828075;15404.69190616187;11885.702857428569;14056.57830265091;14107;14273.000889937708;14318.498852540164;676.2527407215031;696.9651517424134;700.6986995591893;834.0950069174922;834.6411043251414;868.6959564152528;870.9869351959726;872.1452976083442;872.5768002518773;872.742540950418;915.276931224332;916.9174774270315;919.0992827029481;921.4931787516839;921.889373275208;910.6630546697698;912.8585069314267;915.7481692534573;916.3036092569629;917.2478567574592;598.2491972574435;651.7653644687908;679.813051410861;681.7443458702986;683.2108914204102;12710.618681439571;14133;14170.787438188436;14351.569452916428;14869.200579009403;14131.576052718436;14352.282385880768;14505.274736263145;14574.271286435636;14589.05171163871;11522;11844;11874.643760687108;11934.22427542207;11981.640550783402;3707.925841483182;3731.365667836474;3738.2523495300775;3755.6995440364703;3781.5651200112065;101109;103090;104395;105365.47317263442;105371;10400.167986561208;10970;11101.333919964667;11146.665600032013;11299.661010169708;22823;22856;23077.653835192486;23119.422014449436;23175.18886838986;7812.882806757903;7831.216878312237;7835.373170146375;7910.406719496061;7920;4284.507281662586;4311.827526898952;4340.240457919851;4351.477822661301;4393.604575588149;3563.768355056913;3635.927281454409;3639.217568222845;3643.0710168906758;3683.9079023024638;644.9387308205713;649.1852724830402;649.2112083818183;651.0949779806074;663.1445435388295;679.4869873245668;683.8288434221328;695.9756408525778;730.9378702810214;734.3170851108521;8571.144377580022;9467.573959171716;10004.149647280063;10446.665368075723;10446.738831529121;581.9330776960619;595.6902410746387;595.7706283080959;605.4944121658376;606.5208485296566;4847.175980083394;5012.523810238022;5019.14674505335;5020.2720605511995;5030.8239211627415;81317;90177;93067;105996.47001764942;108028;90829;92942.53528732313;93030;93716;95882;67125.66437167783;81300.59349703214;83896.32207355941;83904.16095838964;84254;9670.806583868423;9820;9822.312438129262;9852.113309802153;9855.753606159617;41933;53422;53821.73089134686;54187.91624167573;55208.44791552033;50085.74957125191;55919;67997;69153;69538;10796.244262901522;11366.374849383363;12661.440612337627;13647.931760341531;13841.79237311421;14508.492202772852;14546.345414456164;14715.779263311273;15086.321115550047;15173.620659483602;13597.116187447784;13801.787811821632;13870.861291386957;14535.200563969083;14658;11792.823107653221;13320.600381988555;13407.463701451832;13788.793168102688;14451.349689264218;13102.148360356547;13605.591832244652;13999.370028348952;14275.214863182624;14277.071990320595;10659.94670026645;11027;11154.378721000721;11229.55081796719;11677.299362038304;10974.506147223234;10981.560737570408;11207.43962801873;11247;11264.211505194886 01:29:47 INFO - PROCESS | 2258 | __end_tp_report 01:29:47 INFO - PROCESS | 2258 | __start_cc_report 01:29:47 INFO - PROCESS | 2258 | _x_x_mozilla_cycle_collect,389 01:29:47 INFO - PROCESS | 2258 | __end_cc_report 01:29:47 INFO - PROCESS | 2258 | __startTimestamp1486459786996__endTimestamp 01:29:47 INFO - PROCESS | 2258 | 01:29:47 INFO - PROCESS | 2258 | ------- Summary: start ------- 01:29:47 INFO - PROCESS | 2258 | Number of tests: 6 01:29:47 INFO - PROCESS | 2258 | 01:29:47 INFO - PROCESS | 2258 | [#0] dojo.html Cycles:165 Average:5614.47 Median:5838.07 stddev:663.63 (11.4%) stddev-sans-first:640.38 01:29:47 INFO - PROCESS | 2258 | Values: 3301.4 3312.1 3332.2 3338.1 3344.7 4527.4 5514.8 5571.1 5615.2 5642.5 4631.0 4813.2 5584.7 5639.5 5683.0 5124.2 5155.1 5185.3 5208.3 5230.7 4236.5 5173.2 5228.1 5258.1 5279.5 4728.9 4795.8 5103.1 5107.6 5214.6 5140.7 5147.8 5170.1 5211.4 5271.3 5082.7 5125.6 5131.9 5148.3 5161.4 5491.5 5559.1 5592.6 5713.8 5725.9 6089.9 6105.9 6112.0 6122.4 6141.7 5512.7 6129.3 6142.7 6149.6 6158.4 5733.8 5770.3 5779.6 5791.5 5792.5 6120.3 6143.5 6202.4 6242.1 6244.9 6055.5 6104.7 6107.8 6108.1 6109.1 6160.0 6170.9 6178.2 6203.5 6218.9 5400.6 5538.6 6057.4 6137.6 6174.2 6094.0 6138.4 6145.8 6146.9 6149.0 4919.9 4928.8 4932.5 4954.7 4961.0 4324.5 4333.0 4374.1 4387.3 4409.3 5745.1 5760.5 5807.1 5868.6 5896.5 6208.8 6257.1 6260.6 6283.8 6290.5 5325.3 5603.9 5647.5 5662.0 5838.1 4112.5 5417.3 5432.3 5455.7 5491.9 6286.7 6289.7 6294.9 6298.9 6302.2 5755.5 6079.4 6118.3 6167.5 6249.7 5097.9 6138.3 6166.4 6230.0 6230.2 6056.1 6086.3 6093.8 6099.9 6116.1 4756.9 6058.5 6065.1 6128.4 6155.2 5964.2 5979.1 6013.9 6074.5 6124.4 6009.6 6020.9 6037.0 6038.6 6050.1 5651.7 5898.1 5903.4 5912.8 5927.1 4904.8 5132.3 5677.9 5883.9 6017.1 5890.0 5892.9 5905.4 5910.9 5916.0 01:29:47 INFO - PROCESS | 2258 | 01:29:47 INFO - PROCESS | 2258 | [#1] ext.html Cycles:180 Average:70545.35 Median:40309.10 stddev:148402.16 (368.2%) stddev-sans-first:148725.15 01:29:47 INFO - PROCESS | 2258 | Values: 451.0 455.6 478.2 484.4 490.9 31341.4 41447.6 41497.8 43526.0 43574.6 42455.0 43254.0 43262.8 43293.8 43404.3 8329.2 9061.3 9384.3 9405.6 9412.2 8383.2 11133.7 11387.7 11393.3 11502.8 11261.7 11274.7 11283.9 11291.9 11355.5 11210.2 11210.6 11285.8 11287.0 11298.0 11145.4 11237.3 11251.8 11252.8 11272.8 39535.8 39811.2 39836.6 39976.0 39988.0 3999.4 4005.2 4085.7 4088.6 4132.1 24695.0 29173.7 29206.0 29237.6 29746.9 3010.6 3117.8 3368.8 3395.4 3403.4 422527.9 463540.0 471102.0 482997.0 483401.0 53003.5 65247.3 65465.0 65477.0 65788.7 68946.7 69091.0 69330.3 69336.3 69510.0 16497.8 16637.9 16710.4 16715.5 16725.7 11121.1 11314.5 12647.7 12775.6 12910.4 17603.7 18150.7 18681.3 18705.9 18711.7 5333.5 6410.8 6432.3 6483.8 6506.3 890.0 894.7 897.0 900.7 922.7 28964.9 30431.0 30770.1 30790.5 30793.5 1025.9 1047.8 1074.6 1106.8 1107.3 14213.4 15963.0 15996.3 16303.6 16304.9 594527.0 594554.0 595857.0 596857.0 597969.0 61836.4 61960.0 62104.0 62247.0 62280.0 1430.3 1449.5 1459.3 1460.2 1462.8 29184.1 29651.9 30389.7 30926.0 30969.5 52482.5 62646.7 64309.0 64464.0 64640.0 589886.0 597421.0 600718.0 603007.0 603520.0 34825.7 45341.8 46070.8 46533.3 46773.5 48117.5 49241.0 49662.3 50324.5 50694.5 39764.0 40476.0 41912.0 41924.2 41972.1 40687.0 40883.2 40960.0 41620.0 42257.2 39956.6 40142.2 40978.4 41002.6 42798.6 27797.0 32723.5 36034.8 36339.8 36850.1 26696.2 26736.9 26743.6 26851.1 27019.0 01:29:47 INFO - PROCESS | 2258 | 01:29:47 INFO - PROCESS | 2258 | [#2] jquery.html Cycles:180 Average:40034.27 Median:2827.58 stddev:112553.08 (3980.5%) stddev-sans-first:112829.36 01:29:47 INFO - PROCESS | 2258 | Values: 340.6 357.4 387.9 396.7 418.0 19453.3 21301.9 21461.7 21640.5 21671.3 20903.2 21115.5 21219.2 21383.5 21711.9 5079.6 5664.3 5825.1 5903.2 5911.8 4175.5 4395.5 5802.6 5865.9 6354.4 6631.9 6689.3 6765.6 6781.1 6795.8 6497.2 6691.6 6720.8 6727.4 6741.4 5699.4 5787.5 5894.4 5897.4 5914.5 26063.0 26357.5 26712.7 26871.5 27242.2 2819.8 2835.3 2835.4 2837.8 2967.3 12732.6 16839.5 16886.4 17622.5 17634.0 1917.3 1942.2 1953.9 2010.3 2012.5 161413.0 161789.0 165358.0 166287.3 166739.3 19199.9 24043.3 24110.6 24310.3 24326.0 41703.0 41799.8 42117.0 42904.4 42952.8 8274.3 8586.5 8807.9 8875.6 8951.8 8550.5 8554.7 8571.4 8657.6 8687.2 4835.1 4839.5 4856.2 4865.2 4919.5 1677.8 1762.9 1764.1 2026.4 2076.4 853.7 995.3 1013.4 1051.9 1055.7 19988.5 20327.7 20473.1 20559.7 20943.0 990.2 1002.7 1006.3 1037.9 1046.6 9920.4 10782.4 10820.9 10840.3 10842.0 658571.0 662890.0 669922.0 673166.0 683434.0 139967.0 140727.9 144419.3 144530.0 145064.0 980.2 989.3 1002.6 1006.4 1007.6 14730.6 17036.0 17784.6 18306.3 18427.5 52217.7 56579.2 56701.0 57614.0 58277.0 75348.2 75811.0 78523.6 79231.6 79979.6 5931.5 7502.5 7502.6 7543.3 7667.2 10356.0 12497.8 12775.9 12840.2 12951.4 10745.7 10840.1 11075.7 11175.9 11202.8 8435.7 8613.2 8929.3 10918.2 11173.3 10068.5 10807.5 11018.0 11128.6 11325.8 7447.6 7449.1 7494.4 7586.0 7682.5 6483.6 10770.2 10803.9 11058.3 11306.6 01:29:47 INFO - PROCESS | 2258 | 01:29:47 INFO - PROCESS | 2258 | [#3] mootools.html Cycles:180 Average:5345.85 Median:5207.81 stddev:2922.64 (56.1%) stddev-sans-first:2915.22 01:29:47 INFO - PROCESS | 2258 | Values: 1325.8 1335.5 1441.9 1455.4 1460.0 7357.3 7375.9 7482.6 7717.7 8026.9 7937.9 8144.1 8218.4 8341.0 8353.0 2260.6 2316.7 2323.7 2329.2 2341.9 1935.3 2059.2 2127.7 2302.6 2320.7 1823.0 2305.0 2310.5 2316.0 2316.4 2271.4 2276.7 2286.4 2297.5 2305.2 1950.3 2312.1 2327.6 2335.6 2337.0 8421.1 8423.5 8471.7 8480.9 8487.7 5010.7 5149.9 5180.1 5181.5 5189.2 3463.9 3517.4 3521.3 3577.9 3588.1 1211.0 1224.4 1255.8 1273.3 1280.2 10711.8 10824.2 10900.6 10907.3 10959.3 3463.6 4713.9 4737.4 4760.1 4776.7 8317.6 9462.0 9512.1 9519.9 9524.9 5183.3 5251.8 5264.6 5266.6 5270.5 4017.5 4643.4 4779.5 4792.9 4800.0 3882.2 3904.8 3945.3 4001.8 4028.7 992.9 1208.7 1242.7 1285.5 1292.9 879.6 885.1 885.8 898.7 904.1 4430.3 4750.8 5226.5 5432.7 5442.0 816.9 945.4 986.7 1006.9 1029.0 3301.5 3367.0 3661.9 3678.4 3700.1 8202.6 9864.4 9986.3 10047.4 10064.9 9801.0 9931.5 9934.9 9945.3 9957.5 7426.0 7790.2 7791.7 7889.3 7900.2 5497.7 5525.9 5564.9 5682.1 5693.0 7480.7 8811.5 9021.7 9339.3 9401.0 7554.3 9151.8 9329.1 9374.4 9378.8 7171.3 7311.2 7312.0 7320.8 7331.8 7740.7 7814.5 7914.4 7918.2 7926.9 5810.7 7100.7 7118.7 7260.6 7275.7 7019.3 7020.8 7022.7 7155.4 7166.9 6270.7 6290.1 6346.9 6349.5 6355.0 3844.0 4584.2 4833.0 4893.3 4918.2 4718.2 4763.5 4826.3 4910.7 4948.9 01:29:47 INFO - PROCESS | 2258 | 01:29:47 INFO - PROCESS | 2258 | [#4] prototype.html Cycles:180 Average:4406.48 Median:4922.66 stddev:1357.60 (27.6%) stddev-sans-first:1326.79 01:29:47 INFO - PROCESS | 2258 | Values: 347.5 348.5 360.7 361.4 369.3 4782.6 5218.2 5294.3 5302.4 5306.3 5232.4 5238.3 5250.8 5276.7 5459.5 3045.4 3824.9 4160.2 4163.3 4179.5 3396.4 3503.6 3930.7 4056.5 4107.3 3583.5 4100.5 4110.7 4145.9 4153.0 3393.5 3855.1 4110.9 4162.4 4167.7 3207.3 3537.4 3549.5 3614.4 3642.0 4620.0 4662.8 4721.1 5021.7 5078.2 4713.7 4725.8 4734.4 4737.7 4774.8 5156.6 5549.3 5571.4 5582.4 5587.4 3265.7 3448.7 3744.6 3764.2 3826.6 5514.8 5548.5 5713.0 5874.2 5928.8 3440.0 3529.8 3547.8 3804.3 3845.7 3354.7 3422.0 3453.4 3887.6 3911.5 4035.0 4509.8 4526.6 4542.7 4567.7 4215.5 5363.8 5558.4 5587.9 5603.5 1041.9 1172.4 1245.7 1256.4 1265.7 736.9 810.3 864.3 873.0 874.7 4042.8 4473.0 4666.4 4734.4 4952.8 4731.0 5106.9 5298.8 5506.2 5508.0 4260.8 4504.3 4544.6 4733.7 4970.9 2379.8 2825.5 2835.7 2858.7 2859.8 5366.9 5450.8 5551.9 5632.7 5642.5 5285.5 5320.7 5489.9 5526.7 5556.4 4848.3 4892.6 5278.6 5623.1 5630.9 5088.2 5091.0 5439.4 5470.9 5493.7 4977.8 5318.6 5331.3 5374.8 5380.9 4886.8 5441.3 5629.5 5655.0 5720.2 3390.1 3599.9 3808.3 3834.3 3850.9 5062.0 5703.6 5724.5 5737.0 5746.4 4730.4 5400.8 5438.4 5531.9 5549.2 4505.2 5511.2 5526.0 5528.8 5535.9 4518.2 5362.3 5439.5 5461.3 5476.4 5170.4 5488.5 5509.2 5533.4 5556.2 4764.0 5145.6 5381.8 5410.5 5478.2 01:29:47 INFO - PROCESS | 2258 | 01:29:47 INFO - PROCESS | 2258 | [#5] yui.html Cycles:180 Average:20340.57 Median:23108.75 stddev:29013.71 (125.6%) stddev-sans-first:29057.61 01:29:47 INFO - PROCESS | 2258 | Values: 699.6 713.8 747.6 780.3 825.8 14528.6 15336.9 15345.4 15364.5 15404.7 11885.7 14056.6 14107.0 14273.0 14318.5 676.3 697.0 700.7 834.1 834.6 868.7 871.0 872.1 872.6 872.7 915.3 916.9 919.1 921.5 921.9 910.7 912.9 915.7 916.3 917.2 598.2 651.8 679.8 681.7 683.2 12710.6 14133.0 14170.8 14351.6 14869.2 14131.6 14352.3 14505.3 14574.3 14589.1 11522.0 11844.0 11874.6 11934.2 11981.6 3707.9 3731.4 3738.3 3755.7 3781.6 101109.0 103090.0 104395.0 105365.5 105371.0 10400.2 10970.0 11101.3 11146.7 11299.7 22823.0 22856.0 23077.7 23119.4 23175.2 7812.9 7831.2 7835.4 7910.4 7920.0 4284.5 4311.8 4340.2 4351.5 4393.6 3563.8 3635.9 3639.2 3643.1 3683.9 644.9 649.2 649.2 651.1 663.1 679.5 683.8 696.0 730.9 734.3 8571.1 9467.6 10004.1 10446.7 10446.7 581.9 595.7 595.8 605.5 606.5 4847.2 5012.5 5019.1 5020.3 5030.8 81317.0 90177.0 93067.0 105996.5 108028.0 90829.0 92942.5 93030.0 93716.0 95882.0 67125.7 81300.6 83896.3 83904.2 84254.0 9670.8 9820.0 9822.3 9852.1 9855.8 41933.0 53422.0 53821.7 54187.9 55208.4 50085.7 55919.0 67997.0 69153.0 69538.0 10796.2 11366.4 12661.4 13647.9 13841.8 14508.5 14546.3 14715.8 15086.3 15173.6 13597.1 13801.8 13870.9 14535.2 14658.0 11792.8 13320.6 13407.5 13788.8 14451.3 13102.1 13605.6 13999.4 14275.2 14277.1 10659.9 11027.0 11154.4 11229.6 11677.3 10974.5 10981.6 11207.4 11247.0 11264.2 01:29:47 INFO - PROCESS | 2258 | -------- Summary: end -------- 01:29:47 INFO - PROCESS | 2258 | 01:29:47 INFO - TEST-INFO | 2258: exit 0 01:29:47 INFO - TEST-OK | dromaeo_css | took 1114917ms 01:29:47 INFO - TEST-START | kraken 01:29:47 INFO - operating with platform_type : mac_ 01:29:47 INFO - Initialising browser for kraken test... 01:29:47 INFO - TEST-INFO | started process 2263 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpSFgrMH/profile http://localhost:49594/getInfo.html) 01:29:50 INFO - PROCESS | 2263 | 2017-02-07 01:29:50.404 plugin-container[2264:20969] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 01:29:50 INFO - PROCESS | 2263 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:29:50 INFO - PROCESS | 2263 | 2017-02-07 01:29:50.408 plugin-container[2264:20969] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 01:29:50 INFO - PROCESS | 2263 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:29:50 INFO - PROCESS | 2263 | 2017-02-07 01:29:50.408 plugin-container[2264:20969] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:29:50 INFO - PROCESS | 2263 | __metrics Screen width/height:1600/1200 01:29:50 INFO - PROCESS | 2263 | colorDepth:24 01:29:50 INFO - PROCESS | 2263 | Browser inner width/height: 1024/689 01:29:50 INFO - PROCESS | 2263 | __metrics 01:29:50 ERROR - PROCESS | 2263 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 01:29:50 INFO - PROCESS | 2263 | 1486459790573 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpSFgrMH/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpSFgrMH/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpSFgrMH/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpSFgrMH/profile/extensions/talos-powers@TalosPowersService.js:55:9 01:29:51 INFO - TEST-INFO | 2263: exit 0 01:29:51 INFO - Browser initialized. 01:29:51 INFO - Running cycle 1/1 for kraken test... 01:29:51 INFO - TEST-INFO | started process 2265 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpSFgrMH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:29:53 INFO - PROCESS | 2265 | 2017-02-07 01:29:53.852 plugin-container[2266:21092] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 01:29:53 INFO - PROCESS | 2265 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:29:53 INFO - PROCESS | 2265 | 2017-02-07 01:29:53.852 plugin-container[2266:21092] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 01:29:53 INFO - PROCESS | 2265 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:29:53 INFO - PROCESS | 2265 | 2017-02-07 01:29:53.852 plugin-container[2266:21092] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:30:03 INFO - PROCESS | 2265 | RSS: Main: 218685440 01:30:03 INFO - PROCESS | 2265 | 01:30:06 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49594/tests/kraken/driver.html?testName=audio-beat-detection) 01:30:07 INFO - PROCESS | 2265 | RSS: Main: 232935424 01:30:07 INFO - PROCESS | 2265 | 01:30:10 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49594/tests/kraken/driver.html?testName=audio-dft) 01:30:11 INFO - PROCESS | 2265 | RSS: Main: 240873472 01:30:11 INFO - PROCESS | 2265 | 01:30:14 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49594/tests/kraken/driver.html?testName=audio-fft) 01:30:15 INFO - PROCESS | 2265 | RSS: Main: 242749440 01:30:15 INFO - PROCESS | 2265 | 01:30:17 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49594/tests/kraken/driver.html?testName=audio-oscillator) 01:30:17 INFO - PROCESS | 2265 | RSS: Main: 245743616 01:30:17 INFO - PROCESS | 2265 | 01:30:19 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49594/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:30:20 INFO - PROCESS | 2265 | RSS: Main: 245862400 01:30:20 INFO - PROCESS | 2265 | 01:30:23 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49594/tests/kraken/driver.html?testName=imaging-darkroom) 01:30:24 INFO - PROCESS | 2265 | RSS: Main: 249933824 01:30:24 INFO - PROCESS | 2265 | 01:30:27 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49594/tests/kraken/driver.html?testName=imaging-desaturate) 01:30:28 INFO - PROCESS | 2265 | RSS: Main: 249077760 01:30:28 INFO - PROCESS | 2265 | 01:30:31 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49594/tests/kraken/driver.html?testName=json-parse-financial) 01:30:31 INFO - PROCESS | 2265 | RSS: Main: 248852480 01:30:31 INFO - PROCESS | 2265 | 01:30:33 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49594/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:30:34 INFO - PROCESS | 2265 | RSS: Main: 248553472 01:30:34 INFO - PROCESS | 2265 | 01:30:36 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:30:36 INFO - PROCESS | 2265 | RSS: Main: 248532992 01:30:36 INFO - PROCESS | 2265 | 01:30:38 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:30:39 INFO - PROCESS | 2265 | RSS: Main: 248598528 01:30:39 INFO - PROCESS | 2265 | 01:30:42 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:30:43 INFO - PROCESS | 2265 | RSS: Main: 249057280 01:30:43 INFO - PROCESS | 2265 | 01:30:46 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:30:46 INFO - PROCESS | 2265 | RSS: Main: 248770560 01:30:46 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | Cycle 1(1): loaded http://localhost:49594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49594/tests/kraken/driver.html?testName=ai-astar) 01:30:48 INFO - PROCESS | 2265 | RSS: Main: 252313600 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | __start_tp_report 01:30:48 INFO - PROCESS | 2265 | _x_x_mozilla_page_load 01:30:48 INFO - PROCESS | 2265 | _x_x_mozilla_page_load_details 01:30:48 INFO - PROCESS | 2265 | |i|pagename|runs| 01:30:48 INFO - PROCESS | 2265 | |0;ai-astar;107;117;117;98;169;179;175;118;123;175 01:30:48 INFO - PROCESS | 2265 | |1;audio-beat-detection;177;144;114;148;143;116;100;147;148;117 01:30:48 INFO - PROCESS | 2265 | |2;audio-dft;212;212;206;255;298;239;201;202;196;228 01:30:48 INFO - PROCESS | 2265 | |3;audio-fft;86;60;60;85;63;61;58;61;75;59 01:30:48 INFO - PROCESS | 2265 | |4;audio-oscillator;88;71;84;73;71;72;80;70;77;103 01:30:48 INFO - PROCESS | 2265 | |5;imaging-gaussian-blur;133;86;106;86;82;88;91;131;113;87 01:30:48 INFO - PROCESS | 2265 | |6;imaging-darkroom;107;130;98;151;153;112;152;149;97;97 01:30:48 INFO - PROCESS | 2265 | |7;imaging-desaturate;92;80;133;142;147;92;93;124;144;92 01:30:48 INFO - PROCESS | 2265 | |8;json-parse-financial;61;61;61;76;84;70;63;63;63;64 01:30:48 INFO - PROCESS | 2265 | |9;json-stringify-tinderbox;73;75;71;80;74;70;71;71;108;98 01:30:48 INFO - PROCESS | 2265 | |10;stanford-crypto-aes;84;84;90;84;84;84;88;89;88;77 01:30:48 INFO - PROCESS | 2265 | |11;stanford-crypto-ccm;143;187;157;153;140;156;150;138;198;152 01:30:48 INFO - PROCESS | 2265 | |12;stanford-crypto-pbkdf2;176;204;181;171;176;174;171;177;173;176 01:30:48 INFO - PROCESS | 2265 | |13;stanford-crypto-sha256-iterative;69;83;67;69;65;66;68;69;65;68 01:30:48 INFO - PROCESS | 2265 | __end_tp_report 01:30:48 INFO - PROCESS | 2265 | __start_cc_report 01:30:48 INFO - PROCESS | 2265 | _x_x_mozilla_cycle_collect,956 01:30:48 INFO - PROCESS | 2265 | __end_cc_report 01:30:48 INFO - PROCESS | 2265 | __startTimestamp1486459848954__endTimestamp 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | ------- Summary: start ------- 01:30:48 INFO - PROCESS | 2265 | Number of tests: 14 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#0] ai-astar Cycles:10 Average:137.80 Median:172.00 stddev:32.40 (18.8%) stddev-sans-first:32.39 01:30:48 INFO - PROCESS | 2265 | Values: 107.0 117.0 117.0 98.0 169.0 179.0 175.0 118.0 123.0 175.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:145.50 stddev:22.95 (15.8%) stddev-sans-first:18.77 01:30:48 INFO - PROCESS | 2265 | Values: 177.0 144.0 114.0 148.0 143.0 116.0 100.0 147.0 148.0 117.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#2] audio-dft Cycles:10 Average:224.90 Median:220.00 stddev:31.76 (14.4%) stddev-sans-first:33.34 01:30:48 INFO - PROCESS | 2265 | Values: 212.0 212.0 206.0 255.0 298.0 239.0 201.0 202.0 196.0 228.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#3] audio-fft Cycles:10 Average:66.80 Median:62.00 stddev:10.95 (17.7%) stddev-sans-first:9.15 01:30:48 INFO - PROCESS | 2265 | Values: 86.0 60.0 60.0 85.0 63.0 61.0 58.0 61.0 75.0 59.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:75.00 stddev:10.44 (13.9%) stddev-sans-first:10.54 01:30:48 INFO - PROCESS | 2265 | Values: 88.0 71.0 84.0 73.0 71.0 72.0 80.0 70.0 77.0 103.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#5] imaging-gaussian-blur Cycles:10 Average:100.30 Median:86.00 stddev:19.33 (22.5%) stddev-sans-first:16.49 01:30:48 INFO - PROCESS | 2265 | Values: 133.0 86.0 106.0 86.0 82.0 88.0 91.0 131.0 113.0 87.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#6] imaging-darkroom Cycles:10 Average:124.60 Median:152.50 stddev:24.90 (16.3%) stddev-sans-first:25.58 01:30:48 INFO - PROCESS | 2265 | Values: 107.0 130.0 98.0 151.0 153.0 112.0 152.0 149.0 97.0 97.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#7] imaging-desaturate Cycles:10 Average:113.90 Median:86.00 stddev:26.42 (30.7%) stddev-sans-first:26.81 01:30:48 INFO - PROCESS | 2265 | Values: 92.0 80.0 133.0 142.0 147.0 92.0 93.0 124.0 144.0 92.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:63.50 stddev:7.76 (12.2%) stddev-sans-first:7.97 01:30:48 INFO - PROCESS | 2265 | Values: 61.0 61.0 61.0 76.0 84.0 70.0 63.0 63.0 63.0 64.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#9] json-stringify-tinderbox Cycles:10 Average:79.10 Median:73.50 stddev:13.14 (17.9%) stddev-sans-first:13.75 01:30:48 INFO - PROCESS | 2265 | Values: 73.0 75.0 71.0 80.0 74.0 70.0 71.0 71.0 108.0 98.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:3.77 (4.4%) stddev-sans-first:3.97 01:30:48 INFO - PROCESS | 2265 | Values: 84.0 84.0 90.0 84.0 84.0 84.0 88.0 89.0 88.0 77.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#11] stanford-crypto-ccm Cycles:10 Average:157.40 Median:154.50 stddev:19.77 (12.8%) stddev-sans-first:20.27 01:30:48 INFO - PROCESS | 2265 | Values: 143.0 187.0 157.0 153.0 140.0 156.0 150.0 138.0 198.0 152.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:176.00 stddev:9.64 (5.5%) stddev-sans-first:10.20 01:30:48 INFO - PROCESS | 2265 | Values: 176.0 204.0 181.0 171.0 176.0 174.0 171.0 177.0 173.0 176.0 01:30:48 INFO - PROCESS | 2265 | 01:30:48 INFO - PROCESS | 2265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:5.20 (7.6%) stddev-sans-first:5.51 01:30:48 INFO - PROCESS | 2265 | Values: 69.0 83.0 67.0 69.0 65.0 66.0 68.0 69.0 65.0 68.0 01:30:48 INFO - PROCESS | 2265 | -------- Summary: end -------- 01:30:48 INFO - PROCESS | 2265 | 01:30:49 INFO - TEST-INFO | 2265: exit 0 01:30:49 INFO - TEST-OK | kraken | took 62180ms 01:30:49 INFO - SUITE-END | took 1177s 01:30:50 INFO - Completed test suite (00:19:37) 01:30:50 INFO - javascript benchmark 01:30:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7348.129605788295, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3301.4222511060557, 3312.0891754767435, 3332.1503016730762, 3338.1153994191527, 3344.665533446655, 4527.4340707411575, 5514.751836167372, 5571.0807716726795, 5615.241942337783, 5642.492175704186, 4631.0, 4813.181759100952, 5584.720763961806, 5639.520640745532, 5683.0, 5124.231365295208, 5155.072087024334, 5185.274061631375, 5208.2968799212185, 5230.6600070995455, 4236.512801027875, 5173.198154286091, 5228.058949389108, 5258.106121959257, 5279.472052794728, 4728.881777955544, 4795.784189711471, 5103.055934652101, 5107.565856902168, 5214.582833373321, 5140.66585671932, 5147.768350424221, 5170.146925757245, 5211.42674305826, 5271.262023316739, 5082.720450375228, 5125.641205115643, 5131.87170320745, 5148.330717006803, 5161.406438259611, 5491.533219676332, 5559.110542313251, 5592.636478628876, 5713.800016999385, 5725.885482290331, 6089.939100608982, 6105.908411373833, 6112.0, 6122.367660829195, 6141.662208578527, 5512.6968016759065, 6129.328227221949, 6142.744345496893, 6149.631022138686, 6158.353372895871, 5733.827985160452, 5770.336411312669, 5779.624324418942, 5791.507721843648, 5792.478676919098, 6120.264288666148, 6143.542582966849, 6202.379762023852, 6242.063690446469, 6244.937550624527, 6055.545834062463, 6104.664243466652, 6107.8473038173515, 6108.1143234230785, 6109.14471973924, 6160.043179273884, 6170.907436388457, 6178.227721534809, 6203.534734894901, 6218.9378106219265, 5400.568849254951, 5538.6399884007415, 6057.42454466825, 6137.601055931439, 6174.166487524217, 6093.969530152321, 6138.38839838597, 6145.784897528565, 6146.862830376305, 6148.985417406078, 4919.852404427873, 4928.802847886044, 4932.506749325039, 4954.677945933503, 4961.032598643302, 4324.524302326741, 4332.956670433318, 4374.12517496502, 4387.3418987151545, 4409.294512877988, 5745.080787074132, 5760.481556659921, 5807.128930660435, 5868.647881127146, 5896.528277737771, 6208.782692605737, 6257.092721555349, 6260.624362538262, 6283.8114856554375, 6290.528210384239, 5325.307709997753, 5603.887922241533, 5647.463490968352, 5661.9808434481365, 5838.065909454467, 4112.547619761884, 5417.322834645669, 5432.266644003088, 5455.672659640434, 5491.862703432366, 6286.717097730613, 6289.7169627366875, 6294.937050629435, 6298.937010629835, 6302.212223472066, 5755.453231942959, 6079.392060793885, 6118.284172697687, 6167.537434692326, 6249.656268905072, 5097.949020509747, 6138.324784273816, 6166.383361663977, 6230.0, 6230.15892854477, 6056.121862330026, 6086.330503644507, 6093.786717465045, 6099.878002440015, 6116.082587611894, 4756.857294281177, 6058.485028772604, 6065.059915713072, 6128.417800308964, 6155.230596175478, 5964.224650795369, 5979.13302571116, 6013.909791353046, 6074.514038876968, 6124.356942521149, 6009.609375390585, 6020.90968635462, 6037.0, 6038.607490513103, 6050.122732203894, 5651.745671444877, 5898.1152827076285, 5903.350631430625, 5912.793052243151, 5927.051671732502, 4904.803807847647, 5132.3327967364, 5677.914831277451, 5883.911741323969, 6017.096066705621, 5889.970550147222, 5892.9116063258225, 5905.350411454822, 5910.881782364415, 5915.970420147872], "value": 5574.316507770871, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.99323510147343, 455.5512819872427, 478.21572620901725, 484.3872501285876, 490.9018196360729, 31341.373172536565, 41447.585524144786, 41497.79251103744, 43526.0, 43574.56425435745, 42455.0, 43254.0, 43262.78368608152, 43293.7835310823, 43404.34893476601, 8329.20872517113, 9061.275097992162, 9384.343095983284, 9405.57674904631, 9412.199963003153, 8383.245507904287, 11133.7216569586, 11387.715307117347, 11393.316401015965, 11502.827457588142, 11261.66215013551, 11274.661760147168, 11283.887161128407, 11291.943540282287, 11355.545778168864, 11210.159238057138, 11210.551577936872, 11285.830712539277, 11287.0, 11298.039666628347, 11145.442727863656, 11237.325760454318, 11251.83122253167, 11252.831207531894, 11272.830907536394, 39535.8023209885, 39811.20377592461, 39836.60163398358, 39976.000599984945, 39988.0, 3999.42008408782, 4005.178938317638, 4085.6527195188446, 4088.5707000765087, 4132.090939993197, 24695.0, 29173.708262917313, 29205.977790777433, 29237.561436578257, 29746.85126574375, 3010.6151170461612, 3117.8285194314303, 3368.8147151906637, 3395.3548825723283, 3403.421418358885, 422527.8873605643, 463540.0, 471102.0, 482997.0, 483401.0, 53003.469965300625, 65247.347526525074, 65465.0, 65477.0, 65788.68422631617, 68946.65526672335, 69091.0, 69330.30669693339, 69336.306636934, 69510.0, 16497.83502164987, 16637.91681041587, 16710.4151354702, 16715.498535043967, 16725.749113763304, 11121.110311175087, 11314.547418103348, 12647.683807904692, 12775.61673149807, 12910.354482275849, 17603.73594396085, 18150.727739083923, 18681.252749890125, 18705.906470467562, 18711.71932421015, 5333.519983201453, 6410.8076757697345, 6432.292447830735, 6483.805485835433, 6506.284308726036, 889.9555022248861, 894.7315805258396, 896.9820603587891, 900.7342833864026, 922.7001224601897, 28964.855175723987, 30430.984129519944, 30770.076897693107, 30790.53814192789, 30793.538096928565, 1025.9127974122284, 1047.8166320893813, 1074.5970261152067, 1106.756513567014, 1107.3245320354577, 14213.360398782079, 15963.04221746699, 15996.280167392495, 16303.592410189603, 16304.918475407785, 594527.0, 594554.0, 595857.0, 596857.0, 597969.0, 61836.38163618396, 61960.0, 62104.0, 62247.0, 62280.0, 1430.2920054573053, 1449.521657852927, 1459.321415541757, 1460.1968917095555, 1462.8317743459638, 29184.124476265744, 29651.85174074116, 30389.69610303869, 30926.0, 30969.535456968613, 52482.47517524776, 62646.68676656587, 64309.0, 64464.033039503505, 64640.0, 589886.0, 597421.0, 600718.0, 603007.0, 603520.0, 34825.65174348224, 45341.77329113333, 46070.76964615155, 46533.3020004707, 46773.53226467828, 48117.5188248127, 49241.0, 49662.25506617476, 50324.49675503198, 50694.49305507045, 39764.03584190235, 40476.0, 41912.0, 41924.16151676889, 41972.129507660386, 40686.982825428415, 40883.182336353704, 40960.0, 41620.0, 42257.154856902074, 39956.60043399645, 40142.1971560573, 40978.38532421956, 41002.58997410107, 42798.57201427946, 27797.0, 32723.509147362332, 36034.819825900704, 36339.81830090833, 36850.07874803151, 26696.19911402661, 26736.866315668296, 26743.598846017714, 26851.060212893237, 27019.0], "value": 20857.871745354354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6372213592525, 357.43703666724906, 387.89720724008123, 396.6549102281015, 417.99263774303915, 19453.31913383032, 21301.893490532566, 21461.67807482889, 21640.458988525275, 21671.3498595042, 20903.163873445083, 21115.47211319718, 21219.151233950623, 21383.465413364673, 21711.891440542815, 5079.568236699885, 5664.26364572605, 5825.097109947965, 5903.203067585885, 5911.763529458816, 4175.457190565222, 4395.450568678915, 5802.622829516089, 5865.85335366615, 6354.428101470867, 6631.867362652744, 6689.331066893296, 6765.5602385845, 6781.050652908572, 6795.7621483248095, 6497.220333559956, 6691.565048271871, 6720.83197920051, 6727.428168605675, 6741.4269787067915, 5699.430056994309, 5787.479126878601, 5894.440028197358, 5897.439743224387, 5914.467697907209, 26063.0, 26357.472850543072, 26712.73287267122, 26871.462570748474, 27242.182734517995, 2819.8167119137192, 2835.3478699898933, 2835.432913417325, 2837.75879050281, 2967.332350221183, 12732.554360597334, 16839.494815155565, 16886.408975685914, 17622.50208732259, 17634.030128342936, 1917.2618541861345, 1942.2036964844488, 1953.90230488475, 2010.336588925651, 2012.5069358007236, 161413.0, 161789.0, 165358.0, 166287.3371266296, 166739.3326066736, 19199.90400047991, 24043.278701638978, 24110.638340424906, 24310.27069187892, 24326.0, 41703.0, 41799.7910010448, 42117.0, 42904.356434653506, 42952.78523607362, 8274.29668478186, 8586.484810911365, 8807.911920880837, 8875.556222188994, 8951.820963580692, 8550.529720865412, 8554.743357699279, 8571.357148213785, 8657.567121643893, 8687.218150366498, 4835.105505481497, 4839.516048395132, 4856.247281671346, 4865.172920603506, 4919.458859525449, 1677.7651128841972, 1762.9118544072744, 1764.126757255167, 2026.3515674984158, 2076.397844625072, 853.6542700206427, 995.3331268050424, 1013.3565186106875, 1051.9474026298808, 1055.667464748617, 19988.50028749293, 20327.695084573745, 20473.07871145802, 20559.691604625943, 20942.95285235732, 990.222675199979, 1002.6891663584312, 1006.2905651515664, 1037.8806437259811, 1046.6075221791828, 9920.40477571348, 10782.35305881634, 10820.89179108199, 10840.349579025284, 10841.970012848768, 658571.0, 662890.0, 669922.0, 673166.0, 683434.0, 139967.0, 140727.88908166386, 144419.27790360982, 144530.0, 145064.0, 980.2109302011806, 989.3470309595632, 1002.6190047781942, 1006.3861044762689, 1007.5868893753526, 14730.557924591852, 17036.0, 17784.555386114935, 18306.26774928988, 18427.539311516783, 52217.694557636365, 56579.15131273116, 56701.0, 57614.0, 58277.0, 75348.24651753412, 75811.0, 78523.60738196272, 79231.60384198272, 79979.60010199912, 5931.525477961666, 7502.474826762293, 7502.587357695379, 7543.341479382605, 7667.233276672288, 10356.019175607686, 12497.750044999231, 12775.872241277468, 12840.229586224856, 12951.352432378155, 10745.731356716145, 10840.132789376989, 11075.72310692239, 11175.944120279346, 11202.775944481227, 8435.746927592181, 8613.22480976715, 8929.285657147542, 10918.181136414642, 11173.329600224013, 10068.496575171359, 10807.459627018461, 11018.0, 11128.554857805597, 11325.773484530428, 7447.590382529013, 7449.068866391701, 7494.376968061353, 7585.962070189614, 7682.462227644011, 6483.643399613066, 10770.192235582519, 10803.945980270048, 11058.281211721212, 11306.604268850551], "value": 10425.38248798808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.7679906016451, 1335.472488367095, 1441.9041528438397, 1455.4251070827024, 1459.956201313961, 7357.264273572647, 7375.926240737591, 7482.588457634828, 7717.6912923483, 8026.9197308026905, 7937.920620793805, 8144.10414854367, 8218.424710270283, 8341.0, 8352.958235208815, 2260.626996545572, 2316.698829152208, 2323.7095363079616, 2329.1731435340466, 2341.8711970841596, 1935.332310352926, 2059.1969132038516, 2127.7340332458443, 2302.631578947369, 2320.7331156916916, 1822.9726554101699, 2305.043406986099, 2310.5378924215142, 2315.9652605210936, 2316.3514216019457, 2271.3640180749417, 2276.7495575486764, 2286.4055345610095, 2297.4945511987503, 2305.227748704178, 1950.317388913883, 2312.1098377124927, 2327.627579587275, 2335.614623587106, 2336.953260934789, 8421.115782842835, 8423.452475589067, 8471.70349037787, 8480.915190848136, 8487.702930397469, 5010.69935803853, 5149.897002059938, 5180.119379705459, 5181.5077567631015, 5189.169732842727, 3463.8614455421753, 3517.3668739626855, 3521.2781379817334, 3577.946330805014, 3588.138846676805, 1210.9697257568544, 1224.3510939202238, 1255.755127750089, 1273.2805964629954, 1280.180684362009, 10711.785764284748, 10824.18818588601, 10900.618478353219, 10907.29102608328, 10959.342439453658, 3463.6363181866045, 4713.929291060636, 4737.3841400618385, 4760.071786001697, 4776.689515181502, 8317.584120794058, 9461.952690236505, 9512.143907048261, 9519.857202141973, 9524.904750952403, 5183.2743415921805, 5251.789928402897, 5264.552513036435, 5266.578673706094, 5270.49930256625, 4017.4576432181866, 4643.419572553431, 4779.5220477951925, 4792.904141917142, 4799.952000479951, 3882.223555288897, 3904.824282907276, 3945.3292940200236, 4001.779902105354, 4028.71798974069, 992.9056739609725, 1208.6736581123048, 1242.7328124453286, 1285.4536821850677, 1292.877176668215, 879.569011184515, 885.0972008551241, 885.8361203177433, 898.7169041751828, 904.1184844776291, 4430.291153415438, 4750.786214620351, 5226.45122262157, 5432.728363581805, 5442.0, 816.9094259164083, 945.4374647084974, 986.659602437158, 1006.9244806639531, 1028.9967281900088, 3301.5047742838287, 3367.0, 3661.9267614647556, 3678.429843374281, 3700.1119731264303, 8202.646563316986, 9864.358816677037, 9986.251031172691, 10047.447390393452, 10064.892861785198, 9800.950995244979, 9931.50342482873, 9934.900650993543, 9945.30382873192, 9957.502124893726, 7425.962870185723, 7790.182030886675, 7791.727289544839, 7889.250521200592, 7900.170482099296, 5497.697626630574, 5525.917111243254, 5564.91652625219, 5682.06245969427, 5693.032184528723, 7480.738174163878, 8811.471311721061, 9021.729348119567, 9339.299552533452, 9401.0, 7554.2823431773895, 9151.816963660556, 9329.067093290616, 9374.437533747998, 9378.812423751624, 7171.318724721144, 7311.23232060626, 7312.049433573601, 7320.816979575553, 7331.753601887585, 7740.651670674946, 7814.53112813233, 7914.366850652049, 7918.168592297726, 7926.920730792849, 5810.7094645266725, 7100.680469378787, 7118.683043636944, 7260.600666963368, 7275.672594733355, 7019.29807019294, 7020.7893763187185, 7022.683979221049, 7155.391791697556, 7166.856662866818, 6270.717817698123, 6290.0879372491645, 6346.90479642815, 6349.460295874902, 6355.0, 3844.0, 4584.220682483919, 4833.0, 4893.290472881484, 4918.2376731606655, 4718.245080787057, 4763.4522029967, 4826.348442960156, 4910.680805747615, 4948.901021979468], "value": 4351.562342359303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.4978655842309, 348.5451485811017, 360.7384646131555, 361.39466393790394, 369.31492082187526, 4782.613042217757, 5218.21726740989, 5294.311739473863, 5302.363716354033, 5306.310179676646, 5232.424433312342, 5238.319018527595, 5250.789968401269, 5276.709780962045, 5459.533196420272, 3045.4365942300633, 3824.9043773905596, 4160.230357383879, 4163.271427500191, 4179.519355274137, 3396.439587468077, 3503.5795704515494, 3930.7028680535354, 4056.5132184137797, 4107.322291821846, 3583.5486627915734, 4100.466939297887, 4110.732802367851, 4145.917081658365, 4152.98251928278, 3393.5418718473184, 3855.094052897553, 4110.876673699764, 4162.43807086044, 4167.729097608646, 3207.3104282579357, 3537.4340105582983, 3549.458814622208, 3614.4216925291826, 3641.963580364189, 4619.95380046202, 4662.808480014388, 4721.126591580534, 5021.69869807809, 5078.187490001619, 4713.717176969359, 4725.802501836628, 4734.360861283752, 4737.715737055788, 4774.806298425394, 5156.561692256163, 5549.334079910396, 5571.4428557144365, 5582.441755824426, 5587.407588837203, 3265.7224135948472, 3448.74134439918, 3744.606816284278, 3764.153065560227, 3826.617338266179, 5514.834554963318, 5548.500634942834, 5713.0, 5874.1776151338845, 5928.754961458099, 3439.9828000860334, 3529.7529172957647, 3547.8048707320827, 3804.2581696568905, 3845.7115716321387, 3354.7316214702764, 3421.9828900855337, 3453.4129198036394, 3887.552931412867, 3911.4523966644692, 4034.9596504034585, 4509.797059132281, 4526.615237704832, 4542.727436353829, 4567.6802623816675, 4215.494140703074, 5363.785448582013, 5558.360788509373, 5587.888242235133, 5603.506439634405, 1041.8958104189671, 1172.3962159487871, 1245.682351000489, 1256.4408838066972, 1265.7088869559868, 736.924090827398, 810.2828996338283, 864.3085531574715, 872.9781755456038, 874.728834061443, 4042.8180731867137, 4472.955270447319, 4666.440027196758, 4734.431868175841, 4952.752362381866, 4730.95918897842, 5106.872328191825, 5298.81454149103, 5506.174073888868, 5507.972460137674, 4260.829566817354, 4504.2793153095345, 4544.613707834805, 4733.668643195012, 4970.90058198834, 2379.773921477457, 2825.488363725438, 2835.702251263629, 2858.7130295763304, 2859.828410295389, 5366.872956679141, 5450.809221677222, 5551.8889622208135, 5632.690202038845, 5642.492175704207, 5285.497877701612, 5320.654157479751, 5489.917651235235, 5526.673598336451, 5556.416576259435, 4848.296996935424, 4892.559669629751, 5278.551323137576, 5623.072193088176, 5630.943690563124, 5088.211327244283, 5090.981803639213, 5439.401665816836, 5470.890582188414, 5493.725313734218, 4977.751112444435, 5318.596098496888, 5331.29475014861, 5374.7581358839725, 5380.892382152413, 4886.780094895809, 5441.29263195782, 5629.549636029026, 5655.0, 5720.170575266647, 3390.0846771372085, 3599.8660421966997, 3808.3335416301484, 3834.32899242637, 3850.9037274068373, 5061.974690126526, 5703.5722320826935, 5724.45261858469, 5736.971315143564, 5746.396628353963, 4730.361401210793, 5400.783968641211, 5438.428964958623, 5531.8893622126525, 5549.1676248563035, 4505.197920831693, 5511.200875872896, 5525.972370138124, 5528.75120619565, 5535.916961245665, 4518.209313370213, 5362.329708786402, 5439.456054394687, 5461.34463864323, 5476.3702174250475, 5170.43125256229, 5488.545535433033, 5509.201165830852, 5533.418991005887, 5556.16657501378, 4764.0, 5145.584964134893, 5381.757820898148, 5410.513053825174, 5478.233047373451], "value": 3983.980886632737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.6361891816256, 713.77516082434, 747.5552046532313, 780.2938340801574, 825.7729124490764, 14528.636784080403, 15336.923315383407, 15345.386184552619, 15364.539063828075, 15404.69190616187, 11885.702857428569, 14056.57830265091, 14107.0, 14273.000889937708, 14318.498852540164, 676.2527407215031, 696.9651517424134, 700.6986995591893, 834.0950069174922, 834.6411043251414, 868.6959564152528, 870.9869351959726, 872.1452976083442, 872.5768002518773, 872.742540950418, 915.276931224332, 916.9174774270315, 919.0992827029481, 921.4931787516839, 921.889373275208, 910.6630546697698, 912.8585069314267, 915.7481692534573, 916.3036092569629, 917.2478567574592, 598.2491972574435, 651.7653644687908, 679.813051410861, 681.7443458702986, 683.2108914204102, 12710.618681439571, 14133.0, 14170.787438188436, 14351.569452916428, 14869.200579009403, 14131.576052718436, 14352.282385880768, 14505.274736263145, 14574.271286435636, 14589.05171163871, 11522.0, 11844.0, 11874.643760687108, 11934.22427542207, 11981.640550783402, 3707.925841483182, 3731.365667836474, 3738.2523495300775, 3755.6995440364703, 3781.5651200112065, 101109.0, 103090.0, 104395.0, 105365.47317263442, 105371.0, 10400.167986561208, 10970.0, 11101.333919964667, 11146.665600032013, 11299.661010169708, 22823.0, 22856.0, 23077.653835192486, 23119.422014449436, 23175.18886838986, 7812.882806757903, 7831.216878312237, 7835.373170146375, 7910.406719496061, 7920.0, 4284.507281662586, 4311.827526898952, 4340.240457919851, 4351.477822661301, 4393.604575588149, 3563.768355056913, 3635.927281454409, 3639.217568222845, 3643.0710168906758, 3683.9079023024638, 644.9387308205713, 649.1852724830402, 649.2112083818183, 651.0949779806074, 663.1445435388295, 679.4869873245668, 683.8288434221328, 695.9756408525778, 730.9378702810214, 734.3170851108521, 8571.144377580022, 9467.573959171716, 10004.149647280063, 10446.665368075723, 10446.738831529121, 581.9330776960619, 595.6902410746387, 595.7706283080959, 605.4944121658376, 606.5208485296566, 4847.175980083394, 5012.523810238022, 5019.14674505335, 5020.2720605511995, 5030.8239211627415, 81317.0, 90177.0, 93067.0, 105996.47001764942, 108028.0, 90829.0, 92942.53528732313, 93030.0, 93716.0, 95882.0, 67125.66437167783, 81300.59349703214, 83896.32207355941, 83904.16095838964, 84254.0, 9670.806583868423, 9820.0, 9822.312438129262, 9852.113309802153, 9855.753606159617, 41933.0, 53422.0, 53821.73089134686, 54187.91624167573, 55208.44791552033, 50085.74957125191, 55919.0, 67997.0, 69153.0, 69538.0, 10796.244262901522, 11366.374849383363, 12661.440612337627, 13647.931760341531, 13841.79237311421, 14508.492202772852, 14546.345414456164, 14715.779263311273, 15086.321115550047, 15173.620659483602, 13597.116187447784, 13801.787811821632, 13870.861291386957, 14535.200563969083, 14658.0, 11792.823107653221, 13320.600381988555, 13407.463701451832, 13788.793168102688, 14451.349689264218, 13102.148360356547, 13605.591832244652, 13999.370028348952, 14275.214863182624, 14277.071990320595, 10659.94670026645, 11027.0, 11154.378721000721, 11229.55081796719, 11677.299362038304, 10974.506147223234, 10981.560737570408, 11207.43962801873, 11247.0, 11264.211505194886], "value": 7490.179474673781, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1617.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 117.0, 98.0, 169.0, 179.0, 175.0, 118.0, 123.0, 175.0], "value": 137.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 144.0, 114.0, 148.0, 143.0, 116.0, 100.0, 147.0, 148.0, 117.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 212.0, 206.0, 255.0, 298.0, 239.0, 201.0, 202.0, 196.0, 228.0], "value": 224.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 60.0, 60.0, 85.0, 63.0, 61.0, 58.0, 61.0, 75.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 84.0, 73.0, 71.0, 72.0, 80.0, 70.0, 77.0, 103.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 86.0, 106.0, 86.0, 82.0, 88.0, 91.0, 131.0, 113.0, 87.0], "value": 100.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 130.0, 98.0, 151.0, 153.0, 112.0, 152.0, 149.0, 97.0, 97.0], "value": 124.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 80.0, 133.0, 142.0, 147.0, 92.0, 93.0, 124.0, 144.0, 92.0], "value": 113.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 76.0, 84.0, 70.0, 63.0, 63.0, 63.0, 64.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 71.0, 80.0, 74.0, 70.0, 71.0, 71.0, 108.0, 98.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 90.0, 84.0, 84.0, 84.0, 88.0, 89.0, 88.0, 77.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 187.0, 157.0, 153.0, 140.0, 156.0, 150.0, 138.0, 198.0, 152.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 204.0, 181.0, 171.0, 176.0, 174.0, 171.0, 177.0, 173.0, 176.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 83.0, 67.0, 69.0, 65.0, 66.0, 68.0, 69.0, 65.0, 68.0], "value": 68.9, "unit": "score"}]}]} 01:30:50 INFO - Return code: 0 01:30:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:30:50 ERROR - # TBPL SUCCESS # 01:30:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:30:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:30:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:30:50 INFO - 2017-02-07 01:30:50.284 screenresolution[2271:21485] starting screenresolution argv=screenresolution get 01:30:50 INFO - 2017-02-07 01:30:50.286 screenresolution[2271:21485] Display 0: 1600x1200x32@60 01:30:50 INFO - 2017-02-07 01:30:50.292 screenresolution[2272:21488] starting screenresolution argv=screenresolution list 01:30:50 INFO - Available Modes on Display 0 01:30:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:30:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:30:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:30:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:30:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:30:50 INFO - Intel Iris: 01:30:50 INFO - Chipset Model: Intel Iris 01:30:50 INFO - Type: GPU 01:30:50 INFO - Bus: Built-In 01:30:50 INFO - VRAM (Dynamic, Max): 1536 MB 01:30:50 INFO - Vendor: Intel (0x8086) 01:30:50 INFO - Device ID: 0x0a2e 01:30:50 INFO - Revision ID: 0x0009 01:30:50 INFO - Displays: 01:30:50 INFO - Display: 01:30:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:30:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:30:50 INFO - Display Serial Number: 1600x1200 60 01:30:50 INFO - Main Display: Yes 01:30:50 INFO - Mirror: Off 01:30:50 INFO - Online: Yes 01:30:50 INFO - Rotation: Supported 01:30:50 INFO - Return code: 0 01:30:50 INFO - Running post-action listener: _resource_record_post_action 01:30:50 INFO - [mozharness: 2017-02-07 09:30:50.529878Z] Finished run-tests step (success) 01:30:50 INFO - Running post-run listener: _resource_record_post_run 01:30:50 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 1132032; Write bytes: 513775616; Read time: 11; Write time: 1649 01:30:50 INFO - TinderboxPrint: CPU usage
54.3% 01:30:50 INFO - TinderboxPrint: I/O read bytes / time
1,132,032 / 11 01:30:50 INFO - TinderboxPrint: I/O write bytes / time
513,775,616 / 1,649 01:30:50 INFO - TinderboxPrint: CPU idle
2,190.6 (45.7%) 01:30:50 INFO - TinderboxPrint: CPU system
968.7 (20.2%) 01:30:50 INFO - TinderboxPrint: CPU user
1,634.4 (34.1%) 01:30:50 INFO - TinderboxPrint: Swap in / out
208,224,256 / 0 01:30:50 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 199893504; Write bytes: 198762496; Read time: 15457; Write time: 428 01:30:50 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 1132032; Write bytes: 305199104; Read time: 11; Write time: 1186 01:30:50 INFO - Running post-run listener: _upload_blobber_files 01:30:50 INFO - Blob upload gear active. 01:30:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:30:50 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 01:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:30:51 INFO - (blobuploader) - INFO - Open directory for files ... 01:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:52 INFO - (blobuploader) - INFO - Done attempting. 01:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:30:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:53 INFO - (blobuploader) - INFO - Done attempting. 01:30:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:30:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:54 INFO - (blobuploader) - INFO - Done attempting. 01:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:57 INFO - (blobuploader) - INFO - Done attempting. 01:30:57 INFO - (blobuploader) - INFO - Iteration through files over. 01:30:57 INFO - Return code: 0 01:30:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:30:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:30:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f07f575351c2b0306ce00b8848350e498cb0cb2a4100f126da7f43630ea1bdf9278ce8573c3477249590872ce90e829a17ccc0dc326b092130974b10bd5f69d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48fbf7a3169500d7a230589576cce9ce62a6989aea004e3e313b565d5863b6b7345c5449c5f12ad0e96a5dc8c35c3489bee25f49cf2c4939a792dbe49a187df3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02343d2bcbeceb20990a6b6bf3ade9ad8c641acd8810e637eee77dec1391cc568ffa923184ea33c34d6cf4116c6d3ecf9a13e45249e9603b778660b3107d907c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c531d9116a7fda9bf6e9bdb517e789acbea5030c2d81a1a23ee821495769b63b82dde4e2531b5b56f93e234fb98127c84e2a177a95f3db1b584b2b204ffa4a0c"} 01:30:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:30:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:30:57 INFO - Contents: 01:30:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f07f575351c2b0306ce00b8848350e498cb0cb2a4100f126da7f43630ea1bdf9278ce8573c3477249590872ce90e829a17ccc0dc326b092130974b10bd5f69d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48fbf7a3169500d7a230589576cce9ce62a6989aea004e3e313b565d5863b6b7345c5449c5f12ad0e96a5dc8c35c3489bee25f49cf2c4939a792dbe49a187df3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02343d2bcbeceb20990a6b6bf3ade9ad8c641acd8810e637eee77dec1391cc568ffa923184ea33c34d6cf4116c6d3ecf9a13e45249e9603b778660b3107d907c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c531d9116a7fda9bf6e9bdb517e789acbea5030c2d81a1a23ee821495769b63b82dde4e2531b5b56f93e234fb98127c84e2a177a95f3db1b584b2b204ffa4a0c"} 01:30:57 INFO - Running post-run listener: copy_logs_to_upload_dir 01:30:57 INFO - Copying logs to upload dir... 01:30:57 INFO - mkdir: /builds/slave/test/build/upload/logs 01:30:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.320268 ========= master_lag: 2.18 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-07 01:30:59.331322) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 01:30:59.336005) ========= 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.jfXzFANat8/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.eOpS7KN3Jz/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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/Mozilla-Aurora/sha512/7f07f575351c2b0306ce00b8848350e498cb0cb2a4100f126da7f43630ea1bdf9278ce8573c3477249590872ce90e829a17ccc0dc326b092130974b10bd5f69d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48fbf7a3169500d7a230589576cce9ce62a6989aea004e3e313b565d5863b6b7345c5449c5f12ad0e96a5dc8c35c3489bee25f49cf2c4939a792dbe49a187df3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02343d2bcbeceb20990a6b6bf3ade9ad8c641acd8810e637eee77dec1391cc568ffa923184ea33c34d6cf4116c6d3ecf9a13e45249e9603b778660b3107d907c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c531d9116a7fda9bf6e9bdb517e789acbea5030c2d81a1a23ee821495769b63b82dde4e2531b5b56f93e234fb98127c84e2a177a95f3db1b584b2b204ffa4a0c"} build_url:https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011506 build_url: 'https://queue.taskcluster.net/v1/task/Ee15pPDOTzGfOTcmlujmng/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f07f575351c2b0306ce00b8848350e498cb0cb2a4100f126da7f43630ea1bdf9278ce8573c3477249590872ce90e829a17ccc0dc326b092130974b10bd5f69d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48fbf7a3169500d7a230589576cce9ce62a6989aea004e3e313b565d5863b6b7345c5449c5f12ad0e96a5dc8c35c3489bee25f49cf2c4939a792dbe49a187df3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02343d2bcbeceb20990a6b6bf3ade9ad8c641acd8810e637eee77dec1391cc568ffa923184ea33c34d6cf4116c6d3ecf9a13e45249e9603b778660b3107d907c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c531d9116a7fda9bf6e9bdb517e789acbea5030c2d81a1a23ee821495769b63b82dde4e2531b5b56f93e234fb98127c84e2a177a95f3db1b584b2b204ffa4a0c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 01:30:59.372713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:30:59.373235) ========= 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.jfXzFANat8/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.eOpS7KN3Jz/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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.005353 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 01:30:59.421486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 01:30:59.422009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 01:30:59.422533) ========= ========= Total master_lag: 2.35 =========