builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0054 starttime: 1457709209.61 results: success (0) buildid: 20160310030242 builduid: 8f534ec49a6543cf845c110dea8499bc revision: dd1abe874252e507b825a0a4e1063b0e13578288 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:29.613756) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:29.614204) ========= ========= Started set props: basedir (results: 0, elapsed: 5 secs) (at 2016-03-11 07:13:29.614505) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005752 basedir: '/builds/slave/test' ========= master_lag: 5.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 5 secs) (at 2016-03-11 07:13:34.925850) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2016-03-11 07:13:34.926160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 12 secs) (at 2016-03-11 07:13:47.460418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:47.460932) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005233 ========= master_lag: 0.71 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:48.176092) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:48.176366) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:48.179726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 07:13:48.180037) ========= 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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-03-11 07:13:48-- 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% 63.6M=0s 2016-03-11 07:13:48 (63.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124807 ========= master_lag: 1.48 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 07:13:49.781962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 07:13:49.782260) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.019720 ========= master_lag: 1.27 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 07:13:51.074256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-11 07:13:51.074572) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd1abe874252e507b825a0a4e1063b0e13578288 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev dd1abe874252e507b825a0a4e1063b0e13578288 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-03-11 07:13:51,725 truncating revision to first 12 chars 2016-03-11 07:13:51,725 Setting DEBUG logging. 2016-03-11 07:13:51,725 attempt 1/10 2016-03-11 07:13:51,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd1abe874252?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 07:13:52,807 unpacking tar archive at: mozilla-central-dd1abe874252/testing/mozharness/ program finished with exit code 0 elapsedTime=1.332475 ========= master_lag: 0.79 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-11 07:13:53.200160) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:53.200533) ========= echo dd1abe874252e507b825a0a4e1063b0e13578288 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dd1abe874252e507b825a0a4e1063b0e13578288'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 dd1abe874252e507b825a0a4e1063b0e13578288 program finished with exit code 0 elapsedTime=0.004502 script_repo_revision: 'dd1abe874252e507b825a0a4e1063b0e13578288' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:53.278266) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:53.278616) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 07:13:53.417019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-11 07:13:53.417399) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:13:53 INFO - MultiFileLogger online at 20160311 07:13:53 in /builds/slave/test 07:13:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:13:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:53 INFO - {'append_to_log': False, 07:13:53 INFO - 'base_work_dir': '/builds/slave/test', 07:13:53 INFO - 'blob_upload_branch': 'Firefox', 07:13:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:53 INFO - 'branch': 'Firefox', 07:13:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:53 INFO - 'config_files': ('talos/mac_config.py',), 07:13:53 INFO - 'default_actions': ('clobber', 07:13:53 INFO - 'read-buildbot-config', 07:13:53 INFO - 'download-and-extract', 07:13:53 INFO - 'populate-webroot', 07:13:53 INFO - 'create-virtualenv', 07:13:53 INFO - 'install', 07:13:53 INFO - 'run-tests'), 07:13:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:53 INFO - 'download_minidump_stackwalk': True, 07:13:53 INFO - 'download_symbols': 'ondemand', 07:13:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:53 INFO - 'installer_path': 'installer.exe', 07:13:53 INFO - 'log_level': 'info', 07:13:53 INFO - 'log_name': 'talos', 07:13:53 INFO - 'log_to_console': True, 07:13:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:13:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:13:53 INFO - 'opt_config_files': (), 07:13:53 INFO - 'pip_index': False, 07:13:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:53 INFO - 'cmd': ('bash', 07:13:53 INFO - '-c', 07:13:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:53 INFO - 'enabled': True, 07:13:53 INFO - 'halt_on_failure': False, 07:13:53 INFO - 'name': 'check_screen_resolution'},), 07:13:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:53 INFO - 'cmd': ('bash', 07:13:53 INFO - '-c', 07:13:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:53 INFO - 'enabled': True, 07:13:53 INFO - 'halt_on_failure': False, 07:13:53 INFO - 'name': 'check_screen_resolution'},), 07:13:53 INFO - 'run_cmd_checks_enabled': True, 07:13:53 INFO - 'sps_profile': False, 07:13:53 INFO - 'sps_profile_interval': 0, 07:13:53 INFO - 'suite': 'dromaeojs', 07:13:53 INFO - 'system_bits': '32', 07:13:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:53 INFO - 'title': 't-yosemite-r7-0054', 07:13:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:53 INFO - 'use_talos_json': True, 07:13:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:53 INFO - 'work_dir': 'build'} 07:13:53 INFO - ##### 07:13:53 INFO - ##### Running clobber step. 07:13:53 INFO - ##### 07:13:53 INFO - Running pre-action listener: _resource_record_pre_action 07:13:53 INFO - Running main action method: clobber 07:13:53 INFO - rmtree: /builds/slave/test/build 07:13:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:53 INFO - Running post-action listener: _resource_record_post_action 07:13:53 INFO - ##### 07:13:53 INFO - ##### Running read-buildbot-config step. 07:13:53 INFO - ##### 07:13:53 INFO - Running pre-action listener: _resource_record_pre_action 07:13:53 INFO - Running main action method: read_buildbot_config 07:13:53 INFO - Using buildbot properties: 07:13:53 INFO - { 07:13:53 INFO - "project": "", 07:13:53 INFO - "product": "firefox", 07:13:53 INFO - "script_repo_revision": "production", 07:13:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:13:53 INFO - "repository": "", 07:13:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:13:53 INFO - "buildid": "20160310030242", 07:13:53 INFO - "stage_platform": "macosx64", 07:13:53 INFO - "basedir": "/builds/slave/test", 07:13:53 INFO - "nightly_build": "True", 07:13:53 INFO - "buildnumber": 167, 07:13:53 INFO - "slavename": "t-yosemite-r7-0054", 07:13:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:13:53 INFO - "platform": "yosemite_r7", 07:13:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:13:53 INFO - "branch": "mozilla-central", 07:13:53 INFO - "repo_path": "mozilla-central", 07:13:53 INFO - "revision": "dd1abe874252e507b825a0a4e1063b0e13578288", 07:13:53 INFO - "pgo_build": "False", 07:13:53 INFO - "builduid": "8f534ec49a6543cf845c110dea8499bc", 07:13:53 INFO - "slavebuilddir": "test" 07:13:53 INFO - } 07:13:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:13:53 INFO - Running post-action listener: _resource_record_post_action 07:13:53 INFO - ##### 07:13:53 INFO - ##### Running download-and-extract step. 07:13:53 INFO - ##### 07:13:53 INFO - Running pre-action listener: _resource_record_pre_action 07:13:53 INFO - Running main action method: download_and_extract 07:13:53 INFO - mkdir: /builds/slave/test/build/tests 07:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:13:53 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:13:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:13:57 INFO - Downloaded 1199 bytes. 07:13:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:57 INFO - Using the following test package requirements: 07:13:57 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:13:57 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:57 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:13:57 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:57 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:13:57 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:57 INFO - u'jsshell-mac.zip'], 07:13:57 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:57 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:13:57 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:13:57 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:57 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:13:57 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:57 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:13:57 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:57 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:13:57 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:57 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:13:57 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:13:57 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:13:59 INFO - Downloaded 17867590 bytes. 07:13:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:14:02 INFO - Return code: 0 07:14:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:14:02 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')]} 07:14:02 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:14:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:14:04 INFO - Downloaded 17867590 bytes. 07:14:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:14:08 INFO - Return code: 0 07:14: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')]} 07:14:08 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:14:09 INFO - Downloaded 10845161 bytes. 07:14:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:14:09 INFO - Return code: 0 07:14:09 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')]} 07:14:09 INFO - https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:14:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:14:14 INFO - Downloaded 111132293 bytes. 07:14:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:14 INFO - mkdir: /builds/slave/test/properties 07:14:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:14:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:14:14 INFO - Contents: 07:14:14 INFO - build_url:https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:15 INFO - Running post-action listener: _resource_record_post_action 07:14:15 INFO - Running post-action listener: set_extra_try_arguments 07:14:15 INFO - ##### 07:14:15 INFO - ##### Running populate-webroot step. 07:14:15 INFO - ##### 07:14:15 INFO - Running pre-action listener: _resource_record_pre_action 07:14:15 INFO - Running main action method: populate_webroot 07:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:15 INFO - '--tppagecycles', 07:14:15 INFO - '7'], 07:14:15 INFO - 'tests': ['tsvgm']}}, 07:14:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:14:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:14:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:15 INFO - 'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:15 INFO - 'tests': ['damp', 'tps']}, 07:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:15 INFO - 'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['damp', 'tps']}, 07:14:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:14:15 INFO - 'other': {'tests': ['a11yr', 07:14:15 INFO - 'ts_paint', 07:14:15 INFO - 'tpaint', 07:14:15 INFO - 'sessionrestore', 07:14:15 INFO - 'sessionrestore_no_auto_restore', 07:14:15 INFO - 'tabpaint']}, 07:14:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['a11yr', 07:14:15 INFO - 'ts_paint', 07:14:15 INFO - 'tpaint', 07:14:15 INFO - 'sessionrestore', 07:14:15 INFO - 'sessionrestore_no_auto_restore', 07:14:15 INFO - 'tabpaint']}, 07:14:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['a11yr', 07:14:15 INFO - 'ts_paint', 07:14:15 INFO - 'tpaint', 07:14:15 INFO - 'sessionrestore', 07:14:15 INFO - 'sessionrestore_no_auto_restore', 07:14:15 INFO - 'tabpaint']}, 07:14:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['a11yr', 07:14:15 INFO - 'ts_paint', 07:14:15 INFO - 'tpaint', 07:14:15 INFO - 'sessionrestore', 07:14:15 INFO - 'sessionrestore_no_auto_restore', 07:14:15 INFO - 'tabpaint']}, 07:14:15 INFO - 'other_l64': {'tests': ['a11yr', 07:14:15 INFO - 'ts_paint', 07:14:15 INFO - 'tpaint', 07:14:15 INFO - 'sessionrestore', 07:14:15 INFO - 'sessionrestore_no_auto_restore', 07:14:15 INFO - 'tabpaint']}, 07:14:15 INFO - 'other_nol64': {'tests': ['a11yr', 07:14:15 INFO - 'ts_paint', 07:14:15 INFO - 'tpaint', 07:14:15 INFO - 'sessionrestore', 07:14:15 INFO - 'sessionrestore_no_auto_restore', 07:14:15 INFO - 'tabpaint']}, 07:14:15 INFO - 'svgr': {'tests': ['tsvgx', 07:14:15 INFO - 'tsvgr_opacity', 07:14:15 INFO - 'tart', 07:14:15 INFO - 'tscrollx', 07:14:15 INFO - 'cart']}, 07:14:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['tsvgx', 07:14:15 INFO - 'tsvgr_opacity', 07:14:15 INFO - 'tart', 07:14:15 INFO - 'tscrollx', 07:14:15 INFO - 'cart']}, 07:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:15 INFO - 'tests': ['tp5o']}, 07:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:15 INFO - 'talos_options': ['--e10s'], 07:14:15 INFO - 'tests': ['tp5o']}, 07:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:15 INFO - 'talos_options': ['--xperf_path', 07:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:15 INFO - 'tests': ['tp5n']}, 07:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:15 INFO - 'talos_options': ['--e10s', 07:14:15 INFO - '--xperf_path', 07:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:15 INFO - 'tests': ['tp5n']}}, 07:14:15 INFO - 'talos.zip': {'path': '', 07:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:15 INFO - Running post-action listener: _resource_record_post_action 07:14:15 INFO - ##### 07:14:15 INFO - ##### Running create-virtualenv step. 07:14:15 INFO - ##### 07:14:15 INFO - Running pre-action listener: _resource_record_pre_action 07:14:15 INFO - Running main action method: create_virtualenv 07:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:15 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 07:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:15 INFO - Using real prefix '/tools/python27' 07:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:19 INFO - Installing pip.................done. 07:14:19 INFO - Return code: 0 07:14:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14:19 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')]} 07:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:19 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')]} 07:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:19 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 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:19 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 07:14:19 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 07:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:19 INFO - 'HOME': '/Users/cltbld', 07:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:19 INFO - 'LOGNAME': 'cltbld', 07:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:19 INFO - 'MOZ_NO_REMOTE': '1', 07:14:19 INFO - 'NO_EM_RESTART': '1', 07:14:19 INFO - 'PAGER': '/bin/cat', 07:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:19 INFO - 'PWD': '/builds/slave/test', 07:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:19 INFO - 'SHELL': '/bin/bash', 07:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:19 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:19 INFO - 'USER': 'cltbld', 07:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:19 INFO - 'XPC_FLAGS': '0x0', 07:14:19 INFO - 'XPC_SERVICE_NAME': '0', 07:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:19 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 07:14:19 INFO - Cleaning up... 07:14:19 INFO - Return code: 0 07:14:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:14:19 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')]} 07:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:19 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')]} 07:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:19 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:19 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>=0.7.1'] in /builds/slave/test/build 07:14:19 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>=0.7.1 07:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:19 INFO - 'HOME': '/Users/cltbld', 07:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:19 INFO - 'LOGNAME': 'cltbld', 07:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:19 INFO - 'MOZ_NO_REMOTE': '1', 07:14:19 INFO - 'NO_EM_RESTART': '1', 07:14:19 INFO - 'PAGER': '/bin/cat', 07:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:19 INFO - 'PWD': '/builds/slave/test', 07:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:19 INFO - 'SHELL': '/bin/bash', 07:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:19 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:19 INFO - 'USER': 'cltbld', 07:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:19 INFO - 'XPC_FLAGS': '0x0', 07:14:19 INFO - 'XPC_SERVICE_NAME': '0', 07:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:19 INFO - Downloading/unpacking psutil>=0.7.1 07:14:19 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 07:14:19 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 07:14:19 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 07:14:19 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 07:14:19 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 07:14:19 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 07:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:22 INFO - Installing collected packages: psutil 07:14:22 INFO - Running setup.py install for psutil 07:14:22 INFO - building 'psutil._psutil_osx' extension 07:14:22 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 INFO - building 'psutil._psutil_posix' extension 07:14:23 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 07:14:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:14:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:14:23 INFO - ^ 07:14:23 INFO - 1 warning generated. 07:14:23 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 07:14:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:23 INFO - Successfully installed psutil 07:14:23 INFO - Cleaning up... 07:14:23 INFO - Return code: 0 07:14:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:14:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:23 INFO - 'HOME': '/Users/cltbld', 07:14:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:23 INFO - 'LOGNAME': 'cltbld', 07:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:23 INFO - 'MOZ_NO_REMOTE': '1', 07:14:23 INFO - 'NO_EM_RESTART': '1', 07:14:23 INFO - 'PAGER': '/bin/cat', 07:14:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:23 INFO - 'PWD': '/builds/slave/test', 07:14:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:23 INFO - 'SHELL': '/bin/bash', 07:14:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:23 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:23 INFO - 'USER': 'cltbld', 07:14:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:23 INFO - 'XPC_FLAGS': '0x0', 07:14:23 INFO - 'XPC_SERVICE_NAME': '0', 07:14:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:14:26 INFO - Installing collected packages: mozsystemmonitor 07:14:26 INFO - Running setup.py install for mozsystemmonitor 07:14:26 INFO - Successfully installed mozsystemmonitor 07:14:26 INFO - Cleaning up... 07:14:26 INFO - Return code: 0 07:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14:26 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')]} 07:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:26 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')]} 07:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:26 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 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:26 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 07:14:26 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 07:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:26 INFO - 'HOME': '/Users/cltbld', 07:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:26 INFO - 'LOGNAME': 'cltbld', 07:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:26 INFO - 'MOZ_NO_REMOTE': '1', 07:14:26 INFO - 'NO_EM_RESTART': '1', 07:14:26 INFO - 'PAGER': '/bin/cat', 07:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:26 INFO - 'PWD': '/builds/slave/test', 07:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:26 INFO - 'SHELL': '/bin/bash', 07:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:26 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:26 INFO - 'USER': 'cltbld', 07:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:26 INFO - 'XPC_FLAGS': '0x0', 07:14:26 INFO - 'XPC_SERVICE_NAME': '0', 07:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:30 INFO - Downloading docopt-0.6.1.tar.gz 07:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:30 INFO - Running setup.py install for blobuploader 07:14:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:30 INFO - Running setup.py install for requests 07:14:31 INFO - Running setup.py install for docopt 07:14:31 INFO - Successfully installed blobuploader requests docopt 07:14:31 INFO - Cleaning up... 07:14:31 INFO - Return code: 0 07:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:31 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 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:31 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 07:14:31 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 07:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:31 INFO - 'HOME': '/Users/cltbld', 07:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:31 INFO - 'LOGNAME': 'cltbld', 07:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:31 INFO - 'MOZ_NO_REMOTE': '1', 07:14:31 INFO - 'NO_EM_RESTART': '1', 07:14:31 INFO - 'PAGER': '/bin/cat', 07:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:31 INFO - 'PWD': '/builds/slave/test', 07:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:31 INFO - 'SHELL': '/bin/bash', 07:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:31 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:31 INFO - 'USER': 'cltbld', 07:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:31 INFO - 'XPC_FLAGS': '0x0', 07:14:31 INFO - 'XPC_SERVICE_NAME': '0', 07:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:31 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-McUacM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:31 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Rzji_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:31 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-YB0XaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-RJVOM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Y63D73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-YkjwhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-x7rcJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-iQvC9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-MfbMei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-eMJat_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-VanAqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:32 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-u5QJ9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:33 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-yAG4Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:33 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4ojHu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:33 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-NTaPbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:33 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-qzaIuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:33 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-SerSea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:33 INFO - Running setup.py install for manifestparser 07:14:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:33 INFO - Running setup.py install for mozcrash 07:14:33 INFO - Running setup.py install for mozdebug 07:14:33 INFO - Running setup.py install for mozdevice 07:14:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Running setup.py install for mozfile 07:14:34 INFO - Running setup.py install for mozhttpd 07:14:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Running setup.py install for mozinfo 07:14:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Running setup.py install for mozInstall 07:14:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Running setup.py install for mozleak 07:14:34 INFO - Running setup.py install for mozlog 07:14:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:35 INFO - Running setup.py install for moznetwork 07:14:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:35 INFO - Running setup.py install for mozprocess 07:14:35 INFO - Running setup.py install for mozprofile 07:14:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:35 INFO - Running setup.py install for mozrunner 07:14:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:35 INFO - Running setup.py install for mozscreenshot 07:14:35 INFO - Running setup.py install for moztest 07:14:35 INFO - Running setup.py install for mozversion 07:14:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:36 INFO - Cleaning up... 07:14:36 INFO - Return code: 0 07:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:36 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')]} 07:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:36 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')]} 07:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:36 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 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:36 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 07:14:36 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 07:14:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:36 INFO - 'HOME': '/Users/cltbld', 07:14:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:36 INFO - 'LOGNAME': 'cltbld', 07:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:36 INFO - 'MOZ_NO_REMOTE': '1', 07:14:36 INFO - 'NO_EM_RESTART': '1', 07:14:36 INFO - 'PAGER': '/bin/cat', 07:14:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:36 INFO - 'PWD': '/builds/slave/test', 07:14:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:36 INFO - 'SHELL': '/bin/bash', 07:14:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:36 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:36 INFO - 'USER': 'cltbld', 07:14:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:36 INFO - 'XPC_FLAGS': '0x0', 07:14:36 INFO - 'XPC_SERVICE_NAME': '0', 07:14:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:36 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-KFzK6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:36 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-sYvZ8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:36 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Cur5vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:36 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-u_h4xC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:36 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-dXRT4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:36 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)) 07:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:36 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-IypyKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-EqpXN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-xsUqsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-MmvsPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zJx76B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-H5vIPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Se11OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-SbRO2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-L2MyHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:37 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)) 07:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:37 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-jW1iZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:38 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)) 07:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:38 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-fST4fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:38 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)) 07:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:38 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-VUM7xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 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)) 07:14:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:40 INFO - Downloading blessings-1.6.tar.gz 07:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:40 INFO - Installing collected packages: blessings 07:14:40 INFO - Running setup.py install for blessings 07:14:40 INFO - Successfully installed blessings 07:14:40 INFO - Cleaning up... 07:14:40 INFO - Return code: 0 07:14:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:41 INFO - Reading from file tmpfile_stdout 07:14:41 INFO - Current package versions: 07:14:41 INFO - blessings == 1.6 07:14:41 INFO - blobuploader == 1.2.4 07:14:41 INFO - docopt == 0.6.1 07:14:41 INFO - manifestparser == 1.1 07:14:41 INFO - mozInstall == 1.12 07:14:41 INFO - mozcrash == 0.17 07:14:41 INFO - mozdebug == 0.1 07:14:41 INFO - mozdevice == 0.48 07:14:41 INFO - mozfile == 1.2 07:14:41 INFO - mozhttpd == 0.7 07:14:41 INFO - mozinfo == 0.9 07:14:41 INFO - mozleak == 0.1 07:14:41 INFO - mozlog == 3.1 07:14:41 INFO - moznetwork == 0.27 07:14:41 INFO - mozprocess == 0.22 07:14:41 INFO - mozprofile == 0.28 07:14:41 INFO - mozrunner == 6.11 07:14:41 INFO - mozscreenshot == 0.1 07:14:41 INFO - mozsystemmonitor == 0.0 07:14:41 INFO - moztest == 0.7 07:14:41 INFO - mozversion == 1.4 07:14:41 INFO - psutil == 3.1.1 07:14:41 INFO - requests == 1.2.3 07:14:41 INFO - wsgiref == 0.1.2 07:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:41 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')]} 07:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:41 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')]} 07:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:41 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 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:41 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 07:14:41 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 07:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:41 INFO - 'HOME': '/Users/cltbld', 07:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:41 INFO - 'LOGNAME': 'cltbld', 07:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:41 INFO - 'MOZ_NO_REMOTE': '1', 07:14:41 INFO - 'NO_EM_RESTART': '1', 07:14:41 INFO - 'PAGER': '/bin/cat', 07:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:41 INFO - 'PWD': '/builds/slave/test', 07:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:41 INFO - 'SHELL': '/bin/bash', 07:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:41 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:41 INFO - 'USER': 'cltbld', 07:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:41 INFO - 'XPC_FLAGS': '0x0', 07:14:41 INFO - 'XPC_SERVICE_NAME': '0', 07:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 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)) 07:14:41 INFO - Cleaning up... 07:14:41 INFO - Return code: 0 07:14:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14:41 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')]} 07:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:41 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')]} 07:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:41 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 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:41 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 07:14:41 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 07:14:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:41 INFO - 'HOME': '/Users/cltbld', 07:14:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:41 INFO - 'LOGNAME': 'cltbld', 07:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:41 INFO - 'MOZ_NO_REMOTE': '1', 07:14:41 INFO - 'NO_EM_RESTART': '1', 07:14:41 INFO - 'PAGER': '/bin/cat', 07:14:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:41 INFO - 'PWD': '/builds/slave/test', 07:14:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:41 INFO - 'SHELL': '/bin/bash', 07:14:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:41 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:41 INFO - 'USER': 'cltbld', 07:14:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:41 INFO - 'XPC_FLAGS': '0x0', 07:14:41 INFO - 'XPC_SERVICE_NAME': '0', 07:14:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:41 INFO - Downloading/unpacking jsonschema 07:14:41 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 07:14:41 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 07:14:41 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 07:14:41 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 07:14:41 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 07:14:41 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 07:14:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:44 INFO - Downloading/unpacking functools32 (from jsonschema) 07:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:44 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:44 INFO - warning: no files found matching '*.txt' 07:14:44 INFO - no previously-included directories found matching 'build' 07:14:44 INFO - no previously-included directories found matching 'dist' 07:14:44 INFO - no previously-included directories found matching '.git*' 07:14:44 INFO - Installing collected packages: jsonschema, functools32 07:14:44 INFO - Running setup.py install for functools32 07:14:44 INFO - warning: no files found matching '*.txt' 07:14:44 INFO - no previously-included directories found matching 'build' 07:14:44 INFO - no previously-included directories found matching 'dist' 07:14:44 INFO - no previously-included directories found matching '.git*' 07:14:44 INFO - Successfully installed jsonschema functools32 07:14:44 INFO - Cleaning up... 07:14:44 INFO - Return code: 0 07:14:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:14:44 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')]} 07:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:44 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')]} 07:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:44 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 0x105871a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058794c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefcbc5ea20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, '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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 07:14:44 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 07:14:44 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 07:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:44 INFO - 'HOME': '/Users/cltbld', 07:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:44 INFO - 'LOGNAME': 'cltbld', 07:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:44 INFO - 'MOZ_NO_REMOTE': '1', 07:14:44 INFO - 'NO_EM_RESTART': '1', 07:14:44 INFO - 'PAGER': '/bin/cat', 07:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:44 INFO - 'PWD': '/builds/slave/test', 07:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:44 INFO - 'SHELL': '/bin/bash', 07:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:14:44 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:44 INFO - 'USER': 'cltbld', 07:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:44 INFO - 'XPC_FLAGS': '0x0', 07:14:44 INFO - 'XPC_SERVICE_NAME': '0', 07:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:45 INFO - Downloading/unpacking flake8 07:14:45 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 07:14:45 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 07:14:45 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 07:14:45 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 07:14:45 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 07:14:45 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 07:14:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:14:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:14:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:14:48 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 07:14:48 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 07:14:48 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 07:14:48 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 07:14:48 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 07:14:48 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 07:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:14:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:48 INFO - no previously-included directories found matching 'docs/_build' 07:14:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:14:48 INFO - Running setup.py install for pep8 07:14:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:48 INFO - no previously-included directories found matching 'docs/_build' 07:14:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:14:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:14:49 INFO - Cleaning up... 07:14:49 INFO - Return code: 0 07:14:49 INFO - Running post-action listener: _resource_record_post_action 07:14:49 INFO - Running post-action listener: _start_resource_monitoring 07:14:49 INFO - Starting resource monitoring. 07:14:49 INFO - ##### 07:14:49 INFO - ##### Running install step. 07:14:49 INFO - ##### 07:14:49 INFO - Running pre-action listener: _resource_record_pre_action 07:14:49 INFO - Running main action method: install 07:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:49 INFO - Reading from file tmpfile_stdout 07:14:49 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:49 INFO - Reading from file tmpfile_stdout 07:14:49 INFO - Output received: 07:14:49 INFO - Usage: mozinstall [options] installer 07:14:49 INFO - Options: 07:14:49 INFO - -h, --help show this help message and exit 07:14:49 INFO - -d DEST, --destination=DEST 07:14:49 INFO - Directory to install application into. [default: 07:14:49 INFO - "/builds/slave/test"] 07:14:49 INFO - --app=APP Application being installed. [default: firefox] 07:14:49 INFO - mkdir: /builds/slave/test/build/application 07:14:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:15:24 INFO - Reading from file tmpfile_stdout 07:15:24 INFO - Output received: 07:15:24 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 07:15:24 INFO - Running post-action listener: _resource_record_post_action 07:15:24 INFO - ##### 07:15:24 INFO - ##### Running run-tests step. 07:15:24 INFO - ##### 07:15:24 INFO - Running pre-action listener: _resource_record_pre_action 07:15:24 INFO - Running main action method: run_tests 07:15:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:24 INFO - 2016-03-11 07:15:24.935 screenresolution[2144:16264] starting screenresolution argv=screenresolution get 07:15:24 INFO - 2016-03-11 07:15:24.938 screenresolution[2144:16264] Display 0: 1600x1200x32@60 07:15:24 INFO - 2016-03-11 07:15:24.943 screenresolution[2145:16266] starting screenresolution argv=screenresolution list 07:15:24 INFO - Available Modes on Display 0 07:15:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:25 INFO - Intel Iris: 07:15:25 INFO - Chipset Model: Intel Iris 07:15:25 INFO - Type: GPU 07:15:25 INFO - Bus: Built-In 07:15:25 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:25 INFO - Vendor: Intel (0x8086) 07:15:25 INFO - Device ID: 0x0a2e 07:15:25 INFO - Revision ID: 0x0009 07:15:25 INFO - Displays: 07:15:25 INFO - Display: 07:15:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:25 INFO - Display Serial Number: 1600x1200 60 07:15:25 INFO - Main Display: Yes 07:15:25 INFO - Mirror: Off 07:15:25 INFO - Online: Yes 07:15:25 INFO - Rotation: Supported 07:15:25 INFO - Return code: 0 07:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:25 INFO - Python 2.7.3 07:15:25 INFO - Return code: 0 07:15:25 INFO - grabbing minidump binary from tooltool 07:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:15:25 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105715d30>, '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 0x105539db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10570cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:25 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 07:15:25 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 07:15:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:25 INFO - Return code: 0 07:15:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:15:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:15:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:15:26 INFO - Return code: 0 07:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:15:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3qc7kW6nkP/Render', 07:15:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:26 INFO - 'HOME': '/Users/cltbld', 07:15:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:26 INFO - 'LOGNAME': 'cltbld', 07:15:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:26 INFO - 'MOZ_NO_REMOTE': '1', 07:15:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:26 INFO - 'NO_EM_RESTART': '1', 07:15:26 INFO - 'PAGER': '/bin/cat', 07:15:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:26 INFO - 'PWD': '/builds/slave/test', 07:15:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:26 INFO - 'SHELL': '/bin/bash', 07:15:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JMgqtz6jf9/Listeners', 07:15:26 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 07:15:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:26 INFO - 'USER': 'cltbld', 07:15:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:26 INFO - 'XPC_FLAGS': '0x0', 07:15:26 INFO - 'XPC_SERVICE_NAME': '0', 07:15:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:15:26 INFO - mozversion application_buildid: 20160310030242 07:15:26 INFO - mozversion application_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 07:15:26 INFO - mozversion application_display_name: Nightly 07:15:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:26 INFO - mozversion application_name: Firefox 07:15:26 INFO - mozversion application_remotingname: firefox 07:15:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:15:26 INFO - mozversion application_vendor: Mozilla 07:15:26 INFO - mozversion application_version: 48.0a1 07:15:26 INFO - mozversion platform_buildid: 20160310030242 07:15:26 INFO - mozversion platform_changeset: dd1abe874252e507b825a0a4e1063b0e13578288 07:15:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:15:26 INFO - mozversion platform_version: 48.0a1 07:15:26 INFO - using testdate: 1457709326 07:15:26 INFO - actual date: 1457709326 07:15:26 INFO - starting webserver on 'localhost:51474' 07:15:26 INFO - SUITE-START | Running 2 tests 07:15:26 INFO - TEST-START | dromaeo_css 07:15:26 INFO - operating with platform_type : mac_ 07:15:26 INFO - Initialising browser for dromaeo_css test... 07:15:26 INFO - TEST-INFO | started process 2163 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpmiWQdq/profile http://localhost:51474/getInfo.html) 07:15:28 INFO - PROCESS | 2163 | __metrics Screen width/height:1600/1200 07:15:28 INFO - PROCESS | 2163 | colorDepth:24 07:15:28 INFO - PROCESS | 2163 | Browser inner width/height: 1024/689 07:15:28 INFO - PROCESS | 2163 | __metrics 07:15:29 INFO - PROCESS | 2163 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:15:29 ERROR - PROCESS | 2163 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:15:29 INFO - TEST-INFO | 2163: exit 0 07:15:29 INFO - Browser initialized. 07:15:29 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:29 INFO - TEST-INFO | started process 2167 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpmiWQdq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:41 INFO - PROCESS | 2167 | RSS: Main: 243073024 07:15:41 INFO - PROCESS | 2167 | 07:16:32 INFO - PROCESS | 2167 | 1457709392512 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] 07:18:43 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:51474/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51474/tests/dromaeo/cssquery-ext.html) 07:18:44 INFO - PROCESS | 2167 | RSS: Main: 344330240 07:18:44 INFO - PROCESS | 2167 | 07:21:47 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:51474/tests/dromaeo/cssquery-ext.html (next: http://localhost:51474/tests/dromaeo/cssquery-jquery.html) 07:21:47 INFO - PROCESS | 2167 | RSS: Main: 376971264 07:21:47 INFO - PROCESS | 2167 | 07:24:49 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:51474/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51474/tests/dromaeo/cssquery-mootools.html) 07:24:50 INFO - PROCESS | 2167 | RSS: Main: 370860032 07:24:50 INFO - PROCESS | 2167 | 07:27:52 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:51474/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51474/tests/dromaeo/cssquery-prototype.html) 07:27:53 INFO - PROCESS | 2167 | RSS: Main: 331079680 07:27:53 INFO - PROCESS | 2167 | 07:30:56 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:51474/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51474/tests/dromaeo/cssquery-yui.html) 07:30:56 INFO - PROCESS | 2167 | RSS: Main: 338862080 07:30:56 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | Cycle 1(1): loaded http://localhost:51474/tests/dromaeo/cssquery-yui.html (next: http://localhost:51474/tests/dromaeo/cssquery-dojo.html) 07:33:59 INFO - PROCESS | 2167 | RSS: Main: 451891200 07:33:59 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | __start_tp_report 07:33:59 INFO - PROCESS | 2167 | _x_x_mozilla_page_load 07:33:59 INFO - PROCESS | 2167 | _x_x_mozilla_page_load_details 07:33:59 INFO - PROCESS | 2167 | |i|pagename|runs| 07:33:59 INFO - PROCESS | 2167 | |0;dojo.html;3407.659234076593;3414.6073201581826;3436.3470940521315;3440.2431465077675;3478.8434520446594;5613.971930140354;5666.263385759846;5680.971595142024;5709.286339207599;5724.198612194291;5707.258056452666;5736.741846616902;5748.453896879801;5818.563607729416;5845.620034697742;5102.336696229485;5133.127368347371;5160.8709782255555;5171.250168725533;5281.63028587999;5259.579233661298;5267.868303292429;5289.2859463972445;5310.7610157543;5338.946610533903;5110.693358398508;5131.486851314876;5185.611079169077;5196.948030519684;5201.791928322881;5174.896502069975;5195.9480405195845;5234.555062819665;5236.397814251333;5262.973685131588;5147.948520514784;5171.81898633546;5180.507851754077;5183.896322073538;5206.843794686166;5486.725663716838;5579.246801681762;5661.34894487131;5665.886682266331;5667.4615911488345;6110.908336374958;6121.632702037892;6123.510119190499;6126.111713801519;6134.355892631254;6162.7226774795245;6178.7219575119225;6201.224846894138;6203.565750397474;6259.843503912393;4692.859214223545;4846.297286893416;5687.800926967537;5751.597388182829;5768.990426675315;6277.372262773777;6281.057841323838;6284.5600807943;6298.244210694746;6361.332060133712;5997.610155339889;6057.9095762762245;6099.176611157525;6114.844865410725;6139.140520327158;6240.157578726814;6257.624542527463;6261.592996455216;6278.6546739929745;6280.560360774702;6027.306859711101;6160.9383906161265;6202.968985155046;6232.127502149703;6238.563300568917;6010.429009244115;6088.178095957078;6127.494965205055;6166.630002199882;6173.351798061139;4878.878028049327;4879.878003049881;4887.266909963463;4903.705777653352;4905.828296009622;4316.525182229952;4323.848665296762;4331.935020974688;4381.9342709859375;4390.978045109754;4738.384010078667;5732.541396688255;5735.512481439125;5754.625949313281;5778.508826749689;6307.590006649553;6307.873842523124;6308.810735677937;6311.463525600284;6322.747090116436;4991.975040124848;5748.770049198069;5770.711464426762;5796.0436527972415;5804.2744656917885;4301.849435269751;5247.1866860636665;5338.306020217425;5365.463453654604;5374.623776335619;6266.122742816009;6289.874202516015;6300.369963003846;6308.558400912076;6316.526260530479;6224.813255602339;6300.7479700811455;6302.527310451643;6322.747090116344;6334.9366506334345;6200.782972595937;6229.345918678655;6268.717907694256;6278.811635650938;6603.7688680895935;6157.199564056644;6164.7842325518395;6197.845053873509;6217.098520714561;6223.875522489616;6098.329183789869;6148.262208535004;6274.874502509833;6306.590071645328;6323.873522529431;5944.762209511571;5959.791407300723;6056.06131049688;6093.29927058394;6129.601575897553;5306.52241298285;5929.911051334319;6068.848278792889;6114.694265286629;6137.570370074052;5795.7971471;5959.463648271503;5974.671393073423;5980.461758441587;5989.8203053908455;6081.878362432815;6113.728497863475;6114.113453549122;6140.565599444434;6145.709401025656;5897.823065308047;5930.822075337746;5951.16683664296;5955.612885162451;5977 07:33:59 INFO - PROCESS | 2167 | |1;ext.html;490.72764615638306;532.9786808527659;578.3580225949196;593.0748033068411;627.2942939193407;38434;38991.41512877309;39004.41493377598;39088.21823563531;39133.21733565327;42181;42878;42931.57068429315;43010.56989430112;43068.353974690406;9462.43225406476;9737.367071140354;9746.025397460233;9746.610135594603;9750.804983900352;9531;9676.274279429035;9677.75805604862;9681.951590242039;9688.273379496532;9646.180074693659;9704.320697551175;9711.465869377182;9711.562979665932;9716.368436051669;9605.135537801596;9686.370385924893;9687.370320929118;9689.70930872075;9702.126808587225;9650.517474126336;9775.462349570771;9789.070038346346;9807.362521436155;9811;38683.41974870379;39173.21653566941;39180;39202.80398598017;39301;3209.8395080246128;3345.6877691085892;3345.8996230112893;3436.381451338758;3611.963880361215;24365.512689746283;25473.490530189476;30196.54705179424;30229.244268893235;30246;2493.376655836041;2644.616530603071;2823.830570165776;2839.1198728394056;2843.7440630343367;398862;478045.6097719524;478994;479821;485126;68055.65972170107;68725.65637171782;68731.65634171898;68901.31098689049;69004.6549767258;72608;73903;73928.63035684895;74025;74061;17590.856594321584;17602.735958960628;17779.111044447727;17794.555136121442;17821.554461138316;13364;13426.865731342757;13448.93275533616;13456.798148027592;13461.730765384638;20648.690269645966;21823.781762182494;21831.235906743186;21849.67225491619;21879.890600547213;7962.283394494408;8193.713220037389;8210.3021243195;8302.837602735623;8307.667693292322;893.4326702543931;930.6044930904338;1002.4035698759227;1002.9560284536396;1038.6987773545738;26772.330691732863;28255.273293288865;28286.71713282841;29287.56068658929;29433.264168395963;913.5980168725739;970.3595626886221;1066.184368957748;1083.9566417343376;1134.5405110930087;12248.448819802952;13762.724745505035;13971.510997115052;14260.714785704227;14534.273286335641;479701;522765;527909;528092;529968;53985.46014539804;54113.72943135259;54141;54200;54201.45798541964;1341.7316536692701;1455.0905683947533;1469.4783351909919;1487.7842712806582;1492.8954973151992;21065.262715804874;27826.304342391602;28500.714992849807;28504.714952850205;28709.42581148407;46461.3030804545;46495;46909.53090469052;46944.76527617477;46961.06077878355;292283;294512;294743.52628236724;295234;296272;28459.857700711364;31382.84308578534;32082.518762219053;32340.83829580837;32922.5061624071;40249.39625905555;40821.591784082964;40905.59094409018;41025.79487102546;41521;33776.15559611029;34306.828465857514;34368;35206.64793352034;35217.82391088028;33645.15887102842;33761.324773504886;34275.971720848414;34396.82801585976;34532.82733586316;35545.466817997236;35980.820095899355;36326.455103174005;36571.451428228065;36711.63288367082;31397.30262009877;33415;34217;34247.82876085703;34329.31341373209;21315.721056736646;22211.444713882283;23009;23555.057797688587;23943 07:33:59 INFO - PROCESS | 2167 | |2;jquery.html;352.39740044523865;357.42989931059964;359.2169071424295;364.1297299454305;367.52772687097087;18845.680802343843;19599.216031358745;20228.69656955147;20593.485162870937;21027.053782579784;18667.439976800684;20403.693944590843;21059;21144.365669029914;21151.365459036253;5572.4706152915505;5734.311882574097;5738;5781.248437703092;5792.68140252286;4143.192077544865;4482.148391805563;5703.9714801425935;6554.8689026219445;6561.573497722657;6109.297430795449;6229.750809967596;6251.9374806252035;6259.248890133191;6260.217472815898;6020.8494787630225;6190.721417536199;6417.197850268716;6424.10062591233;6430.839229019289;5550.639208451437;5563.304586926634;5567.8886422271735;5584.636998595119;5589.413111623302;25231.747682523124;25656.102036428823;25917.481650366888;25938.22185334443;26079.608805867927;1902.9809701902943;2071.637463443891;2108.599366120432;2180.4221881201493;2851.70057144001;9603.951980240125;9683.709488715349;9803.607855685765;9938.15525680318;10145.847812282822;1740.6953783087909;1761.867859910512;1803.9098045097692;1810.7646006019265;1814.383109742694;75166;112262;113270.30094548588;113913;114001.4299928495;10981.341119532854;11266.310053491878;11274.267172633752;11295.435228238555;11379.487923043484;13450.26023568713;13553.39009744564;13555.661108472366;13563.796543051862;13579.456821727217;7068.7525936593;8525.957370213233;8574.528400938008;8750.69372571957;8768.254698350584;8796.95601522001;8815.294776417872;8829.646814127364;8915.910840891638;8955.328350373748;4358.3244597087505;4461.531539188403;4469.7318160910445;4498.775061246924;4575.405197324327;1839.3562253211537;1883.9529011774816;1887.9339223127124;1888.7450194223604;1892.0917959379574;894.4633220068038;931.9627214911328;1017.7760892603616;1028.861103750999;1049.0768124050787;18059.91640501548;18380.540486487676;19813.405597832087;20071.799282006992;20252;813.5322189740923;943.9528023598792;975.1759763000254;998.610541888664;1044.5926088825365;10612.734681632866;10856;10857.34855908648;10884.455777211107;10889.618863339745;597239;601053;619554;622716;629897;72831;94073;104273.47863260635;112759.87240127493;123191.38404308101;995.2038369304528;1021.5556233038652;1025.5743866295552;1052.1004541117388;1101.4107452513028;18329.266829326676;18848.24607015704;18853.528661783566;18949.71575426342;19131.521711957314;44073.338899917166;53298;54721.72639136938;55114;55412.445875540725;77463.61268193848;80081.39837203339;80949;83781.10845590278;83883;7964.522128672298;8115.1479094694205;8200.83598328042;8245.216704413071;8491.787705307417;13118.803217951547;13405.66485837862;13464.730705385642;13842.100263483244;13925.930370348084;11218.439078046229;11486.597969071043;11574.594889178838;11807;11820.940895295469;11270.94364528172;11345.773084538429;11373.658790236306;11585.594504192313;11693.532258709556;10163.593456261668;11526.250793698382;11785.646430607096;11816.468258928197;11904.464299106734;7819.609019549113;7935.563544005136;8018.318442932183;8180.46826956246;8272.545010024265;10936.249136049006;11511.42442877836;11516;11710.180287379802;11880.702982425508 07:33:59 INFO - PROCESS | 2167 | |3;mootools.html;1429.6783223774657;1562.7577725452554;1588.7934568506093;1880.4734674291194;2016.7781544030145;7955.801104972378;8143.47067440616;8147.91852081479;8148.266656000967;8154.91845081549;8284.54435006076;8461.153884611536;8587.656493740244;8588.91411085889;8592.570371481417;2445.1197568875236;2480.0203919451897;2481.1440053181623;2482.342179322472;2484.7018357797;2418.22616762636;2488.962665560018;2489.3652118709792;2491.277529516438;2496.8127390445698;2437.561238976992;2472.863992480413;2487.788537974265;2491.389609545664;2494.4761600064007;2447.8776061197045;2481.888315025828;2484.1429706751233;2485.6023036314105;2491.9127830526027;2437.902483900642;2481.627755836621;2483.615039668854;2485.8135639827087;2491.302435318114;8773.956130219309;8842.469451832847;8845.203931646183;8846.24806891415;8850.02649708538;5357.517823395913;5399.730013499348;5486.984907792032;5487.780488780484;5532.806351777709;3542.397792375277;3579.2483578448555;3656.981715091434;3667.651573100551;3682.779033258013;1017.3234798858824;1019.8572199892021;1039.3192458939407;1043.7755882485303;1053.6944286157004;11557.901999310136;11601.245919015322;11656.708582285426;11676.29942203462;11679.883201167964;4543.704659197141;4693.366395536627;4785.832495862628;4806.206975849016;4816.975915120472;9282.025387334368;9358.578863951003;9361.06389361072;9365.297602679826;9368.906310936803;5404.83785486436;5413.945860541423;5414.864628384322;5416.350037995466;5418.4039755626845;4439.334099885043;4594.793234304464;4909.435414927258;5016.799328026911;5039.21892106724;3773.8867833965023;3831.425286207091;3834.3481608126126;3850.614938506127;3892.8832135035996;1176.4588289386977;1187.6971372300009;1188.1623455463878;1199.2984104298907;1204.4459548607738;994.2145704893054;1027.1474676018886;1185.525789684116;1278.4438769135456;1408.845027047024;7920.643571039317;8062.234087761653;8116.391270654724;8184.549849758201;8185.590720463953;609.9847503812351;623.6476390839161;624.5347216323868;625.8748250349948;778.01581000035;6159.1069294951985;6182.474489668339;6262.060690896402;6315.400036996478;6325.841853953688;10434.373937563618;10883;10898.618548350929;10904.182186336056;10919.508622112024;10238.641647542301;10528.842067368996;10576;10672.359658420519;10750.946245268724;7087.645617719197;8250.669973201006;8283.17168283167;8401.53791541471;8415.242628163494;7817.570033648204;8020.398470114648;8050.637721302438;8062.072861620989;8071.515709057476;9141.085891410805;9362.953185234303;9521.952585215482;9527.428354298765;9624.807503850025;9419.764505887408;9823.607055717692;9874.259430542594;9948.204143668634;9952.950235248778;7923.445358825057;8225.629846656795;8227.053888802864;8230.176982301722;8239.711610093618;8184.304334131665;8238.629261683118;8355.832883342178;8363.95818020906;8376.32989360862;7393.260673932564;7393.741219057307;7563.054618172729;7566.848663026599;7603.2776886195725;7181.640917954186;7246.89129663066;7357.705691772269;7437.181909990005;7537.472376933562;7807.219278072147;7841.451098423056;7850.214978502104;7853.960730196541;7864.370850332074;6168.444839964424;6627.3372662733345;6789.558678685869;6963.0251764751965;7092.326229008236;7187.389071928945;7205.207427183111;7230.240824713329;7238.746643867439;7240.203577606354 07:33:59 INFO - PROCESS | 2167 | |4;prototype.html;263.6190704432095;321.4455065012853;326.1064682769213;331.4994358518636;337.85472246933807;6262.154609127772;6370.108184854118;6373.872522549546;6400;6414.583052101616;5072.923906141411;6299.968500157504;6319.526035547329;6340.144080549125;6349.523785716066;3784.981075094621;4601.953980460203;4604.917844306594;4635.559621835937;4651.674382793206;3827.980860095696;4588.931166032512;4655.7439340836245;4680.765961701902;4687.484376718576;4625.606823420013;4630.930536041962;4648.209804333254;4653.8371157009515;4674.415698037746;4668.066386722652;4687.554682305175;4694.788734506921;4697.3893393858925;4708.058388322315;3197.6642452542383;3900.2004589059457;3947.585503522146;3957.5053118360206;3993.1414745829497;6009.45914867664;6015.39846015395;6047.0929360596265;6063.393660633946;6082.817515474543;5451.2640793492765;5482.835514934558;5493.121100623921;5500.119980803052;5513.889722205574;6683.832904177434;6701.899471507932;6740.662966851638;6764.3573860483175;6767.42476889465;4499.3475945987975;4504.6396288296855;4504.954950450487;4507.256302710049;4536.7504787236685;6795.524313298071;7109.8222544436285;7127.394171495429;7141.67862446186;7170.354668079845;3833.674137698271;4155.58444155582;4317.935230971538;4604.148232576984;4659.627229821606;4697.812087516461;4706.294055891643;4709.929351059737;4710.081534100886;4747.121782470254;4803.543663351976;5500.972495137578;5506.972465137729;5524.8342549723575;5602.887942241132;6768.120144381297;6772.390484856288;6792.286809884989;6794.830129246809;6808.9659551701925;1554.9533513994597;1616.272677295222;1638.7787648667277;1644.5888527868033;1648.8928219665684;1070.5022164693455;1073.795978764048;1080.357187473452;1082.1721383141903;1091.028984204059;6297.370262973757;6365.14070600463;6372.649504277217;6383.96808015957;6393.073004414334;6822.249552549216;6948.687309071104;6949.478789090737;7014;7029.0862187915245;6214.130021796952;6427.775027874096;6429.1320671709655;6450.322716114834;6470.255920569195;3007.1579957611903;3697.9630203698157;3722.3757251138422;3740.588535261119;3742.2702572998546;7372.557646541225;7376.668049937765;7387.4090072795125;7396.593187374639;7402.777916662509;5826.6795326256615;6984.685689144001;7289.963550182321;7293.817654558572;7343.522671026366;7345.522541034922;7387.630618469055;7411.444141689502;7424.443166762514;7435.219301973323;7054.118235220598;7069.575825450283;7076.115485564304;7092.574445533284;7118.85762284741;6934.826629334307;6945.930540694529;6961.930380696128;6976.162860456778;6985.057017302599;7159;7405;7407.296306850841;7414.073240844895;7453.776386708408;4600;4642.837500687459;4650.116477869194;4652.55800698933;4667.486576476517;6987.056747339044;6987.545809522365;6989.685464154024;7008;7018.543794653331;6774.4580433564215;6780.220274668476;6780.321967803377;6783.389494945479;6808.148981377328;6518.542151677334;6767.390934815693;6768.390844823989;6773.89839152423;6781.728730850711;6586.110875032001;6612.603243805387;6632.1709786276715;6634.734610615715;6638.137042184485;6784.626845523544;6784.948333008391;6794.286599907136;6797.592144471348;6809.93190068093;6640.203175618956;6660.533762636569;6662.600243985376;6668;6674.666266686743 07:33:59 INFO - PROCESS | 2167 | |5;yui.html;641.7400952614192;663.5819433756734;689.0628744906929;714.217931365155;750.5759246025995;15082.622934426645;15265.160416177107;15283.159426231552;15295.770563441558;15301.081935083888;13989.880809535238;14095.365708543115;14321.641958951031;14385.136891786475;14386.208758518304;890.7639475538971;910.8633704944245;911.0889110889111;911.7994041310934;912.8265629530368;724.0587236592435;744.709563270325;899.0919171636662;920.1166879795404;921.9861702074475;950.7432993091861;960.8798900137483;961.2886464016613;961.4663861556833;961.4759955824057;760.6196901549225;944.2398868910524;955.1690029674158;956.861255118011;957.4446820843893;677.6137601567109;705.696550483292;709.1525626875886;710.6446776611695;712.5439718580113;14871;14933.477328293458;14935.626609334853;14947;14948.62628434287;12449.75100497994;12495.75008499825;12558.309292988883;12770.87229127706;12984;8220.465669731448;9864;10035.648752293635;10681.145508359312;10843.186760992878;3075.492543730282;3543.326767914088;3565;3569.125564236753;3651.6713495785507;74995.04656231414;76002.23997760007;76742;76773.55490895997;77202.06994825118;9044.592993315317;9218.354715170008;9272.536373181314;9478.715638530855;9589.376690515093;20573.69139462909;21125.366239012856;21131.8943405282;21140.78859211388;21241.68137477939;6351.777687780998;7334.119905611361;7452.590107544137;7508;7508.061492313461;4094.877153685394;4144.316187828975;4150.875473735793;4153.190127925026;4176.248275310412;3617.8010209438735;3672.412414013745;3682.0978860179425;3683.189698266377;3696.9260614787554;650.8828410886086;652.6345246661884;658.2561705273107;661.1966460750116;672.331030624522;531.572084471996;567.5629765080864;586.3345103307691;593.6319481921237;604.305049193431;8020.43856930021;8023.277904988579;8127.674893004332;8264.793380165544;8291.295239904555;505.2522267044721;577.9248697669276;580.1211165084816;599.3646734461485;607.5443417436923;3641.872534461334;3818.6754125899056;3826.8660596878976;3859.3635226618;3888.319544079775;83002.16997829944;83720;84051.15948840433;84096.57951710325;85757;72250.27749722435;75628;78388.60805695935;79163;79730.40539189184;53596.732016339665;67129.64351782392;67988;68535;69664.30335696679;7527.134379546423;7860.641807457854;7989.560574168477;8230.300424463987;8268.917310827055;47448.33930812405;48362.54912352635;50201;50649.74675126601;51348.48651513587;69639;70295.64852175706;70299;71499;71674.56650866849;10879.456027198767;10986;11023.44882755875;11614.12894032934;12074.45664945062;12099.879001209874;12208.145429820182;12302.938485307874;12482.75034499323;12913.096083274457;11365.374904380338;11535.884641153481;11615.5353785851;11759.588414405454;11781.342127617118;11517.827232591686;11535.884641153816;11833.349165795964;12008.039356851255;12527.310997895203;11067.944660276647;11262.493187806733;11432.542698292307;11551.018163455865;11566.65300041;9509.714708558755;9534.378046037395;9535.063445765602;9681.951590242004;10167.949160254151;7193.3166349196745;8582.914170858212;8720.694775682821;8889.555522223734;9300.348975571645 07:33:59 INFO - PROCESS | 2167 | __end_tp_report 07:33:59 INFO - PROCESS | 2167 | __start_cc_report 07:33:59 INFO - PROCESS | 2167 | _x_x_mozilla_cycle_collect,1222 07:33:59 INFO - PROCESS | 2167 | __end_cc_report 07:33:59 INFO - PROCESS | 2167 | __startTimestamp1457710439832__endTimestamp 07:33:59 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | ------- Summary: start ------- 07:33:59 INFO - PROCESS | 2167 | Number of tests: 6 07:33:59 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | [#0] dojo.html Cycles:165 Average:5704.88 Median:5955.61 stddev:659.36 (11.1%) stddev-sans-first:636.28 07:33:59 INFO - PROCESS | 2167 | Values: 3407.7 3414.6 3436.3 3440.2 3478.8 5614.0 5666.3 5681.0 5709.3 5724.2 5707.3 5736.7 5748.5 5818.6 5845.6 5102.3 5133.1 5160.9 5171.3 5281.6 5259.6 5267.9 5289.3 5310.8 5338.9 5110.7 5131.5 5185.6 5196.9 5201.8 5174.9 5195.9 5234.6 5236.4 5263.0 5147.9 5171.8 5180.5 5183.9 5206.8 5486.7 5579.2 5661.3 5665.9 5667.5 6110.9 6121.6 6123.5 6126.1 6134.4 6162.7 6178.7 6201.2 6203.6 6259.8 4692.9 4846.3 5687.8 5751.6 5769.0 6277.4 6281.1 6284.6 6298.2 6361.3 5997.6 6057.9 6099.2 6114.8 6139.1 6240.2 6257.6 6261.6 6278.7 6280.6 6027.3 6160.9 6203.0 6232.1 6238.6 6010.4 6088.2 6127.5 6166.6 6173.4 4878.9 4879.9 4887.3 4903.7 4905.8 4316.5 4323.8 4331.9 4381.9 4391.0 4738.4 5732.5 5735.5 5754.6 5778.5 6307.6 6307.9 6308.8 6311.5 6322.7 4992.0 5748.8 5770.7 5796.0 5804.3 4301.8 5247.2 5338.3 5365.5 5374.6 6266.1 6289.9 6300.4 6308.6 6316.5 6224.8 6300.7 6302.5 6322.7 6334.9 6200.8 6229.3 6268.7 6278.8 6603.8 6157.2 6164.8 6197.8 6217.1 6223.9 6098.3 6148.3 6274.9 6306.6 6323.9 5944.8 5959.8 6056.1 6093.3 6129.6 5306.5 5929.9 6068.8 6114.7 6137.6 5795.8 5959.5 5974.7 5980.5 5989.8 6081.9 6113.7 6114.1 6140.6 6145.7 5897.8 5930.8 5951.2 5955.6 5977.0 07:33:59 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | [#1] ext.html Cycles:180 Average:58081.69 Median:37572.82 stddev:116083.68 (309.0%) stddev-sans-first:116328.80 07:33:59 INFO - PROCESS | 2167 | Values: 490.7 533.0 578.4 593.1 627.3 38434.0 38991.4 39004.4 39088.2 39133.2 42181.0 42878.0 42931.6 43010.6 43068.4 9462.4 9737.4 9746.0 9746.6 9750.8 9531.0 9676.3 9677.8 9682.0 9688.3 9646.2 9704.3 9711.5 9711.6 9716.4 9605.1 9686.4 9687.4 9689.7 9702.1 9650.5 9775.5 9789.1 9807.4 9811.0 38683.4 39173.2 39180.0 39202.8 39301.0 3209.8 3345.7 3345.9 3436.4 3612.0 24365.5 25473.5 30196.5 30229.2 30246.0 2493.4 2644.6 2823.8 2839.1 2843.7 398862.0 478045.6 478994.0 479821.0 485126.0 68055.7 68725.7 68731.7 68901.3 69004.7 72608.0 73903.0 73928.6 74025.0 74061.0 17590.9 17602.7 17779.1 17794.6 17821.6 13364.0 13426.9 13448.9 13456.8 13461.7 20648.7 21823.8 21831.2 21849.7 21879.9 7962.3 8193.7 8210.3 8302.8 8307.7 893.4 930.6 1002.4 1003.0 1038.7 26772.3 28255.3 28286.7 29287.6 29433.3 913.6 970.4 1066.2 1084.0 1134.5 12248.4 13762.7 13971.5 14260.7 14534.3 479701.0 522765.0 527909.0 528092.0 529968.0 53985.5 54113.7 54141.0 54200.0 54201.5 1341.7 1455.1 1469.5 1487.8 1492.9 21065.3 27826.3 28500.7 28504.7 28709.4 46461.3 46495.0 46909.5 46944.8 46961.1 292283.0 294512.0 294743.5 295234.0 296272.0 28459.9 31382.8 32082.5 32340.8 32922.5 40249.4 40821.6 40905.6 41025.8 41521.0 33776.2 34306.8 34368.0 35206.6 35217.8 33645.2 33761.3 34276.0 34396.8 34532.8 35545.5 35980.8 36326.5 36571.5 36711.6 31397.3 33415.0 34217.0 34247.8 34329.3 21315.7 22211.4 23009.0 23555.1 23943.0 07:33:59 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | [#2] jquery.html Cycles:180 Average:34468.49 Median:25443.92 stddev:101636.99 (399.5%) stddev-sans-first:101889.83 07:33:59 INFO - PROCESS | 2167 | Values: 352.4 357.4 359.2 364.1 367.5 18845.7 19599.2 20228.7 20593.5 21027.1 18667.4 20403.7 21059.0 21144.4 21151.4 5572.5 5734.3 5738.0 5781.2 5792.7 4143.2 4482.1 5704.0 6554.9 6561.6 6109.3 6229.8 6251.9 6259.2 6260.2 6020.8 6190.7 6417.2 6424.1 6430.8 5550.6 5563.3 5567.9 5584.6 5589.4 25231.7 25656.1 25917.5 25938.2 26079.6 1903.0 2071.6 2108.6 2180.4 2851.7 9604.0 9683.7 9803.6 9938.2 10145.8 1740.7 1761.9 1803.9 1810.8 1814.4 75166.0 112262.0 113270.3 113913.0 114001.4 10981.3 11266.3 11274.3 11295.4 11379.5 13450.3 13553.4 13555.7 13563.8 13579.5 7068.8 8526.0 8574.5 8750.7 8768.3 8797.0 8815.3 8829.6 8915.9 8955.3 4358.3 4461.5 4469.7 4498.8 4575.4 1839.4 1884.0 1887.9 1888.7 1892.1 894.5 932.0 1017.8 1028.9 1049.1 18059.9 18380.5 19813.4 20071.8 20252.0 813.5 944.0 975.2 998.6 1044.6 10612.7 10856.0 10857.3 10884.5 10889.6 597239.0 601053.0 619554.0 622716.0 629897.0 72831.0 94073.0 104273.5 112759.9 123191.4 995.2 1021.6 1025.6 1052.1 1101.4 18329.3 18848.2 18853.5 18949.7 19131.5 44073.3 53298.0 54721.7 55114.0 55412.4 77463.6 80081.4 80949.0 83781.1 83883.0 7964.5 8115.1 8200.8 8245.2 8491.8 13118.8 13405.7 13464.7 13842.1 13925.9 11218.4 11486.6 11574.6 11807.0 11820.9 11270.9 11345.8 11373.7 11585.6 11693.5 10163.6 11526.3 11785.6 11816.5 11904.5 7819.6 7935.6 8018.3 8180.5 8272.5 10936.2 11511.4 11516.0 11710.2 11880.7 07:33:59 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | [#3] mootools.html Cycles:180 Average:6016.03 Median:6163.78 stddev:3167.20 (51.4%) stddev-sans-first:3157.32 07:33:59 INFO - PROCESS | 2167 | Values: 1429.7 1562.8 1588.8 1880.5 2016.8 7955.8 8143.5 8147.9 8148.3 8154.9 8284.5 8461.2 8587.7 8588.9 8592.6 2445.1 2480.0 2481.1 2482.3 2484.7 2418.2 2489.0 2489.4 2491.3 2496.8 2437.6 2472.9 2487.8 2491.4 2494.5 2447.9 2481.9 2484.1 2485.6 2491.9 2437.9 2481.6 2483.6 2485.8 2491.3 8774.0 8842.5 8845.2 8846.2 8850.0 5357.5 5399.7 5487.0 5487.8 5532.8 3542.4 3579.2 3657.0 3667.7 3682.8 1017.3 1019.9 1039.3 1043.8 1053.7 11557.9 11601.2 11656.7 11676.3 11679.9 4543.7 4693.4 4785.8 4806.2 4817.0 9282.0 9358.6 9361.1 9365.3 9368.9 5404.8 5413.9 5414.9 5416.4 5418.4 4439.3 4594.8 4909.4 5016.8 5039.2 3773.9 3831.4 3834.3 3850.6 3892.9 1176.5 1187.7 1188.2 1199.3 1204.4 994.2 1027.1 1185.5 1278.4 1408.8 7920.6 8062.2 8116.4 8184.5 8185.6 610.0 623.6 624.5 625.9 778.0 6159.1 6182.5 6262.1 6315.4 6325.8 10434.4 10883.0 10898.6 10904.2 10919.5 10238.6 10528.8 10576.0 10672.4 10750.9 7087.6 8250.7 8283.2 8401.5 8415.2 7817.6 8020.4 8050.6 8062.1 8071.5 9141.1 9363.0 9522.0 9527.4 9624.8 9419.8 9823.6 9874.3 9948.2 9953.0 7923.4 8225.6 8227.1 8230.2 8239.7 8184.3 8238.6 8355.8 8364.0 8376.3 7393.3 7393.7 7563.1 7566.8 7603.3 7181.6 7246.9 7357.7 7437.2 7537.5 7807.2 7841.5 7850.2 7854.0 7864.4 6168.4 6627.3 6789.6 6963.0 7092.3 7187.4 7205.2 7230.2 7238.7 7240.2 07:33:59 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | [#4] prototype.html Cycles:180 Average:5562.53 Median:6371.38 stddev:1785.28 (28.0%) stddev-sans-first:1745.42 07:33:59 INFO - PROCESS | 2167 | Values: 263.6 321.4 326.1 331.5 337.9 6262.2 6370.1 6373.9 6400.0 6414.6 5072.9 6300.0 6319.5 6340.1 6349.5 3785.0 4602.0 4604.9 4635.6 4651.7 3828.0 4588.9 4655.7 4680.8 4687.5 4625.6 4630.9 4648.2 4653.8 4674.4 4668.1 4687.6 4694.8 4697.4 4708.1 3197.7 3900.2 3947.6 3957.5 3993.1 6009.5 6015.4 6047.1 6063.4 6082.8 5451.3 5482.8 5493.1 5500.1 5513.9 6683.8 6701.9 6740.7 6764.4 6767.4 4499.3 4504.6 4505.0 4507.3 4536.8 6795.5 7109.8 7127.4 7141.7 7170.4 3833.7 4155.6 4317.9 4604.1 4659.6 4697.8 4706.3 4709.9 4710.1 4747.1 4803.5 5501.0 5507.0 5524.8 5602.9 6768.1 6772.4 6792.3 6794.8 6809.0 1555.0 1616.3 1638.8 1644.6 1648.9 1070.5 1073.8 1080.4 1082.2 1091.0 6297.4 6365.1 6372.6 6384.0 6393.1 6822.2 6948.7 6949.5 7014.0 7029.1 6214.1 6427.8 6429.1 6450.3 6470.3 3007.2 3698.0 3722.4 3740.6 3742.3 7372.6 7376.7 7387.4 7396.6 7402.8 5826.7 6984.7 7290.0 7293.8 7343.5 7345.5 7387.6 7411.4 7424.4 7435.2 7054.1 7069.6 7076.1 7092.6 7118.9 6934.8 6945.9 6961.9 6976.2 6985.1 7159.0 7405.0 7407.3 7414.1 7453.8 4600.0 4642.8 4650.1 4652.6 4667.5 6987.1 6987.5 6989.7 7008.0 7018.5 6774.5 6780.2 6780.3 6783.4 6808.1 6518.5 6767.4 6768.4 6773.9 6781.7 6586.1 6612.6 6632.2 6634.7 6638.1 6784.6 6784.9 6794.3 6797.6 6809.9 6640.2 6660.5 6662.6 6668.0 6674.7 07:33:59 INFO - PROCESS | 2167 | 07:33:59 INFO - PROCESS | 2167 | [#5] yui.html Cycles:180 Average:17850.37 Median:3496.76 stddev:24616.79 (704.0%) stddev-sans-first:24651.94 07:33:59 INFO - PROCESS | 2167 | Values: 641.7 663.6 689.1 714.2 750.6 15082.6 15265.2 15283.2 15295.8 15301.1 13989.9 14095.4 14321.6 14385.1 14386.2 890.8 910.9 911.1 911.8 912.8 724.1 744.7 899.1 920.1 922.0 950.7 960.9 961.3 961.5 961.5 760.6 944.2 955.2 956.9 957.4 677.6 705.7 709.2 710.6 712.5 14871.0 14933.5 14935.6 14947.0 14948.6 12449.8 12495.8 12558.3 12770.9 12984.0 8220.5 9864.0 10035.6 10681.1 10843.2 3075.5 3543.3 3565.0 3569.1 3651.7 74995.0 76002.2 76742.0 76773.6 77202.1 9044.6 9218.4 9272.5 9478.7 9589.4 20573.7 21125.4 21131.9 21140.8 21241.7 6351.8 7334.1 7452.6 7508.0 7508.1 4094.9 4144.3 4150.9 4153.2 4176.2 3617.8 3672.4 3682.1 3683.2 3696.9 650.9 652.6 658.3 661.2 672.3 531.6 567.6 586.3 593.6 604.3 8020.4 8023.3 8127.7 8264.8 8291.3 505.3 577.9 580.1 599.4 607.5 3641.9 3818.7 3826.9 3859.4 3888.3 83002.2 83720.0 84051.2 84096.6 85757.0 72250.3 75628.0 78388.6 79163.0 79730.4 53596.7 67129.6 67988.0 68535.0 69664.3 7527.1 7860.6 7989.6 8230.3 8268.9 47448.3 48362.5 50201.0 50649.7 51348.5 69639.0 70295.6 70299.0 71499.0 71674.6 10879.5 10986.0 11023.4 11614.1 12074.5 12099.9 12208.1 12302.9 12482.8 12913.1 11365.4 11535.9 11615.5 11759.6 11781.3 11517.8 11535.9 11833.3 12008.0 12527.3 11067.9 11262.5 11432.5 11551.0 11566.7 9509.7 9534.4 9535.1 9682.0 10167.9 7193.3 8582.9 8720.7 8889.6 9300.3 07:33:59 INFO - PROCESS | 2167 | -------- Summary: end -------- 07:33:59 INFO - PROCESS | 2167 | 07:34:00 INFO - TEST-INFO | 2167: exit 0 07:34:00 INFO - TEST-OK | dromaeo_css | took 1113705ms 07:34:00 INFO - TEST-START | kraken 07:34:00 INFO - operating with platform_type : mac_ 07:34:00 INFO - Initialising browser for kraken test... 07:34:00 INFO - TEST-INFO | started process 2171 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmp9eBqN6/profile http://localhost:51474/getInfo.html) 07:34:02 INFO - PROCESS | 2171 | __metrics Screen width/height:1600/1200 07:34:02 INFO - PROCESS | 2171 | colorDepth:24 07:34:02 INFO - PROCESS | 2171 | Browser inner width/height: 1024/689 07:34:02 INFO - PROCESS | 2171 | __metrics 07:34:02 INFO - PROCESS | 2171 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:34:02 ERROR - PROCESS | 2171 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:34:03 INFO - TEST-INFO | 2171: exit 0 07:34:03 INFO - Browser initialized. 07:34:03 INFO - Running cycle 1/1 for kraken test... 07:34:03 INFO - TEST-INFO | started process 2174 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmp9eBqN6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:15 INFO - PROCESS | 2174 | RSS: Main: 243044352 07:34:15 INFO - PROCESS | 2174 | 07:34:17 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51474/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:18 INFO - PROCESS | 2174 | RSS: Main: 289157120 07:34:18 INFO - PROCESS | 2174 | 07:34:21 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51474/tests/kraken/driver.html?testName=audio-dft) 07:34:21 INFO - PROCESS | 2174 | RSS: Main: 300220416 07:34:21 INFO - PROCESS | 2174 | 07:34:25 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51474/tests/kraken/driver.html?testName=audio-fft) 07:34:25 INFO - PROCESS | 2174 | RSS: Main: 290148352 07:34:25 INFO - PROCESS | 2174 | 07:34:27 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51474/tests/kraken/driver.html?testName=audio-oscillator) 07:34:28 INFO - PROCESS | 2174 | RSS: Main: 290861056 07:34:28 INFO - PROCESS | 2174 | 07:34:30 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51474/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:31 INFO - PROCESS | 2174 | RSS: Main: 291201024 07:34:31 INFO - PROCESS | 2174 | 07:34:33 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51474/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:34 INFO - PROCESS | 2174 | RSS: Main: 290504704 07:34:34 INFO - PROCESS | 2174 | 07:34:37 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51474/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:37 INFO - PROCESS | 2174 | RSS: Main: 291328000 07:34:37 INFO - PROCESS | 2174 | 07:34:40 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51474/tests/kraken/driver.html?testName=json-parse-financial) 07:34:41 INFO - PROCESS | 2174 | RSS: Main: 292667392 07:34:41 INFO - PROCESS | 2174 | 07:34:42 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51474/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:43 INFO - PROCESS | 2174 | RSS: Main: 325160960 07:34:43 INFO - PROCESS | 2174 | 07:34:45 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51474/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:45 INFO - PROCESS | 2174 | RSS: Main: 325242880 07:34:45 INFO - PROCESS | 2174 | 07:34:48 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51474/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:48 INFO - PROCESS | 2174 | RSS: Main: 331055104 07:34:48 INFO - PROCESS | 2174 | 07:34:51 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:51 INFO - PROCESS | 2174 | RSS: Main: 332009472 07:34:51 INFO - PROCESS | 2174 | 07:34:54 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:54 INFO - PROCESS | 2174 | RSS: Main: 331849728 07:34:54 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | Cycle 1(1): loaded http://localhost:51474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51474/tests/kraken/driver.html?testName=ai-astar) 07:34:56 INFO - PROCESS | 2174 | RSS: Main: 393166848 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | __start_tp_report 07:34:56 INFO - PROCESS | 2174 | _x_x_mozilla_page_load 07:34:56 INFO - PROCESS | 2174 | _x_x_mozilla_page_load_details 07:34:56 INFO - PROCESS | 2174 | |i|pagename|runs| 07:34:56 INFO - PROCESS | 2174 | |0;ai-astar;112;109;112;111;112;112;119;112;110;112 07:34:56 INFO - PROCESS | 2174 | |1;audio-beat-detection;159;120;143;175;143;167;144;121;168;121 07:34:56 INFO - PROCESS | 2174 | |2;audio-dft;196;184;184;185;201;267;185;182;202;208 07:34:56 INFO - PROCESS | 2174 | |3;audio-fft;78;75;86;78;56;60;58;81;78;57 07:34:56 INFO - PROCESS | 2174 | |4;audio-oscillator;92;99;130;88;114;116;120;77;78;114 07:34:56 INFO - PROCESS | 2174 | |5;imaging-gaussian-blur;95;88;93;91;95;92;95;91;90;88 07:34:56 INFO - PROCESS | 2174 | |6;imaging-darkroom;95;109;146;97;95;96;95;97;95;96 07:34:56 INFO - PROCESS | 2174 | |7;imaging-desaturate;86;88;87;87;88;102;133;122;88;87 07:34:56 INFO - PROCESS | 2174 | |8;json-parse-financial;56;54;53;54;55;56;55;65;56;53 07:34:56 INFO - PROCESS | 2174 | |9;json-stringify-tinderbox;64;64;81;73;71;68;68;67;68;67 07:34:56 INFO - PROCESS | 2174 | |10;stanford-crypto-aes;81;82;82;84;82;82;84;81;83;84 07:34:56 INFO - PROCESS | 2174 | |11;stanford-crypto-ccm;147;132;118;133;118;117;120;120;129;119 07:34:56 INFO - PROCESS | 2174 | |12;stanford-crypto-pbkdf2;174;148;140;138;139;127;140;138;136;138 07:34:56 INFO - PROCESS | 2174 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;66;67;68;68;66 07:34:56 INFO - PROCESS | 2174 | __end_tp_report 07:34:56 INFO - PROCESS | 2174 | __start_cc_report 07:34:56 INFO - PROCESS | 2174 | _x_x_mozilla_cycle_collect,1210 07:34:56 INFO - PROCESS | 2174 | __end_cc_report 07:34:56 INFO - PROCESS | 2174 | __startTimestamp1457710496871__endTimestamp 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | ------- Summary: start ------- 07:34:56 INFO - PROCESS | 2174 | Number of tests: 14 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:2.64 (2.4%) stddev-sans-first:2.80 07:34:56 INFO - PROCESS | 2174 | Values: 112.0 109.0 112.0 111.0 112.0 112.0 119.0 112.0 110.0 112.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:151.50 stddev:20.77 (13.7%) stddev-sans-first:21.50 07:34:56 INFO - PROCESS | 2174 | Values: 159.0 120.0 143.0 175.0 143.0 167.0 144.0 121.0 168.0 121.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#2] audio-dft Cycles:10 Average:199.40 Median:198.50 stddev:25.51 (12.9%) stddev-sans-first:27.03 07:34:56 INFO - PROCESS | 2174 | Values: 196.0 184.0 184.0 185.0 201.0 267.0 185.0 182.0 202.0 208.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#3] audio-fft Cycles:10 Average:70.70 Median:78.00 stddev:11.54 (14.8%) stddev-sans-first:11.93 07:34:56 INFO - PROCESS | 2174 | Values: 78.0 75.0 86.0 78.0 56.0 60.0 58.0 81.0 78.0 57.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:77.50 stddev:18.53 (23.9%) stddev-sans-first:19.24 07:34:56 INFO - PROCESS | 2174 | Values: 92.0 99.0 130.0 88.0 114.0 116.0 120.0 77.0 78.0 114.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:92.50 stddev:2.70 (2.9%) stddev-sans-first:2.60 07:34:56 INFO - PROCESS | 2174 | Values: 95.0 88.0 93.0 91.0 95.0 92.0 95.0 91.0 90.0 88.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:95.50 stddev:16.00 (16.7%) stddev-sans-first:16.76 07:34:56 INFO - PROCESS | 2174 | Values: 95.0 109.0 146.0 97.0 95.0 96.0 95.0 97.0 95.0 96.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:87.00 stddev:17.03 (19.6%) stddev-sans-first:17.61 07:34:56 INFO - PROCESS | 2174 | Values: 86.0 88.0 87.0 87.0 88.0 102.0 133.0 122.0 88.0 87.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:3.47 (6.2%) stddev-sans-first:3.67 07:34:56 INFO - PROCESS | 2174 | Values: 56.0 54.0 53.0 54.0 55.0 56.0 55.0 65.0 56.0 53.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.00 stddev:5.00 (7.4%) stddev-sans-first:4.95 07:34:56 INFO - PROCESS | 2174 | Values: 64.0 64.0 81.0 73.0 71.0 68.0 68.0 67.0 68.0 67.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:1.18 (1.4%) stddev-sans-first:1.12 07:34:56 INFO - PROCESS | 2174 | Values: 81.0 82.0 82.0 84.0 82.0 82.0 84.0 81.0 83.0 84.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:124.50 stddev:9.78 (7.9%) stddev-sans-first:6.49 07:34:56 INFO - PROCESS | 2174 | Values: 147.0 132.0 118.0 133.0 118.0 117.0 120.0 120.0 129.0 119.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:139.50 stddev:12.41 (8.9%) stddev-sans-first:5.40 07:34:56 INFO - PROCESS | 2174 | Values: 174.0 148.0 140.0 138.0 139.0 127.0 140.0 138.0 136.0 138.0 07:34:56 INFO - PROCESS | 2174 | 07:34:56 INFO - PROCESS | 2174 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 07:34:56 INFO - PROCESS | 2174 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 67.0 68.0 68.0 66.0 07:34:56 INFO - PROCESS | 2174 | -------- Summary: end -------- 07:34:56 INFO - PROCESS | 2174 | 07:34:57 INFO - TEST-INFO | 2174: exit 0 07:34:57 INFO - TEST-OK | kraken | took 57250ms 07:34:57 INFO - SUITE-END | took 1170s 07:34:58 INFO - Completed test suite (00:19:31) 07:34:58 INFO - javascript benchmark 07:34:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3407.659234076593, 3414.6073201581826, 3436.3470940521315, 3440.2431465077675, 3478.8434520446594, 5613.971930140354, 5666.263385759846, 5680.971595142024, 5709.286339207599, 5724.198612194291, 5707.258056452666, 5736.741846616902, 5748.453896879801, 5818.563607729416, 5845.620034697742, 5102.336696229485, 5133.127368347371, 5160.8709782255555, 5171.250168725533, 5281.63028587999, 5259.579233661298, 5267.868303292429, 5289.2859463972445, 5310.7610157543, 5338.946610533903, 5110.693358398508, 5131.486851314876, 5185.611079169077, 5196.948030519684, 5201.791928322881, 5174.896502069975, 5195.9480405195845, 5234.555062819665, 5236.397814251333, 5262.973685131588, 5147.948520514784, 5171.81898633546, 5180.507851754077, 5183.896322073538, 5206.843794686166, 5486.725663716838, 5579.246801681762, 5661.34894487131, 5665.886682266331, 5667.4615911488345, 6110.908336374958, 6121.632702037892, 6123.510119190499, 6126.111713801519, 6134.355892631254, 6162.7226774795245, 6178.7219575119225, 6201.224846894138, 6203.565750397474, 6259.843503912393, 4692.859214223545, 4846.297286893416, 5687.800926967537, 5751.597388182829, 5768.990426675315, 6277.372262773777, 6281.057841323838, 6284.5600807943, 6298.244210694746, 6361.332060133712, 5997.610155339889, 6057.9095762762245, 6099.176611157525, 6114.844865410725, 6139.140520327158, 6240.157578726814, 6257.624542527463, 6261.592996455216, 6278.6546739929745, 6280.560360774702, 6027.306859711101, 6160.9383906161265, 6202.968985155046, 6232.127502149703, 6238.563300568917, 6010.429009244115, 6088.178095957078, 6127.494965205055, 6166.630002199882, 6173.351798061139, 4878.878028049327, 4879.878003049881, 4887.266909963463, 4903.705777653352, 4905.828296009622, 4316.525182229952, 4323.848665296762, 4331.935020974688, 4381.9342709859375, 4390.978045109754, 4738.384010078667, 5732.541396688255, 5735.512481439125, 5754.625949313281, 5778.508826749689, 6307.590006649553, 6307.873842523124, 6308.810735677937, 6311.463525600284, 6322.747090116436, 4991.975040124848, 5748.770049198069, 5770.711464426762, 5796.0436527972415, 5804.2744656917885, 4301.849435269751, 5247.1866860636665, 5338.306020217425, 5365.463453654604, 5374.623776335619, 6266.122742816009, 6289.874202516015, 6300.369963003846, 6308.558400912076, 6316.526260530479, 6224.813255602339, 6300.7479700811455, 6302.527310451643, 6322.747090116344, 6334.9366506334345, 6200.782972595937, 6229.345918678655, 6268.717907694256, 6278.811635650938, 6603.7688680895935, 6157.199564056644, 6164.7842325518395, 6197.845053873509, 6217.098520714561, 6223.875522489616, 6098.329183789869, 6148.262208535004, 6274.874502509833, 6306.590071645328, 6323.873522529431, 5944.762209511571, 5959.791407300723, 6056.06131049688, 6093.29927058394, 6129.601575897553, 5306.52241298285, 5929.911051334319, 6068.848278792889, 6114.694265286629, 6137.570370074052, 5795.7971471, 5959.463648271503, 5974.671393073423, 5980.461758441587, 5989.8203053908455, 6081.878362432815, 6113.728497863475, 6114.113453549122, 6140.565599444434, 6145.709401025656, 5897.823065308047, 5930.822075337746, 5951.16683664296, 5955.612885162451, 5977.0], "unit": "score", "name": "dojo.html", "value": 5663.333234174535}, {"lowerIsBetter": false, "replicates": [490.72764615638306, 532.9786808527659, 578.3580225949196, 593.0748033068411, 627.2942939193407, 38434.0, 38991.41512877309, 39004.41493377598, 39088.21823563531, 39133.21733565327, 42181.0, 42878.0, 42931.57068429315, 43010.56989430112, 43068.353974690406, 9462.43225406476, 9737.367071140354, 9746.025397460233, 9746.610135594603, 9750.804983900352, 9531.0, 9676.274279429035, 9677.75805604862, 9681.951590242039, 9688.273379496532, 9646.180074693659, 9704.320697551175, 9711.465869377182, 9711.562979665932, 9716.368436051669, 9605.135537801596, 9686.370385924893, 9687.370320929118, 9689.70930872075, 9702.126808587225, 9650.517474126336, 9775.462349570771, 9789.070038346346, 9807.362521436155, 9811.0, 38683.41974870379, 39173.21653566941, 39180.0, 39202.80398598017, 39301.0, 3209.8395080246128, 3345.6877691085892, 3345.8996230112893, 3436.381451338758, 3611.963880361215, 24365.512689746283, 25473.490530189476, 30196.54705179424, 30229.244268893235, 30246.0, 2493.376655836041, 2644.616530603071, 2823.830570165776, 2839.1198728394056, 2843.7440630343367, 398862.0, 478045.6097719524, 478994.0, 479821.0, 485126.0, 68055.65972170107, 68725.65637171782, 68731.65634171898, 68901.31098689049, 69004.6549767258, 72608.0, 73903.0, 73928.63035684895, 74025.0, 74061.0, 17590.856594321584, 17602.735958960628, 17779.111044447727, 17794.555136121442, 17821.554461138316, 13364.0, 13426.865731342757, 13448.93275533616, 13456.798148027592, 13461.730765384638, 20648.690269645966, 21823.781762182494, 21831.235906743186, 21849.67225491619, 21879.890600547213, 7962.283394494408, 8193.713220037389, 8210.3021243195, 8302.837602735623, 8307.667693292322, 893.4326702543931, 930.6044930904338, 1002.4035698759227, 1002.9560284536396, 1038.6987773545738, 26772.330691732863, 28255.273293288865, 28286.71713282841, 29287.56068658929, 29433.264168395963, 913.5980168725739, 970.3595626886221, 1066.184368957748, 1083.9566417343376, 1134.5405110930087, 12248.448819802952, 13762.724745505035, 13971.510997115052, 14260.714785704227, 14534.273286335641, 479701.0, 522765.0, 527909.0, 528092.0, 529968.0, 53985.46014539804, 54113.72943135259, 54141.0, 54200.0, 54201.45798541964, 1341.7316536692701, 1455.0905683947533, 1469.4783351909919, 1487.7842712806582, 1492.8954973151992, 21065.262715804874, 27826.304342391602, 28500.714992849807, 28504.714952850205, 28709.42581148407, 46461.3030804545, 46495.0, 46909.53090469052, 46944.76527617477, 46961.06077878355, 292283.0, 294512.0, 294743.52628236724, 295234.0, 296272.0, 28459.857700711364, 31382.84308578534, 32082.518762219053, 32340.83829580837, 32922.5061624071, 40249.39625905555, 40821.591784082964, 40905.59094409018, 41025.79487102546, 41521.0, 33776.15559611029, 34306.828465857514, 34368.0, 35206.64793352034, 35217.82391088028, 33645.15887102842, 33761.324773504886, 34275.971720848414, 34396.82801585976, 34532.82733586316, 35545.466817997236, 35980.820095899355, 36326.455103174005, 36571.451428228065, 36711.63288367082, 31397.30262009877, 33415.0, 34217.0, 34247.82876085703, 34329.31341373209, 21315.721056736646, 22211.444713882283, 23009.0, 23555.057797688587, 23943.0], "unit": "score", "name": "ext.html", "value": 19333.668051401528}, {"lowerIsBetter": false, "replicates": [352.39740044523865, 357.42989931059964, 359.2169071424295, 364.1297299454305, 367.52772687097087, 18845.680802343843, 19599.216031358745, 20228.69656955147, 20593.485162870937, 21027.053782579784, 18667.439976800684, 20403.693944590843, 21059.0, 21144.365669029914, 21151.365459036253, 5572.4706152915505, 5734.311882574097, 5738.0, 5781.248437703092, 5792.68140252286, 4143.192077544865, 4482.148391805563, 5703.9714801425935, 6554.8689026219445, 6561.573497722657, 6109.297430795449, 6229.750809967596, 6251.9374806252035, 6259.248890133191, 6260.217472815898, 6020.8494787630225, 6190.721417536199, 6417.197850268716, 6424.10062591233, 6430.839229019289, 5550.639208451437, 5563.304586926634, 5567.8886422271735, 5584.636998595119, 5589.413111623302, 25231.747682523124, 25656.102036428823, 25917.481650366888, 25938.22185334443, 26079.608805867927, 1902.9809701902943, 2071.637463443891, 2108.599366120432, 2180.4221881201493, 2851.70057144001, 9603.951980240125, 9683.709488715349, 9803.607855685765, 9938.15525680318, 10145.847812282822, 1740.6953783087909, 1761.867859910512, 1803.9098045097692, 1810.7646006019265, 1814.383109742694, 75166.0, 112262.0, 113270.30094548588, 113913.0, 114001.4299928495, 10981.341119532854, 11266.310053491878, 11274.267172633752, 11295.435228238555, 11379.487923043484, 13450.26023568713, 13553.39009744564, 13555.661108472366, 13563.796543051862, 13579.456821727217, 7068.7525936593, 8525.957370213233, 8574.528400938008, 8750.69372571957, 8768.254698350584, 8796.95601522001, 8815.294776417872, 8829.646814127364, 8915.910840891638, 8955.328350373748, 4358.3244597087505, 4461.531539188403, 4469.7318160910445, 4498.775061246924, 4575.405197324327, 1839.3562253211537, 1883.9529011774816, 1887.9339223127124, 1888.7450194223604, 1892.0917959379574, 894.4633220068038, 931.9627214911328, 1017.7760892603616, 1028.861103750999, 1049.0768124050787, 18059.91640501548, 18380.540486487676, 19813.405597832087, 20071.799282006992, 20252.0, 813.5322189740923, 943.9528023598792, 975.1759763000254, 998.610541888664, 1044.5926088825365, 10612.734681632866, 10856.0, 10857.34855908648, 10884.455777211107, 10889.618863339745, 597239.0, 601053.0, 619554.0, 622716.0, 629897.0, 72831.0, 94073.0, 104273.47863260635, 112759.87240127493, 123191.38404308101, 995.2038369304528, 1021.5556233038652, 1025.5743866295552, 1052.1004541117388, 1101.4107452513028, 18329.266829326676, 18848.24607015704, 18853.528661783566, 18949.71575426342, 19131.521711957314, 44073.338899917166, 53298.0, 54721.72639136938, 55114.0, 55412.445875540725, 77463.61268193848, 80081.39837203339, 80949.0, 83781.10845590278, 83883.0, 7964.522128672298, 8115.1479094694205, 8200.83598328042, 8245.216704413071, 8491.787705307417, 13118.803217951547, 13405.66485837862, 13464.730705385642, 13842.100263483244, 13925.930370348084, 11218.439078046229, 11486.597969071043, 11574.594889178838, 11807.0, 11820.940895295469, 11270.94364528172, 11345.773084538429, 11373.658790236306, 11585.594504192313, 11693.532258709556, 10163.593456261668, 11526.250793698382, 11785.646430607096, 11816.468258928197, 11904.464299106734, 7819.609019549113, 7935.563544005136, 8018.318442932183, 8180.46826956246, 8272.545010024265, 10936.249136049006, 11511.42442877836, 11516.0, 11710.180287379802, 11880.702982425508], "unit": "score", "name": "jquery.html", "value": 9509.878893646499}, {"lowerIsBetter": false, "replicates": [1429.6783223774657, 1562.7577725452554, 1588.7934568506093, 1880.4734674291194, 2016.7781544030145, 7955.801104972378, 8143.47067440616, 8147.91852081479, 8148.266656000967, 8154.91845081549, 8284.54435006076, 8461.153884611536, 8587.656493740244, 8588.91411085889, 8592.570371481417, 2445.1197568875236, 2480.0203919451897, 2481.1440053181623, 2482.342179322472, 2484.7018357797, 2418.22616762636, 2488.962665560018, 2489.3652118709792, 2491.277529516438, 2496.8127390445698, 2437.561238976992, 2472.863992480413, 2487.788537974265, 2491.389609545664, 2494.4761600064007, 2447.8776061197045, 2481.888315025828, 2484.1429706751233, 2485.6023036314105, 2491.9127830526027, 2437.902483900642, 2481.627755836621, 2483.615039668854, 2485.8135639827087, 2491.302435318114, 8773.956130219309, 8842.469451832847, 8845.203931646183, 8846.24806891415, 8850.02649708538, 5357.517823395913, 5399.730013499348, 5486.984907792032, 5487.780488780484, 5532.806351777709, 3542.397792375277, 3579.2483578448555, 3656.981715091434, 3667.651573100551, 3682.779033258013, 1017.3234798858824, 1019.8572199892021, 1039.3192458939407, 1043.7755882485303, 1053.6944286157004, 11557.901999310136, 11601.245919015322, 11656.708582285426, 11676.29942203462, 11679.883201167964, 4543.704659197141, 4693.366395536627, 4785.832495862628, 4806.206975849016, 4816.975915120472, 9282.025387334368, 9358.578863951003, 9361.06389361072, 9365.297602679826, 9368.906310936803, 5404.83785486436, 5413.945860541423, 5414.864628384322, 5416.350037995466, 5418.4039755626845, 4439.334099885043, 4594.793234304464, 4909.435414927258, 5016.799328026911, 5039.21892106724, 3773.8867833965023, 3831.425286207091, 3834.3481608126126, 3850.614938506127, 3892.8832135035996, 1176.4588289386977, 1187.6971372300009, 1188.1623455463878, 1199.2984104298907, 1204.4459548607738, 994.2145704893054, 1027.1474676018886, 1185.525789684116, 1278.4438769135456, 1408.845027047024, 7920.643571039317, 8062.234087761653, 8116.391270654724, 8184.549849758201, 8185.590720463953, 609.9847503812351, 623.6476390839161, 624.5347216323868, 625.8748250349948, 778.01581000035, 6159.1069294951985, 6182.474489668339, 6262.060690896402, 6315.400036996478, 6325.841853953688, 10434.373937563618, 10883.0, 10898.618548350929, 10904.182186336056, 10919.508622112024, 10238.641647542301, 10528.842067368996, 10576.0, 10672.359658420519, 10750.946245268724, 7087.645617719197, 8250.669973201006, 8283.17168283167, 8401.53791541471, 8415.242628163494, 7817.570033648204, 8020.398470114648, 8050.637721302438, 8062.072861620989, 8071.515709057476, 9141.085891410805, 9362.953185234303, 9521.952585215482, 9527.428354298765, 9624.807503850025, 9419.764505887408, 9823.607055717692, 9874.259430542594, 9948.204143668634, 9952.950235248778, 7923.445358825057, 8225.629846656795, 8227.053888802864, 8230.176982301722, 8239.711610093618, 8184.304334131665, 8238.629261683118, 8355.832883342178, 8363.95818020906, 8376.32989360862, 7393.260673932564, 7393.741219057307, 7563.054618172729, 7566.848663026599, 7603.2776886195725, 7181.640917954186, 7246.89129663066, 7357.705691772269, 7437.181909990005, 7537.472376933562, 7807.219278072147, 7841.451098423056, 7850.214978502104, 7853.960730196541, 7864.370850332074, 6168.444839964424, 6627.3372662733345, 6789.558678685869, 6963.0251764751965, 7092.326229008236, 7187.389071928945, 7205.207427183111, 7230.240824713329, 7238.746643867439, 7240.203577606354], "unit": "score", "name": "mootools.html", "value": 4841.676363262265}, {"lowerIsBetter": false, "replicates": [263.6190704432095, 321.4455065012853, 326.1064682769213, 331.4994358518636, 337.85472246933807, 6262.154609127772, 6370.108184854118, 6373.872522549546, 6400.0, 6414.583052101616, 5072.923906141411, 6299.968500157504, 6319.526035547329, 6340.144080549125, 6349.523785716066, 3784.981075094621, 4601.953980460203, 4604.917844306594, 4635.559621835937, 4651.674382793206, 3827.980860095696, 4588.931166032512, 4655.7439340836245, 4680.765961701902, 4687.484376718576, 4625.606823420013, 4630.930536041962, 4648.209804333254, 4653.8371157009515, 4674.415698037746, 4668.066386722652, 4687.554682305175, 4694.788734506921, 4697.3893393858925, 4708.058388322315, 3197.6642452542383, 3900.2004589059457, 3947.585503522146, 3957.5053118360206, 3993.1414745829497, 6009.45914867664, 6015.39846015395, 6047.0929360596265, 6063.393660633946, 6082.817515474543, 5451.2640793492765, 5482.835514934558, 5493.121100623921, 5500.119980803052, 5513.889722205574, 6683.832904177434, 6701.899471507932, 6740.662966851638, 6764.3573860483175, 6767.42476889465, 4499.3475945987975, 4504.6396288296855, 4504.954950450487, 4507.256302710049, 4536.7504787236685, 6795.524313298071, 7109.8222544436285, 7127.394171495429, 7141.67862446186, 7170.354668079845, 3833.674137698271, 4155.58444155582, 4317.935230971538, 4604.148232576984, 4659.627229821606, 4697.812087516461, 4706.294055891643, 4709.929351059737, 4710.081534100886, 4747.121782470254, 4803.543663351976, 5500.972495137578, 5506.972465137729, 5524.8342549723575, 5602.887942241132, 6768.120144381297, 6772.390484856288, 6792.286809884989, 6794.830129246809, 6808.9659551701925, 1554.9533513994597, 1616.272677295222, 1638.7787648667277, 1644.5888527868033, 1648.8928219665684, 1070.5022164693455, 1073.795978764048, 1080.357187473452, 1082.1721383141903, 1091.028984204059, 6297.370262973757, 6365.14070600463, 6372.649504277217, 6383.96808015957, 6393.073004414334, 6822.249552549216, 6948.687309071104, 6949.478789090737, 7014.0, 7029.0862187915245, 6214.130021796952, 6427.775027874096, 6429.1320671709655, 6450.322716114834, 6470.255920569195, 3007.1579957611903, 3697.9630203698157, 3722.3757251138422, 3740.588535261119, 3742.2702572998546, 7372.557646541225, 7376.668049937765, 7387.4090072795125, 7396.593187374639, 7402.777916662509, 5826.6795326256615, 6984.685689144001, 7289.963550182321, 7293.817654558572, 7343.522671026366, 7345.522541034922, 7387.630618469055, 7411.444141689502, 7424.443166762514, 7435.219301973323, 7054.118235220598, 7069.575825450283, 7076.115485564304, 7092.574445533284, 7118.85762284741, 6934.826629334307, 6945.930540694529, 6961.930380696128, 6976.162860456778, 6985.057017302599, 7159.0, 7405.0, 7407.296306850841, 7414.073240844895, 7453.776386708408, 4600.0, 4642.837500687459, 4650.116477869194, 4652.55800698933, 4667.486576476517, 6987.056747339044, 6987.545809522365, 6989.685464154024, 7008.0, 7018.543794653331, 6774.4580433564215, 6780.220274668476, 6780.321967803377, 6783.389494945479, 6808.148981377328, 6518.542151677334, 6767.390934815693, 6768.390844823989, 6773.89839152423, 6781.728730850711, 6586.110875032001, 6612.603243805387, 6632.1709786276715, 6634.734610615715, 6638.137042184485, 6784.626845523544, 6784.948333008391, 6794.286599907136, 6797.592144471348, 6809.93190068093, 6640.203175618956, 6660.533762636569, 6662.600243985376, 6668.0, 6674.666266686743], "unit": "score", "name": "prototype.html", "value": 4969.645914242536}, {"lowerIsBetter": false, "replicates": [641.7400952614192, 663.5819433756734, 689.0628744906929, 714.217931365155, 750.5759246025995, 15082.622934426645, 15265.160416177107, 15283.159426231552, 15295.770563441558, 15301.081935083888, 13989.880809535238, 14095.365708543115, 14321.641958951031, 14385.136891786475, 14386.208758518304, 890.7639475538971, 910.8633704944245, 911.0889110889111, 911.7994041310934, 912.8265629530368, 724.0587236592435, 744.709563270325, 899.0919171636662, 920.1166879795404, 921.9861702074475, 950.7432993091861, 960.8798900137483, 961.2886464016613, 961.4663861556833, 961.4759955824057, 760.6196901549225, 944.2398868910524, 955.1690029674158, 956.861255118011, 957.4446820843893, 677.6137601567109, 705.696550483292, 709.1525626875886, 710.6446776611695, 712.5439718580113, 14871.0, 14933.477328293458, 14935.626609334853, 14947.0, 14948.62628434287, 12449.75100497994, 12495.75008499825, 12558.309292988883, 12770.87229127706, 12984.0, 8220.465669731448, 9864.0, 10035.648752293635, 10681.145508359312, 10843.186760992878, 3075.492543730282, 3543.326767914088, 3565.0, 3569.125564236753, 3651.6713495785507, 74995.04656231414, 76002.23997760007, 76742.0, 76773.55490895997, 77202.06994825118, 9044.592993315317, 9218.354715170008, 9272.536373181314, 9478.715638530855, 9589.376690515093, 20573.69139462909, 21125.366239012856, 21131.8943405282, 21140.78859211388, 21241.68137477939, 6351.777687780998, 7334.119905611361, 7452.590107544137, 7508.0, 7508.061492313461, 4094.877153685394, 4144.316187828975, 4150.875473735793, 4153.190127925026, 4176.248275310412, 3617.8010209438735, 3672.412414013745, 3682.0978860179425, 3683.189698266377, 3696.9260614787554, 650.8828410886086, 652.6345246661884, 658.2561705273107, 661.1966460750116, 672.331030624522, 531.572084471996, 567.5629765080864, 586.3345103307691, 593.6319481921237, 604.305049193431, 8020.43856930021, 8023.277904988579, 8127.674893004332, 8264.793380165544, 8291.295239904555, 505.2522267044721, 577.9248697669276, 580.1211165084816, 599.3646734461485, 607.5443417436923, 3641.872534461334, 3818.6754125899056, 3826.8660596878976, 3859.3635226618, 3888.319544079775, 83002.16997829944, 83720.0, 84051.15948840433, 84096.57951710325, 85757.0, 72250.27749722435, 75628.0, 78388.60805695935, 79163.0, 79730.40539189184, 53596.732016339665, 67129.64351782392, 67988.0, 68535.0, 69664.30335696679, 7527.134379546423, 7860.641807457854, 7989.560574168477, 8230.300424463987, 8268.917310827055, 47448.33930812405, 48362.54912352635, 50201.0, 50649.74675126601, 51348.48651513587, 69639.0, 70295.64852175706, 70299.0, 71499.0, 71674.56650866849, 10879.456027198767, 10986.0, 11023.44882755875, 11614.12894032934, 12074.45664945062, 12099.879001209874, 12208.145429820182, 12302.938485307874, 12482.75034499323, 12913.096083274457, 11365.374904380338, 11535.884641153481, 11615.5353785851, 11759.588414405454, 11781.342127617118, 11517.827232591686, 11535.884641153816, 11833.349165795964, 12008.039356851255, 12527.310997895203, 11067.944660276647, 11262.493187806733, 11432.542698292307, 11551.018163455865, 11566.65300041, 9509.714708558755, 9534.378046037395, 9535.063445765602, 9681.951590242004, 10167.949160254151, 7193.3166349196745, 8582.914170858212, 8720.694775682821, 8889.555522223734, 9300.348975571645], "unit": "score", "name": "yui.html", "value": 6834.715688350893}], "name": "dromaeo_css", "value": 7452.00487374457}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 112.0, 111.0, 112.0, 112.0, 119.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 143.0, 175.0, 143.0, 167.0, 144.0, 121.0, 168.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [196.0, 184.0, 184.0, 185.0, 201.0, 267.0, 185.0, 182.0, 202.0, 208.0], "unit": "score", "name": "audio-dft", "value": 199.4}, {"lowerIsBetter": true, "replicates": [78.0, 75.0, 86.0, 78.0, 56.0, 60.0, 58.0, 81.0, 78.0, 57.0], "unit": "score", "name": "audio-fft", "value": 70.7}, {"lowerIsBetter": true, "replicates": [92.0, 99.0, 130.0, 88.0, 114.0, 116.0, 120.0, 77.0, 78.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [95.0, 88.0, 93.0, 91.0, 95.0, 92.0, 95.0, 91.0, 90.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.8}, {"lowerIsBetter": true, "replicates": [95.0, 109.0, 146.0, 97.0, 95.0, 96.0, 95.0, 97.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 102.1}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 87.0, 87.0, 88.0, 102.0, 133.0, 122.0, 88.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 53.0, 54.0, 55.0, 56.0, 55.0, 65.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 81.0, 73.0, 71.0, 68.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 84.0, 82.0, 82.0, 84.0, 81.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [147.0, 132.0, 118.0, 133.0, 118.0, 117.0, 120.0, 120.0, 129.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [174.0, 148.0, 140.0, 138.0, 139.0, 127.0, 140.0, 138.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 68.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1463.1}]} 07:34:58 INFO - Return code: 0 07:34:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:34:58 ERROR - # TBPL SUCCESS # 07:34:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:34:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:34:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:34:58 INFO - 2016-03-11 07:34:58.174 screenresolution[2178:18174] starting screenresolution argv=screenresolution get 07:34:58 INFO - 2016-03-11 07:34:58.177 screenresolution[2178:18174] Display 0: 1600x1200x32@60 07:34:58 INFO - 2016-03-11 07:34:58.183 screenresolution[2179:18178] starting screenresolution argv=screenresolution list 07:34:58 INFO - Available Modes on Display 0 07:34:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:34:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:34:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:34:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:34:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:34:58 INFO - Intel Iris: 07:34:58 INFO - Chipset Model: Intel Iris 07:34:58 INFO - Type: GPU 07:34:58 INFO - Bus: Built-In 07:34:58 INFO - VRAM (Dynamic, Max): 1536 MB 07:34:58 INFO - Vendor: Intel (0x8086) 07:34:58 INFO - Device ID: 0x0a2e 07:34:58 INFO - Revision ID: 0x0009 07:34:58 INFO - Displays: 07:34:58 INFO - Display: 07:34:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:34:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:34:58 INFO - Display Serial Number: 1600x1200 60 07:34:58 INFO - Main Display: Yes 07:34:58 INFO - Mirror: Off 07:34:58 INFO - Online: Yes 07:34:58 INFO - Rotation: Supported 07:34:58 INFO - Return code: 0 07:34:58 INFO - Running post-action listener: _resource_record_post_action 07:34:58 INFO - Running post-run listener: _resource_record_post_run 07:34:59 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 815616; Write bytes: 706383360; Read time: 12; Write time: 1992 07:34:59 INFO - install - Wall time: 36s; CPU: 54.0%; Read bytes: 386779648; Write bytes: 383655936; Read time: 31020; Write time: 783 07:34:59 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 815616; Write bytes: 300002816; Read time: 12; Write time: 1162 07:34:59 INFO - Running post-run listener: _upload_blobber_files 07:34:59 INFO - Blob upload gear active. 07:34:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:59 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 07:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:34:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:00 INFO - (blobuploader) - INFO - Done attempting. 07:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:01 INFO - (blobuploader) - INFO - Done attempting. 07:35:01 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:01 INFO - Return code: 0 07:35:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7cfafd680f758c3e0783799e974900f51e1ad3f6939aaff19717a91e52bc84b4caa42fc739c5c1587b0cdf6a30b3972d23ca8f4cefffbbd9176a7b4aa3e0fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/873bda7d311e33a24eabf364632a24bb678d59a5fad4d4281ee5c8c33b2a0091fcdbb28f8e808f978af73f77241d78468468afffd7a156ac419a2df1dc49afb1"} 07:35:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:01 INFO - Contents: 07:35:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7cfafd680f758c3e0783799e974900f51e1ad3f6939aaff19717a91e52bc84b4caa42fc739c5c1587b0cdf6a30b3972d23ca8f4cefffbbd9176a7b4aa3e0fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/873bda7d311e33a24eabf364632a24bb678d59a5fad4d4281ee5c8c33b2a0091fcdbb28f8e808f978af73f77241d78468468afffd7a156ac419a2df1dc49afb1"} 07:35:01 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:01 INFO - Copying logs to upload dir... 07:35:01 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.191169 ========= master_lag: 2.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-11 07:35:03.683600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-11 07:35:03.691046) ========= 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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7cfafd680f758c3e0783799e974900f51e1ad3f6939aaff19717a91e52bc84b4caa42fc739c5c1587b0cdf6a30b3972d23ca8f4cefffbbd9176a7b4aa3e0fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/873bda7d311e33a24eabf364632a24bb678d59a5fad4d4281ee5c8c33b2a0091fcdbb28f8e808f978af73f77241d78468468afffd7a156ac419a2df1dc49afb1"} build_url:https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011566 build_url: 'https://queue.taskcluster.net/v1/task/VeubB3ArSS-9RrlFIf4vAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7cfafd680f758c3e0783799e974900f51e1ad3f6939aaff19717a91e52bc84b4caa42fc739c5c1587b0cdf6a30b3972d23ca8f4cefffbbd9176a7b4aa3e0fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/873bda7d311e33a24eabf364632a24bb678d59a5fad4d4281ee5c8c33b2a0091fcdbb28f8e808f978af73f77241d78468468afffd7a156ac419a2df1dc49afb1"}' ========= master_lag: 1.00 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-11 07:35:04.704335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 17 secs) (at 2016-03-11 07:35:04.704715) ========= 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.3qc7kW6nkP/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.JMgqtz6jf9/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005505 ========= master_lag: 17.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 17 secs) (at 2016-03-11 07:35:21.776980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 07:35:21.777255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 07:35:21.915046) ========= ========= Total master_lag: 29.77 =========