builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0322 starttime: 1464044595.49 results: success (0) buildid: 20160523144654 builduid: e92648406c49408d84939f75e67c7e00 revision: c90fe6f633f400db7eb108f02397bcc391c12a0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:15.486600) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:15.487165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:15.487451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:15.588151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:15.588419) ========= 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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-23 16:03:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-05-23 16:03:15 (19.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.451569 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:16.060555) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:16.060892) ========= 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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.025845 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:16.110431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:16.110805) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c90fe6f633f400db7eb108f02397bcc391c12a0d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c90fe6f633f400db7eb108f02397bcc391c12a0d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-23 16:03:15,678 truncating revision to first 12 chars 2016-05-23 16:03:15,678 Setting DEBUG logging. 2016-05-23 16:03:15,678 attempt 1/10 2016-05-23 16:03:15,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c90fe6f633f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 16:03:16,285 unpacking tar archive at: fx-team-c90fe6f633f4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.860786 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:16.989529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:16.989810) ========= script_repo_revision: c90fe6f633f400db7eb108f02397bcc391c12a0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:16.990232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:16.990497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 16:03:17.005201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 22 secs) (at 2016-05-23 16:03:17.005585) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:03:16 INFO - MultiFileLogger online at 20160523 16:03:16 in /builds/slave/test 16:03:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:03:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:03:16 INFO - {'append_to_log': False, 16:03:16 INFO - 'base_work_dir': '/builds/slave/test', 16:03:16 INFO - 'blob_upload_branch': 'Fx-Team', 16:03:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:03:16 INFO - 'branch': 'Fx-Team', 16:03:16 INFO - 'buildbot_json_path': 'buildprops.json', 16:03:16 INFO - 'config_files': ('talos/mac_config.py',), 16:03:16 INFO - 'default_actions': ('clobber', 16:03:16 INFO - 'read-buildbot-config', 16:03:16 INFO - 'download-and-extract', 16:03:16 INFO - 'populate-webroot', 16:03:16 INFO - 'create-virtualenv', 16:03:16 INFO - 'install', 16:03:16 INFO - 'run-tests'), 16:03:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:03:16 INFO - 'download_minidump_stackwalk': True, 16:03:16 INFO - 'download_symbols': 'ondemand', 16:03:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:03:16 INFO - 'tooltool.py': '/tools/tooltool.py', 16:03:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:03:16 INFO - '/tools/misc-python/virtualenv.py')}, 16:03:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:03:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:03:16 INFO - 'installer_path': 'installer.exe', 16:03:16 INFO - 'log_level': 'info', 16:03:16 INFO - 'log_name': 'talos', 16:03:16 INFO - 'log_to_console': True, 16:03:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:03:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:03:16 INFO - 'opt_config_files': (), 16:03:16 INFO - 'pip_index': False, 16:03:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:03:16 INFO - 'cmd': ('bash', 16:03:16 INFO - '-c', 16:03:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:03:16 INFO - 'enabled': True, 16:03:16 INFO - 'halt_on_failure': False, 16:03:16 INFO - 'name': 'check_screen_resolution'},), 16:03:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:03:16 INFO - 'cmd': ('bash', 16:03:16 INFO - '-c', 16:03:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:03:16 INFO - 'enabled': True, 16:03:16 INFO - 'halt_on_failure': False, 16:03:16 INFO - 'name': 'check_screen_resolution'},), 16:03:16 INFO - 'run_cmd_checks_enabled': True, 16:03:16 INFO - 'sps_profile': False, 16:03:16 INFO - 'sps_profile_interval': 0, 16:03:16 INFO - 'suite': 'dromaeojs-e10s', 16:03:16 INFO - 'system_bits': '32', 16:03:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:03:16 INFO - 'title': 't-yosemite-r7-0322', 16:03:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:03:16 INFO - 'use_talos_json': True, 16:03:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:03:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:03:16 INFO - 'work_dir': 'build'} 16:03:16 INFO - ##### 16:03:16 INFO - ##### Running clobber step. 16:03:16 INFO - ##### 16:03:16 INFO - Running pre-action listener: _resource_record_pre_action 16:03:16 INFO - Running main action method: clobber 16:03:16 INFO - rmtree: /builds/slave/test/build 16:03:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:03:18 INFO - Running post-action listener: _resource_record_post_action 16:03:18 INFO - ##### 16:03:18 INFO - ##### Finished clobber step (success) 16:03:18 INFO - ##### 16:03:18 INFO - ##### 16:03:18 INFO - ##### Running read-buildbot-config step. 16:03:18 INFO - ##### 16:03:18 INFO - Running pre-action listener: _resource_record_pre_action 16:03:18 INFO - Running main action method: read_buildbot_config 16:03:18 INFO - Using buildbot properties: 16:03:18 INFO - { 16:03:18 INFO - "project": "", 16:03:18 INFO - "product": "firefox", 16:03:18 INFO - "script_repo_revision": "production", 16:03:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:03:18 INFO - "repository": "", 16:03:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:03:18 INFO - "buildid": "20160523144654", 16:03:18 INFO - "pgo_build": "False", 16:03:18 INFO - "basedir": "/builds/slave/test", 16:03:18 INFO - "buildnumber": 13, 16:03:18 INFO - "slavename": "t-yosemite-r7-0322", 16:03:18 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 16:03:18 INFO - "platform": "yosemite_r7", 16:03:18 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 16:03:18 INFO - "branch": "fx-team", 16:03:18 INFO - "repo_path": "integration/fx-team", 16:03:18 INFO - "revision": "c90fe6f633f400db7eb108f02397bcc391c12a0d", 16:03:18 INFO - "stage_platform": "macosx64", 16:03:18 INFO - "builduid": "e92648406c49408d84939f75e67c7e00", 16:03:18 INFO - "slavebuilddir": "test" 16:03:18 INFO - } 16:03:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 16:03:18 INFO - Running post-action listener: _resource_record_post_action 16:03:18 INFO - ##### 16:03:18 INFO - ##### Finished read-buildbot-config step (success) 16:03:18 INFO - ##### 16:03:18 INFO - ##### 16:03:18 INFO - ##### Running download-and-extract step. 16:03:18 INFO - ##### 16:03:18 INFO - Running pre-action listener: _resource_record_pre_action 16:03:18 INFO - Running main action method: download_and_extract 16:03:18 INFO - mkdir: /builds/slave/test/build/tests 16:03:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:03:18 INFO - https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:03:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 16:03:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 16:03:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 16:03:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 16:03:49 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 16:03:49 INFO - retry: attempt #1 caught exception: timed out 16:03:49 INFO - retry: Failed, sleeping 30 seconds before retrying 16:04:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #2 16:04:24 INFO - Downloaded 1199 bytes. 16:04:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 16:04:24 INFO - Using the following test package requirements: 16:04:24 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 16:04:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:04:24 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 16:04:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:04:24 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 16:04:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:04:24 INFO - u'jsshell-mac.zip'], 16:04:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:04:24 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 16:04:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 16:04:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:04:24 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 16:04:24 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:04:24 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 16:04:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:04:24 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 16:04:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:04:24 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 16:04:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:04:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:24 INFO - https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:04:26 INFO - Downloaded 18630441 bytes. 16:04:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:04:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:04:29 INFO - Return code: 0 16:04:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:04:29 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:29 INFO - https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:04:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:04:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:04:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:04:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:04:30 INFO - Downloaded 18630441 bytes. 16:04:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:04:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:04:34 INFO - Return code: 0 16:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:34 INFO - https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:04:34 INFO - Downloaded 10840359 bytes. 16:04:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:04:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:04:35 INFO - Return code: 0 16:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:35 INFO - https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:04:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:04:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:04:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 16:04:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 16:04:46 INFO - Downloaded 110172120 bytes. 16:04:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:04:46 INFO - mkdir: /builds/slave/test/properties 16:04:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:04:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:04:46 INFO - Contents: 16:04:46 INFO - build_url:https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:04:48 INFO - Running post-action listener: _resource_record_post_action 16:04:48 INFO - Running post-action listener: set_extra_try_arguments 16:04:48 INFO - ##### 16:04:48 INFO - ##### Finished download-and-extract step (success) 16:04:48 INFO - ##### 16:04:48 INFO - ##### 16:04:48 INFO - ##### Running populate-webroot step. 16:04:48 INFO - ##### 16:04:48 INFO - Running pre-action listener: _resource_record_pre_action 16:04:48 INFO - Running main action method: populate_webroot 16:04:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:04:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:04:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:04:48 INFO - '--tppagecycles', 16:04:48 INFO - '7'], 16:04:48 INFO - 'tests': ['tsvgm']}}, 16:04:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:04:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:04:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:04:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:04:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:48 INFO - 'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:04:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:48 INFO - 'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['damp', 'tps']}, 16:04:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:48 INFO - 'tests': ['damp', 'tps']}, 16:04:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['dromaeo_dom']}, 16:04:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:04:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['a11yr', 16:04:48 INFO - 'ts_paint', 16:04:48 INFO - 'tpaint', 16:04:48 INFO - 'sessionrestore', 16:04:48 INFO - 'sessionrestore_no_auto_restore', 16:04:48 INFO - 'tabpaint']}, 16:04:48 INFO - 'other-e10s': {'tests': ['a11yr', 16:04:48 INFO - 'ts_paint', 16:04:48 INFO - 'tpaint', 16:04:48 INFO - 'sessionrestore', 16:04:48 INFO - 'sessionrestore_no_auto_restore', 16:04:48 INFO - 'tabpaint']}, 16:04:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:04:48 INFO - 'ts_paint', 16:04:48 INFO - 'tpaint', 16:04:48 INFO - 'sessionrestore', 16:04:48 INFO - 'sessionrestore_no_auto_restore', 16:04:48 INFO - 'tabpaint']}, 16:04:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:04:48 INFO - 'ts_paint', 16:04:48 INFO - 'tpaint', 16:04:48 INFO - 'sessionrestore', 16:04:48 INFO - 'sessionrestore_no_auto_restore', 16:04:48 INFO - 'tabpaint']}, 16:04:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['a11yr', 16:04:48 INFO - 'ts_paint', 16:04:48 INFO - 'tpaint', 16:04:48 INFO - 'sessionrestore', 16:04:48 INFO - 'sessionrestore_no_auto_restore', 16:04:48 INFO - 'tabpaint']}, 16:04:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['a11yr', 16:04:48 INFO - 'ts_paint', 16:04:48 INFO - 'tpaint', 16:04:48 INFO - 'sessionrestore', 16:04:48 INFO - 'sessionrestore_no_auto_restore', 16:04:48 INFO - 'tabpaint']}, 16:04:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['tsvgx', 16:04:48 INFO - 'tsvgr_opacity', 16:04:48 INFO - 'tart', 16:04:48 INFO - 'tscrollx', 16:04:48 INFO - 'cart']}, 16:04:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:04:48 INFO - 'tsvgr_opacity', 16:04:48 INFO - 'tart', 16:04:48 INFO - 'tscrollx', 16:04:48 INFO - 'cart']}, 16:04:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:48 INFO - 'talos_options': ['--disable-e10s'], 16:04:48 INFO - 'tests': ['tp5o']}, 16:04:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:48 INFO - 'tests': ['tp5o']}, 16:04:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:48 INFO - 'talos_options': ['--disable-e10s', 16:04:48 INFO - '--xperf_path', 16:04:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:48 INFO - 'tests': ['tp5n']}, 16:04:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:04:48 INFO - 'talos_options': ['--xperf_path', 16:04:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:04:48 INFO - 'tests': ['tp5n']}}, 16:04:48 INFO - 'talos.zip': {'path': '', 16:04:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:04:48 INFO - Running post-action listener: _resource_record_post_action 16:04:48 INFO - ##### 16:04:48 INFO - ##### Finished populate-webroot step (success) 16:04:48 INFO - ##### 16:04:48 INFO - ##### 16:04:48 INFO - ##### Running create-virtualenv step. 16:04:48 INFO - ##### 16:04:48 INFO - Running pre-action listener: _resource_record_pre_action 16:04:48 INFO - Running main action method: create_virtualenv 16:04:48 INFO - Creating virtualenv /builds/slave/test/build/venv 16:04:48 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 16:04:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:04:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:04:48 INFO - Using real prefix '/tools/python27' 16:04:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:04:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:04:51 INFO - Installing pip.................done. 16:04:51 INFO - Return code: 0 16:04:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:04: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', 'pip>=1.5'] in /builds/slave/test/build 16:04: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 pip>=1.5 16:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:51 INFO - 'HOME': '/Users/cltbld', 16:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:51 INFO - 'LOGNAME': 'cltbld', 16:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:51 INFO - 'MOZ_NO_REMOTE': '1', 16:04:51 INFO - 'NO_EM_RESTART': '1', 16:04:51 INFO - 'PAGER': '/bin/cat', 16:04:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:51 INFO - 'PWD': '/builds/slave/test', 16:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:51 INFO - 'SHELL': '/bin/bash', 16:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:04:51 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:51 INFO - 'USER': 'cltbld', 16:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:51 INFO - 'XPC_FLAGS': '0x0', 16:04:51 INFO - 'XPC_SERVICE_NAME': '0', 16:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:04:52 INFO - Cleaning up... 16:04:52 INFO - Return code: 0 16:04:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:04:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:04:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:04:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:52 INFO - 'HOME': '/Users/cltbld', 16:04:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:52 INFO - 'LOGNAME': 'cltbld', 16:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:52 INFO - 'MOZ_NO_REMOTE': '1', 16:04:52 INFO - 'NO_EM_RESTART': '1', 16:04:52 INFO - 'PAGER': '/bin/cat', 16:04:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:52 INFO - 'PWD': '/builds/slave/test', 16:04:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:52 INFO - 'SHELL': '/bin/bash', 16:04:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:04:52 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:04:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:52 INFO - 'USER': 'cltbld', 16:04:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:52 INFO - 'XPC_FLAGS': '0x0', 16:04:52 INFO - 'XPC_SERVICE_NAME': '0', 16:04:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:52 INFO - Downloading/unpacking psutil>=3.1.1 16:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:04:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:55 INFO - Installing collected packages: psutil 16:04:55 INFO - Running setup.py install for psutil 16:04:55 INFO - building 'psutil._psutil_osx' extension 16:04:55 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 16:04:56 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 16:04:56 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 16:04:56 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 16:04:56 INFO - building 'psutil._psutil_posix' extension 16:04:56 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 16:04:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:04:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:04:56 INFO - ^ 16:04:56 INFO - 1 warning generated. 16:04:56 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 16:04:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:04:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:04:56 INFO - Successfully installed psutil 16:04:56 INFO - Cleaning up... 16:04:56 INFO - Return code: 0 16:04:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:04:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:56 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 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:04:56 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 16:04:56 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 16:04:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:04:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:56 INFO - 'HOME': '/Users/cltbld', 16:04:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:56 INFO - 'LOGNAME': 'cltbld', 16:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:56 INFO - 'MOZ_NO_REMOTE': '1', 16:04:56 INFO - 'NO_EM_RESTART': '1', 16:04:56 INFO - 'PAGER': '/bin/cat', 16:04:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:56 INFO - 'PWD': '/builds/slave/test', 16:04:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:56 INFO - 'SHELL': '/bin/bash', 16:04:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:04:56 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:04:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:56 INFO - 'USER': 'cltbld', 16:04:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:56 INFO - 'XPC_FLAGS': '0x0', 16:04:56 INFO - 'XPC_SERVICE_NAME': '0', 16:04:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:04:56 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 16:04:56 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 16:04:56 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 16:04:56 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 16:04:56 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 16:04:56 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 16:04:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:04:59 INFO - Installing collected packages: mozsystemmonitor 16:04:59 INFO - Running setup.py install for mozsystemmonitor 16:04:59 INFO - Successfully installed mozsystemmonitor 16:04:59 INFO - Cleaning up... 16:04:59 INFO - Return code: 0 16:04:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:04:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:04:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:04:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:04:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:04:59 INFO - 'HOME': '/Users/cltbld', 16:04:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:04:59 INFO - 'LOGNAME': 'cltbld', 16:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:04:59 INFO - 'MOZ_NO_REMOTE': '1', 16:04:59 INFO - 'NO_EM_RESTART': '1', 16:04:59 INFO - 'PAGER': '/bin/cat', 16:04:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:04:59 INFO - 'PWD': '/builds/slave/test', 16:04:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:04:59 INFO - 'SHELL': '/bin/bash', 16:04:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:04:59 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:04:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:04:59 INFO - 'USER': 'cltbld', 16:04:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:04:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:04:59 INFO - 'XPC_FLAGS': '0x0', 16:04:59 INFO - 'XPC_SERVICE_NAME': '0', 16:04:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:04:59 INFO - Downloading/unpacking blobuploader==1.2.4 16:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:05:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:05:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:03 INFO - Downloading docopt-0.6.1.tar.gz 16:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:05:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:05:03 INFO - Running setup.py install for blobuploader 16:05:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:05:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:05:03 INFO - Running setup.py install for requests 16:05:04 INFO - Running setup.py install for docopt 16:05:04 INFO - Successfully installed blobuploader requests docopt 16:05:04 INFO - Cleaning up... 16:05:04 INFO - Return code: 0 16:05:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:05:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:05:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:05:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:05:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:04 INFO - 'HOME': '/Users/cltbld', 16:05:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:04 INFO - 'LOGNAME': 'cltbld', 16:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:04 INFO - 'MOZ_NO_REMOTE': '1', 16:05:04 INFO - 'NO_EM_RESTART': '1', 16:05:04 INFO - 'PAGER': '/bin/cat', 16:05:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:04 INFO - 'PWD': '/builds/slave/test', 16:05:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:04 INFO - 'SHELL': '/bin/bash', 16:05:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:05:04 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:05:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:04 INFO - 'USER': 'cltbld', 16:05:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:04 INFO - 'XPC_FLAGS': '0x0', 16:05:04 INFO - 'XPC_SERVICE_NAME': '0', 16:05:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-jmfHQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-7dnMrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Wip9vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:04 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-N9DjFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-dAyCVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-MTJ4tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-TanDSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-t9W_7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-TeB7gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-URsETi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-tkMOGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-QgJbT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-9yrFBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:05 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-qzqj25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:06 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-BPrkt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:06 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-WvIAAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:06 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Qwv_V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:05:06 INFO - Running setup.py install for manifestparser 16:05:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:05:06 INFO - Running setup.py install for mozcrash 16:05:06 INFO - Running setup.py install for mozdebug 16:05:06 INFO - Running setup.py install for mozdevice 16:05:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:05:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:05:06 INFO - Running setup.py install for mozfile 16:05:07 INFO - Running setup.py install for mozhttpd 16:05:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:05:07 INFO - Running setup.py install for mozinfo 16:05:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:05:07 INFO - Running setup.py install for mozInstall 16:05:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:05:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:05:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:05:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:05:07 INFO - Running setup.py install for mozleak 16:05:07 INFO - Running setup.py install for mozlog 16:05:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:05:07 INFO - Running setup.py install for moznetwork 16:05:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:05:08 INFO - Running setup.py install for mozprocess 16:05:08 INFO - Running setup.py install for mozprofile 16:05:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:05:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:05:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:05:08 INFO - Running setup.py install for mozrunner 16:05:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:05:08 INFO - Running setup.py install for mozscreenshot 16:05:08 INFO - Running setup.py install for moztest 16:05:08 INFO - Running setup.py install for mozversion 16:05:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:05:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:05:08 INFO - Cleaning up... 16:05:08 INFO - Return code: 0 16:05:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:08 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 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:05:08 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 16:05:08 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 16:05:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:05:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:08 INFO - 'HOME': '/Users/cltbld', 16:05:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:08 INFO - 'LOGNAME': 'cltbld', 16:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:08 INFO - 'MOZ_NO_REMOTE': '1', 16:05:08 INFO - 'NO_EM_RESTART': '1', 16:05:08 INFO - 'PAGER': '/bin/cat', 16:05:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:08 INFO - 'PWD': '/builds/slave/test', 16:05:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:08 INFO - 'SHELL': '/bin/bash', 16:05:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:05:08 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:05:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:08 INFO - 'USER': 'cltbld', 16:05:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:08 INFO - 'XPC_FLAGS': '0x0', 16:05:08 INFO - 'XPC_SERVICE_NAME': '0', 16:05:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:05:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-oMq01m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:05:09 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)) 16:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:05:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-lBN3LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:05:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-0k2LnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:05:09 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)) 16:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:05:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-Qd3oQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:05:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-gMIbhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:05:09 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)) 16:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:05:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-vm4tfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:05:09 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)) 16:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:05:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-UAsQ88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:05:09 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)) 16:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:05:09 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-XJXMNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:05:10 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)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ikAOex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:05:10 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)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-M656eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-0UBSBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:05:10 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)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-s1q7Nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-6r61uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:05:10 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)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-P2IVnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-OkN3cV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:05:10 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)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-ii7601-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:05:10 INFO - Running setup.py (path:/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/pip-xqmoim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:05:11 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)) 16:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:05:11 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)) 16:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:05:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:05:11 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 16:05:11 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 16:05:11 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 16:05:11 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 16:05:11 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 16:05:11 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 16:05:13 INFO - Downloading blessings-1.6.tar.gz 16:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:05:13 INFO - Installing collected packages: blessings 16:05:13 INFO - Running setup.py install for blessings 16:05:13 INFO - Successfully installed blessings 16:05:13 INFO - Cleaning up... 16:05:13 INFO - Return code: 0 16:05:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:05:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:14 INFO - Reading from file tmpfile_stdout 16:05:14 INFO - Current package versions: 16:05:14 INFO - blessings == 1.6 16:05:14 INFO - blobuploader == 1.2.4 16:05:14 INFO - docopt == 0.6.1 16:05:14 INFO - manifestparser == 1.1 16:05:14 INFO - mozInstall == 1.12 16:05:14 INFO - mozcrash == 0.17 16:05:14 INFO - mozdebug == 0.1 16:05:14 INFO - mozdevice == 0.48 16:05:14 INFO - mozfile == 1.2 16:05:14 INFO - mozhttpd == 0.7 16:05:14 INFO - mozinfo == 0.9 16:05:14 INFO - mozleak == 0.1 16:05:14 INFO - mozlog == 3.2 16:05:14 INFO - moznetwork == 0.27 16:05:14 INFO - mozprocess == 0.22 16:05:14 INFO - mozprofile == 0.28 16:05:14 INFO - mozrunner == 6.11 16:05:14 INFO - mozscreenshot == 0.1 16:05:14 INFO - mozsystemmonitor == 0.3 16:05:14 INFO - moztest == 0.7 16:05:14 INFO - mozversion == 1.4 16:05:14 INFO - psutil == 3.1.1 16:05:14 INFO - requests == 1.2.3 16:05:14 INFO - wsgiref == 0.1.2 16:05:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:05:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:14 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 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:05:14 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 16:05:14 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 16:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:14 INFO - 'HOME': '/Users/cltbld', 16:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:14 INFO - 'LOGNAME': 'cltbld', 16:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:14 INFO - 'MOZ_NO_REMOTE': '1', 16:05:14 INFO - 'NO_EM_RESTART': '1', 16:05:14 INFO - 'PAGER': '/bin/cat', 16:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:14 INFO - 'PWD': '/builds/slave/test', 16:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:14 INFO - 'SHELL': '/bin/bash', 16:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:05:14 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:14 INFO - 'USER': 'cltbld', 16:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:14 INFO - 'XPC_FLAGS': '0x0', 16:05:14 INFO - 'XPC_SERVICE_NAME': '0', 16:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 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)) 16:05:14 INFO - Cleaning up... 16:05:14 INFO - Return code: 0 16:05:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:05:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:14 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:14 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 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:05:14 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 16:05:14 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 16:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:14 INFO - 'HOME': '/Users/cltbld', 16:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:14 INFO - 'LOGNAME': 'cltbld', 16:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:14 INFO - 'MOZ_NO_REMOTE': '1', 16:05:14 INFO - 'NO_EM_RESTART': '1', 16:05:14 INFO - 'PAGER': '/bin/cat', 16:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:14 INFO - 'PWD': '/builds/slave/test', 16:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:14 INFO - 'SHELL': '/bin/bash', 16:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:05:14 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:14 INFO - 'USER': 'cltbld', 16:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:14 INFO - 'XPC_FLAGS': '0x0', 16:05:14 INFO - 'XPC_SERVICE_NAME': '0', 16:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:14 INFO - Downloading/unpacking jsonschema 16:05:14 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 16:05:14 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 16:05:14 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 16:05:14 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 16:05:14 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 16:05:14 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 16:05:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:05:16 INFO - Downloading/unpacking functools32 (from jsonschema) 16:05:17 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 16:05:17 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 16:05:17 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 16:05:17 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 16:05:17 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 16:05:17 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 16:05:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:05:17 INFO - warning: no files found matching '*.txt' 16:05:17 INFO - no previously-included directories found matching 'build' 16:05:17 INFO - no previously-included directories found matching 'dist' 16:05:17 INFO - no previously-included directories found matching '.git*' 16:05:17 INFO - Installing collected packages: jsonschema, functools32 16:05:17 INFO - Running setup.py install for functools32 16:05:17 INFO - warning: no files found matching '*.txt' 16:05:17 INFO - no previously-included directories found matching 'build' 16:05:17 INFO - no previously-included directories found matching 'dist' 16:05:17 INFO - no previously-included directories found matching '.git*' 16:05:17 INFO - Successfully installed jsonschema functools32 16:05:17 INFO - Cleaning up... 16:05:17 INFO - Return code: 0 16:05:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:17 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104bc0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bc6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae95abc20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, '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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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 16:05:17 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', 'flake8'] in /builds/slave/test/build 16:05:17 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 flake8 16:05:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:05:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:17 INFO - 'HOME': '/Users/cltbld', 16:05:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:17 INFO - 'LOGNAME': 'cltbld', 16:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:17 INFO - 'MOZ_NO_REMOTE': '1', 16:05:17 INFO - 'NO_EM_RESTART': '1', 16:05:17 INFO - 'PAGER': '/bin/cat', 16:05:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:17 INFO - 'PWD': '/builds/slave/test', 16:05:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:17 INFO - 'SHELL': '/bin/bash', 16:05:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:05:17 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:05:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:17 INFO - 'USER': 'cltbld', 16:05:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:17 INFO - 'XPC_FLAGS': '0x0', 16:05:17 INFO - 'XPC_SERVICE_NAME': '0', 16:05:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:18 INFO - Downloading/unpacking flake8 16:05:18 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 16:05:18 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 16:05:18 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 16:05:18 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 16:05:18 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 16:05:18 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 16:05:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:05:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:05:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:20 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 16:05:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:05:21 INFO - no previously-included directories found matching 'docs/_build' 16:05:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:05:21 INFO - Running setup.py install for pep8 16:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:05:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:05:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:05:21 INFO - no previously-included directories found matching 'docs/_build' 16:05:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:05:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:05:22 INFO - Cleaning up... 16:05:22 INFO - Return code: 0 16:05:22 INFO - Running post-action listener: _resource_record_post_action 16:05:22 INFO - Running post-action listener: _start_resource_monitoring 16:05:22 INFO - Starting resource monitoring. 16:05:22 INFO - ##### 16:05:22 INFO - ##### Finished create-virtualenv step (success) 16:05:22 INFO - ##### 16:05:22 INFO - ##### 16:05:22 INFO - ##### Running install step. 16:05:22 INFO - ##### 16:05:22 INFO - Running pre-action listener: _resource_record_pre_action 16:05:22 INFO - Running main action method: install 16:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:05:22 INFO - Reading from file tmpfile_stdout 16:05:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:05:22 INFO - Reading from file tmpfile_stdout 16:05:22 INFO - Output received: 16:05:22 INFO - Usage: mozinstall [options] installer 16:05:22 INFO - Options: 16:05:22 INFO - -h, --help show this help message and exit 16:05:22 INFO - -d DEST, --destination=DEST 16:05:22 INFO - Directory to install application into. [default: 16:05:22 INFO - "/builds/slave/test"] 16:05:22 INFO - --app=APP Application being installed. [default: firefox] 16:05:22 INFO - mkdir: /builds/slave/test/build/application 16:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:05:55 INFO - Reading from file tmpfile_stdout 16:05:55 INFO - Output received: 16:05:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:05:55 INFO - Running post-action listener: _resource_record_post_action 16:05:55 INFO - ##### 16:05:55 INFO - ##### Finished install step (success) 16:05:55 INFO - ##### 16:05:55 INFO - ##### 16:05:55 INFO - ##### Running run-tests step. 16:05:55 INFO - ##### 16:05:55 INFO - Running pre-action listener: _resource_record_pre_action 16:05:55 INFO - Running main action method: run_tests 16:05:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:05:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:05:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:05:55 INFO - 2016-05-23 16:05:55.859 screenresolution[1656:8255] starting screenresolution argv=screenresolution get 16:05:55 INFO - 2016-05-23 16:05:55.861 screenresolution[1656:8255] Display 0: 1600x1200x32@60 16:05:55 INFO - 2016-05-23 16:05:55.867 screenresolution[1657:8257] starting screenresolution argv=screenresolution list 16:05:55 INFO - Available Modes on Display 0 16:05:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:05:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:05:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:05:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:05:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:05:56 INFO - Intel Iris: 16:05:56 INFO - Chipset Model: Intel Iris 16:05:56 INFO - Type: GPU 16:05:56 INFO - Bus: Built-In 16:05:56 INFO - VRAM (Dynamic, Max): 1536 MB 16:05:56 INFO - Vendor: Intel (0x8086) 16:05:56 INFO - Device ID: 0x0a2e 16:05:56 INFO - Revision ID: 0x0009 16:05:56 INFO - Displays: 16:05:56 INFO - Display: 16:05:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:05:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:05:56 INFO - Display Serial Number: 1600x1200 60 16:05:56 INFO - Main Display: Yes 16:05:56 INFO - Mirror: Off 16:05:56 INFO - Online: Yes 16:05:56 INFO - Rotation: Supported 16:05:56 INFO - Return code: 0 16:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:05:56 INFO - Python 2.7.3 16:05:56 INFO - Return code: 0 16:05:56 INFO - grabbing minidump binary from tooltool 16:05:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:05:56 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 0x104a64d30>, '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 0x104888db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a5bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:05:56 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 16:05:56 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 16:05:56 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 16:05:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:05:56 INFO - Return code: 0 16:05:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:05:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:05:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:05:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:05:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:05:57 INFO - Return code: 0 16:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 16:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0322 --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 16:05:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xq6ZFQQZVI/Render', 16:05:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:05:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:05:57 INFO - 'HOME': '/Users/cltbld', 16:05:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:05:57 INFO - 'LOGNAME': 'cltbld', 16:05:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:05:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:57 INFO - 'MOZ_NO_REMOTE': '1', 16:05:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:05:57 INFO - 'NO_EM_RESTART': '1', 16:05:57 INFO - 'PAGER': '/bin/cat', 16:05:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:57 INFO - 'PWD': '/builds/slave/test', 16:05:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:05:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:05:57 INFO - 'SHELL': '/bin/bash', 16:05:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HsG3cIaWHH/Listeners', 16:05:57 INFO - 'TMPDIR': '/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/', 16:05:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:05:57 INFO - 'USER': 'cltbld', 16:05:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:05:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:57 INFO - 'XPC_FLAGS': '0x0', 16:05:57 INFO - 'XPC_SERVICE_NAME': '0', 16:05:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:05:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0322', '--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 16:05:57 INFO - mozversion application_buildid: 20160523144654 16:05:57 INFO - mozversion application_changeset: c90fe6f633f400db7eb108f02397bcc391c12a0d 16:05:57 INFO - mozversion application_display_name: Nightly 16:05:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:05:57 INFO - mozversion application_name: Firefox 16:05:57 INFO - mozversion application_remotingname: firefox 16:05:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:05:57 INFO - mozversion application_vendor: Mozilla 16:05:57 INFO - mozversion application_version: 49.0a1 16:05:57 INFO - mozversion platform_buildid: 20160523144654 16:05:57 INFO - mozversion platform_changeset: c90fe6f633f400db7eb108f02397bcc391c12a0d 16:05:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:05:57 INFO - mozversion platform_version: 49.0a1 16:05:57 INFO - using testdate: 1464044757 16:05:57 INFO - actual date: 1464044757 16:05:57 INFO - starting webserver on 'localhost:49271' 16:05:57 INFO - SUITE-START | Running 2 tests 16:05:57 INFO - TEST-START | dromaeo_css 16:05:57 INFO - operating with platform_type : mac_ 16:05:57 INFO - Initialising browser for dromaeo_css test... 16:05:57 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpD1I_tM/profile http://localhost:49271/getInfo.html) 16:06:00 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 16:06:00 INFO - PROCESS | 1675 | colorDepth:24 16:06:00 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 16:06:00 INFO - PROCESS | 1675 | __metrics 16:06:00 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:06:01 INFO - TEST-INFO | 1675: exit 0 16:06:01 INFO - Browser initialized. 16:06:01 INFO - Running cycle 1/1 for dromaeo_css test... 16:06:01 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpD1I_tM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:13 INFO - PROCESS | 1679 | RSS: Main: 249876480 16:06:13 INFO - PROCESS | 1679 | 16:07:03 INFO - PROCESS | 1679 | 1464044823044 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:09:13 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 16:09:14 INFO - PROCESS | 1679 | RSS: Main: 261222400 16:09:14 INFO - PROCESS | 1679 | 16:12:17 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 16:12:17 INFO - PROCESS | 1679 | RSS: Main: 273526784 16:12:17 INFO - PROCESS | 1679 | 16:15:19 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:15:20 INFO - PROCESS | 1679 | RSS: Main: 275869696 16:15:20 INFO - PROCESS | 1679 | 16:18:22 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:18:22 INFO - PROCESS | 1679 | RSS: Main: 277159936 16:18:22 INFO - PROCESS | 1679 | 16:21:25 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:21:26 INFO - PROCESS | 1679 | RSS: Main: 280309760 16:21:26 INFO - PROCESS | 1679 | 16:24:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:24:29 INFO - PROCESS | 1679 | RSS: Main: 281075712 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - PROCESS | 1679 | __start_tp_report 16:24:29 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 16:24:29 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 16:24:29 INFO - PROCESS | 1679 | |i|pagename|runs| 16:24:29 INFO - PROCESS | 1679 | |0;dojo.html;3116.688331166883;3363.075154332558;3486.912827179322;3541.132422556474;3544.113971507123;4267.765272909989;5853.09277062055;5901.203337549429;5953.910691339628;6022.885766133258;5721.456461636138;5727.57043221759;5782.277215348082;5782.739776710047;5853.560982926277;5211.218317252414;5250.9474905250845;5333.786648534054;5344.759485823147;5385.730713464331;45.910990068005646;5228.712420816853;5308.734563271841;5325;5337.14605663094;5263.736813159365;5288.338957630296;5293.417724050351;5311.814086506973;5317.601179911522;5311.787528498855;5335.733213339317;5341.1988201769655;5372.516473517363;5394.8921021579745;5191.896162076775;5195.896082078375;5265.710385928773;5270.104082305978;5312;5573.6098473106895;5678.4037676044245;5688.658680479143;5736.024875771129;5766.452187042224;6095.891769653485;6294.433500984887;6335.8732825343695;6378.075179099051;6391.77628782995;6292.685365731741;6308.716107775161;6352.364763523657;6363.363663633646;6364.331745166737;5892.616979896293;5951.375105613892;5962.493188079018;5977.193078934288;6025.367336429699;6236.251649802053;6286.779962701284;6346.714397852108;6389.488840892717;6395.296517383084;6192;6309.936900631027;6318.462930650854;6330.39861213184;6331.525135614847;6222.439980401786;6341.048842673544;6356.396142366468;6363.459105975951;6378.075179099097;6147.924113280247;6262;6277.435030847154;6350.872982540416;6358.77744278948;5233.345831771028;5286.62993590445;6290.433860952445;6356.046593011085;6370.203724534434;5070.138076527;5073.365829271341;5077.238414237894;5085.796568137307;5105.953279577752;4448.532904045093;4453.77731113443;4489.9775501122285;4523.660725445539;4576.81692732287;5779.306483222041;5794.565407594448;5813.157092221689;5840.3575606683235;5905.852353691106;6287.2140982377205;6297.464715499143;6303.558750887394;6313.08460273267;6351.872962540816;5765.913511297334;5840.532757379399;5910.083936989773;5924.674142922181;5933.465988061095;5543.972280138573;5573.191887176417;5574.163875418639;5575.860603484864;5604.271444712243;6469.611823290617;6473.643949582724;6477.125588045554;6486.254080780771;6491.156149700509;6275.34108918557;6276.027215781562;6319.58922670025;6325.810225693236;6353.52348573868;6486.513511486563;6494.772682956074;6504.674766261763;6507.967460162668;6535.117759102461;6352.301246862934;6354.205724284465;6360.522960777867;6366.554341196072;6391.041343798467;6261.7182226799;6267.310595834363;6313.526485513513;6325.209348831396;6328.303886572566;5154.948450515447;6199.1011303361665;6227.564070515202;6308.337624549356;6312.305646378986;5949.636194867781;6101.633901965896;6252.980922098605;6304.590201636879;6327.683615819283;6027.969860150672;6081.939180608138;6117.510599151969;6120.936985674706;6132.110843927695;6013.548983826318;6201.906971395523;6202.1527227809;6245.28179259391;6270.12218289449;5514.6691198528215;5847.38602446737;5924.259467566554;6082.482988945812;6131.141640170291 16:24:29 INFO - PROCESS | 1679 | |1;ext.html;471.5119850954261;472.02526782194775;479.04669707282505;534.7139280484939;535.1010302691477;29323.853380733093;38238;40336.79831600838;42661.57338426615;42819.78590107045;43136.137277254515;43907.34138987918;43917.560824391745;44067.55932440675;44083.338749918694;9565.617375304997;9744.75638109046;9772.657956971507;9803;9803.754906127333;9666.951665241699;9714;9733.075357840993;9758.804823903518;9813.116819486244;9791.167750741195;9831.213502919749;9845.310828242025;9852.852207216898;9855.753606159831;9698.321117521777;9766.609335626566;9781.90218097817;9802.901970980305;9815.558299876522;8868.15752503511;9050.592723327467;9531.475768832712;9613;9630.374025688308;40035.59964400348;40726.79636601798;41162;41175;41179.97050073742;2795.3011747063233;3076.492378757502;3151.590293261884;3371.460566309379;3374.4432168692138;27113.322166945785;28141.015064472645;28932.27669308284;29391.971281005277;30135.246618834484;2674.6924103728124;2723.155821695281;2759.820611660256;2777.5000499910007;2797.021042635082;461245.0813237804;463731;464898;466899.6655016737;467647;33863.49204761931;34643.4803477948;34661.30677386488;34720;35578.82210588982;36220.27559448796;36499.27001459956;36721.265574688354;36842.447363289575;36943.445848312294;15136.243187840564;15149.242537873062;15236.847631523542;15246.237688115772;15290.853186011094;12811.487540498461;12814.231146131262;12868.935655321851;12890.29103399322;12892;7764.029496312961;7980.840383192303;7981.561014144278;8016.278534931884;8069.0317161939765;2862.8997985070423;3236.5630639863316;3281;3303.7852539585333;3336.616289126733;970.1365784451843;1016.993176755022;1077.0414331245197;1106;1124.173732306754;24692.876535617565;27968.88124474998;28278.293042674097;28320.575191372147;28774.712252877624;1082.220801023262;1118.4128332625273;1147.0823341326904;1152.521703493041;1152.8501294831617;14448.060876043024;15249;15364;15493.225338733018;15622.218889055503;534074;680571;702208;706596;708561;54973;62866;62877.37122628715;62978.68510657417;63039.6848015757;1279.7650267491915;1316.427354100969;1452.9055611385227;1472.6686495538418;1472.7496325624884;27173.04894328689;28948;29155.416891661625;29526.852365738036;29846.403071938876;48701.7824554389;57688.4231157683;58252.70873645604;59973;63465.36534634595;554500;557973;558134;565477;566470;42337.78831105825;43248.783756081015;43773.78113109414;43969;44516.10967780691;47123;47551.762241188575;47851.04297914092;47855.76072119617;48184.51815481941;38965.41551876668;39338.60661393464;39389.409158863215;39710.80144599258;39945.801625951266;38569;39025.6097439022;39204;39504.407433887936;39637.40543891901;32943.67056329406;38369.4244586337;38958.4156237651;39133;39254;32445.18887027843;33954.8302258497;34218;34425.139371515914;35162.824185878904;24965;25072.874635626704;25100.62349064729;25427.745722543277;25507.489850203263 16:24:29 INFO - PROCESS | 1679 | |2;jquery.html;340.2565394612771;387.41500334494924;390.1961958365767;401.59238373051375;408.1449363583294;15177.468788592401;18564.90717546412;19671.5082122947;20367.898160509194;20417.183312667476;19818;19859.50351241216;20989.790102098974;21332.786672133276;22041.00815463304;5123.282740416335;6148.169997050386;6148.784792532262;6160;6160.19917410736;5169.345809341013;7102.928970710304;7487.588182649952;7510.586917719524;7627.5042122261875;6479.8056058318325;7414.406847452218;7841.568713720743;7873.409494287923;7880.684772609117;7647.946588308206;7697.769066928001;7839.764807055797;7844.450888437812;7858.528488290693;7262.709491620329;7571.469997100206;7578.317951384402;7579;7588.506747061423;24537.263882083567;27753.861230693918;28562.428751425065;29127;30024.399512009855;1840.300685739424;2262.9434264143365;2315.444293369596;2409.0002648900686;2456.250843492734;14261.928690356483;16353.936994095346;16398.26207820639;16453.91773041127;16520.09139497327;1687.59086163054;1786.56229223841;1977.5352792093847;1979.712941623471;1985.3646833013443;132661.33669331687;137161.62838371587;138118;138459.30770346083;138958.3052084743;21880.9059547022;22321.87942145526;22436.775632243796;22786.43033924165;22877;10363.32638378503;11674.474648640831;12428.37858107091;35809.283814323564;36588.451173232424;7973.521588704696;8116.837663246702;8131.7560473185895;8198.549079800669;8337.374696897758;8520.957395213109;8643.956780216184;8667.956660216658;8759.912400876037;8769;3368.545246391755;3917.196974620196;3949.5458022327225;4074.124063326399;4074.7758873262255;1968.7440632717655;2015.5488048604982;2015.9596808063757;2024.4533975826444;2057.1565658080117;868.913108689126;907.2469850024464;935.6678379175431;964.4117088575963;977.9266555008261;19698.90150549238;20326.695099573517;20376.083076261602;20413.591728165353;20501.38495845127;935.5322338830584;949.5252373813094;961.778790878102;1009.5507499162802;1056.8678915135608;9623.711288661352;10078.697639070839;10776.35341879474;10895.782084358269;10904.836427453594;527323;540411;543468;545668;635260;100429;104645;134194.32902835423;139402.58031067476;143055.28472357572;436.96722745794193;455.39432554701506;456.92232320505593;459.0909998203576;461.9976900115478;9479.041916167665;10556.366618002945;10610.840837387292;11193.104551635686;11345.376004319842;50402.4879253623;54886.17670735022;55219.72390138024;55722;55929.720351397984;66556;68304.31695683178;82141.58929205316;82419.3516129686;83463.5826820862;7771.261730135628;7887.605619719106;8055.275025247756;8098.149694282016;8351.081381048201;7756.263155000492;11319.660410187707;12000.459979301128;12145.332006739714;12309.953653939516;9022.684206052756;10211.693649190536;10229.181665466893;10654.029004634167;10751.860918219763;10289.125424339016;10344.689659310232;10429.061384475433;10640.84038739435;10705.732356691145;9237.722868313962;10431.37411755297;10546;10909.34543927367;10937.28907621034;7904.762857114296;7932.801679957816;8165.714200002972;8168;8327.333813295043;10323.174146068446;10629.468526573795;10629.94685026601;10865.674029779118;10876.293040952312 16:24:29 INFO - PROCESS | 1679 | |3;mootools.html;1400.2916441940831;1571.9056856588602;1785.187739578492;1909.9140538675758;1958.7159861820046;8070.71752488663;8624.956875215616;8695.608697608606;9167.633294668214;9173.31200159989;8737.781555461117;8807.91192088079;8823.647054117828;8872.024077351487;8878.955605221965;2381.1784934197717;2395.0539536883007;2409.9397515062087;2421.9757802421927;2432.9878350608224;2300.4823914619246;2338.9064437422485;2341.379534423379;2343.1096183450263;2369.917052903149;2388.1880160745345;2395.808335333169;2406.5066661334386;2415.770501802335;2421.4430680943306;2336.971732437739;2346.77705617966;2348.2133485282366;2374.3589230907733;2375.0618505690327;2351.6472529120597;2353.9646905296263;2383.2611890314056;2387.140629373424;2392.868392238426;8900.287976961827;8977.820443591158;8988.280937524982;9003.234725048378;9004.27965762744;5309.840704778863;5370.2750128732905;5376.973115134399;5408.783648654049;5482.5613950883835;3221.7905836120813;3490.1449144959392;3551.147724546116;3570.767900086486;3652.4521321801676;1000.214831357381;1039.7140786283758;1040.1003132290589;1041.156663102889;1053.4311471805293;11833.343331933536;11996.160268781188;12011.21927074746;12026;12062.336571488564;4750.239961606127;4796.754434810311;4908.042931628298;4909.607231421478;4914.410270767531;10038.949805251073;10077.992200779863;10127.139193168663;10140.797184056277;10173.389596624227;5351.464853514617;5375.973120134374;5387.757550910218;5433.375161856358;5448.128299472065;4487.461504619467;4783.019481006385;4912.9508704913205;4947.678400903929;4955.975220123876;4071.450354202204;4094.8148730754883;4115.115250221217;4141.4409054777825;4154.1068670236045;1278.3672082319126;1294.3140135728079;1302.856685764565;1315.9868401315864;1329.8005299205004;827.9213474719892;880.6389380354024;890.1632465482426;900.8651480276228;913.9634414623473;5639.6334238274385;5773.307203135567;5919.852003699856;5942.1383899335215;5982.820515384546;918.8254231695956;936.8735220745112;944.1125342178468;947.1570302430843;999.8050380175941;3855.20968201518;3939.5075615548058;3982.3827306766916;3999.0002499375155;4015.558288588253;10291.794164116825;10961.342319460859;10993.395363254938;10996.945015274872;11085.22403431752;10660.733481662865;10819.78360432787;10825.67522974312;10839.024487796136;10926.016658500774;8278.751637450887;8385.035720892054;8425.83148337042;8425.915740842636;8449.11284315138;5663.1788390682295;5775.653460792366;5791.594588378773;5862.179294898803;5871.7651293947765;9888.555015024485;10148.695539133838;10306.948465257627;10312.432816194882;10328.328658637165;10135.898641013791;10272.897271027194;10431.530581123716;10466.476676166008;10517.00088491592;6473.77341793035;6605.966970165118;6607.702653380513;8017.478863873829;8330.166983301622;8323.500589964622;8446.282066024456;8516.829663406821;8532.872006919777;8556;7439.479236453612;7573.734919277799;7651.464397492345;7669.079710434784;7717.305442510201;6749.3250674932115;7175.8159903615315;7310.634468276671;7363.668634911549;7530.134034586093;6930.549514281555;7046.788596342118;7081.044059051962;7082.681279342545;7111.075560177143;4398.582134697199;4679.532046795293;4761.357216775691;4803.3995750531185;4927.088488629472;4839.104765618372;4878.731669758055;4903.8528844134735;4940.950590494049;5124.79500819978 16:24:29 INFO - PROCESS | 1679 | |4;prototype.html;317.2006543510354;318.8628889577482;323.5971215836284;328.5974681015756;328.8290089153639;5290.92063619046;5758.712064396774;5763.711814409278;5801.767929282829;5808.912866306998;5350.652207606513;5629.521490673287;5678.148277758339;5706.543476521879;5733.168690539869;3569.6613769836313;3763.9435408468894;3828.7894165820867;3871.2838124946975;4159.7920103994675;4201.516825565053;4254.893627659318;4258.829646814123;4315.4389929309145;4329.7618630975285;3556.9110772230642;4260.403543503912;4260.744355338674;4281.100968796556;4304.7632380219075;4083.4283200351824;4227.978860105711;4232.132412855357;4265.466816647919;4271.376876786817;3527.5061491391225;3532.6290739472497;3667.3948798448223;3669.7247706422127;3680.705543556509;4504.549545045502;5045.798168073273;5360.91958620621;5464.754086066137;5470.781168753245;4474.955250447487;4769.952300476985;4770.689905156154;4877.658643872928;4960.751962401901;4773.856784296477;5312.415634280226;5535.640183388067;5542.808296216333;5996.340402555716;4079.4492743479545;4082.3672330788777;4110.506739191286;4117.197146556423;4121.9381709274385;5992.240049136379;6280;6281.335446106831;6298.49612031041;6312.305646378894;3448.5344478495585;4116.403121547359;4132.483439570054;4140.544540100586;4141.358089496133;4223.289567725076;4229.175310814423;4235.25882970479;4243.6605071594195;4264.658827293809;4068.3083875741195;4348.7390756554705;4354.867734389019;4511.62395469385;4770.785314660849;5310.389305229871;6028.397160284024;6029.186059881948;6035.517158627299;6077;1197.9820302695293;1412.0680350968312;1413.4699487692114;1414.886809055273;1420.884605584611;795.6697970342243;840.9495430274203;859.9656013759504;863.4387648028832;876.5003947749722;4831.033793241366;5552.639078459968;5560.527355174774;5582.63712858671;5619.606627536034;4698.459677137173;5037.647364684511;6075.301340345828;6118.449339559372;6167.414095660905;4768.332433459318;5265.973670131625;5542.224088627595;5548.389677135512;5558.277423934863;2846.331112188634;3043.5738996540504;3077.1845460952864;3134.746101559349;3229.1442767666585;5393.892122157535;6376.617402955838;6380.649064301415;6380.968095159587;6414.839629009312;5162.7542019221755;5513.8220402940615;6229.3770622937345;6265.96867015662;6294.339094395114;5398.46015398457;5848.64908105515;6352.618842869442;6394.008928615979;6440.971094105435;5570.387257401763;5605.402460298796;6034.63792172471;6113.449789518964;6177.96911015442;4943.5797957174045;5728.140778883201;5871.266091738533;6049.45922712453;6052.848678783065;5557.583181261502;5580.944190558205;5693.943060569507;6342.809715708536;6376.936230637634;3855.749376290532;3862.5364956205435;4011.2779699654343;4021.8592349267633;4051.736637118578;6092.725827337692;6115.571909966259;6120.17377654011;6148.538859585638;6159.414855588712;4890.217565189552;4951;4990.975045124751;5052.924206136984;5788.855278618068;5021.84934451967;5348.572114230775;5359.571234301168;5845;5909.320428150818;5318.97340513295;5398.055340315507;5559.24950131727;5747.19539264495;5831.883362332815;5807;5929.080992446177;5954.732037058429;5992.1910542078;6005.939940600538;5843.824685259449;5852.795152169653;5874.412558744091;5880.970595147168;5920.5069009284725 16:24:29 INFO - PROCESS | 1679 | |5;yui.html;669.5146019136126;688.1295161620554;712.3909057755616;729.7664747280872;746.0227102495733;15207.391704331827;15439.382424703012;15631.140287284208;15655.608609784762;16603.169841507908;16128;16508.33966641333;16542.421015264466;16546;16562.254698538563;920.9539523023839;927.5269612497641;934.0332755597957;935.3546053223288;937.5124935033779;721.7437809577604;890.7416849113749;926.1479438916214;927.7819712367589;928.8792456980583;935.8689783430325;970.0687340153461;976.8681228034231;978.4178413843787;981.4994352880011;816.930560902327;958.1855422890523;959.9760005999836;963.5037955452947;964.0841200859212;726.484196220684;726.7347418192375;728.3408515293668;730.9634518274065;732.3555271361168;15002.62493437662;15061.698766024727;15073.020253683475;15085.170315632637;15128.848711512854;11868.347240901747;11890.346030968294;11917.463714132884;11918.582849600223;11980.880191198064;9923;9942.850857237147;10088.394696318244;10103.949480252626;10333.018363255555;3413.2149605590853;3449.482577613353;3454.792712437262;3489.1626009757474;3572.1783989682517;79911.60044199742;80414.59792701057;81361.59319203426;81378.33797479127;83673.58163209206;9101.044390338919;9236.67671631503;9254.629814807333;9261.907380926104;9458.52707364629;20324.288649897477;20742.274020409513;20931.476713082295;21168.047437865334;21409.143634254455;7264.564126152342;7368.37368823656;7382.926170738224;7392.741254056083;7527.059117610299;3459.3600183966046;4005.459262999516;4076.470058892325;4077.2049450356894;4110.712250142521;3402.4726167444087;3426.400379933502;3459.584849818038;3468.3410152071024;3499.1951851073886;606.5844896246085;618.9938100618937;621.8352136683783;627.0312367392389;629.7575433458152;469.2468587916345;534.9759260833272;577.8988676981511;602.6564858030968;607.8358843112335;8026.558539280279;8114.918850811534;8162.1837816219095;8185.754427367069;8231.794205144919;547.5209191957038;557.4954666027252;559.1919676068043;596.6599038548072;603.8611119442553;3677.669009789132;3895.454636350913;3916.4321173429694;3972.324704800191;3999.042384462725;76505.6174719134;78014;78925.60537197391;86344.5682771582;87495;76889.615551923;77073.6146319276;77547;77858.61070694723;79013.60493197612;70941.64529177321;72382.63808680818;72908.63545682238;73217;73460.63269683617;7560.5841678706;7644.847103058019;8080;8332.6666933322;8404.705835295736;42170.36744448775;43390.34914476222;45654;46089;47078.76460617675;61338;61971.380286198364;63619.363806363195;64475.35524644693;64687;10933.671989840317;11027.22809403334;11185.832212516982;11189.104871610414;11482.94258528702;11927.403629818647;11999.940000299943;12147.210431321935;12453.564125255572;12562.246265224116;11168.497417616065;11227.157963152633;11399.97400233983;11421.481040301833;11676.975259377561;11052;11425.2002359834;11518.53925842957;11613.30320180792;11787.469563869476;10123.392596444237;11203.43982800873;11360.318380897173;11372.658820235407;11743.412829358327;8266.834663306821;8751.518666473405;9475.952620236854;9680.370775899544;9977.45124018186;8464.730290456235;8862.911370886466;8989.505577193317;9656.662016829378;9685.70942871715 16:24:29 INFO - PROCESS | 1679 | __end_tp_report 16:24:29 INFO - PROCESS | 1679 | __start_cc_report 16:24:29 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,415 16:24:29 INFO - PROCESS | 1679 | __end_cc_report 16:24:29 INFO - PROCESS | 1679 | __startTimestamp1464045869156__endTimestamp 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - PROCESS | 1679 | ------- Summary: start ------- 16:24:29 INFO - PROCESS | 1679 | Number of tests: 6 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - PROCESS | 1679 | [#0] dojo.html Cycles:165 Average:5793.98 Median:6025.37 stddev:801.34 (13.3%) stddev-sans-first:775.79 16:24:29 INFO - PROCESS | 1679 | Values: 3116.7 3363.1 3486.9 3541.1 3544.1 4267.8 5853.1 5901.2 5953.9 6022.9 5721.5 5727.6 5782.3 5782.7 5853.6 5211.2 5250.9 5333.8 5344.8 5385.7 45.9 5228.7 5308.7 5325.0 5337.1 5263.7 5288.3 5293.4 5311.8 5317.6 5311.8 5335.7 5341.2 5372.5 5394.9 5191.9 5195.9 5265.7 5270.1 5312.0 5573.6 5678.4 5688.7 5736.0 5766.5 6095.9 6294.4 6335.9 6378.1 6391.8 6292.7 6308.7 6352.4 6363.4 6364.3 5892.6 5951.4 5962.5 5977.2 6025.4 6236.3 6286.8 6346.7 6389.5 6395.3 6192.0 6309.9 6318.5 6330.4 6331.5 6222.4 6341.0 6356.4 6363.5 6378.1 6147.9 6262.0 6277.4 6350.9 6358.8 5233.3 5286.6 6290.4 6356.0 6370.2 5070.1 5073.4 5077.2 5085.8 5106.0 4448.5 4453.8 4490.0 4523.7 4576.8 5779.3 5794.6 5813.2 5840.4 5905.9 6287.2 6297.5 6303.6 6313.1 6351.9 5765.9 5840.5 5910.1 5924.7 5933.5 5544.0 5573.2 5574.2 5575.9 5604.3 6469.6 6473.6 6477.1 6486.3 6491.2 6275.3 6276.0 6319.6 6325.8 6353.5 6486.5 6494.8 6504.7 6508.0 6535.1 6352.3 6354.2 6360.5 6366.6 6391.0 6261.7 6267.3 6313.5 6325.2 6328.3 5154.9 6199.1 6227.6 6308.3 6312.3 5949.6 6101.6 6253.0 6304.6 6327.7 6028.0 6081.9 6117.5 6120.9 6132.1 6013.5 6201.9 6202.2 6245.3 6270.1 5514.7 5847.4 5924.3 6082.5 6131.1 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - PROCESS | 1679 | [#1] ext.html Cycles:180 Average:68626.10 Median:39364.01 stddev:153017.52 (388.7%) stddev-sans-first:153361.21 16:24:29 INFO - PROCESS | 1679 | Values: 471.5 472.0 479.0 534.7 535.1 29323.9 38238.0 40336.8 42661.6 42819.8 43136.1 43907.3 43917.6 44067.6 44083.3 9565.6 9744.8 9772.7 9803.0 9803.8 9667.0 9714.0 9733.1 9758.8 9813.1 9791.2 9831.2 9845.3 9852.9 9855.8 9698.3 9766.6 9781.9 9802.9 9815.6 8868.2 9050.6 9531.5 9613.0 9630.4 40035.6 40726.8 41162.0 41175.0 41180.0 2795.3 3076.5 3151.6 3371.5 3374.4 27113.3 28141.0 28932.3 29392.0 30135.2 2674.7 2723.2 2759.8 2777.5 2797.0 461245.1 463731.0 464898.0 466899.7 467647.0 33863.5 34643.5 34661.3 34720.0 35578.8 36220.3 36499.3 36721.3 36842.4 36943.4 15136.2 15149.2 15236.8 15246.2 15290.9 12811.5 12814.2 12868.9 12890.3 12892.0 7764.0 7980.8 7981.6 8016.3 8069.0 2862.9 3236.6 3281.0 3303.8 3336.6 970.1 1017.0 1077.0 1106.0 1124.2 24692.9 27968.9 28278.3 28320.6 28774.7 1082.2 1118.4 1147.1 1152.5 1152.9 14448.1 15249.0 15364.0 15493.2 15622.2 534074.0 680571.0 702208.0 706596.0 708561.0 54973.0 62866.0 62877.4 62978.7 63039.7 1279.8 1316.4 1452.9 1472.7 1472.7 27173.0 28948.0 29155.4 29526.9 29846.4 48701.8 57688.4 58252.7 59973.0 63465.4 554500.0 557973.0 558134.0 565477.0 566470.0 42337.8 43248.8 43773.8 43969.0 44516.1 47123.0 47551.8 47851.0 47855.8 48184.5 38965.4 39338.6 39389.4 39710.8 39945.8 38569.0 39025.6 39204.0 39504.4 39637.4 32943.7 38369.4 38958.4 39133.0 39254.0 32445.2 33954.8 34218.0 34425.1 35162.8 24965.0 25072.9 25100.6 25427.7 25507.5 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - PROCESS | 1679 | [#2] jquery.html Cycles:180 Average:34833.04 Median:1854.40 stddev:94225.40 (5081.2%) stddev-sans-first:94454.14 16:24:29 INFO - PROCESS | 1679 | Values: 340.3 387.4 390.2 401.6 408.1 15177.5 18564.9 19671.5 20367.9 20417.2 19818.0 19859.5 20989.8 21332.8 22041.0 5123.3 6148.2 6148.8 6160.0 6160.2 5169.3 7102.9 7487.6 7510.6 7627.5 6479.8 7414.4 7841.6 7873.4 7880.7 7647.9 7697.8 7839.8 7844.5 7858.5 7262.7 7571.5 7578.3 7579.0 7588.5 24537.3 27753.9 28562.4 29127.0 30024.4 1840.3 2262.9 2315.4 2409.0 2456.3 14261.9 16353.9 16398.3 16453.9 16520.1 1687.6 1786.6 1977.5 1979.7 1985.4 132661.3 137161.6 138118.0 138459.3 138958.3 21880.9 22321.9 22436.8 22786.4 22877.0 10363.3 11674.5 12428.4 35809.3 36588.5 7973.5 8116.8 8131.8 8198.5 8337.4 8521.0 8644.0 8668.0 8759.9 8769.0 3368.5 3917.2 3949.5 4074.1 4074.8 1968.7 2015.5 2016.0 2024.5 2057.2 868.9 907.2 935.7 964.4 977.9 19698.9 20326.7 20376.1 20413.6 20501.4 935.5 949.5 961.8 1009.6 1056.9 9623.7 10078.7 10776.4 10895.8 10904.8 527323.0 540411.0 543468.0 545668.0 635260.0 100429.0 104645.0 134194.3 139402.6 143055.3 437.0 455.4 456.9 459.1 462.0 9479.0 10556.4 10610.8 11193.1 11345.4 50402.5 54886.2 55219.7 55722.0 55929.7 66556.0 68304.3 82141.6 82419.4 83463.6 7771.3 7887.6 8055.3 8098.1 8351.1 7756.3 11319.7 12000.5 12145.3 12310.0 9022.7 10211.7 10229.2 10654.0 10751.9 10289.1 10344.7 10429.1 10640.8 10705.7 9237.7 10431.4 10546.0 10909.3 10937.3 7904.8 7932.8 8165.7 8168.0 8327.3 10323.2 10629.5 10629.9 10865.7 10876.3 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - PROCESS | 1679 | [#3] mootools.html Cycles:180 Average:5776.51 Median:4800.08 stddev:3262.93 (68.0%) stddev-sans-first:3255.51 16:24:29 INFO - PROCESS | 1679 | Values: 1400.3 1571.9 1785.2 1909.9 1958.7 8070.7 8625.0 8695.6 9167.6 9173.3 8737.8 8807.9 8823.6 8872.0 8879.0 2381.2 2395.1 2409.9 2422.0 2433.0 2300.5 2338.9 2341.4 2343.1 2369.9 2388.2 2395.8 2406.5 2415.8 2421.4 2337.0 2346.8 2348.2 2374.4 2375.1 2351.6 2354.0 2383.3 2387.1 2392.9 8900.3 8977.8 8988.3 9003.2 9004.3 5309.8 5370.3 5377.0 5408.8 5482.6 3221.8 3490.1 3551.1 3570.8 3652.5 1000.2 1039.7 1040.1 1041.2 1053.4 11833.3 11996.2 12011.2 12026.0 12062.3 4750.2 4796.8 4908.0 4909.6 4914.4 10038.9 10078.0 10127.1 10140.8 10173.4 5351.5 5376.0 5387.8 5433.4 5448.1 4487.5 4783.0 4913.0 4947.7 4956.0 4071.5 4094.8 4115.1 4141.4 4154.1 1278.4 1294.3 1302.9 1316.0 1329.8 827.9 880.6 890.2 900.9 914.0 5639.6 5773.3 5919.9 5942.1 5982.8 918.8 936.9 944.1 947.2 999.8 3855.2 3939.5 3982.4 3999.0 4015.6 10291.8 10961.3 10993.4 10996.9 11085.2 10660.7 10819.8 10825.7 10839.0 10926.0 8278.8 8385.0 8425.8 8425.9 8449.1 5663.2 5775.7 5791.6 5862.2 5871.8 9888.6 10148.7 10306.9 10312.4 10328.3 10135.9 10272.9 10431.5 10466.5 10517.0 6473.8 6606.0 6607.7 8017.5 8330.2 8323.5 8446.3 8516.8 8532.9 8556.0 7439.5 7573.7 7651.5 7669.1 7717.3 6749.3 7175.8 7310.6 7363.7 7530.1 6930.5 7046.8 7081.0 7082.7 7111.1 4398.6 4679.5 4761.4 4803.4 4927.1 4839.1 4878.7 4903.9 4941.0 5124.8 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - PROCESS | 1679 | [#4] prototype.html Cycles:180 Average:4762.10 Median:5355.11 stddev:1482.49 (27.7%) stddev-sans-first:1448.62 16:24:29 INFO - PROCESS | 1679 | Values: 317.2 318.9 323.6 328.6 328.8 5290.9 5758.7 5763.7 5801.8 5808.9 5350.7 5629.5 5678.1 5706.5 5733.2 3569.7 3763.9 3828.8 3871.3 4159.8 4201.5 4254.9 4258.8 4315.4 4329.8 3556.9 4260.4 4260.7 4281.1 4304.8 4083.4 4228.0 4232.1 4265.5 4271.4 3527.5 3532.6 3667.4 3669.7 3680.7 4504.5 5045.8 5360.9 5464.8 5470.8 4475.0 4770.0 4770.7 4877.7 4960.8 4773.9 5312.4 5535.6 5542.8 5996.3 4079.4 4082.4 4110.5 4117.2 4121.9 5992.2 6280.0 6281.3 6298.5 6312.3 3448.5 4116.4 4132.5 4140.5 4141.4 4223.3 4229.2 4235.3 4243.7 4264.7 4068.3 4348.7 4354.9 4511.6 4770.8 5310.4 6028.4 6029.2 6035.5 6077.0 1198.0 1412.1 1413.5 1414.9 1420.9 795.7 840.9 860.0 863.4 876.5 4831.0 5552.6 5560.5 5582.6 5619.6 4698.5 5037.6 6075.3 6118.4 6167.4 4768.3 5266.0 5542.2 5548.4 5558.3 2846.3 3043.6 3077.2 3134.7 3229.1 5393.9 6376.6 6380.6 6381.0 6414.8 5162.8 5513.8 6229.4 6266.0 6294.3 5398.5 5848.6 6352.6 6394.0 6441.0 5570.4 5605.4 6034.6 6113.4 6178.0 4943.6 5728.1 5871.3 6049.5 6052.8 5557.6 5580.9 5693.9 6342.8 6376.9 3855.7 3862.5 4011.3 4021.9 4051.7 6092.7 6115.6 6120.2 6148.5 6159.4 4890.2 4951.0 4991.0 5052.9 5788.9 5021.8 5348.6 5359.6 5845.0 5909.3 5319.0 5398.1 5559.2 5747.2 5831.9 5807.0 5929.1 5954.7 5992.2 6005.9 5843.8 5852.8 5874.4 5881.0 5920.5 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - PROCESS | 1679 | [#5] yui.html Cycles:180 Average:17820.27 Median:31295.19 stddev:24647.35 (78.8%) stddev-sans-first:24682.85 16:24:29 INFO - PROCESS | 1679 | Values: 669.5 688.1 712.4 729.8 746.0 15207.4 15439.4 15631.1 15655.6 16603.2 16128.0 16508.3 16542.4 16546.0 16562.3 921.0 927.5 934.0 935.4 937.5 721.7 890.7 926.1 927.8 928.9 935.9 970.1 976.9 978.4 981.5 816.9 958.2 960.0 963.5 964.1 726.5 726.7 728.3 731.0 732.4 15002.6 15061.7 15073.0 15085.2 15128.8 11868.3 11890.3 11917.5 11918.6 11980.9 9923.0 9942.9 10088.4 10103.9 10333.0 3413.2 3449.5 3454.8 3489.2 3572.2 79911.6 80414.6 81361.6 81378.3 83673.6 9101.0 9236.7 9254.6 9261.9 9458.5 20324.3 20742.3 20931.5 21168.0 21409.1 7264.6 7368.4 7382.9 7392.7 7527.1 3459.4 4005.5 4076.5 4077.2 4110.7 3402.5 3426.4 3459.6 3468.3 3499.2 606.6 619.0 621.8 627.0 629.8 469.2 535.0 577.9 602.7 607.8 8026.6 8114.9 8162.2 8185.8 8231.8 547.5 557.5 559.2 596.7 603.9 3677.7 3895.5 3916.4 3972.3 3999.0 76505.6 78014.0 78925.6 86344.6 87495.0 76889.6 77073.6 77547.0 77858.6 79013.6 70941.6 72382.6 72908.6 73217.0 73460.6 7560.6 7644.8 8080.0 8332.7 8404.7 42170.4 43390.3 45654.0 46089.0 47078.8 61338.0 61971.4 63619.4 64475.4 64687.0 10933.7 11027.2 11185.8 11189.1 11482.9 11927.4 11999.9 12147.2 12453.6 12562.2 11168.5 11227.2 11400.0 11421.5 11677.0 11052.0 11425.2 11518.5 11613.3 11787.5 10123.4 11203.4 11360.3 11372.7 11743.4 8266.8 8751.5 9476.0 9680.4 9977.5 8464.7 8862.9 8989.5 9656.7 9685.7 16:24:29 INFO - PROCESS | 1679 | -------- Summary: end -------- 16:24:29 INFO - PROCESS | 1679 | 16:24:29 INFO - TEST-INFO | 1679: exit 0 16:24:29 INFO - TEST-OK | dromaeo_css | took 1112294ms 16:24:29 INFO - TEST-START | kraken 16:24:29 INFO - operating with platform_type : mac_ 16:24:29 INFO - Initialising browser for kraken test... 16:24:29 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpqcRgQV/profile http://localhost:49271/getInfo.html) 16:24:32 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 16:24:32 INFO - PROCESS | 1687 | colorDepth:24 16:24:32 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 16:24:32 INFO - PROCESS | 1687 | __metrics 16:24:32 ERROR - PROCESS | 1687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:24:33 INFO - TEST-INFO | 1687: exit 0 16:24:33 INFO - Browser initialized. 16:24:33 INFO - Running cycle 1/1 for kraken test... 16:24:33 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/T/tmpqcRgQV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:24:45 INFO - PROCESS | 1690 | RSS: Main: 249921536 16:24:45 INFO - PROCESS | 1690 | 16:24:48 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:24:49 INFO - PROCESS | 1690 | RSS: Main: 261730304 16:24:49 INFO - PROCESS | 1690 | 16:24:52 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:24:53 INFO - PROCESS | 1690 | RSS: Main: 266461184 16:24:53 INFO - PROCESS | 1690 | 16:24:56 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:24:57 INFO - PROCESS | 1690 | RSS: Main: 267300864 16:24:57 INFO - PROCESS | 1690 | 16:24:59 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:24:59 INFO - PROCESS | 1690 | RSS: Main: 267919360 16:24:59 INFO - PROCESS | 1690 | 16:25:02 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:02 INFO - PROCESS | 1690 | RSS: Main: 268222464 16:25:02 INFO - PROCESS | 1690 | 16:25:05 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:06 INFO - PROCESS | 1690 | RSS: Main: 269115392 16:25:06 INFO - PROCESS | 1690 | 16:25:09 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:10 INFO - PROCESS | 1690 | RSS: Main: 269959168 16:25:10 INFO - PROCESS | 1690 | 16:25:13 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:25:14 INFO - PROCESS | 1690 | RSS: Main: 270622720 16:25:14 INFO - PROCESS | 1690 | 16:25:16 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:16 INFO - PROCESS | 1690 | RSS: Main: 270393344 16:25:16 INFO - PROCESS | 1690 | 16:25:18 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:25:19 INFO - PROCESS | 1690 | RSS: Main: 269991936 16:25:19 INFO - PROCESS | 1690 | 16:25:21 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:25:22 INFO - PROCESS | 1690 | RSS: Main: 270553088 16:25:22 INFO - PROCESS | 1690 | 16:25:25 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:25:26 INFO - PROCESS | 1690 | RSS: Main: 270438400 16:25:26 INFO - PROCESS | 1690 | 16:25:29 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:25:29 INFO - PROCESS | 1690 | RSS: Main: 270512128 16:25:29 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:25:31 INFO - PROCESS | 1690 | RSS: Main: 273199104 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | __start_tp_report 16:25:31 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 16:25:31 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 16:25:31 INFO - PROCESS | 1690 | |i|pagename|runs| 16:25:31 INFO - PROCESS | 1690 | |0;ai-astar;115;108;116;115;116;130;169;161;113;115 16:25:31 INFO - PROCESS | 1690 | |1;audio-beat-detection;157;108;166;209;137;172;166;146;167;120 16:25:31 INFO - PROCESS | 1690 | |2;audio-dft;198;214;261;279;204;196;197;197;199;197 16:25:31 INFO - PROCESS | 1690 | |3;audio-fft;66;81;75;171;54;57;62;67;127;75 16:25:31 INFO - PROCESS | 1690 | |4;audio-oscillator;80;81;158;78;83;102;121;107;118;156 16:25:31 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;120;86;89;87;102;130;89;132;80;130 16:25:31 INFO - PROCESS | 1690 | |6;imaging-darkroom;95;94;109;150;112;96;95;137;145;94 16:25:31 INFO - PROCESS | 1690 | |7;imaging-desaturate;92;90;91;91;121;85;144;150;89;96 16:25:31 INFO - PROCESS | 1690 | |8;json-parse-financial;59;61;60;60;58;57;59;121;59;57 16:25:31 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;64;69;68;71;75;74;70;78;104;104 16:25:31 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;104;111;110;106;85;89;86;83;87;87 16:25:31 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;139;130;157;153;151;153;147;137;215;154 16:25:31 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;168;165;176;166;164;157;211;221;166;167 16:25:31 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;65;71;78;78;85;75;90;85;68;64 16:25:31 INFO - PROCESS | 1690 | __end_tp_report 16:25:31 INFO - PROCESS | 1690 | __start_cc_report 16:25:31 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,1099 16:25:31 INFO - PROCESS | 1690 | __end_cc_report 16:25:31 INFO - PROCESS | 1690 | __startTimestamp1464045931870__endTimestamp 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | ------- Summary: start ------- 16:25:31 INFO - PROCESS | 1690 | Number of tests: 14 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:125.80 Median:116.00 stddev:21.46 (18.5%) stddev-sans-first:22.41 16:25:31 INFO - PROCESS | 1690 | Values: 115.0 108.0 116.0 115.0 116.0 130.0 169.0 161.0 113.0 115.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:166.00 stddev:28.74 (17.3%) stddev-sans-first:30.47 16:25:31 INFO - PROCESS | 1690 | Values: 157.0 108.0 166.0 209.0 137.0 172.0 166.0 146.0 167.0 120.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:214.20 Median:201.50 stddev:30.19 (15.0%) stddev-sans-first:31.45 16:25:31 INFO - PROCESS | 1690 | Values: 198.0 214.0 261.0 279.0 204.0 196.0 197.0 197.0 199.0 197.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:83.50 Median:66.50 stddev:36.99 (55.6%) stddev-sans-first:38.68 16:25:31 INFO - PROCESS | 1690 | Values: 66.0 81.0 75.0 171.0 54.0 57.0 62.0 67.0 127.0 75.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:118.00 stddev:30.09 (25.5%) stddev-sans-first:30.10 16:25:31 INFO - PROCESS | 1690 | Values: 80.0 81.0 158.0 78.0 83.0 102.0 121.0 107.0 118.0 156.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:104.50 Median:83.00 stddev:21.17 (25.5%) stddev-sans-first:21.70 16:25:31 INFO - PROCESS | 1690 | Values: 120.0 86.0 89.0 87.0 102.0 130.0 89.0 132.0 80.0 130.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:94.00 stddev:22.72 (24.2%) stddev-sans-first:23.17 16:25:31 INFO - PROCESS | 1690 | Values: 95.0 94.0 109.0 150.0 112.0 96.0 95.0 137.0 145.0 94.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:90.50 stddev:24.32 (26.9%) stddev-sans-first:25.35 16:25:31 INFO - PROCESS | 1690 | Values: 92.0 90.0 91.0 91.0 121.0 85.0 144.0 150.0 89.0 96.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:59.00 stddev:19.68 (33.4%) stddev-sans-first:20.75 16:25:31 INFO - PROCESS | 1690 | Values: 59.0 61.0 60.0 60.0 58.0 57.0 59.0 121.0 59.0 57.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:70.50 stddev:14.40 (20.4%) stddev-sans-first:14.39 16:25:31 INFO - PROCESS | 1690 | Values: 64.0 69.0 68.0 71.0 75.0 74.0 70.0 78.0 104.0 104.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:94.80 Median:85.50 stddev:11.41 (13.3%) stddev-sans-first:11.61 16:25:31 INFO - PROCESS | 1690 | Values: 104.0 111.0 110.0 106.0 85.0 89.0 86.0 83.0 87.0 87.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:153.00 stddev:23.28 (15.2%) stddev-sans-first:24.09 16:25:31 INFO - PROCESS | 1690 | Values: 139.0 130.0 157.0 153.0 151.0 153.0 147.0 137.0 215.0 154.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:167.50 stddev:21.66 (12.9%) stddev-sans-first:22.77 16:25:31 INFO - PROCESS | 1690 | Values: 168.0 165.0 176.0 166.0 164.0 157.0 211.0 221.0 166.0 167.0 16:25:31 INFO - PROCESS | 1690 | 16:25:31 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:78.00 stddev:8.95 (11.5%) stddev-sans-first:8.58 16:25:31 INFO - PROCESS | 1690 | Values: 65.0 71.0 78.0 78.0 85.0 75.0 90.0 85.0 68.0 64.0 16:25:31 INFO - PROCESS | 1690 | -------- Summary: end -------- 16:25:31 INFO - PROCESS | 1690 | 16:25:32 INFO - TEST-INFO | 1690: exit 0 16:25:32 INFO - TEST-OK | kraken | took 62786ms 16:25:32 INFO - SUITE-END | took 1175s 16:25:33 INFO - Completed test suite (00:19:35) 16:25:33 INFO - javascript benchmark 16:25:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7226.249342250497, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.688331166883, 3363.075154332558, 3486.912827179322, 3541.132422556474, 3544.113971507123, 4267.765272909989, 5853.09277062055, 5901.203337549429, 5953.910691339628, 6022.885766133258, 5721.456461636138, 5727.57043221759, 5782.277215348082, 5782.739776710047, 5853.560982926277, 5211.218317252414, 5250.9474905250845, 5333.786648534054, 5344.759485823147, 5385.730713464331, 45.910990068005646, 5228.712420816853, 5308.734563271841, 5325.0, 5337.14605663094, 5263.736813159365, 5288.338957630296, 5293.417724050351, 5311.814086506973, 5317.601179911522, 5311.787528498855, 5335.733213339317, 5341.1988201769655, 5372.516473517363, 5394.8921021579745, 5191.896162076775, 5195.896082078375, 5265.710385928773, 5270.104082305978, 5312.0, 5573.6098473106895, 5678.4037676044245, 5688.658680479143, 5736.024875771129, 5766.452187042224, 6095.891769653485, 6294.433500984887, 6335.8732825343695, 6378.075179099051, 6391.77628782995, 6292.685365731741, 6308.716107775161, 6352.364763523657, 6363.363663633646, 6364.331745166737, 5892.616979896293, 5951.375105613892, 5962.493188079018, 5977.193078934288, 6025.367336429699, 6236.251649802053, 6286.779962701284, 6346.714397852108, 6389.488840892717, 6395.296517383084, 6192.0, 6309.936900631027, 6318.462930650854, 6330.39861213184, 6331.525135614847, 6222.439980401786, 6341.048842673544, 6356.396142366468, 6363.459105975951, 6378.075179099097, 6147.924113280247, 6262.0, 6277.435030847154, 6350.872982540416, 6358.77744278948, 5233.345831771028, 5286.62993590445, 6290.433860952445, 6356.046593011085, 6370.203724534434, 5070.138076527, 5073.365829271341, 5077.238414237894, 5085.796568137307, 5105.953279577752, 4448.532904045093, 4453.77731113443, 4489.9775501122285, 4523.660725445539, 4576.81692732287, 5779.306483222041, 5794.565407594448, 5813.157092221689, 5840.3575606683235, 5905.852353691106, 6287.2140982377205, 6297.464715499143, 6303.558750887394, 6313.08460273267, 6351.872962540816, 5765.913511297334, 5840.532757379399, 5910.083936989773, 5924.674142922181, 5933.465988061095, 5543.972280138573, 5573.191887176417, 5574.163875418639, 5575.860603484864, 5604.271444712243, 6469.611823290617, 6473.643949582724, 6477.125588045554, 6486.254080780771, 6491.156149700509, 6275.34108918557, 6276.027215781562, 6319.58922670025, 6325.810225693236, 6353.52348573868, 6486.513511486563, 6494.772682956074, 6504.674766261763, 6507.967460162668, 6535.117759102461, 6352.301246862934, 6354.205724284465, 6360.522960777867, 6366.554341196072, 6391.041343798467, 6261.7182226799, 6267.310595834363, 6313.526485513513, 6325.209348831396, 6328.303886572566, 5154.948450515447, 6199.1011303361665, 6227.564070515202, 6308.337624549356, 6312.305646378986, 5949.636194867781, 6101.633901965896, 6252.980922098605, 6304.590201636879, 6327.683615819283, 6027.969860150672, 6081.939180608138, 6117.510599151969, 6120.936985674706, 6132.110843927695, 6013.548983826318, 6201.906971395523, 6202.1527227809, 6245.28179259391, 6270.12218289449, 5514.6691198528215, 5847.38602446737, 5924.259467566554, 6082.482988945812, 6131.141640170291], "value": 5745.711113813636, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.5119850954261, 472.02526782194775, 479.04669707282505, 534.7139280484939, 535.1010302691477, 29323.853380733093, 38238.0, 40336.79831600838, 42661.57338426615, 42819.78590107045, 43136.137277254515, 43907.34138987918, 43917.560824391745, 44067.55932440675, 44083.338749918694, 9565.617375304997, 9744.75638109046, 9772.657956971507, 9803.0, 9803.754906127333, 9666.951665241699, 9714.0, 9733.075357840993, 9758.804823903518, 9813.116819486244, 9791.167750741195, 9831.213502919749, 9845.310828242025, 9852.852207216898, 9855.753606159831, 9698.321117521777, 9766.609335626566, 9781.90218097817, 9802.901970980305, 9815.558299876522, 8868.15752503511, 9050.592723327467, 9531.475768832712, 9613.0, 9630.374025688308, 40035.59964400348, 40726.79636601798, 41162.0, 41175.0, 41179.97050073742, 2795.3011747063233, 3076.492378757502, 3151.590293261884, 3371.460566309379, 3374.4432168692138, 27113.322166945785, 28141.015064472645, 28932.27669308284, 29391.971281005277, 30135.246618834484, 2674.6924103728124, 2723.155821695281, 2759.820611660256, 2777.5000499910007, 2797.021042635082, 461245.0813237804, 463731.0, 464898.0, 466899.6655016737, 467647.0, 33863.49204761931, 34643.4803477948, 34661.30677386488, 34720.0, 35578.82210588982, 36220.27559448796, 36499.27001459956, 36721.265574688354, 36842.447363289575, 36943.445848312294, 15136.243187840564, 15149.242537873062, 15236.847631523542, 15246.237688115772, 15290.853186011094, 12811.487540498461, 12814.231146131262, 12868.935655321851, 12890.29103399322, 12892.0, 7764.029496312961, 7980.840383192303, 7981.561014144278, 8016.278534931884, 8069.0317161939765, 2862.8997985070423, 3236.5630639863316, 3281.0, 3303.7852539585333, 3336.616289126733, 970.1365784451843, 1016.993176755022, 1077.0414331245197, 1106.0, 1124.173732306754, 24692.876535617565, 27968.88124474998, 28278.293042674097, 28320.575191372147, 28774.712252877624, 1082.220801023262, 1118.4128332625273, 1147.0823341326904, 1152.521703493041, 1152.8501294831617, 14448.060876043024, 15249.0, 15364.0, 15493.225338733018, 15622.218889055503, 534074.0, 680571.0, 702208.0, 706596.0, 708561.0, 54973.0, 62866.0, 62877.37122628715, 62978.68510657417, 63039.6848015757, 1279.7650267491915, 1316.427354100969, 1452.9055611385227, 1472.6686495538418, 1472.7496325624884, 27173.04894328689, 28948.0, 29155.416891661625, 29526.852365738036, 29846.403071938876, 48701.7824554389, 57688.4231157683, 58252.70873645604, 59973.0, 63465.36534634595, 554500.0, 557973.0, 558134.0, 565477.0, 566470.0, 42337.78831105825, 43248.783756081015, 43773.78113109414, 43969.0, 44516.10967780691, 47123.0, 47551.762241188575, 47851.04297914092, 47855.76072119617, 48184.51815481941, 38965.41551876668, 39338.60661393464, 39389.409158863215, 39710.80144599258, 39945.801625951266, 38569.0, 39025.6097439022, 39204.0, 39504.407433887936, 39637.40543891901, 32943.67056329406, 38369.4244586337, 38958.4156237651, 39133.0, 39254.0, 32445.18887027843, 33954.8302258497, 34218.0, 34425.139371515914, 35162.824185878904, 24965.0, 25072.874635626704, 25100.62349064729, 25427.745722543277, 25507.489850203263], "value": 18696.521570727153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.2565394612771, 387.41500334494924, 390.1961958365767, 401.59238373051375, 408.1449363583294, 15177.468788592401, 18564.90717546412, 19671.5082122947, 20367.898160509194, 20417.183312667476, 19818.0, 19859.50351241216, 20989.790102098974, 21332.786672133276, 22041.00815463304, 5123.282740416335, 6148.169997050386, 6148.784792532262, 6160.0, 6160.19917410736, 5169.345809341013, 7102.928970710304, 7487.588182649952, 7510.586917719524, 7627.5042122261875, 6479.8056058318325, 7414.406847452218, 7841.568713720743, 7873.409494287923, 7880.684772609117, 7647.946588308206, 7697.769066928001, 7839.764807055797, 7844.450888437812, 7858.528488290693, 7262.709491620329, 7571.469997100206, 7578.317951384402, 7579.0, 7588.506747061423, 24537.263882083567, 27753.861230693918, 28562.428751425065, 29127.0, 30024.399512009855, 1840.300685739424, 2262.9434264143365, 2315.444293369596, 2409.0002648900686, 2456.250843492734, 14261.928690356483, 16353.936994095346, 16398.26207820639, 16453.91773041127, 16520.09139497327, 1687.59086163054, 1786.56229223841, 1977.5352792093847, 1979.712941623471, 1985.3646833013443, 132661.33669331687, 137161.62838371587, 138118.0, 138459.30770346083, 138958.3052084743, 21880.9059547022, 22321.87942145526, 22436.775632243796, 22786.43033924165, 22877.0, 10363.32638378503, 11674.474648640831, 12428.37858107091, 35809.283814323564, 36588.451173232424, 7973.521588704696, 8116.837663246702, 8131.7560473185895, 8198.549079800669, 8337.374696897758, 8520.957395213109, 8643.956780216184, 8667.956660216658, 8759.912400876037, 8769.0, 3368.545246391755, 3917.196974620196, 3949.5458022327225, 4074.124063326399, 4074.7758873262255, 1968.7440632717655, 2015.5488048604982, 2015.9596808063757, 2024.4533975826444, 2057.1565658080117, 868.913108689126, 907.2469850024464, 935.6678379175431, 964.4117088575963, 977.9266555008261, 19698.90150549238, 20326.695099573517, 20376.083076261602, 20413.591728165353, 20501.38495845127, 935.5322338830584, 949.5252373813094, 961.778790878102, 1009.5507499162802, 1056.8678915135608, 9623.711288661352, 10078.697639070839, 10776.35341879474, 10895.782084358269, 10904.836427453594, 527323.0, 540411.0, 543468.0, 545668.0, 635260.0, 100429.0, 104645.0, 134194.32902835423, 139402.58031067476, 143055.28472357572, 436.96722745794193, 455.39432554701506, 456.92232320505593, 459.0909998203576, 461.9976900115478, 9479.041916167665, 10556.366618002945, 10610.840837387292, 11193.104551635686, 11345.376004319842, 50402.4879253623, 54886.17670735022, 55219.72390138024, 55722.0, 55929.720351397984, 66556.0, 68304.31695683178, 82141.58929205316, 82419.3516129686, 83463.5826820862, 7771.261730135628, 7887.605619719106, 8055.275025247756, 8098.149694282016, 8351.081381048201, 7756.263155000492, 11319.660410187707, 12000.459979301128, 12145.332006739714, 12309.953653939516, 9022.684206052756, 10211.693649190536, 10229.181665466893, 10654.029004634167, 10751.860918219763, 10289.125424339016, 10344.689659310232, 10429.061384475433, 10640.84038739435, 10705.732356691145, 9237.722868313962, 10431.37411755297, 10546.0, 10909.34543927367, 10937.28907621034, 7904.762857114296, 7932.801679957816, 8165.714200002972, 8168.0, 8327.333813295043, 10323.174146068446, 10629.468526573795, 10629.94685026601, 10865.674029779118, 10876.293040952312], "value": 9777.336504241857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.2916441940831, 1571.9056856588602, 1785.187739578492, 1909.9140538675758, 1958.7159861820046, 8070.71752488663, 8624.956875215616, 8695.608697608606, 9167.633294668214, 9173.31200159989, 8737.781555461117, 8807.91192088079, 8823.647054117828, 8872.024077351487, 8878.955605221965, 2381.1784934197717, 2395.0539536883007, 2409.9397515062087, 2421.9757802421927, 2432.9878350608224, 2300.4823914619246, 2338.9064437422485, 2341.379534423379, 2343.1096183450263, 2369.917052903149, 2388.1880160745345, 2395.808335333169, 2406.5066661334386, 2415.770501802335, 2421.4430680943306, 2336.971732437739, 2346.77705617966, 2348.2133485282366, 2374.3589230907733, 2375.0618505690327, 2351.6472529120597, 2353.9646905296263, 2383.2611890314056, 2387.140629373424, 2392.868392238426, 8900.287976961827, 8977.820443591158, 8988.280937524982, 9003.234725048378, 9004.27965762744, 5309.840704778863, 5370.2750128732905, 5376.973115134399, 5408.783648654049, 5482.5613950883835, 3221.7905836120813, 3490.1449144959392, 3551.147724546116, 3570.767900086486, 3652.4521321801676, 1000.214831357381, 1039.7140786283758, 1040.1003132290589, 1041.156663102889, 1053.4311471805293, 11833.343331933536, 11996.160268781188, 12011.21927074746, 12026.0, 12062.336571488564, 4750.239961606127, 4796.754434810311, 4908.042931628298, 4909.607231421478, 4914.410270767531, 10038.949805251073, 10077.992200779863, 10127.139193168663, 10140.797184056277, 10173.389596624227, 5351.464853514617, 5375.973120134374, 5387.757550910218, 5433.375161856358, 5448.128299472065, 4487.461504619467, 4783.019481006385, 4912.9508704913205, 4947.678400903929, 4955.975220123876, 4071.450354202204, 4094.8148730754883, 4115.115250221217, 4141.4409054777825, 4154.1068670236045, 1278.3672082319126, 1294.3140135728079, 1302.856685764565, 1315.9868401315864, 1329.8005299205004, 827.9213474719892, 880.6389380354024, 890.1632465482426, 900.8651480276228, 913.9634414623473, 5639.6334238274385, 5773.307203135567, 5919.852003699856, 5942.1383899335215, 5982.820515384546, 918.8254231695956, 936.8735220745112, 944.1125342178468, 947.1570302430843, 999.8050380175941, 3855.20968201518, 3939.5075615548058, 3982.3827306766916, 3999.0002499375155, 4015.558288588253, 10291.794164116825, 10961.342319460859, 10993.395363254938, 10996.945015274872, 11085.22403431752, 10660.733481662865, 10819.78360432787, 10825.67522974312, 10839.024487796136, 10926.016658500774, 8278.751637450887, 8385.035720892054, 8425.83148337042, 8425.915740842636, 8449.11284315138, 5663.1788390682295, 5775.653460792366, 5791.594588378773, 5862.179294898803, 5871.7651293947765, 9888.555015024485, 10148.695539133838, 10306.948465257627, 10312.432816194882, 10328.328658637165, 10135.898641013791, 10272.897271027194, 10431.530581123716, 10466.476676166008, 10517.00088491592, 6473.77341793035, 6605.966970165118, 6607.702653380513, 8017.478863873829, 8330.166983301622, 8323.500589964622, 8446.282066024456, 8516.829663406821, 8532.872006919777, 8556.0, 7439.479236453612, 7573.734919277799, 7651.464397492345, 7669.079710434784, 7717.305442510201, 6749.3250674932115, 7175.8159903615315, 7310.634468276671, 7363.668634911549, 7530.134034586093, 6930.549514281555, 7046.788596342118, 7081.044059051962, 7082.681279342545, 7111.075560177143, 4398.582134697199, 4679.532046795293, 4761.357216775691, 4803.3995750531185, 4927.088488629472, 4839.104765618372, 4878.731669758055, 4903.8528844134735, 4940.950590494049, 5124.79500819978], "value": 4633.659645833914, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.2006543510354, 318.8628889577482, 323.5971215836284, 328.5974681015756, 328.8290089153639, 5290.92063619046, 5758.712064396774, 5763.711814409278, 5801.767929282829, 5808.912866306998, 5350.652207606513, 5629.521490673287, 5678.148277758339, 5706.543476521879, 5733.168690539869, 3569.6613769836313, 3763.9435408468894, 3828.7894165820867, 3871.2838124946975, 4159.7920103994675, 4201.516825565053, 4254.893627659318, 4258.829646814123, 4315.4389929309145, 4329.7618630975285, 3556.9110772230642, 4260.403543503912, 4260.744355338674, 4281.100968796556, 4304.7632380219075, 4083.4283200351824, 4227.978860105711, 4232.132412855357, 4265.466816647919, 4271.376876786817, 3527.5061491391225, 3532.6290739472497, 3667.3948798448223, 3669.7247706422127, 3680.705543556509, 4504.549545045502, 5045.798168073273, 5360.91958620621, 5464.754086066137, 5470.781168753245, 4474.955250447487, 4769.952300476985, 4770.689905156154, 4877.658643872928, 4960.751962401901, 4773.856784296477, 5312.415634280226, 5535.640183388067, 5542.808296216333, 5996.340402555716, 4079.4492743479545, 4082.3672330788777, 4110.506739191286, 4117.197146556423, 4121.9381709274385, 5992.240049136379, 6280.0, 6281.335446106831, 6298.49612031041, 6312.305646378894, 3448.5344478495585, 4116.403121547359, 4132.483439570054, 4140.544540100586, 4141.358089496133, 4223.289567725076, 4229.175310814423, 4235.25882970479, 4243.6605071594195, 4264.658827293809, 4068.3083875741195, 4348.7390756554705, 4354.867734389019, 4511.62395469385, 4770.785314660849, 5310.389305229871, 6028.397160284024, 6029.186059881948, 6035.517158627299, 6077.0, 1197.9820302695293, 1412.0680350968312, 1413.4699487692114, 1414.886809055273, 1420.884605584611, 795.6697970342243, 840.9495430274203, 859.9656013759504, 863.4387648028832, 876.5003947749722, 4831.033793241366, 5552.639078459968, 5560.527355174774, 5582.63712858671, 5619.606627536034, 4698.459677137173, 5037.647364684511, 6075.301340345828, 6118.449339559372, 6167.414095660905, 4768.332433459318, 5265.973670131625, 5542.224088627595, 5548.389677135512, 5558.277423934863, 2846.331112188634, 3043.5738996540504, 3077.1845460952864, 3134.746101559349, 3229.1442767666585, 5393.892122157535, 6376.617402955838, 6380.649064301415, 6380.968095159587, 6414.839629009312, 5162.7542019221755, 5513.8220402940615, 6229.3770622937345, 6265.96867015662, 6294.339094395114, 5398.46015398457, 5848.64908105515, 6352.618842869442, 6394.008928615979, 6440.971094105435, 5570.387257401763, 5605.402460298796, 6034.63792172471, 6113.449789518964, 6177.96911015442, 4943.5797957174045, 5728.140778883201, 5871.266091738533, 6049.45922712453, 6052.848678783065, 5557.583181261502, 5580.944190558205, 5693.943060569507, 6342.809715708536, 6376.936230637634, 3855.749376290532, 3862.5364956205435, 4011.2779699654343, 4021.8592349267633, 4051.736637118578, 6092.725827337692, 6115.571909966259, 6120.17377654011, 6148.538859585638, 6159.414855588712, 4890.217565189552, 4951.0, 4990.975045124751, 5052.924206136984, 5788.855278618068, 5021.84934451967, 5348.572114230775, 5359.571234301168, 5845.0, 5909.320428150818, 5318.97340513295, 5398.055340315507, 5559.24950131727, 5747.19539264495, 5831.883362332815, 5807.0, 5929.080992446177, 5954.732037058429, 5992.1910542078, 6005.939940600538, 5843.824685259449, 5852.795152169653, 5874.412558744091, 5880.970595147168, 5920.5069009284725], "value": 4283.102314532942, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.5146019136126, 688.1295161620554, 712.3909057755616, 729.7664747280872, 746.0227102495733, 15207.391704331827, 15439.382424703012, 15631.140287284208, 15655.608609784762, 16603.169841507908, 16128.0, 16508.33966641333, 16542.421015264466, 16546.0, 16562.254698538563, 920.9539523023839, 927.5269612497641, 934.0332755597957, 935.3546053223288, 937.5124935033779, 721.7437809577604, 890.7416849113749, 926.1479438916214, 927.7819712367589, 928.8792456980583, 935.8689783430325, 970.0687340153461, 976.8681228034231, 978.4178413843787, 981.4994352880011, 816.930560902327, 958.1855422890523, 959.9760005999836, 963.5037955452947, 964.0841200859212, 726.484196220684, 726.7347418192375, 728.3408515293668, 730.9634518274065, 732.3555271361168, 15002.62493437662, 15061.698766024727, 15073.020253683475, 15085.170315632637, 15128.848711512854, 11868.347240901747, 11890.346030968294, 11917.463714132884, 11918.582849600223, 11980.880191198064, 9923.0, 9942.850857237147, 10088.394696318244, 10103.949480252626, 10333.018363255555, 3413.2149605590853, 3449.482577613353, 3454.792712437262, 3489.1626009757474, 3572.1783989682517, 79911.60044199742, 80414.59792701057, 81361.59319203426, 81378.33797479127, 83673.58163209206, 9101.044390338919, 9236.67671631503, 9254.629814807333, 9261.907380926104, 9458.52707364629, 20324.288649897477, 20742.274020409513, 20931.476713082295, 21168.047437865334, 21409.143634254455, 7264.564126152342, 7368.37368823656, 7382.926170738224, 7392.741254056083, 7527.059117610299, 3459.3600183966046, 4005.459262999516, 4076.470058892325, 4077.2049450356894, 4110.712250142521, 3402.4726167444087, 3426.400379933502, 3459.584849818038, 3468.3410152071024, 3499.1951851073886, 606.5844896246085, 618.9938100618937, 621.8352136683783, 627.0312367392389, 629.7575433458152, 469.2468587916345, 534.9759260833272, 577.8988676981511, 602.6564858030968, 607.8358843112335, 8026.558539280279, 8114.918850811534, 8162.1837816219095, 8185.754427367069, 8231.794205144919, 547.5209191957038, 557.4954666027252, 559.1919676068043, 596.6599038548072, 603.8611119442553, 3677.669009789132, 3895.454636350913, 3916.4321173429694, 3972.324704800191, 3999.042384462725, 76505.6174719134, 78014.0, 78925.60537197391, 86344.5682771582, 87495.0, 76889.615551923, 77073.6146319276, 77547.0, 77858.61070694723, 79013.60493197612, 70941.64529177321, 72382.63808680818, 72908.63545682238, 73217.0, 73460.63269683617, 7560.5841678706, 7644.847103058019, 8080.0, 8332.6666933322, 8404.705835295736, 42170.36744448775, 43390.34914476222, 45654.0, 46089.0, 47078.76460617675, 61338.0, 61971.380286198364, 63619.363806363195, 64475.35524644693, 64687.0, 10933.671989840317, 11027.22809403334, 11185.832212516982, 11189.104871610414, 11482.94258528702, 11927.403629818647, 11999.940000299943, 12147.210431321935, 12453.564125255572, 12562.246265224116, 11168.497417616065, 11227.157963152633, 11399.97400233983, 11421.481040301833, 11676.975259377561, 11052.0, 11425.2002359834, 11518.53925842957, 11613.30320180792, 11787.469563869476, 10123.392596444237, 11203.43982800873, 11360.318380897173, 11372.658820235407, 11743.412829358327, 8266.834663306821, 8751.518666473405, 9475.952620236854, 9680.370775899544, 9977.45124018186, 8464.730290456235, 8862.911370886466, 8989.505577193317, 9656.662016829378, 9685.70942871715], "value": 6830.123884467375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1651.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 116.0, 115.0, 116.0, 130.0, 169.0, 161.0, 113.0, 115.0], "value": 125.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 108.0, 166.0, 209.0, 137.0, 172.0, 166.0, 146.0, 167.0, 120.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 214.0, 261.0, 279.0, 204.0, 196.0, 197.0, 197.0, 199.0, 197.0], "value": 214.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 81.0, 75.0, 171.0, 54.0, 57.0, 62.0, 67.0, 127.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 158.0, 78.0, 83.0, 102.0, 121.0, 107.0, 118.0, 156.0], "value": 108.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 86.0, 89.0, 87.0, 102.0, 130.0, 89.0, 132.0, 80.0, 130.0], "value": 104.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 109.0, 150.0, 112.0, 96.0, 95.0, 137.0, 145.0, 94.0], "value": 112.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 91.0, 91.0, 121.0, 85.0, 144.0, 150.0, 89.0, 96.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 60.0, 58.0, 57.0, 59.0, 121.0, 59.0, 57.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 68.0, 71.0, 75.0, 74.0, 70.0, 78.0, 104.0, 104.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 110.0, 106.0, 85.0, 89.0, 86.0, 83.0, 87.0, 87.0], "value": 94.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 130.0, 157.0, 153.0, 151.0, 153.0, 147.0, 137.0, 215.0, 154.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 176.0, 166.0, 164.0, 157.0, 211.0, 221.0, 166.0, 167.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 78.0, 78.0, 85.0, 75.0, 90.0, 85.0, 68.0, 64.0], "value": 75.9, "unit": "score"}]}]} 16:25:33 INFO - Return code: 0 16:25:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:25:33 ERROR - # TBPL SUCCESS # 16:25:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:25:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:25:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:25:33 INFO - 2016-05-23 16:25:33.178 screenresolution[1695:10924] starting screenresolution argv=screenresolution get 16:25:33 INFO - 2016-05-23 16:25:33.181 screenresolution[1695:10924] Display 0: 1600x1200x32@60 16:25:33 INFO - 2016-05-23 16:25:33.187 screenresolution[1696:10927] starting screenresolution argv=screenresolution list 16:25:33 INFO - Available Modes on Display 0 16:25:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:25:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:25:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:25:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:25:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:25:33 INFO - Intel Iris: 16:25:33 INFO - Chipset Model: Intel Iris 16:25:33 INFO - Type: GPU 16:25:33 INFO - Bus: Built-In 16:25:33 INFO - VRAM (Dynamic, Max): 1536 MB 16:25:33 INFO - Vendor: Intel (0x8086) 16:25:33 INFO - Device ID: 0x0a2e 16:25:33 INFO - Revision ID: 0x0009 16:25:33 INFO - Displays: 16:25:33 INFO - Display: 16:25:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:25:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:25:33 INFO - Display Serial Number: 1600x1200 60 16:25:33 INFO - Main Display: Yes 16:25:33 INFO - Mirror: Off 16:25:33 INFO - Online: Yes 16:25:33 INFO - Rotation: Supported 16:25:33 INFO - Return code: 0 16:25:33 INFO - Running post-action listener: _resource_record_post_action 16:25:33 INFO - ##### 16:25:33 INFO - ##### Finished run-tests step (success) 16:25:33 INFO - ##### 16:25:33 INFO - Running post-run listener: _resource_record_post_run 16:25:33 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 31522304; Write bytes: 699161088; Read time: 197; Write time: 1979 16:25:33 INFO - TinderboxPrint: CPU usage
54.3% 16:25:33 INFO - TinderboxPrint: I/O read bytes / time
31,522,304 / 197 16:25:33 INFO - TinderboxPrint: I/O write bytes / time
699,161,088 / 1,979 16:25:33 INFO - TinderboxPrint: CPU idle
2,210.2 (45.7%) 16:25:33 INFO - TinderboxPrint: CPU system
972.7 (20.1%) 16:25:33 INFO - TinderboxPrint: CPU user
1,658.8 (34.3%) 16:25:33 INFO - TinderboxPrint: Swap in / out
424,353,792 / 0 16:25:33 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 383920640; Write bytes: 378042368; Read time: 28485; Write time: 802 16:25:33 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 30600704; Write bytes: 300347904; Read time: 186; Write time: 1123 16:25:33 INFO - Running post-run listener: _upload_blobber_files 16:25:33 INFO - Blob upload gear active. 16:25:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:25:33 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 16:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:25:34 INFO - (blobuploader) - INFO - Open directory for files ... 16:25:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:25:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:25:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:35 INFO - (blobuploader) - INFO - Done attempting. 16:25:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:25:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:36 INFO - (blobuploader) - INFO - Done attempting. 16:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:25:39 INFO - (blobuploader) - INFO - Done attempting. 16:25:39 INFO - (blobuploader) - INFO - Iteration through files over. 16:25:39 INFO - Return code: 0 16:25:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:25:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:25:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52686b4376b35824cb2861bb1e4d7b86b528e5485140d1772a703e08fe9be293d2d474b4f4fcf95406394c7891c492e882ce5010dd30a33fba3e4faa427b40c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48456f8c7df0a066530746c04b36cc79e19b7d404801f44c0a3d1be46409d6a3afbda7d0349d13bee9ada1b7e441136bcb01b8d3629ba3d00fd05b4b12ce146d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fde6c421a37d4a16b27d548de39542ad4cf7fa8393a686e9536c2582a118ea70a533d0af35da51dcc791599d55593a6418163ed76d24eb1a896b06ed5e39184"} 16:25:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:25:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:25:39 INFO - Contents: 16:25:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52686b4376b35824cb2861bb1e4d7b86b528e5485140d1772a703e08fe9be293d2d474b4f4fcf95406394c7891c492e882ce5010dd30a33fba3e4faa427b40c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48456f8c7df0a066530746c04b36cc79e19b7d404801f44c0a3d1be46409d6a3afbda7d0349d13bee9ada1b7e441136bcb01b8d3629ba3d00fd05b4b12ce146d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fde6c421a37d4a16b27d548de39542ad4cf7fa8393a686e9536c2582a118ea70a533d0af35da51dcc791599d55593a6418163ed76d24eb1a896b06ed5e39184"} 16:25:39 INFO - Running post-run listener: copy_logs_to_upload_dir 16:25:39 INFO - Copying logs to upload dir... 16:25:39 INFO - mkdir: /builds/slave/test/build/upload/logs 16:25:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1342.653311 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 22 secs) (at 2016-05-23 16:25:39.705294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 16:25:39.708464) ========= 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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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/Fx-Team/sha512/52686b4376b35824cb2861bb1e4d7b86b528e5485140d1772a703e08fe9be293d2d474b4f4fcf95406394c7891c492e882ce5010dd30a33fba3e4faa427b40c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48456f8c7df0a066530746c04b36cc79e19b7d404801f44c0a3d1be46409d6a3afbda7d0349d13bee9ada1b7e441136bcb01b8d3629ba3d00fd05b4b12ce146d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fde6c421a37d4a16b27d548de39542ad4cf7fa8393a686e9536c2582a118ea70a533d0af35da51dcc791599d55593a6418163ed76d24eb1a896b06ed5e39184"} build_url:https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/Ef-N6mq9QSqIXsEiADFqXQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52686b4376b35824cb2861bb1e4d7b86b528e5485140d1772a703e08fe9be293d2d474b4f4fcf95406394c7891c492e882ce5010dd30a33fba3e4faa427b40c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48456f8c7df0a066530746c04b36cc79e19b7d404801f44c0a3d1be46409d6a3afbda7d0349d13bee9ada1b7e441136bcb01b8d3629ba3d00fd05b4b12ce146d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4fde6c421a37d4a16b27d548de39542ad4cf7fa8393a686e9536c2582a118ea70a533d0af35da51dcc791599d55593a6418163ed76d24eb1a896b06ed5e39184"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 16:25:39.737847) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 16:25:39.738179) ========= 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.xq6ZFQQZVI/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.HsG3cIaWHH/Listeners TMPDIR=/var/folders/38/7s9s8qps6rj1x54mtxs_b9vw00000w/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.005002 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 16:25:39.787097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 16:25:39.787422) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 16:25:39.787794) ========= ========= Total master_lag: 0.17 =========