builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0167 starttime: 1458034315.13 results: success (0) buildid: 20160315004033 builduid: 654778185861486cb435b5b3ee34af17 revision: c492b319e0c05798bc43e601ac0c406cfecb06b4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 02:31:55.134707) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 02:31:55.135160) ========= ========= Started set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-15 02:31:55.135447) ========= 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.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005651 basedir: '/builds/slave/test' ========= master_lag: 1.48 ========= ========= Finished set props: basedir (results: 0, elapsed: 1 secs) (at 2016-03-15 02:31:56.617414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 13 secs) (at 2016-03-15 02:31:56.617699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 13 secs) (at 2016-03-15 02:32:10.499025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:10.499277) ========= 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.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005247 ========= master_lag: 0.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:10.682034) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:10.682333) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:10.682745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:10.688060) ========= 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.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-15 02:32:10-- 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% 8.48M=0.001s 2016-03-15 02:32:10 (8.48 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175926 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:10.954210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:10.954494) ========= 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.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.020310 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:11.012058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 02:32:11.012395) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c492b319e0c05798bc43e601ac0c406cfecb06b4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c492b319e0c05798bc43e601ac0c406cfecb06b4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-15 02:32:11,095 truncating revision to first 12 chars 2016-03-15 02:32:11,095 Setting DEBUG logging. 2016-03-15 02:32:11,095 attempt 1/10 2016-03-15 02:32:11,095 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c492b319e0c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 02:32:11,713 unpacking tar archive at: fx-team-c492b319e0c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.866203 ========= master_lag: 1.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 02:32:12.950073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-15 02:32:12.950378) ========= echo c492b319e0c05798bc43e601ac0c406cfecb06b4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c492b319e0c05798bc43e601ac0c406cfecb06b4'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 c492b319e0c05798bc43e601ac0c406cfecb06b4 program finished with exit code 0 elapsedTime=0.005119 script_repo_revision: 'c492b319e0c05798bc43e601ac0c406cfecb06b4' ========= master_lag: 1.84 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-15 02:32:14.798809) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:14.799114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 02:32:14.870922) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-03-15 02:32:14.871179) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:32:15 INFO - MultiFileLogger online at 20160315 02:32:15 in /builds/slave/test 02:32:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:32:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:15 INFO - {'append_to_log': False, 02:32:15 INFO - 'base_work_dir': '/builds/slave/test', 02:32:15 INFO - 'blob_upload_branch': 'Fx-Team', 02:32:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:15 INFO - 'branch': 'Fx-Team', 02:32:15 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:15 INFO - 'config_files': ('talos/mac_config.py',), 02:32:15 INFO - 'default_actions': ('clobber', 02:32:15 INFO - 'read-buildbot-config', 02:32:15 INFO - 'download-and-extract', 02:32:15 INFO - 'populate-webroot', 02:32:15 INFO - 'create-virtualenv', 02:32:15 INFO - 'install', 02:32:15 INFO - 'run-tests'), 02:32:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:15 INFO - 'download_minidump_stackwalk': True, 02:32:15 INFO - 'download_symbols': 'ondemand', 02:32:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:15 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:15 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:15 INFO - 'installer_path': 'installer.exe', 02:32:15 INFO - 'log_level': 'info', 02:32:15 INFO - 'log_name': 'talos', 02:32:15 INFO - 'log_to_console': True, 02:32:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:32:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:32:15 INFO - 'opt_config_files': (), 02:32:15 INFO - 'pip_index': False, 02:32:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:32:15 INFO - 'cmd': ('bash', 02:32:15 INFO - '-c', 02:32:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:32:15 INFO - 'enabled': True, 02:32:15 INFO - 'halt_on_failure': False, 02:32:15 INFO - 'name': 'check_screen_resolution'},), 02:32:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:32:15 INFO - 'cmd': ('bash', 02:32:15 INFO - '-c', 02:32:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:32:15 INFO - 'enabled': True, 02:32:15 INFO - 'halt_on_failure': False, 02:32:15 INFO - 'name': 'check_screen_resolution'},), 02:32:15 INFO - 'run_cmd_checks_enabled': True, 02:32:15 INFO - 'sps_profile': False, 02:32:15 INFO - 'sps_profile_interval': 0, 02:32:15 INFO - 'suite': 'dromaeojs', 02:32:15 INFO - 'system_bits': '32', 02:32:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:15 INFO - 'title': 't-yosemite-r7-0167', 02:32:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:15 INFO - 'use_talos_json': True, 02:32:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:15 INFO - 'work_dir': 'build'} 02:32:15 INFO - ##### 02:32:15 INFO - ##### Running clobber step. 02:32:15 INFO - ##### 02:32:15 INFO - Running pre-action listener: _resource_record_pre_action 02:32:15 INFO - Running main action method: clobber 02:32:15 INFO - rmtree: /builds/slave/test/build 02:32:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:16 INFO - Running post-action listener: _resource_record_post_action 02:32:16 INFO - ##### 02:32:16 INFO - ##### Running read-buildbot-config step. 02:32:16 INFO - ##### 02:32:16 INFO - Running pre-action listener: _resource_record_pre_action 02:32:16 INFO - Running main action method: read_buildbot_config 02:32:16 INFO - Using buildbot properties: 02:32:16 INFO - { 02:32:16 INFO - "project": "", 02:32:16 INFO - "product": "firefox", 02:32:16 INFO - "script_repo_revision": "production", 02:32:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:32:16 INFO - "repository": "", 02:32:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:32:16 INFO - "buildid": "20160315004033", 02:32:16 INFO - "pgo_build": "False", 02:32:16 INFO - "basedir": "/builds/slave/test", 02:32:16 INFO - "buildnumber": 584, 02:32:16 INFO - "slavename": "t-yosemite-r7-0167", 02:32:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:32:16 INFO - "platform": "yosemite_r7", 02:32:16 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:32:16 INFO - "branch": "fx-team", 02:32:16 INFO - "repo_path": "integration/fx-team", 02:32:16 INFO - "revision": "c492b319e0c05798bc43e601ac0c406cfecb06b4", 02:32:16 INFO - "stage_platform": "macosx64", 02:32:16 INFO - "builduid": "654778185861486cb435b5b3ee34af17", 02:32:16 INFO - "slavebuilddir": "test" 02:32:16 INFO - } 02:32:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 02:32:16 INFO - Running post-action listener: _resource_record_post_action 02:32:16 INFO - ##### 02:32:16 INFO - ##### Running download-and-extract step. 02:32:16 INFO - ##### 02:32:16 INFO - Running pre-action listener: _resource_record_pre_action 02:32:16 INFO - Running main action method: download_and_extract 02:32:16 INFO - mkdir: /builds/slave/test/build/tests 02:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:32:16 INFO - https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:21 INFO - Downloaded 1199 bytes. 02:32:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 02:32:21 INFO - Using the following test package requirements: 02:32:21 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:32:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:32:21 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 02:32:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:32:21 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 02:32:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:32:21 INFO - u'jsshell-mac.zip'], 02:32:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:32:21 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 02:32:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:32:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:32:21 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 02:32:21 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:32:21 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 02:32:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:32:21 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 02:32:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:32:21 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 02:32:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:32:21 INFO - https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:32:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:32:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:32:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:23 INFO - Downloaded 17852509 bytes. 02:32:23 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'] 02:32:23 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 02:32:26 INFO - Return code: 0 02:32:26 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 02:32: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')]} 02:32:26 INFO - https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:32:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:32:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:32:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:27 INFO - Downloaded 17852509 bytes. 02:32:27 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'] 02:32:27 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 02:32:31 INFO - Return code: 0 02:32: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')]} 02:32:31 INFO - https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:32:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:32:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:32:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:32 INFO - Downloaded 10845263 bytes. 02:32:32 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'] 02:32:32 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 02:32:32 INFO - Return code: 0 02:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:32:32 INFO - https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:32:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:32:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:32:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 02:32:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aG6SZjAdQ1WnShE6twCN5Q/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 02:32:35 INFO - Downloaded 111239723 bytes. 02:32:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:32:35 INFO - mkdir: /builds/slave/test/properties 02:32:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:35 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:35 INFO - Contents: 02:32:35 INFO - build_url:https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:32:36 INFO - Running post-action listener: _resource_record_post_action 02:32:36 INFO - Running post-action listener: set_extra_try_arguments 02:32:36 INFO - ##### 02:32:36 INFO - ##### Running populate-webroot step. 02:32:36 INFO - ##### 02:32:36 INFO - Running pre-action listener: _resource_record_pre_action 02:32:36 INFO - Running main action method: populate_webroot 02:32:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:36 INFO - '--tppagecycles', 02:32:36 INFO - '7'], 02:32:36 INFO - 'tests': ['tsvgm']}}, 02:32:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:32:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:32:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:36 INFO - 'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:36 INFO - 'tests': ['damp', 'tps']}, 02:32:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:36 INFO - 'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['damp', 'tps']}, 02:32:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:32:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:36 INFO - 'other': {'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other_l64': {'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'other_nol64': {'tests': ['a11yr', 02:32:36 INFO - 'ts_paint', 02:32:36 INFO - 'tpaint', 02:32:36 INFO - 'sessionrestore', 02:32:36 INFO - 'sessionrestore_no_auto_restore', 02:32:36 INFO - 'tabpaint']}, 02:32:36 INFO - 'svgr': {'tests': ['tsvgx', 02:32:36 INFO - 'tsvgr_opacity', 02:32:36 INFO - 'tart', 02:32:36 INFO - 'tscrollx', 02:32:36 INFO - 'cart']}, 02:32:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['tsvgx', 02:32:36 INFO - 'tsvgr_opacity', 02:32:36 INFO - 'tart', 02:32:36 INFO - 'tscrollx', 02:32:36 INFO - 'cart']}, 02:32:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:36 INFO - 'tests': ['tp5o']}, 02:32:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:36 INFO - 'talos_options': ['--e10s'], 02:32:36 INFO - 'tests': ['tp5o']}, 02:32:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:36 INFO - 'talos_options': ['--xperf_path', 02:32:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:36 INFO - 'tests': ['tp5n']}, 02:32:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:36 INFO - 'talos_options': ['--e10s', 02:32:36 INFO - '--xperf_path', 02:32:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:36 INFO - 'tests': ['tp5n']}}, 02:32:36 INFO - 'talos.zip': {'path': '', 02:32:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:36 INFO - Running post-action listener: _resource_record_post_action 02:32:36 INFO - ##### 02:32:36 INFO - ##### Running create-virtualenv step. 02:32:36 INFO - ##### 02:32:36 INFO - Running pre-action listener: _resource_record_pre_action 02:32:36 INFO - Running main action method: create_virtualenv 02:32:36 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:36 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 02:32:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:36 INFO - Using real prefix '/tools/python27' 02:32:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:39 INFO - Installing pip.................done. 02:32:39 INFO - Return code: 0 02:32:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:39 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')]} 02:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:39 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')]} 02:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:39 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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:32:39 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 02:32:39 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 02:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:39 INFO - 'HOME': '/Users/cltbld', 02:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:39 INFO - 'LOGNAME': 'cltbld', 02:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:39 INFO - 'MOZ_NO_REMOTE': '1', 02:32:39 INFO - 'NO_EM_RESTART': '1', 02:32:39 INFO - 'PAGER': '/bin/cat', 02:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:39 INFO - 'PWD': '/builds/slave/test', 02:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:39 INFO - 'SHELL': '/bin/bash', 02:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:32:39 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:39 INFO - 'USER': 'cltbld', 02:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:39 INFO - 'XPC_FLAGS': '0x0', 02:32:39 INFO - 'XPC_SERVICE_NAME': '0', 02:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:40 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 02:32:40 INFO - Cleaning up... 02:32:40 INFO - Return code: 0 02:32:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:32:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:32:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:40 INFO - 'HOME': '/Users/cltbld', 02:32:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:40 INFO - 'LOGNAME': 'cltbld', 02:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:40 INFO - 'MOZ_NO_REMOTE': '1', 02:32:40 INFO - 'NO_EM_RESTART': '1', 02:32:40 INFO - 'PAGER': '/bin/cat', 02:32:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:40 INFO - 'PWD': '/builds/slave/test', 02:32:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:40 INFO - 'SHELL': '/bin/bash', 02:32:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:32:40 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:32:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:40 INFO - 'USER': 'cltbld', 02:32:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:40 INFO - 'XPC_FLAGS': '0x0', 02:32:40 INFO - 'XPC_SERVICE_NAME': '0', 02:32:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:40 INFO - Downloading/unpacking psutil>=0.7.1 02:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:43 INFO - Installing collected packages: psutil 02:32:43 INFO - Running setup.py install for psutil 02:32:43 INFO - building 'psutil._psutil_osx' extension 02:32:43 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 02:32:43 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 02:32:43 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 02:32:43 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 02:32:43 INFO - building 'psutil._psutil_posix' extension 02:32:43 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 02:32:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:32:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:32:44 INFO - ^ 02:32:44 INFO - 1 warning generated. 02:32:44 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 02:32:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:44 INFO - Successfully installed psutil 02:32:44 INFO - Cleaning up... 02:32:44 INFO - Return code: 0 02:32:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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', '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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:32: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:32: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 mozsystemmonitor==0.0.0 02:32:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:32:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:44 INFO - 'HOME': '/Users/cltbld', 02:32:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:44 INFO - 'LOGNAME': 'cltbld', 02:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:44 INFO - 'MOZ_NO_REMOTE': '1', 02:32:44 INFO - 'NO_EM_RESTART': '1', 02:32:44 INFO - 'PAGER': '/bin/cat', 02:32:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:44 INFO - 'PWD': '/builds/slave/test', 02:32:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:44 INFO - 'SHELL': '/bin/bash', 02:32:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:32:44 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:32:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:44 INFO - 'USER': 'cltbld', 02:32:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:44 INFO - 'XPC_FLAGS': '0x0', 02:32:44 INFO - 'XPC_SERVICE_NAME': '0', 02:32:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:32:46 INFO - Installing collected packages: mozsystemmonitor 02:32:46 INFO - Running setup.py install for mozsystemmonitor 02:32:47 INFO - Successfully installed mozsystemmonitor 02:32:47 INFO - Cleaning up... 02:32:47 INFO - Return code: 0 02:32:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32:47 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')]} 02:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:47 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')]} 02:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:47 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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:32:47 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 02:32:47 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 02:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:47 INFO - 'HOME': '/Users/cltbld', 02:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:47 INFO - 'LOGNAME': 'cltbld', 02:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:47 INFO - 'MOZ_NO_REMOTE': '1', 02:32:47 INFO - 'NO_EM_RESTART': '1', 02:32:47 INFO - 'PAGER': '/bin/cat', 02:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:47 INFO - 'PWD': '/builds/slave/test', 02:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:47 INFO - 'SHELL': '/bin/bash', 02:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:32:47 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:47 INFO - 'USER': 'cltbld', 02:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:47 INFO - 'XPC_FLAGS': '0x0', 02:32:47 INFO - 'XPC_SERVICE_NAME': '0', 02:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32:49 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 02:32:49 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 02:32:49 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 02:32:49 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 02:32:49 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 02:32:49 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 02:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32:50 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 02:32:50 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 02:32:50 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 02:32:50 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 02:32:50 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 02:32:50 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 02:32:51 INFO - Downloading docopt-0.6.1.tar.gz 02:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:51 INFO - Running setup.py install for blobuploader 02:32:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:51 INFO - Running setup.py install for requests 02:32:51 INFO - Running setup.py install for docopt 02:32:51 INFO - Successfully installed blobuploader requests docopt 02:32:51 INFO - Cleaning up... 02:32:52 INFO - Return code: 0 02:32:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:52 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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:32:52 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 02:32:52 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 02:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:52 INFO - 'HOME': '/Users/cltbld', 02:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:52 INFO - 'LOGNAME': 'cltbld', 02:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:52 INFO - 'MOZ_NO_REMOTE': '1', 02:32:52 INFO - 'NO_EM_RESTART': '1', 02:32:52 INFO - 'PAGER': '/bin/cat', 02:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:52 INFO - 'PWD': '/builds/slave/test', 02:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:52 INFO - 'SHELL': '/bin/bash', 02:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:32:52 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:52 INFO - 'USER': 'cltbld', 02:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:52 INFO - 'XPC_FLAGS': '0x0', 02:32:52 INFO - 'XPC_SERVICE_NAME': '0', 02:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:52 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-O_muuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:52 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-4DQbd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:52 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-4hRl7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:52 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-VO_J1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:52 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ghq99q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:52 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zYIshi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:52 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zwLb20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Okainb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-JQB8U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-UiRk9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-52N2kX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-jH92lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-_hAPWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9fjcyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7Sf78L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:53 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zFdeh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:54 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-SLrJQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:54 INFO - Running setup.py install for manifestparser 02:32:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:54 INFO - Running setup.py install for mozcrash 02:32:54 INFO - Running setup.py install for mozdebug 02:32:54 INFO - Running setup.py install for mozdevice 02:32:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:32:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:54 INFO - Running setup.py install for mozfile 02:32:54 INFO - Running setup.py install for mozhttpd 02:32:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:54 INFO - Running setup.py install for mozinfo 02:32:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:55 INFO - Running setup.py install for mozInstall 02:32:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:55 INFO - Running setup.py install for mozleak 02:32:55 INFO - Running setup.py install for mozlog 02:32:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:55 INFO - Running setup.py install for moznetwork 02:32:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:55 INFO - Running setup.py install for mozprocess 02:32:55 INFO - Running setup.py install for mozprofile 02:32:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:56 INFO - Running setup.py install for mozrunner 02:32:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:56 INFO - Running setup.py install for mozscreenshot 02:32:56 INFO - Running setup.py install for moztest 02:32:56 INFO - Running setup.py install for mozversion 02:32:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:56 INFO - Cleaning up... 02:32:56 INFO - Return code: 0 02:32:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:56 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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:32:56 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 02:32:56 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 02:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:32:56 INFO - 'HOME': '/Users/cltbld', 02:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:32:56 INFO - 'LOGNAME': 'cltbld', 02:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:56 INFO - 'MOZ_NO_REMOTE': '1', 02:32:56 INFO - 'NO_EM_RESTART': '1', 02:32:56 INFO - 'PAGER': '/bin/cat', 02:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:56 INFO - 'PWD': '/builds/slave/test', 02:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:32:56 INFO - 'SHELL': '/bin/bash', 02:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:32:56 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:32:56 INFO - 'USER': 'cltbld', 02:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:56 INFO - 'XPC_FLAGS': '0x0', 02:32:56 INFO - 'XPC_SERVICE_NAME': '0', 02:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:56 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-EAnh8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-FDPYYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-YBnIxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-mfFpub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-BNmrjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7z0CS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-6wfcWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uMxjyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-kjeQYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-qcq22c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:57 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)) 02:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:57 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-4czLbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:58 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)) 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-JvpnUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:58 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)) 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-7q3Gzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:58 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)) 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ir89DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:58 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)) 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ki0YoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:58 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)) 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-nfYPGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:58 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)) 02:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:58 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uWOVkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:58 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)) 02:32:58 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)) 02:32:58 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)) 02:32:58 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)) 02:32:58 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)) 02:32:58 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)) 02:32:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32:58 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 02:32:58 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 02:32:58 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 02:32:58 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 02:32:58 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 02:32:58 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 02:33:01 INFO - Downloading blessings-1.6.tar.gz 02:33:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:01 INFO - Installing collected packages: blessings 02:33:01 INFO - Running setup.py install for blessings 02:33:01 INFO - Successfully installed blessings 02:33:01 INFO - Cleaning up... 02:33:01 INFO - Return code: 0 02:33:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:01 INFO - Reading from file tmpfile_stdout 02:33:01 INFO - Current package versions: 02:33:01 INFO - blessings == 1.6 02:33:01 INFO - blobuploader == 1.2.4 02:33:01 INFO - docopt == 0.6.1 02:33:01 INFO - manifestparser == 1.1 02:33:01 INFO - mozInstall == 1.12 02:33:01 INFO - mozcrash == 0.17 02:33:01 INFO - mozdebug == 0.1 02:33:01 INFO - mozdevice == 0.48 02:33:01 INFO - mozfile == 1.2 02:33:01 INFO - mozhttpd == 0.7 02:33:01 INFO - mozinfo == 0.9 02:33:01 INFO - mozleak == 0.1 02:33:01 INFO - mozlog == 3.1 02:33:01 INFO - moznetwork == 0.27 02:33:01 INFO - mozprocess == 0.22 02:33:01 INFO - mozprofile == 0.28 02:33:01 INFO - mozrunner == 6.11 02:33:01 INFO - mozscreenshot == 0.1 02:33:01 INFO - mozsystemmonitor == 0.0 02:33:01 INFO - moztest == 0.7 02:33:01 INFO - mozversion == 1.4 02:33:01 INFO - psutil == 3.1.1 02:33:01 INFO - requests == 1.2.3 02:33:01 INFO - wsgiref == 0.1.2 02:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:01 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')]} 02:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:01 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')]} 02:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:01 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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:33:01 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 02:33:01 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 02:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:01 INFO - 'HOME': '/Users/cltbld', 02:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:01 INFO - 'LOGNAME': 'cltbld', 02:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:01 INFO - 'MOZ_NO_REMOTE': '1', 02:33:01 INFO - 'NO_EM_RESTART': '1', 02:33:01 INFO - 'PAGER': '/bin/cat', 02:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:01 INFO - 'PWD': '/builds/slave/test', 02:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:01 INFO - 'SHELL': '/bin/bash', 02:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:33:01 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:01 INFO - 'USER': 'cltbld', 02:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:01 INFO - 'XPC_FLAGS': '0x0', 02:33:01 INFO - 'XPC_SERVICE_NAME': '0', 02:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 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)) 02:33:01 INFO - Cleaning up... 02:33:01 INFO - Return code: 0 02:33:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:01 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')]} 02:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:01 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')]} 02:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:01 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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:33:01 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 02:33:01 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 02:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:01 INFO - 'HOME': '/Users/cltbld', 02:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:01 INFO - 'LOGNAME': 'cltbld', 02:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:01 INFO - 'MOZ_NO_REMOTE': '1', 02:33:01 INFO - 'NO_EM_RESTART': '1', 02:33:01 INFO - 'PAGER': '/bin/cat', 02:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:01 INFO - 'PWD': '/builds/slave/test', 02:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:01 INFO - 'SHELL': '/bin/bash', 02:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:33:01 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:01 INFO - 'USER': 'cltbld', 02:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:01 INFO - 'XPC_FLAGS': '0x0', 02:33:01 INFO - 'XPC_SERVICE_NAME': '0', 02:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:02 INFO - Downloading/unpacking jsonschema 02:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:04 INFO - Downloading/unpacking functools32 (from jsonschema) 02:33:04 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 02:33:04 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 02:33:04 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 02:33:04 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 02:33:04 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 02:33:04 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 02:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:05 INFO - warning: no files found matching '*.txt' 02:33:05 INFO - no previously-included directories found matching 'build' 02:33:05 INFO - no previously-included directories found matching 'dist' 02:33:05 INFO - no previously-included directories found matching '.git*' 02:33:05 INFO - Installing collected packages: jsonschema, functools32 02:33:05 INFO - Running setup.py install for functools32 02:33:05 INFO - warning: no files found matching '*.txt' 02:33:05 INFO - no previously-included directories found matching 'build' 02:33:05 INFO - no previously-included directories found matching 'dist' 02:33:05 INFO - no previously-included directories found matching '.git*' 02:33:05 INFO - Successfully installed jsonschema functools32 02:33:05 INFO - Cleaning up... 02:33:05 INFO - Return code: 0 02:33:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:33:05 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')]} 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 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')]} 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 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 0x107142a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10714a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab30cb78b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, '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.A66NPDuPBY/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.UL9wOgSgtl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 02:33:05 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 02:33:05 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 02:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:05 INFO - 'HOME': '/Users/cltbld', 02:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:05 INFO - 'LOGNAME': 'cltbld', 02:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:05 INFO - 'MOZ_NO_REMOTE': '1', 02:33:05 INFO - 'NO_EM_RESTART': '1', 02:33:05 INFO - 'PAGER': '/bin/cat', 02:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:05 INFO - 'PWD': '/builds/slave/test', 02:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:05 INFO - 'SHELL': '/bin/bash', 02:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:33:05 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:05 INFO - 'USER': 'cltbld', 02:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:05 INFO - 'XPC_FLAGS': '0x0', 02:33:05 INFO - 'XPC_SERVICE_NAME': '0', 02:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:05 INFO - Downloading/unpacking flake8 02:33:05 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 02:33:05 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 02:33:05 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 02:33:05 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 02:33:05 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 02:33:05 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 02:33:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:33:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:33:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:08 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 02:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:33:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:09 INFO - no previously-included directories found matching 'docs/_build' 02:33:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:33:09 INFO - Running setup.py install for pep8 02:33:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:09 INFO - no previously-included directories found matching 'docs/_build' 02:33:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:33:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:33:09 INFO - Cleaning up... 02:33:09 INFO - Return code: 0 02:33:09 INFO - Running post-action listener: _resource_record_post_action 02:33:09 INFO - Running post-action listener: _start_resource_monitoring 02:33:09 INFO - Starting resource monitoring. 02:33:09 INFO - ##### 02:33:09 INFO - ##### Running install step. 02:33:09 INFO - ##### 02:33:09 INFO - Running pre-action listener: _resource_record_pre_action 02:33:09 INFO - Running main action method: install 02:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:09 INFO - Reading from file tmpfile_stdout 02:33:09 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:09 INFO - Reading from file tmpfile_stdout 02:33:09 INFO - Output received: 02:33:09 INFO - Usage: mozinstall [options] installer 02:33:09 INFO - Options: 02:33:09 INFO - -h, --help show this help message and exit 02:33:09 INFO - -d DEST, --destination=DEST 02:33:09 INFO - Directory to install application into. [default: 02:33:09 INFO - "/builds/slave/test"] 02:33:09 INFO - --app=APP Application being installed. [default: firefox] 02:33:09 INFO - mkdir: /builds/slave/test/build/application 02:33:09 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'] 02:33:09 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 02:33:44 INFO - Reading from file tmpfile_stdout 02:33:44 INFO - Output received: 02:33:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:33:44 INFO - Running post-action listener: _resource_record_post_action 02:33:44 INFO - ##### 02:33:44 INFO - ##### Running run-tests step. 02:33:44 INFO - ##### 02:33:44 INFO - Running pre-action listener: _resource_record_pre_action 02:33:44 INFO - Running main action method: run_tests 02:33:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:33:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:33:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:33:44 INFO - 2016-03-15 02:33:44.174 screenresolution[1952:22698] starting screenresolution argv=screenresolution get 02:33:44 INFO - 2016-03-15 02:33:44.177 screenresolution[1952:22698] Display 0: 1600x1200x32@60 02:33:44 INFO - 2016-03-15 02:33:44.183 screenresolution[1953:22700] starting screenresolution argv=screenresolution list 02:33:44 INFO - Available Modes on Display 0 02:33:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:33:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:33:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:33:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:33:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:33:44 INFO - Intel Iris: 02:33:44 INFO - Chipset Model: Intel Iris 02:33:44 INFO - Type: GPU 02:33:44 INFO - Bus: Built-In 02:33:44 INFO - VRAM (Dynamic, Max): 1536 MB 02:33:44 INFO - Vendor: Intel (0x8086) 02:33:44 INFO - Device ID: 0x0a2e 02:33:44 INFO - Revision ID: 0x0009 02:33:44 INFO - Displays: 02:33:44 INFO - Display: 02:33:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:33:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:33:44 INFO - Display Serial Number: 1600x1200 60 02:33:44 INFO - Main Display: Yes 02:33:44 INFO - Mirror: Off 02:33:44 INFO - Online: Yes 02:33:44 INFO - Rotation: Supported 02:33:44 INFO - Return code: 0 02:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:44 INFO - Python 2.7.3 02:33:44 INFO - Return code: 0 02:33:44 INFO - grabbing minidump binary from tooltool 02:33: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')]} 02:33:44 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 0x106fe6d30>, '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 0x106e0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fddb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:44 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 02:33:44 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 02:33:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:44 INFO - Return code: 0 02:33:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:33:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:33:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:33:45 INFO - Return code: 0 02:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 02:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 02:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A66NPDuPBY/Render', 02:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:33:45 INFO - 'HOME': '/Users/cltbld', 02:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:33:45 INFO - 'LOGNAME': 'cltbld', 02:33:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:45 INFO - 'MOZ_NO_REMOTE': '1', 02:33:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:45 INFO - 'NO_EM_RESTART': '1', 02:33:45 INFO - 'PAGER': '/bin/cat', 02:33:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:45 INFO - 'PWD': '/builds/slave/test', 02:33:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:33:45 INFO - 'SHELL': '/bin/bash', 02:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UL9wOgSgtl/Listeners', 02:33:45 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 02:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:33:45 INFO - 'USER': 'cltbld', 02:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:45 INFO - 'XPC_FLAGS': '0x0', 02:33:45 INFO - 'XPC_SERVICE_NAME': '0', 02:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:33:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 02:33:45 INFO - mozversion application_buildid: 20160315004033 02:33:45 INFO - mozversion application_changeset: c492b319e0c05798bc43e601ac0c406cfecb06b4 02:33:45 INFO - mozversion application_display_name: Nightly 02:33:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:45 INFO - mozversion application_name: Firefox 02:33:45 INFO - mozversion application_remotingname: firefox 02:33:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:33:45 INFO - mozversion application_vendor: Mozilla 02:33:45 INFO - mozversion application_version: 48.0a1 02:33:45 INFO - mozversion platform_buildid: 20160315004033 02:33:45 INFO - mozversion platform_changeset: c492b319e0c05798bc43e601ac0c406cfecb06b4 02:33:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:33:45 INFO - mozversion platform_version: 48.0a1 02:33:45 INFO - using testdate: 1458034425 02:33:45 INFO - actual date: 1458034425 02:33:45 INFO - starting webserver on 'localhost:51737' 02:33:45 INFO - SUITE-START | Running 2 tests 02:33:45 INFO - TEST-START | dromaeo_css 02:33:45 INFO - operating with platform_type : mac_ 02:33:45 INFO - Initialising browser for dromaeo_css test... 02:33:45 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpWNhRWf/profile http://localhost:51737/getInfo.html) 02:33:48 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 02:33:48 INFO - PROCESS | 1971 | colorDepth:24 02:33:48 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 02:33:48 INFO - PROCESS | 1971 | __metrics 02:33:48 INFO - PROCESS | 1971 | 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" 02:33:48 ERROR - PROCESS | 1971 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:33:48 INFO - TEST-INFO | 1971: exit 0 02:33:48 INFO - Browser initialized. 02:33:48 INFO - Running cycle 1/1 for dromaeo_css test... 02:33:48 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpWNhRWf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:34:00 INFO - PROCESS | 1974 | RSS: Main: 241410048 02:34:00 INFO - PROCESS | 1974 | 02:34:51 INFO - PROCESS | 1974 | 1458034491806 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] 02:37:02 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:51737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51737/tests/dromaeo/cssquery-ext.html) 02:37:04 INFO - PROCESS | 1974 | RSS: Main: 433635328 02:37:04 INFO - PROCESS | 1974 | 02:40:07 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:51737/tests/dromaeo/cssquery-ext.html (next: http://localhost:51737/tests/dromaeo/cssquery-jquery.html) 02:40:07 INFO - PROCESS | 1974 | RSS: Main: 371470336 02:40:07 INFO - PROCESS | 1974 | 02:43:09 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:51737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51737/tests/dromaeo/cssquery-mootools.html) 02:43:10 INFO - PROCESS | 1974 | RSS: Main: 374886400 02:43:10 INFO - PROCESS | 1974 | 02:46:12 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:51737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51737/tests/dromaeo/cssquery-prototype.html) 02:46:13 INFO - PROCESS | 1974 | RSS: Main: 330817536 02:46:13 INFO - PROCESS | 1974 | 02:49:16 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:51737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51737/tests/dromaeo/cssquery-yui.html) 02:49:16 INFO - PROCESS | 1974 | RSS: Main: 333357056 02:49:16 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:51737/tests/dromaeo/cssquery-yui.html (next: http://localhost:51737/tests/dromaeo/cssquery-dojo.html) 02:52:19 INFO - PROCESS | 1974 | RSS: Main: 424628224 02:52:19 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | __start_tp_report 02:52:19 INFO - PROCESS | 1974 | _x_x_mozilla_page_load 02:52:19 INFO - PROCESS | 1974 | _x_x_mozilla_page_load_details 02:52:19 INFO - PROCESS | 1974 | |i|pagename|runs| 02:52:19 INFO - PROCESS | 1974 | |0;dojo.html;3215.6302025267096;3510.56117985252;3524.0308915048377;3537.4693795930616;3583.7312201584887;4755;5662.801801936933;5704.458076482738;5722.055860782976;5722.656640601562;5734.4265573442635;5813.33146688131;5824.621399609023;5840.182374467568;5912.054071348585;5195.220716892478;5234.58123350133;5255.76349064293;5265.921011184835;5294.735263236832;5194.27280180775;5286.973565132188;5307.761150748206;5377.865553361158;5391.083515802323;5120.974395128038;5287.841364759063;5288.23320618512;5350.678959262456;5385.380681221651;5200.141976573861;5239.528442440199;5242.18746094356;5246.632735708502;5248.291480650101;5169.922451163236;5220.817271395521;5221.843344699665;5224.0074385866565;5244.5279924806955;5592.720363981784;5605.047141985872;5607.299087614048;5629.324481062258;5643.68959707216;6145.924463218918;6229.314775374705;6268.968655156741;6277.52918531112;6286.779962701329;6229.96885015572;6306.180196574462;6313.3686631336495;6336.873262534724;6338.904916426257;5715.828525144252;5746.080627099685;5805.7387417566315;5808.099744539603;5827.300723913115;6148.862460444832;6258.843528911722;6274.090256912813;6291.056341548804;6300.621962682254;6156.630602163885;6181.876362472815;6186.412290832363;6186.938130618636;6197.03945888388;6097.645669838137;6191.071339299051;6264.843378915563;6280.780172694025;6285;6097.585173720644;6125.571219981412;6140.969295153585;6145.938540614626;6151.323354431009;6147.72335244915;6160.291566469824;6170.938290617126;6172.660503672251;6179.69101544921;4799.592034677022;4818.927716084261;4820.8794780130775;4885.096257192431;4888.6577939543895;4332.588404101605;4338.674599405057;4339.913201735948;4371.0820727646915;4380.518143004267;5603.8879222416135;5634.605577609528;5642.520385767174;5649.378568357477;5655.632383895034;6109.860177052684;6210.968945155245;6229.626222426669;6238.282597501255;6271.310155882849;4861.7326047067045;5693.800716974886;5719.628224165416;5726.685032323262;5736.770529178786;5306.52241298285;5323.680579165185;5338.386085600128;5349.304590403301;5356.785728570813;6195.721192546346;6234.9688251558455;6300.527460440485;6300.653464059521;6306.085617585332;6274.435300822948;6288.151099601495;6296.307406185224;6300.495960323072;6305.684715764285;6274.623522588659;6289.622622642656;6291.150694656163;6291.968540157453;6298.212723409574;6021.42796434338;6108.554560543837;6114.358196334042;6144.539159562962;6176.104464852661;6169.383061693795;6202.782902598387;6264.5301602379095;6280.340564240872;6295.496360291258;6099.817005489843;6116.396640261158;6124.29570599369;6130.765048853685;6144.446999770043;6021.066734656135;6085.087236914498;6094.146819445193;6100.75596976116;6123.357047509948;5752.626079304831;5890.057590785454;5904.911426328695;5934.881302374015;5935.258092738408;6098.474884983619;6112.724927378367;6117.188044311166;6118.432525348006;6122.021314812626;5775.8556036099435;5841.883162336644;5894.793682221101;5950.3454619992635;5983.880322393441 02:52:19 INFO - PROCESS | 1974 | |1;ext.html;490.448245723561;540.4354587869361;546.7402983582801;624.9844003494321;639.7121295417062;39026;39628;39699.00752481186;39707.80146099273;39745.602543974586;42544;43125.7843710781;43239.35140972888;43277.78361108198;43366;9462.858057129148;9658.985806490287;9672.709818705414;9687;9694.127528522431;9589.37669051513;9743.610255589803;9751.463669498175;9769.120779129877;9770.218382529381;9866.309358344919;9959;9979.251556133282;9979.251556133282;10002.299839011272;9831.31180817343;9932.304738668225;9937.35407198537;9939;9951.104400603908;9630.133288004114;9762.072603102764;9778.217742580577;9780.41317520944;9786.412815231039;41929.95175120616;42339;42355;42450.57549424497;42486;3195.680431956809;3247.594050743657;3308.586426696663;3339.231976645361;3647.4164133738473;29339.413211735646;29344.972925947703;29967.250818729488;30612.846935765403;31026.844865775525;2737.137801592512;2748.8350698958125;2765.0737003103986;2868.7991840570958;2913.6066631004755;422893;500521.9947800512;501073;502748;502794;62132;62497.37502625006;62857;62960.68519657372;63034;72617;74008;74021.25978740143;74039;74239.25760742431;17066;17329.7400538992;17366.56583585395;17387.913060434617;17390.391336303168;13176.670583235496;13220.537281195113;13248.271345076113;13255.072144949954;13256.469741210436;21498.892505537373;21802.672959905613;21864.45338866541;21864.562708745736;21876.562468750537;8266.512027834928;8920.955395223113;9683.951580242194;9685.046060951478;9703.417794932186;984.8128855517572;1001.2040427859869;1102.8556437201958;1124.7019539821954;1129.390129330169;24674.50650987006;27954.86022569874;28942.710572894;29035.854820725763;29564.408711825643;973.5473005052685;1089.7765957978595;1151.5624062856061;1158.8551431071116;1191.7854786138578;12265.202761820632;14806;14880.925595371953;14929.70140597182;15227.619309517351;520821;525831;526257;526671;527719;57659.4234057654;59530.70234648799;59588.70205648944;59662.70168649216;59740.999999999134;1332.5269529317147;1361.6800051987775;1459.0953608762422;1468.302556285777;1497.8127734033246;29877.5518367229;30422.922885757;31429.842850786514;31557.526637100003;31853.681463186;42474.78762606167;50288.748556256985;50782.74608627081;50788.23817642812;51179.97640047104;477086;488596.3421097373;489114;489236;489691;34332.82833585816;34342;34994.82502587471;35034.12414689653;35047.47428788519;45382.54617453915;45451.545484546055;45595.31607025831;46232.53767462282;46768.53231467642;31713.841430792698;37588.06029849166;37689.43465847959;38236.617633823305;38545;36855.26289474142;36919.8154009239;37450.43824342582;37543.9315692378;37824.62175378321;36898.8155059223;37110.886673399844;37257.813710931274;37883.62116378801;38205.85382438531;29689.703102968695;32481.350372991936;32532.51201231936;32701.18247043843;32744.40751946866;24792;24889.751102489467;24927.875360623082;25107.748922511273;25225.369365766004 02:52:19 INFO - PROCESS | 1974 | |2;jquery.html;358.59478788968465;360.50610663391143;361.701596183149;370.4942753141962;371.92189640175565;15747.606309842246;16412.34350625975;20243.49391265217;20717.482062948435;20759.481012974684;19439.222431102775;19625.31311404101;20456.079476423558;20464.89767551164;20489.07799149038;5805.825825225239;5908.1433192187105;5918.408159184069;5967.910481342762;6048.879022419549;4216.198922204787;4399.05420334628;5885.881682480315;6211.6273023618505;6498.317676643956;6398.13625160602;6412.358764123597;6425.518086143535;6429.035644653292;6431.42117209451;6162.876742465148;6492.35076492347;6518.413342799147;6529.673516324188;6530.706118224643;3716.201016781378;5253.448387919251;5473.67157970523;5473.890522189574;5547.223388725582;12797.296148711817;13334.733305333935;13375.732485350238;25387.365315867068;25508.489830203293;2111.250506070354;2262.4343914021497;2315.4095705594964;2433.3065076453304;2702.162329677806;9509.809803803884;9683.564239609235;9787;9971.601135954554;10131.037551432602;1660.4603503861294;1688.5609741467183;1741.303478608554;1760.6390689908537;1768.4075834595426;99643.50178249135;103978;107568.38647420295;107625;107899.46050269698;9382.48396338208;11261.887381126247;11268.985791278661;11270.661880143609;11290.774184516264;13624.86375136236;13632.795508067387;13657;13679.110857794212;13696.246706431242;8413.663453461915;8619.569021548898;8633.223009929137;8707.47755134694;8723.040465548911;8767.912320876838;8776.648934042567;8786.648534058566;8875;8879.023307436177;4397.164538737694;4466;4479.507254202035;4510.548945105529;4537.319402089713;1518.3774652392467;1722;1793.5561872692608;1800.4598620414085;1842.1986435900426;956.4213650741341;974.2985050763439;977.2182254196614;996.865423167863;1009.2279406254221;18882.811171888105;19095.80904190968;19272.518187045436;19431.514212144808;19517.51206219856;770.6493545436813;925.4632313258294;938.877945867033;961.7451375385529;1027.814993301198;10194.949025254826;10537.789244215073;10551.788964220672;10576.682699519026;10775.353478791141;439614;439982.8000860039;443838;446447;638637.8068109723;73480.63259683775;99865.50067249617;111803;119393.40303298428;124679.01283948541;981.7300242433388;1015.329882277708;1015.8374660054355;1019.8521214423866;1046.3617193512105;16010.359585616445;16392.5082247528;17724.291028358723;17900.41452329831;18001.729974050137;50652.24021639604;50809;50836.74581627068;51074.233886492475;53730.92538149137;73344;74816.62591687006;74989;74989.62505187439;76902;7370.557766534025;7466.850662986819;7501.962490187514;7582.962085189539;7794.493357931717;11603.593874214363;11766;12031.518739250332;12074.637760867188;12098.576549820715;9920.908700042844;10064.798704025732;10110.595576176871;10394.324368915995;10468.895311047097;8998.86501702488;10030.749231269278;10106.39892102491;10407.739806504595;10409.531571079167;10286.228532860216;10312.587496500057;10651.467426628793;10739.08717758968;10855.565777368816;7422;7427.145878224073;7539.547627142389;7559.20628334017;7656.349210317186;8015.599220039091;9336.346455748033;10027.448490333101;10238.436885971343;10625.25623206368 02:52:19 INFO - PROCESS | 1974 | |3;mootools.html;1274.770541302565;1603.5269595469338;1621.2056092514667;1922.7212054252134;2065.1636087384613;7995.200479952009;8653.653853845846;8838.469691818495;8838.734837954855;8853.778655533606;7238.384737297336;7458.515196512223;8765.16730910564;8789.121087891208;8807.559622018905;2176.804087632113;2419.129113519132;2459.0409740201335;2484.5776218042975;2486.0677246032737;2489.439876027888;2497.3756560859783;2498.2255500794813;2499.0378704198833;2505.348609361561;2415.698037745282;2459.827812053157;2477.5044991001782;2478.429961108946;2479.4917042006437;2298.7931086202157;2371.8814059296965;2444.6699695541142;2475.8266921315517;2476.6161245006874;2452.2152911068465;2463.507298540299;2482.8510289382693;2485;2487.619371248956;8912.73261802147;8963.731088067369;8980.775480613036;9000.77498062547;9013.053629368887;5460.235567020621;5580.274564306655;5595.104783234704;5600.131979543177;5615.438456154393;3538.5930617979006;3662.4140137578124;3702.8148592570533;3721.5162028936334;3731.3656678364473;1057.4237040812775;1061.7398737309331;1078.051314842941;1084.0893649334519;1084.143526613974;12066.215695979734;12073.154879158375;12081.973032292353;12084.335361555199;12111.212771169845;4908.901821963541;4919.950800492021;4966.453690094087;4995;5037.345145131183;10107.3430227035;10141.645042423479;10147.594096236215;10150.593976241016;10170.644027459151;5510.752016159283;5514.145307477347;5546.584006199551;5548.278723765885;5552.555795536347;4463.977680111643;4608.976955115203;4842.58837998774;4993.475685053089;5015.799368025311;3486.825658717054;3930.7051971102283;4030.334994725896;4044.373122166069;4067.8169482373364;1312.2126723965544;1323.7099817316098;1328.9335083944559;1341.1885809085363;1344.072589912957;1380.8481067082612;1381.3990913952262;1399.6151058458802;1402.5091218073592;1413.046193819168;8341.082480927093;8355.540445275446;8378.036525799489;8383.496990180609;8436.072032076467;529.317180836724;534;1213.1750409721474;1262.0912942681255;1299.4737131461773;6213.65824879627;6423;6426.260979987362;6628.867422651617;6705.128333316735;9174.541272936327;10542.367457952394;10660.680179594625;10810.67567972962;10889.074428673493;10543.736406589896;10603.09873660732;10670.839937400946;10697.893021069845;10752.462376881125;8333.958330208432;8340.41617086798;8517.74446766598;8530.70142545008;8669.436486628349;7115.324044215791;8356.206160414751;8413.789655258668;8415.831683366421;8448.788780280296;9441.291903107158;9547.379420337656;9707;9771.951140244253;9793.167580755715;10012.69961901144;10091.44497052669;10163.898361016296;10312.690619281433;10331.32846364984;6775.49183811226;6988.79033628992;7246.782596522113;7546.207648196861;7687.0391201099865;7165.534240274365;8293;8355.498670079814;8367.205115514016;8373.539455330016;6829.112215411965;7334.596597186993;7435.330820226206;7571.962140189264;7611.619419029137;7270.927290727025;7284.307990741083;7284.745033923788;7328.560286382834;7370.557766534025;7670.309672129535;7773.844523109619;7775.261350171724;7781.26078022587;7826.373890088666;6949.200841903245;6991.545549539263;7046.436285097282;7070.222275549789;7071.434285257064;7073.610951397723;7139.964300178466;7155.821104472222;7215.170255420694;7215.783526494213 02:52:19 INFO - PROCESS | 1974 | |4;prototype.html;325.53286034540434;328.79778935954397;333.2019812548947;334.2496096263887;339.32135728542914;6495.382938620835;6521.869562608751;6659.73361065558;6684.431823295025;6691.6319602421845;6541.116949211855;6563.835904102388;6574.9671251643795;6577.2436169840485;6577.671116444182;4742.2886567014875;4764.6188304935695;4887.706737595738;4893.510648935114;4982.6263030272785;4876.195807551211;4879.292502587123;4885.316055752198;4887.560119589236;4921.286413470062;4824.734639594821;4885.291632713254;4904.705717656934;4906.730129842857;4909.803607855682;4631.282151266559;4705.600023997964;4760.976195119037;4762.904531957634;4778.665493415462;3656.03115174479;3915.960840391588;4173.3114036184;4182.477190351206;4182.602652747984;6270.216222972129;6274.9960006399215;6285.43431091204;6295.811125666238;6303.2751233607805;5664.830055098354;5689.146628005791;5691.231683722686;5704.971475142639;5707.3721890592005;6687.765928192539;6915.965420172917;6916.20463646682;6921.169459664822;6929.792106236821;4618.191816432144;4701.929471057937;4702.647301452371;4712.6229901607785;4714.669973101884;7266.346028857428;7307.451941104438;7326.743563975236;7336.706531738778;7352.48532602718;4771.165046116985;4778.880527986828;4783.115123702126;4786.712797232177;4792.993471370982;4832.492588278251;4833.758312084382;4836.540528649773;4838.758062096951;4840.152973229741;5679.034564124109;5710.3433105193435;5711.3146422428745;5715.114157305624;5717.142428635738;6667.599944003376;6934.410575101072;6968.44252459802;6980.616066116311;6984.685689144001;1659.8921070130402;1670.523900688298;1686.9240884160242;1688.1559220389804;1688.653825965674;1081.9242653014214;1090.7000574841982;1097.665212110314;1102.8125218712678;1115.3475216997986;5474.3704473986;6349.619022858643;6440.323766004502;6578.703958321887;6678.699458524281;6299.622022678654;7000.61496617691;7273.818154546178;7278.272172782786;7293.380062694624;6622.602643841385;6629.436497897733;6629.469642428594;6637;6649.102371179925;3790.374588192917;3832.080300727805;3845.8269377878064;3847.53793558446;3852.788096654655;6086.969565152146;7246.782596522113;7519.285667861544;7543.3965282778345;7548.66031028605;7410.555366678017;7431.2197219292275;7437.776866694008;7440.2931721486375;7454.142773580999;7515.248475152441;7518.699252029857;7532.455846551554;7536.698532058656;7551.282628150317;5989.1914591529585;7254.637268136677;7257.637118144177;7274.272572742683;7283.708651654087;6773.695183716646;7059.082319298458;7081.93770934364;7087.82280442993;7104.822379440556;7475.542269257443;7582.469227154046;7597.696092156252;7598.886016709865;7614.390848732199;4589.518100599523;4637.489876113692;4642.698224615389;4644.93032604518;4650.883727906829;6082.996305609702;7178.3898368637165;7222.674979625825;7235.986961825454;7247.4926755126635;6738.898916516354;6963.1296087989;7000.439964802702;7008.894866576903;7132.821679458055;6935.583864968118;6953.269906659728;6966.2584353911525;6977;6986.231514533499;6828.0440738297675;6832.248452670302;6835.658217089225;6837.008633747979;6842.897356539556;6956.721731130698;6969.895451568129;6973.860522789617;6988.301169882971;6991.580505169706;6543.574667646588;6565.113709649137;6735;6836.931630683828;6875.5874647521305 02:52:19 INFO - PROCESS | 1974 | |5;yui.html;739.6080077558896;753.1940823319051;753.4236309223442;776.0299625468165;820.3232333325006;14931.925340373296;15219.999999999985;15246.542603721879;15257.542273731806;15265.313060912258;12568.680288569705;13267.203967761918;14111.15333080016;14146.858531414708;14179.78730319046;726.4696771356913;734.3611058379217;735.7461675721868;736.3924762071285;905.235076360476;740.3780824107776;908.8818453601023;932.7155217658611;935.5836652689555;935.7052528453515;974.2400927276735;991.9931269761198;992.092235604421;993.3642468819961;993.92545559083;955.0974329258853;980.9362391444533;982.9361091529028;983.8376667849797;985.6008316631776;571.3201290464334;722.8987941688168;724.5869854183118;725.9818504537376;738.8559230949967;14881.925590372088;14913.701725965528;14943.178125203109;14959.177245251507;14982;12473.438695258736;12578.308193049379;12583.307918064504;12621.179623324455;12710.555130570385;9704.272179586489;9780.510974451248;9823.557939892722;10132.24008199388;10336.276460647683;3051.328707684328;3467.809270490122;3515.1739341254784;3561.6438356164435;3606.6934310583633;83821;84206.73689894656;84453.15546844575;84479.15520844774;84581.57709211415;8210.712625058095;9418.529073546295;9632.373895696757;9704.417734935927;9833.852492212622;22320;22407.887960560092;22423;22434.439139021328;22452.438689032904;7318.158411782607;7331.266873312626;7438.033055702724;7444.478886477895;7631.084269887649;4072.735272207297;4149.7095203335475;4149.771762553089;4151.46031015966;4155.605217504332;3596.2987217492337;3655.7440979131206;3657.9268414632093;3658.4695219193068;3667.2848794485353;659.2804680692145;660.2539130782185;670.0686046395514;671.2984930747381;683.9794806155824;499.84005118361773;536.6592213944095;548.9862753431196;549.6619578958991;575.5424437572141;7886.581270986196;7999.84000320002;8017.198280171936;8145.185481451807;8216.712415065444;515.1448595331732;541.5423966748092;572.3675338750704;585.0901847626895;586.1588620329755;3329.300846822146;3736.3274610570356;3791.469194312798;3975.900602484903;3978.124812541236;68786.312136878;85586.57206713926;88284;88911.2207706497;93055.74304899295;78926.6053669728;79460.20539794644;80193;80897.19102809014;81516;59326.11010834841;70375.29624703688;71558.64220678863;71577.86092117216;72053.91245225673;7592.962035190009;7782.649780759766;7993.280604745368;8237.382196335418;8253.752387428387;49646.50353496419;49832.75418114576;50410.243846341604;50850.491495086055;51142.48857511377;69529.65235173995;69624.037596242;70654.94017589843;71273.64363178151;71640;10922.945385273022;11114.22200445961;11249.718757030812;11279.09767218637;11563.364014979257;11016.339019658526;11981.880181198425;12151.453184606891;12363.32001739913;12767;10780.622678206226;11210.943945280222;11265.943670281924;11308.378039207922;11649.534018639499;11432.599859004895;11505.48225329879;11639.6508104757;11863.34751588671;11951.22317049389;10726.356418614909;10735.570577176826;10757.838632420677;10811.567537298735;11043.39261340634;8073.313768329758;8840;8967.686130985645;9120.954395228247;9959.601615935282;8602.18279263469;8650.1349865013;8675.86986195195;8704.216620504185;8959.776005599912 02:52:19 INFO - PROCESS | 1974 | __end_tp_report 02:52:19 INFO - PROCESS | 1974 | __start_cc_report 02:52:19 INFO - PROCESS | 1974 | _x_x_mozilla_cycle_collect,1999 02:52:19 INFO - PROCESS | 1974 | __end_cc_report 02:52:19 INFO - PROCESS | 1974 | __startTimestamp1458035539797__endTimestamp 02:52:19 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | ------- Summary: start ------- 02:52:19 INFO - PROCESS | 1974 | Number of tests: 6 02:52:19 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | [#0] dojo.html Cycles:165 Average:5734.56 Median:5935.26 stddev:634.28 (10.7%) stddev-sans-first:604.66 02:52:19 INFO - PROCESS | 1974 | Values: 3215.6 3510.6 3524.0 3537.5 3583.7 4755.0 5662.8 5704.5 5722.1 5722.7 5734.4 5813.3 5824.6 5840.2 5912.1 5195.2 5234.6 5255.8 5265.9 5294.7 5194.3 5287.0 5307.8 5377.9 5391.1 5121.0 5287.8 5288.2 5350.7 5385.4 5200.1 5239.5 5242.2 5246.6 5248.3 5169.9 5220.8 5221.8 5224.0 5244.5 5592.7 5605.0 5607.3 5629.3 5643.7 6145.9 6229.3 6269.0 6277.5 6286.8 6230.0 6306.2 6313.4 6336.9 6338.9 5715.8 5746.1 5805.7 5808.1 5827.3 6148.9 6258.8 6274.1 6291.1 6300.6 6156.6 6181.9 6186.4 6186.9 6197.0 6097.6 6191.1 6264.8 6280.8 6285.0 6097.6 6125.6 6141.0 6145.9 6151.3 6147.7 6160.3 6170.9 6172.7 6179.7 4799.6 4818.9 4820.9 4885.1 4888.7 4332.6 4338.7 4339.9 4371.1 4380.5 5603.9 5634.6 5642.5 5649.4 5655.6 6109.9 6211.0 6229.6 6238.3 6271.3 4861.7 5693.8 5719.6 5726.7 5736.8 5306.5 5323.7 5338.4 5349.3 5356.8 6195.7 6235.0 6300.5 6300.7 6306.1 6274.4 6288.2 6296.3 6300.5 6305.7 6274.6 6289.6 6291.2 6292.0 6298.2 6021.4 6108.6 6114.4 6144.5 6176.1 6169.4 6202.8 6264.5 6280.3 6295.5 6099.8 6116.4 6124.3 6130.8 6144.4 6021.1 6085.1 6094.1 6100.8 6123.4 5752.6 5890.1 5904.9 5934.9 5935.3 6098.5 6112.7 6117.2 6118.4 6122.0 5775.9 5841.9 5894.8 5950.3 5983.9 02:52:19 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | [#1] ext.html Cycles:180 Average:65045.60 Median:39663.50 stddev:132865.71 (335.0%) stddev-sans-first:133150.03 02:52:19 INFO - PROCESS | 1974 | Values: 490.4 540.4 546.7 625.0 639.7 39026.0 39628.0 39699.0 39707.8 39745.6 42544.0 43125.8 43239.4 43277.8 43366.0 9462.9 9659.0 9672.7 9687.0 9694.1 9589.4 9743.6 9751.5 9769.1 9770.2 9866.3 9959.0 9979.3 9979.3 10002.3 9831.3 9932.3 9937.4 9939.0 9951.1 9630.1 9762.1 9778.2 9780.4 9786.4 41930.0 42339.0 42355.0 42450.6 42486.0 3195.7 3247.6 3308.6 3339.2 3647.4 29339.4 29345.0 29967.3 30612.8 31026.8 2737.1 2748.8 2765.1 2868.8 2913.6 422893.0 500522.0 501073.0 502748.0 502794.0 62132.0 62497.4 62857.0 62960.7 63034.0 72617.0 74008.0 74021.3 74039.0 74239.3 17066.0 17329.7 17366.6 17387.9 17390.4 13176.7 13220.5 13248.3 13255.1 13256.5 21498.9 21802.7 21864.5 21864.6 21876.6 8266.5 8921.0 9684.0 9685.0 9703.4 984.8 1001.2 1102.9 1124.7 1129.4 24674.5 27954.9 28942.7 29035.9 29564.4 973.5 1089.8 1151.6 1158.9 1191.8 12265.2 14806.0 14880.9 14929.7 15227.6 520821.0 525831.0 526257.0 526671.0 527719.0 57659.4 59530.7 59588.7 59662.7 59741.0 1332.5 1361.7 1459.1 1468.3 1497.8 29877.6 30422.9 31429.8 31557.5 31853.7 42474.8 50288.7 50782.7 50788.2 51180.0 477086.0 488596.3 489114.0 489236.0 489691.0 34332.8 34342.0 34994.8 35034.1 35047.5 45382.5 45451.5 45595.3 46232.5 46768.5 31713.8 37588.1 37689.4 38236.6 38545.0 36855.3 36919.8 37450.4 37543.9 37824.6 36898.8 37110.9 37257.8 37883.6 38205.9 29689.7 32481.4 32532.5 32701.2 32744.4 24792.0 24889.8 24927.9 25107.7 25225.4 02:52:19 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | [#2] jquery.html Cycles:180 Average:30148.66 Median:361.10 stddev:81830.73 (22661.3%) stddev-sans-first:82029.72 02:52:19 INFO - PROCESS | 1974 | Values: 358.6 360.5 361.7 370.5 371.9 15747.6 16412.3 20243.5 20717.5 20759.5 19439.2 19625.3 20456.1 20464.9 20489.1 5805.8 5908.1 5918.4 5967.9 6048.9 4216.2 4399.1 5885.9 6211.6 6498.3 6398.1 6412.4 6425.5 6429.0 6431.4 6162.9 6492.4 6518.4 6529.7 6530.7 3716.2 5253.4 5473.7 5473.9 5547.2 12797.3 13334.7 13375.7 25387.4 25508.5 2111.3 2262.4 2315.4 2433.3 2702.2 9509.8 9683.6 9787.0 9971.6 10131.0 1660.5 1688.6 1741.3 1760.6 1768.4 99643.5 103978.0 107568.4 107625.0 107899.5 9382.5 11261.9 11269.0 11270.7 11290.8 13624.9 13632.8 13657.0 13679.1 13696.2 8413.7 8619.6 8633.2 8707.5 8723.0 8767.9 8776.6 8786.6 8875.0 8879.0 4397.2 4466.0 4479.5 4510.5 4537.3 1518.4 1722.0 1793.6 1800.5 1842.2 956.4 974.3 977.2 996.9 1009.2 18882.8 19095.8 19272.5 19431.5 19517.5 770.6 925.5 938.9 961.7 1027.8 10194.9 10537.8 10551.8 10576.7 10775.4 439614.0 439982.8 443838.0 446447.0 638637.8 73480.6 99865.5 111803.0 119393.4 124679.0 981.7 1015.3 1015.8 1019.9 1046.4 16010.4 16392.5 17724.3 17900.4 18001.7 50652.2 50809.0 50836.7 51074.2 53730.9 73344.0 74816.6 74989.0 74989.6 76902.0 7370.6 7466.9 7502.0 7583.0 7794.5 11603.6 11766.0 12031.5 12074.6 12098.6 9920.9 10064.8 10110.6 10394.3 10468.9 8998.9 10030.7 10106.4 10407.7 10409.5 10286.2 10312.6 10651.5 10739.1 10855.6 7422.0 7427.1 7539.5 7559.2 7656.3 8015.6 9336.3 10027.4 10238.4 10625.3 02:52:19 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | [#3] mootools.html Cycles:180 Average:6099.16 Median:5026.57 stddev:3202.64 (63.7%) stddev-sans-first:3191.09 02:52:19 INFO - PROCESS | 1974 | Values: 1274.8 1603.5 1621.2 1922.7 2065.2 7995.2 8653.7 8838.5 8838.7 8853.8 7238.4 7458.5 8765.2 8789.1 8807.6 2176.8 2419.1 2459.0 2484.6 2486.1 2489.4 2497.4 2498.2 2499.0 2505.3 2415.7 2459.8 2477.5 2478.4 2479.5 2298.8 2371.9 2444.7 2475.8 2476.6 2452.2 2463.5 2482.9 2485.0 2487.6 8912.7 8963.7 8980.8 9000.8 9013.1 5460.2 5580.3 5595.1 5600.1 5615.4 3538.6 3662.4 3702.8 3721.5 3731.4 1057.4 1061.7 1078.1 1084.1 1084.1 12066.2 12073.2 12082.0 12084.3 12111.2 4908.9 4920.0 4966.5 4995.0 5037.3 10107.3 10141.6 10147.6 10150.6 10170.6 5510.8 5514.1 5546.6 5548.3 5552.6 4464.0 4609.0 4842.6 4993.5 5015.8 3486.8 3930.7 4030.3 4044.4 4067.8 1312.2 1323.7 1328.9 1341.2 1344.1 1380.8 1381.4 1399.6 1402.5 1413.0 8341.1 8355.5 8378.0 8383.5 8436.1 529.3 534.0 1213.2 1262.1 1299.5 6213.7 6423.0 6426.3 6628.9 6705.1 9174.5 10542.4 10660.7 10810.7 10889.1 10543.7 10603.1 10670.8 10697.9 10752.5 8334.0 8340.4 8517.7 8530.7 8669.4 7115.3 8356.2 8413.8 8415.8 8448.8 9441.3 9547.4 9707.0 9772.0 9793.2 10012.7 10091.4 10163.9 10312.7 10331.3 6775.5 6988.8 7246.8 7546.2 7687.0 7165.5 8293.0 8355.5 8367.2 8373.5 6829.1 7334.6 7435.3 7572.0 7611.6 7270.9 7284.3 7284.7 7328.6 7370.6 7670.3 7773.8 7775.3 7781.3 7826.4 6949.2 6991.5 7046.4 7070.2 7071.4 7073.6 7140.0 7155.8 7215.2 7215.8 02:52:19 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | [#4] prototype.html Cycles:180 Average:5733.42 Median:6553.71 stddev:1793.58 (27.4%) stddev-sans-first:1752.08 02:52:19 INFO - PROCESS | 1974 | Values: 325.5 328.8 333.2 334.2 339.3 6495.4 6521.9 6659.7 6684.4 6691.6 6541.1 6563.8 6575.0 6577.2 6577.7 4742.3 4764.6 4887.7 4893.5 4982.6 4876.2 4879.3 4885.3 4887.6 4921.3 4824.7 4885.3 4904.7 4906.7 4909.8 4631.3 4705.6 4761.0 4762.9 4778.7 3656.0 3916.0 4173.3 4182.5 4182.6 6270.2 6275.0 6285.4 6295.8 6303.3 5664.8 5689.1 5691.2 5705.0 5707.4 6687.8 6916.0 6916.2 6921.2 6929.8 4618.2 4701.9 4702.6 4712.6 4714.7 7266.3 7307.5 7326.7 7336.7 7352.5 4771.2 4778.9 4783.1 4786.7 4793.0 4832.5 4833.8 4836.5 4838.8 4840.2 5679.0 5710.3 5711.3 5715.1 5717.1 6667.6 6934.4 6968.4 6980.6 6984.7 1659.9 1670.5 1686.9 1688.2 1688.7 1081.9 1090.7 1097.7 1102.8 1115.3 5474.4 6349.6 6440.3 6578.7 6678.7 6299.6 7000.6 7273.8 7278.3 7293.4 6622.6 6629.4 6629.5 6637.0 6649.1 3790.4 3832.1 3845.8 3847.5 3852.8 6087.0 7246.8 7519.3 7543.4 7548.7 7410.6 7431.2 7437.8 7440.3 7454.1 7515.2 7518.7 7532.5 7536.7 7551.3 5989.2 7254.6 7257.6 7274.3 7283.7 6773.7 7059.1 7081.9 7087.8 7104.8 7475.5 7582.5 7597.7 7598.9 7614.4 4589.5 4637.5 4642.7 4644.9 4650.9 6083.0 7178.4 7222.7 7236.0 7247.5 6738.9 6963.1 7000.4 7008.9 7132.8 6935.6 6953.3 6966.3 6977.0 6986.2 6828.0 6832.2 6835.7 6837.0 6842.9 6956.7 6969.9 6973.9 6988.3 6991.6 6543.6 6565.1 6735.0 6836.9 6875.6 02:52:19 INFO - PROCESS | 1974 | 02:52:19 INFO - PROCESS | 1974 | [#5] yui.html Cycles:180 Average:18262.68 Median:665.16 stddev:25706.07 (3864.6%) stddev-sans-first:25744.51 02:52:19 INFO - PROCESS | 1974 | Values: 739.6 753.2 753.4 776.0 820.3 14931.9 15220.0 15246.5 15257.5 15265.3 12568.7 13267.2 14111.2 14146.9 14179.8 726.5 734.4 735.7 736.4 905.2 740.4 908.9 932.7 935.6 935.7 974.2 992.0 992.1 993.4 993.9 955.1 980.9 982.9 983.8 985.6 571.3 722.9 724.6 726.0 738.9 14881.9 14913.7 14943.2 14959.2 14982.0 12473.4 12578.3 12583.3 12621.2 12710.6 9704.3 9780.5 9823.6 10132.2 10336.3 3051.3 3467.8 3515.2 3561.6 3606.7 83821.0 84206.7 84453.2 84479.2 84581.6 8210.7 9418.5 9632.4 9704.4 9833.9 22320.0 22407.9 22423.0 22434.4 22452.4 7318.2 7331.3 7438.0 7444.5 7631.1 4072.7 4149.7 4149.8 4151.5 4155.6 3596.3 3655.7 3657.9 3658.5 3667.3 659.3 660.3 670.1 671.3 684.0 499.8 536.7 549.0 549.7 575.5 7886.6 7999.8 8017.2 8145.2 8216.7 515.1 541.5 572.4 585.1 586.2 3329.3 3736.3 3791.5 3975.9 3978.1 68786.3 85586.6 88284.0 88911.2 93055.7 78926.6 79460.2 80193.0 80897.2 81516.0 59326.1 70375.3 71558.6 71577.9 72053.9 7593.0 7782.6 7993.3 8237.4 8253.8 49646.5 49832.8 50410.2 50850.5 51142.5 69529.7 69624.0 70654.9 71273.6 71640.0 10922.9 11114.2 11249.7 11279.1 11563.4 11016.3 11981.9 12151.5 12363.3 12767.0 10780.6 11210.9 11265.9 11308.4 11649.5 11432.6 11505.5 11639.7 11863.3 11951.2 10726.4 10735.6 10757.8 10811.6 11043.4 8073.3 8840.0 8967.7 9121.0 9959.6 8602.2 8650.1 8675.9 8704.2 8959.8 02:52:19 INFO - PROCESS | 1974 | -------- Summary: end -------- 02:52:19 INFO - PROCESS | 1974 | 02:52:20 INFO - TEST-INFO | 1974: exit 0 02:52:20 INFO - TEST-OK | dromaeo_css | took 1114412ms 02:52:20 INFO - TEST-START | kraken 02:52:20 INFO - operating with platform_type : mac_ 02:52:20 INFO - Initialising browser for kraken test... 02:52:20 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpF2hfMK/profile http://localhost:51737/getInfo.html) 02:52:22 INFO - PROCESS | 1978 | __metrics Screen width/height:1600/1200 02:52:22 INFO - PROCESS | 1978 | colorDepth:24 02:52:22 INFO - PROCESS | 1978 | Browser inner width/height: 1024/689 02:52:22 INFO - PROCESS | 1978 | __metrics 02:52:22 INFO - PROCESS | 1978 | 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" 02:52:22 ERROR - PROCESS | 1978 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:52:23 INFO - TEST-INFO | 1978: exit 0 02:52:23 INFO - Browser initialized. 02:52:23 INFO - Running cycle 1/1 for kraken test... 02:52:23 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpF2hfMK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:35 INFO - PROCESS | 1980 | RSS: Main: 243326976 02:52:35 INFO - PROCESS | 1980 | 02:52:37 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51737/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:38 INFO - PROCESS | 1980 | RSS: Main: 290578432 02:52:38 INFO - PROCESS | 1980 | 02:52:41 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51737/tests/kraken/driver.html?testName=audio-dft) 02:52:41 INFO - PROCESS | 1980 | RSS: Main: 300457984 02:52:41 INFO - PROCESS | 1980 | 02:52:47 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51737/tests/kraken/driver.html?testName=audio-fft) 02:52:47 INFO - PROCESS | 1980 | RSS: Main: 287600640 02:52:47 INFO - PROCESS | 1980 | 02:52:49 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51737/tests/kraken/driver.html?testName=audio-oscillator) 02:52:50 INFO - PROCESS | 1980 | RSS: Main: 288538624 02:52:50 INFO - PROCESS | 1980 | 02:52:52 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:52 INFO - PROCESS | 1980 | RSS: Main: 290488320 02:52:52 INFO - PROCESS | 1980 | 02:52:55 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51737/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:56 INFO - PROCESS | 1980 | RSS: Main: 290222080 02:52:56 INFO - PROCESS | 1980 | 02:53:00 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51737/tests/kraken/driver.html?testName=imaging-desaturate) 02:53:00 INFO - PROCESS | 1980 | RSS: Main: 289542144 02:53:00 INFO - PROCESS | 1980 | 02:53:03 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51737/tests/kraken/driver.html?testName=json-parse-financial) 02:53:04 INFO - PROCESS | 1980 | RSS: Main: 288579584 02:53:04 INFO - PROCESS | 1980 | 02:53:05 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:53:06 INFO - PROCESS | 1980 | RSS: Main: 323866624 02:53:06 INFO - PROCESS | 1980 | 02:53:07 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51737/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:08 INFO - PROCESS | 1980 | RSS: Main: 325148672 02:53:08 INFO - PROCESS | 1980 | 02:53:10 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:11 INFO - PROCESS | 1980 | RSS: Main: 330334208 02:53:11 INFO - PROCESS | 1980 | 02:53:13 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:14 INFO - PROCESS | 1980 | RSS: Main: 331722752 02:53:14 INFO - PROCESS | 1980 | 02:53:16 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:17 INFO - PROCESS | 1980 | RSS: Main: 332722176 02:53:17 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:51737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51737/tests/kraken/driver.html?testName=ai-astar) 02:53:19 INFO - PROCESS | 1980 | RSS: Main: 391761920 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | __start_tp_report 02:53:19 INFO - PROCESS | 1980 | _x_x_mozilla_page_load 02:53:19 INFO - PROCESS | 1980 | _x_x_mozilla_page_load_details 02:53:19 INFO - PROCESS | 1980 | |i|pagename|runs| 02:53:19 INFO - PROCESS | 1980 | |0;ai-astar;111;105;111;111;110;111;116;111;110;110 02:53:19 INFO - PROCESS | 1980 | |1;audio-beat-detection;154;119;148;173;143;142;137;144;156;117 02:53:19 INFO - PROCESS | 1980 | |2;audio-dft;385;382;384;382;385;381;381;380;385;382 02:53:19 INFO - PROCESS | 1980 | |3;audio-fft;73;77;85;97;78;63;56;78;78;72 02:53:19 INFO - PROCESS | 1980 | |4;audio-oscillator;95;100;130;80;78;87;114;75;79;112 02:53:19 INFO - PROCESS | 1980 | |5;imaging-gaussian-blur;117;126;83;113;131;125;89;84;86;84 02:53:19 INFO - PROCESS | 1980 | |6;imaging-darkroom;157;159;158;160;157;159;159;168;157;159 02:53:19 INFO - PROCESS | 1980 | |7;imaging-desaturate;85;87;87;102;131;141;87;86;86;87 02:53:19 INFO - PROCESS | 1980 | |8;json-parse-financial;54;54;53;52;53;53;52;64;55;53 02:53:19 INFO - PROCESS | 1980 | |9;json-stringify-tinderbox;66;71;67;74;75;73;68;67;68;68 02:53:19 INFO - PROCESS | 1980 | |10;stanford-crypto-aes;83;82;83;82;79;82;81;82;83;83 02:53:19 INFO - PROCESS | 1980 | |11;stanford-crypto-ccm;129;129;131;119;123;121;125;127;125;125 02:53:19 INFO - PROCESS | 1980 | |12;stanford-crypto-pbkdf2;136;136;139;141;137;126;136;135;136;133 02:53:19 INFO - PROCESS | 1980 | |13;stanford-crypto-sha256-iterative;68;66;66;66;67;68;89;95;80;84 02:53:19 INFO - PROCESS | 1980 | __end_tp_report 02:53:19 INFO - PROCESS | 1980 | __start_cc_report 02:53:19 INFO - PROCESS | 1980 | _x_x_mozilla_cycle_collect,1222 02:53:19 INFO - PROCESS | 1980 | __end_cc_report 02:53:19 INFO - PROCESS | 1980 | __startTimestamp1458035599567__endTimestamp 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | ------- Summary: start ------- 02:53:19 INFO - PROCESS | 1980 | Number of tests: 14 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.63 (2.4%) stddev-sans-first:2.79 02:53:19 INFO - PROCESS | 1980 | Values: 111.0 105.0 111.0 111.0 110.0 111.0 116.0 111.0 110.0 110.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:146.00 stddev:16.68 (11.4%) stddev-sans-first:17.24 02:53:19 INFO - PROCESS | 1980 | Values: 154.0 119.0 148.0 173.0 143.0 142.0 137.0 144.0 156.0 117.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#2] audio-dft Cycles:10 Average:382.70 Median:383.00 stddev:1.89 (0.5%) stddev-sans-first:1.81 02:53:19 INFO - PROCESS | 1980 | Values: 385.0 382.0 384.0 382.0 385.0 381.0 381.0 380.0 385.0 382.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#3] audio-fft Cycles:10 Average:75.70 Median:78.00 stddev:11.20 (14.4%) stddev-sans-first:11.83 02:53:19 INFO - PROCESS | 1980 | Values: 73.0 77.0 85.0 97.0 78.0 63.0 56.0 78.0 78.0 72.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:78.50 stddev:18.66 (23.8%) stddev-sans-first:19.79 02:53:19 INFO - PROCESS | 1980 | Values: 95.0 100.0 130.0 80.0 78.0 87.0 114.0 75.0 79.0 112.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#5] imaging-gaussian-blur Cycles:10 Average:103.80 Median:83.50 stddev:20.26 (24.3%) stddev-sans-first:20.92 02:53:19 INFO - PROCESS | 1980 | Values: 117.0 126.0 83.0 113.0 131.0 125.0 89.0 84.0 86.0 84.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#6] imaging-darkroom Cycles:10 Average:159.30 Median:159.00 stddev:3.23 (2.0%) stddev-sans-first:3.32 02:53:19 INFO - PROCESS | 1980 | Values: 157.0 159.0 158.0 160.0 157.0 159.0 159.0 168.0 157.0 159.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:86.50 stddev:20.80 (24.0%) stddev-sans-first:21.53 02:53:19 INFO - PROCESS | 1980 | Values: 85.0 87.0 87.0 102.0 131.0 141.0 87.0 86.0 86.0 87.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:53.50 stddev:3.53 (6.6%) stddev-sans-first:3.74 02:53:19 INFO - PROCESS | 1980 | Values: 54.0 54.0 53.0 52.0 53.0 53.0 52.0 64.0 55.0 53.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:3.27 (4.7%) stddev-sans-first:3.18 02:53:19 INFO - PROCESS | 1980 | Values: 66.0 71.0 67.0 74.0 75.0 73.0 68.0 67.0 68.0 68.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:1.25 (1.5%) stddev-sans-first:1.27 02:53:19 INFO - PROCESS | 1980 | Values: 83.0 82.0 83.0 82.0 79.0 82.0 81.0 82.0 83.0 83.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:126.00 stddev:3.75 (3.0%) stddev-sans-first:3.74 02:53:19 INFO - PROCESS | 1980 | Values: 129.0 129.0 131.0 119.0 123.0 121.0 125.0 127.0 125.0 125.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.50 Median:136.00 stddev:3.98 (2.9%) stddev-sans-first:4.22 02:53:19 INFO - PROCESS | 1980 | Values: 136.0 136.0 139.0 141.0 137.0 126.0 136.0 135.0 136.0 133.0 02:53:19 INFO - PROCESS | 1980 | 02:53:19 INFO - PROCESS | 1980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:74.00 stddev:11.09 (15.0%) stddev-sans-first:11.48 02:53:19 INFO - PROCESS | 1980 | Values: 68.0 66.0 66.0 66.0 67.0 68.0 89.0 95.0 80.0 84.0 02:53:19 INFO - PROCESS | 1980 | -------- Summary: end -------- 02:53:19 INFO - PROCESS | 1980 | 02:53:20 INFO - TEST-INFO | 1980: exit 0 02:53:20 INFO - TEST-OK | kraken | took 60003ms 02:53:20 INFO - SUITE-END | took 1174s 02:53:20 INFO - Completed test suite (00:19:34) 02:53:20 INFO - javascript benchmark 02:53:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3215.6302025267096, 3510.56117985252, 3524.0308915048377, 3537.4693795930616, 3583.7312201584887, 4755.0, 5662.801801936933, 5704.458076482738, 5722.055860782976, 5722.656640601562, 5734.4265573442635, 5813.33146688131, 5824.621399609023, 5840.182374467568, 5912.054071348585, 5195.220716892478, 5234.58123350133, 5255.76349064293, 5265.921011184835, 5294.735263236832, 5194.27280180775, 5286.973565132188, 5307.761150748206, 5377.865553361158, 5391.083515802323, 5120.974395128038, 5287.841364759063, 5288.23320618512, 5350.678959262456, 5385.380681221651, 5200.141976573861, 5239.528442440199, 5242.18746094356, 5246.632735708502, 5248.291480650101, 5169.922451163236, 5220.817271395521, 5221.843344699665, 5224.0074385866565, 5244.5279924806955, 5592.720363981784, 5605.047141985872, 5607.299087614048, 5629.324481062258, 5643.68959707216, 6145.924463218918, 6229.314775374705, 6268.968655156741, 6277.52918531112, 6286.779962701329, 6229.96885015572, 6306.180196574462, 6313.3686631336495, 6336.873262534724, 6338.904916426257, 5715.828525144252, 5746.080627099685, 5805.7387417566315, 5808.099744539603, 5827.300723913115, 6148.862460444832, 6258.843528911722, 6274.090256912813, 6291.056341548804, 6300.621962682254, 6156.630602163885, 6181.876362472815, 6186.412290832363, 6186.938130618636, 6197.03945888388, 6097.645669838137, 6191.071339299051, 6264.843378915563, 6280.780172694025, 6285.0, 6097.585173720644, 6125.571219981412, 6140.969295153585, 6145.938540614626, 6151.323354431009, 6147.72335244915, 6160.291566469824, 6170.938290617126, 6172.660503672251, 6179.69101544921, 4799.592034677022, 4818.927716084261, 4820.8794780130775, 4885.096257192431, 4888.6577939543895, 4332.588404101605, 4338.674599405057, 4339.913201735948, 4371.0820727646915, 4380.518143004267, 5603.8879222416135, 5634.605577609528, 5642.520385767174, 5649.378568357477, 5655.632383895034, 6109.860177052684, 6210.968945155245, 6229.626222426669, 6238.282597501255, 6271.310155882849, 4861.7326047067045, 5693.800716974886, 5719.628224165416, 5726.685032323262, 5736.770529178786, 5306.52241298285, 5323.680579165185, 5338.386085600128, 5349.304590403301, 5356.785728570813, 6195.721192546346, 6234.9688251558455, 6300.527460440485, 6300.653464059521, 6306.085617585332, 6274.435300822948, 6288.151099601495, 6296.307406185224, 6300.495960323072, 6305.684715764285, 6274.623522588659, 6289.622622642656, 6291.150694656163, 6291.968540157453, 6298.212723409574, 6021.42796434338, 6108.554560543837, 6114.358196334042, 6144.539159562962, 6176.104464852661, 6169.383061693795, 6202.782902598387, 6264.5301602379095, 6280.340564240872, 6295.496360291258, 6099.817005489843, 6116.396640261158, 6124.29570599369, 6130.765048853685, 6144.446999770043, 6021.066734656135, 6085.087236914498, 6094.146819445193, 6100.75596976116, 6123.357047509948, 5752.626079304831, 5890.057590785454, 5904.911426328695, 5934.881302374015, 5935.258092738408, 6098.474884983619, 6112.724927378367, 6117.188044311166, 6118.432525348006, 6122.021314812626, 5775.8556036099435, 5841.883162336644, 5894.793682221101, 5950.3454619992635, 5983.880322393441], "unit": "score", "name": "dojo.html", "value": 5694.706799119904}, {"lowerIsBetter": false, "replicates": [490.448245723561, 540.4354587869361, 546.7402983582801, 624.9844003494321, 639.7121295417062, 39026.0, 39628.0, 39699.00752481186, 39707.80146099273, 39745.602543974586, 42544.0, 43125.7843710781, 43239.35140972888, 43277.78361108198, 43366.0, 9462.858057129148, 9658.985806490287, 9672.709818705414, 9687.0, 9694.127528522431, 9589.37669051513, 9743.610255589803, 9751.463669498175, 9769.120779129877, 9770.218382529381, 9866.309358344919, 9959.0, 9979.251556133282, 9979.251556133282, 10002.299839011272, 9831.31180817343, 9932.304738668225, 9937.35407198537, 9939.0, 9951.104400603908, 9630.133288004114, 9762.072603102764, 9778.217742580577, 9780.41317520944, 9786.412815231039, 41929.95175120616, 42339.0, 42355.0, 42450.57549424497, 42486.0, 3195.680431956809, 3247.594050743657, 3308.586426696663, 3339.231976645361, 3647.4164133738473, 29339.413211735646, 29344.972925947703, 29967.250818729488, 30612.846935765403, 31026.844865775525, 2737.137801592512, 2748.8350698958125, 2765.0737003103986, 2868.7991840570958, 2913.6066631004755, 422893.0, 500521.9947800512, 501073.0, 502748.0, 502794.0, 62132.0, 62497.37502625006, 62857.0, 62960.68519657372, 63034.0, 72617.0, 74008.0, 74021.25978740143, 74039.0, 74239.25760742431, 17066.0, 17329.7400538992, 17366.56583585395, 17387.913060434617, 17390.391336303168, 13176.670583235496, 13220.537281195113, 13248.271345076113, 13255.072144949954, 13256.469741210436, 21498.892505537373, 21802.672959905613, 21864.45338866541, 21864.562708745736, 21876.562468750537, 8266.512027834928, 8920.955395223113, 9683.951580242194, 9685.046060951478, 9703.417794932186, 984.8128855517572, 1001.2040427859869, 1102.8556437201958, 1124.7019539821954, 1129.390129330169, 24674.50650987006, 27954.86022569874, 28942.710572894, 29035.854820725763, 29564.408711825643, 973.5473005052685, 1089.7765957978595, 1151.5624062856061, 1158.8551431071116, 1191.7854786138578, 12265.202761820632, 14806.0, 14880.925595371953, 14929.70140597182, 15227.619309517351, 520821.0, 525831.0, 526257.0, 526671.0, 527719.0, 57659.4234057654, 59530.70234648799, 59588.70205648944, 59662.70168649216, 59740.999999999134, 1332.5269529317147, 1361.6800051987775, 1459.0953608762422, 1468.302556285777, 1497.8127734033246, 29877.5518367229, 30422.922885757, 31429.842850786514, 31557.526637100003, 31853.681463186, 42474.78762606167, 50288.748556256985, 50782.74608627081, 50788.23817642812, 51179.97640047104, 477086.0, 488596.3421097373, 489114.0, 489236.0, 489691.0, 34332.82833585816, 34342.0, 34994.82502587471, 35034.12414689653, 35047.47428788519, 45382.54617453915, 45451.545484546055, 45595.31607025831, 46232.53767462282, 46768.53231467642, 31713.841430792698, 37588.06029849166, 37689.43465847959, 38236.617633823305, 38545.0, 36855.26289474142, 36919.8154009239, 37450.43824342582, 37543.9315692378, 37824.62175378321, 36898.8155059223, 37110.886673399844, 37257.813710931274, 37883.62116378801, 38205.85382438531, 29689.703102968695, 32481.350372991936, 32532.51201231936, 32701.18247043843, 32744.40751946866, 24792.0, 24889.751102489467, 24927.875360623082, 25107.748922511273, 25225.369365766004], "unit": "score", "name": "ext.html", "value": 20277.877633191423}, {"lowerIsBetter": false, "replicates": [358.59478788968465, 360.50610663391143, 361.701596183149, 370.4942753141962, 371.92189640175565, 15747.606309842246, 16412.34350625975, 20243.49391265217, 20717.482062948435, 20759.481012974684, 19439.222431102775, 19625.31311404101, 20456.079476423558, 20464.89767551164, 20489.07799149038, 5805.825825225239, 5908.1433192187105, 5918.408159184069, 5967.910481342762, 6048.879022419549, 4216.198922204787, 4399.05420334628, 5885.881682480315, 6211.6273023618505, 6498.317676643956, 6398.13625160602, 6412.358764123597, 6425.518086143535, 6429.035644653292, 6431.42117209451, 6162.876742465148, 6492.35076492347, 6518.413342799147, 6529.673516324188, 6530.706118224643, 3716.201016781378, 5253.448387919251, 5473.67157970523, 5473.890522189574, 5547.223388725582, 12797.296148711817, 13334.733305333935, 13375.732485350238, 25387.365315867068, 25508.489830203293, 2111.250506070354, 2262.4343914021497, 2315.4095705594964, 2433.3065076453304, 2702.162329677806, 9509.809803803884, 9683.564239609235, 9787.0, 9971.601135954554, 10131.037551432602, 1660.4603503861294, 1688.5609741467183, 1741.303478608554, 1760.6390689908537, 1768.4075834595426, 99643.50178249135, 103978.0, 107568.38647420295, 107625.0, 107899.46050269698, 9382.48396338208, 11261.887381126247, 11268.985791278661, 11270.661880143609, 11290.774184516264, 13624.86375136236, 13632.795508067387, 13657.0, 13679.110857794212, 13696.246706431242, 8413.663453461915, 8619.569021548898, 8633.223009929137, 8707.47755134694, 8723.040465548911, 8767.912320876838, 8776.648934042567, 8786.648534058566, 8875.0, 8879.023307436177, 4397.164538737694, 4466.0, 4479.507254202035, 4510.548945105529, 4537.319402089713, 1518.3774652392467, 1722.0, 1793.5561872692608, 1800.4598620414085, 1842.1986435900426, 956.4213650741341, 974.2985050763439, 977.2182254196614, 996.865423167863, 1009.2279406254221, 18882.811171888105, 19095.80904190968, 19272.518187045436, 19431.514212144808, 19517.51206219856, 770.6493545436813, 925.4632313258294, 938.877945867033, 961.7451375385529, 1027.814993301198, 10194.949025254826, 10537.789244215073, 10551.788964220672, 10576.682699519026, 10775.353478791141, 439614.0, 439982.8000860039, 443838.0, 446447.0, 638637.8068109723, 73480.63259683775, 99865.50067249617, 111803.0, 119393.40303298428, 124679.01283948541, 981.7300242433388, 1015.329882277708, 1015.8374660054355, 1019.8521214423866, 1046.3617193512105, 16010.359585616445, 16392.5082247528, 17724.291028358723, 17900.41452329831, 18001.729974050137, 50652.24021639604, 50809.0, 50836.74581627068, 51074.233886492475, 53730.92538149137, 73344.0, 74816.62591687006, 74989.0, 74989.62505187439, 76902.0, 7370.557766534025, 7466.850662986819, 7501.962490187514, 7582.962085189539, 7794.493357931717, 11603.593874214363, 11766.0, 12031.518739250332, 12074.637760867188, 12098.576549820715, 9920.908700042844, 10064.798704025732, 10110.595576176871, 10394.324368915995, 10468.895311047097, 8998.86501702488, 10030.749231269278, 10106.39892102491, 10407.739806504595, 10409.531571079167, 10286.228532860216, 10312.587496500057, 10651.467426628793, 10739.08717758968, 10855.565777368816, 7422.0, 7427.145878224073, 7539.547627142389, 7559.20628334017, 7656.349210317186, 8015.599220039091, 9336.346455748033, 10027.448490333101, 10238.436885971343, 10625.25623206368], "unit": "score", "name": "jquery.html", "value": 9054.655211220728}, {"lowerIsBetter": false, "replicates": [1274.770541302565, 1603.5269595469338, 1621.2056092514667, 1922.7212054252134, 2065.1636087384613, 7995.200479952009, 8653.653853845846, 8838.469691818495, 8838.734837954855, 8853.778655533606, 7238.384737297336, 7458.515196512223, 8765.16730910564, 8789.121087891208, 8807.559622018905, 2176.804087632113, 2419.129113519132, 2459.0409740201335, 2484.5776218042975, 2486.0677246032737, 2489.439876027888, 2497.3756560859783, 2498.2255500794813, 2499.0378704198833, 2505.348609361561, 2415.698037745282, 2459.827812053157, 2477.5044991001782, 2478.429961108946, 2479.4917042006437, 2298.7931086202157, 2371.8814059296965, 2444.6699695541142, 2475.8266921315517, 2476.6161245006874, 2452.2152911068465, 2463.507298540299, 2482.8510289382693, 2485.0, 2487.619371248956, 8912.73261802147, 8963.731088067369, 8980.775480613036, 9000.77498062547, 9013.053629368887, 5460.235567020621, 5580.274564306655, 5595.104783234704, 5600.131979543177, 5615.438456154393, 3538.5930617979006, 3662.4140137578124, 3702.8148592570533, 3721.5162028936334, 3731.3656678364473, 1057.4237040812775, 1061.7398737309331, 1078.051314842941, 1084.0893649334519, 1084.143526613974, 12066.215695979734, 12073.154879158375, 12081.973032292353, 12084.335361555199, 12111.212771169845, 4908.901821963541, 4919.950800492021, 4966.453690094087, 4995.0, 5037.345145131183, 10107.3430227035, 10141.645042423479, 10147.594096236215, 10150.593976241016, 10170.644027459151, 5510.752016159283, 5514.145307477347, 5546.584006199551, 5548.278723765885, 5552.555795536347, 4463.977680111643, 4608.976955115203, 4842.58837998774, 4993.475685053089, 5015.799368025311, 3486.825658717054, 3930.7051971102283, 4030.334994725896, 4044.373122166069, 4067.8169482373364, 1312.2126723965544, 1323.7099817316098, 1328.9335083944559, 1341.1885809085363, 1344.072589912957, 1380.8481067082612, 1381.3990913952262, 1399.6151058458802, 1402.5091218073592, 1413.046193819168, 8341.082480927093, 8355.540445275446, 8378.036525799489, 8383.496990180609, 8436.072032076467, 529.317180836724, 534.0, 1213.1750409721474, 1262.0912942681255, 1299.4737131461773, 6213.65824879627, 6423.0, 6426.260979987362, 6628.867422651617, 6705.128333316735, 9174.541272936327, 10542.367457952394, 10660.680179594625, 10810.67567972962, 10889.074428673493, 10543.736406589896, 10603.09873660732, 10670.839937400946, 10697.893021069845, 10752.462376881125, 8333.958330208432, 8340.41617086798, 8517.74446766598, 8530.70142545008, 8669.436486628349, 7115.324044215791, 8356.206160414751, 8413.789655258668, 8415.831683366421, 8448.788780280296, 9441.291903107158, 9547.379420337656, 9707.0, 9771.951140244253, 9793.167580755715, 10012.69961901144, 10091.44497052669, 10163.898361016296, 10312.690619281433, 10331.32846364984, 6775.49183811226, 6988.79033628992, 7246.782596522113, 7546.207648196861, 7687.0391201099865, 7165.534240274365, 8293.0, 8355.498670079814, 8367.205115514016, 8373.539455330016, 6829.112215411965, 7334.596597186993, 7435.330820226206, 7571.962140189264, 7611.619419029137, 7270.927290727025, 7284.307990741083, 7284.745033923788, 7328.560286382834, 7370.557766534025, 7670.309672129535, 7773.844523109619, 7775.261350171724, 7781.26078022587, 7826.373890088666, 6949.200841903245, 6991.545549539263, 7046.436285097282, 7070.222275549789, 7071.434285257064, 7073.610951397723, 7139.964300178466, 7155.821104472222, 7215.170255420694, 7215.783526494213], "unit": "score", "name": "mootools.html", "value": 4973.393941764343}, {"lowerIsBetter": false, "replicates": [325.53286034540434, 328.79778935954397, 333.2019812548947, 334.2496096263887, 339.32135728542914, 6495.382938620835, 6521.869562608751, 6659.73361065558, 6684.431823295025, 6691.6319602421845, 6541.116949211855, 6563.835904102388, 6574.9671251643795, 6577.2436169840485, 6577.671116444182, 4742.2886567014875, 4764.6188304935695, 4887.706737595738, 4893.510648935114, 4982.6263030272785, 4876.195807551211, 4879.292502587123, 4885.316055752198, 4887.560119589236, 4921.286413470062, 4824.734639594821, 4885.291632713254, 4904.705717656934, 4906.730129842857, 4909.803607855682, 4631.282151266559, 4705.600023997964, 4760.976195119037, 4762.904531957634, 4778.665493415462, 3656.03115174479, 3915.960840391588, 4173.3114036184, 4182.477190351206, 4182.602652747984, 6270.216222972129, 6274.9960006399215, 6285.43431091204, 6295.811125666238, 6303.2751233607805, 5664.830055098354, 5689.146628005791, 5691.231683722686, 5704.971475142639, 5707.3721890592005, 6687.765928192539, 6915.965420172917, 6916.20463646682, 6921.169459664822, 6929.792106236821, 4618.191816432144, 4701.929471057937, 4702.647301452371, 4712.6229901607785, 4714.669973101884, 7266.346028857428, 7307.451941104438, 7326.743563975236, 7336.706531738778, 7352.48532602718, 4771.165046116985, 4778.880527986828, 4783.115123702126, 4786.712797232177, 4792.993471370982, 4832.492588278251, 4833.758312084382, 4836.540528649773, 4838.758062096951, 4840.152973229741, 5679.034564124109, 5710.3433105193435, 5711.3146422428745, 5715.114157305624, 5717.142428635738, 6667.599944003376, 6934.410575101072, 6968.44252459802, 6980.616066116311, 6984.685689144001, 1659.8921070130402, 1670.523900688298, 1686.9240884160242, 1688.1559220389804, 1688.653825965674, 1081.9242653014214, 1090.7000574841982, 1097.665212110314, 1102.8125218712678, 1115.3475216997986, 5474.3704473986, 6349.619022858643, 6440.323766004502, 6578.703958321887, 6678.699458524281, 6299.622022678654, 7000.61496617691, 7273.818154546178, 7278.272172782786, 7293.380062694624, 6622.602643841385, 6629.436497897733, 6629.469642428594, 6637.0, 6649.102371179925, 3790.374588192917, 3832.080300727805, 3845.8269377878064, 3847.53793558446, 3852.788096654655, 6086.969565152146, 7246.782596522113, 7519.285667861544, 7543.3965282778345, 7548.66031028605, 7410.555366678017, 7431.2197219292275, 7437.776866694008, 7440.2931721486375, 7454.142773580999, 7515.248475152441, 7518.699252029857, 7532.455846551554, 7536.698532058656, 7551.282628150317, 5989.1914591529585, 7254.637268136677, 7257.637118144177, 7274.272572742683, 7283.708651654087, 6773.695183716646, 7059.082319298458, 7081.93770934364, 7087.82280442993, 7104.822379440556, 7475.542269257443, 7582.469227154046, 7597.696092156252, 7598.886016709865, 7614.390848732199, 4589.518100599523, 4637.489876113692, 4642.698224615389, 4644.93032604518, 4650.883727906829, 6082.996305609702, 7178.3898368637165, 7222.674979625825, 7235.986961825454, 7247.4926755126635, 6738.898916516354, 6963.1296087989, 7000.439964802702, 7008.894866576903, 7132.821679458055, 6935.583864968118, 6953.269906659728, 6966.2584353911525, 6977.0, 6986.231514533499, 6828.0440738297675, 6832.248452670302, 6835.658217089225, 6837.008633747979, 6842.897356539556, 6956.721731130698, 6969.895451568129, 6973.860522789617, 6988.301169882971, 6991.580505169706, 6543.574667646588, 6565.113709649137, 6735.0, 6836.931630683828, 6875.5874647521305], "unit": "score", "name": "prototype.html", "value": 5137.016589388234}, {"lowerIsBetter": false, "replicates": [739.6080077558896, 753.1940823319051, 753.4236309223442, 776.0299625468165, 820.3232333325006, 14931.925340373296, 15219.999999999985, 15246.542603721879, 15257.542273731806, 15265.313060912258, 12568.680288569705, 13267.203967761918, 14111.15333080016, 14146.858531414708, 14179.78730319046, 726.4696771356913, 734.3611058379217, 735.7461675721868, 736.3924762071285, 905.235076360476, 740.3780824107776, 908.8818453601023, 932.7155217658611, 935.5836652689555, 935.7052528453515, 974.2400927276735, 991.9931269761198, 992.092235604421, 993.3642468819961, 993.92545559083, 955.0974329258853, 980.9362391444533, 982.9361091529028, 983.8376667849797, 985.6008316631776, 571.3201290464334, 722.8987941688168, 724.5869854183118, 725.9818504537376, 738.8559230949967, 14881.925590372088, 14913.701725965528, 14943.178125203109, 14959.177245251507, 14982.0, 12473.438695258736, 12578.308193049379, 12583.307918064504, 12621.179623324455, 12710.555130570385, 9704.272179586489, 9780.510974451248, 9823.557939892722, 10132.24008199388, 10336.276460647683, 3051.328707684328, 3467.809270490122, 3515.1739341254784, 3561.6438356164435, 3606.6934310583633, 83821.0, 84206.73689894656, 84453.15546844575, 84479.15520844774, 84581.57709211415, 8210.712625058095, 9418.529073546295, 9632.373895696757, 9704.417734935927, 9833.852492212622, 22320.0, 22407.887960560092, 22423.0, 22434.439139021328, 22452.438689032904, 7318.158411782607, 7331.266873312626, 7438.033055702724, 7444.478886477895, 7631.084269887649, 4072.735272207297, 4149.7095203335475, 4149.771762553089, 4151.46031015966, 4155.605217504332, 3596.2987217492337, 3655.7440979131206, 3657.9268414632093, 3658.4695219193068, 3667.2848794485353, 659.2804680692145, 660.2539130782185, 670.0686046395514, 671.2984930747381, 683.9794806155824, 499.84005118361773, 536.6592213944095, 548.9862753431196, 549.6619578958991, 575.5424437572141, 7886.581270986196, 7999.84000320002, 8017.198280171936, 8145.185481451807, 8216.712415065444, 515.1448595331732, 541.5423966748092, 572.3675338750704, 585.0901847626895, 586.1588620329755, 3329.300846822146, 3736.3274610570356, 3791.469194312798, 3975.900602484903, 3978.124812541236, 68786.312136878, 85586.57206713926, 88284.0, 88911.2207706497, 93055.74304899295, 78926.6053669728, 79460.20539794644, 80193.0, 80897.19102809014, 81516.0, 59326.11010834841, 70375.29624703688, 71558.64220678863, 71577.86092117216, 72053.91245225673, 7592.962035190009, 7782.649780759766, 7993.280604745368, 8237.382196335418, 8253.752387428387, 49646.50353496419, 49832.75418114576, 50410.243846341604, 50850.491495086055, 51142.48857511377, 69529.65235173995, 69624.037596242, 70654.94017589843, 71273.64363178151, 71640.0, 10922.945385273022, 11114.22200445961, 11249.718757030812, 11279.09767218637, 11563.364014979257, 11016.339019658526, 11981.880181198425, 12151.453184606891, 12363.32001739913, 12767.0, 10780.622678206226, 11210.943945280222, 11265.943670281924, 11308.378039207922, 11649.534018639499, 11432.599859004895, 11505.48225329879, 11639.6508104757, 11863.34751588671, 11951.22317049389, 10726.356418614909, 10735.570577176826, 10757.838632420677, 10811.567537298735, 11043.39261340634, 8073.313768329758, 8840.0, 8967.686130985645, 9120.954395228247, 9959.601615935282, 8602.18279263469, 8650.1349865013, 8675.86986195195, 8704.216620504185, 8959.776005599912], "unit": "score", "name": "yui.html", "value": 6842.43474378433}], "name": "dromaeo_css", "value": 7533.484394925323}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 111.0, 111.0, 110.0, 111.0, 116.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [154.0, 119.0, 148.0, 173.0, 143.0, 142.0, 137.0, 144.0, 156.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [385.0, 382.0, 384.0, 382.0, 385.0, 381.0, 381.0, 380.0, 385.0, 382.0], "unit": "score", "name": "audio-dft", "value": 382.7}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 85.0, 97.0, 78.0, 63.0, 56.0, 78.0, 78.0, 72.0], "unit": "score", "name": "audio-fft", "value": 75.7}, {"lowerIsBetter": true, "replicates": [95.0, 100.0, 130.0, 80.0, 78.0, 87.0, 114.0, 75.0, 79.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 95.0}, {"lowerIsBetter": true, "replicates": [117.0, 126.0, 83.0, 113.0, 131.0, 125.0, 89.0, 84.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 103.8}, {"lowerIsBetter": true, "replicates": [157.0, 159.0, 158.0, 160.0, 157.0, 159.0, 159.0, 168.0, 157.0, 159.0], "unit": "score", "name": "imaging-darkroom", "value": 159.3}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 87.0, 102.0, 131.0, 141.0, 87.0, 86.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 97.9}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 53.0, 52.0, 53.0, 53.0, 52.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 67.0, 74.0, 75.0, 73.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 82.0, 79.0, 82.0, 81.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [129.0, 129.0, 131.0, 119.0, 123.0, 121.0, 125.0, 127.0, 125.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [136.0, 136.0, 139.0, 141.0, 137.0, 126.0, 136.0, 135.0, 136.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.5}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 66.0, 67.0, 68.0, 89.0, 95.0, 80.0, 84.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.9}], "name": "kraken", "value": 1710.1000000000004}]} 02:53:20 INFO - Return code: 0 02:53:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:53:20 ERROR - # TBPL SUCCESS # 02:53:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:20 INFO - 2016-03-15 02:53:20.855 screenresolution[1984:24602] starting screenresolution argv=screenresolution get 02:53:20 INFO - 2016-03-15 02:53:20.857 screenresolution[1984:24602] Display 0: 1600x1200x32@60 02:53:20 INFO - 2016-03-15 02:53:20.863 screenresolution[1985:24605] starting screenresolution argv=screenresolution list 02:53:20 INFO - Available Modes on Display 0 02:53:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:21 INFO - Intel Iris: 02:53:21 INFO - Chipset Model: Intel Iris 02:53:21 INFO - Type: GPU 02:53:21 INFO - Bus: Built-In 02:53:21 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:21 INFO - Vendor: Intel (0x8086) 02:53:21 INFO - Device ID: 0x0a2e 02:53:21 INFO - Revision ID: 0x0009 02:53:21 INFO - Displays: 02:53:21 INFO - Display: 02:53:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:21 INFO - Display Serial Number: 1600x1200 60 02:53:21 INFO - Main Display: Yes 02:53:21 INFO - Mirror: Off 02:53:21 INFO - Online: Yes 02:53:21 INFO - Rotation: Supported 02:53:21 INFO - Return code: 0 02:53:21 INFO - Running post-action listener: _resource_record_post_action 02:53:21 INFO - Running post-run listener: _resource_record_post_run 02:53:22 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 2674688; Write bytes: 703885824; Read time: 52; Write time: 2457 02:53:22 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391504384; Write bytes: 386352640; Read time: 29788; Write time: 770 02:53:22 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 2674688; Write bytes: 298138624; Read time: 52; Write time: 1641 02:53:22 INFO - Running post-run listener: _upload_blobber_files 02:53:22 INFO - Blob upload gear active. 02:53:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:22 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 02:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:53:22 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:23 INFO - (blobuploader) - INFO - Done attempting. 02:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:24 INFO - (blobuploader) - INFO - Done attempting. 02:53:24 INFO - (blobuploader) - INFO - Iteration through files over. 02:53:24 INFO - Return code: 0 02:53:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:53:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:53:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24e324da0db666700642aa9d7d8bafe132b3cb9637c7d83513fc1af5c6bd9bf2654a7eb693716520ed88c30565ae855aaacb0475ddca5a406406bafc490497f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/217e003289f5b0ae639decc1d6f51ca1c6d6b1c1f7f4e0520b9f3ce79ef22ad9c386064eee87e25e2b13991649c0fc1d7657857a88a5ff8234cb81248aa90046"} 02:53:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:53:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:53:24 INFO - Contents: 02:53:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24e324da0db666700642aa9d7d8bafe132b3cb9637c7d83513fc1af5c6bd9bf2654a7eb693716520ed88c30565ae855aaacb0475ddca5a406406bafc490497f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/217e003289f5b0ae639decc1d6f51ca1c6d6b1c1f7f4e0520b9f3ce79ef22ad9c386064eee87e25e2b13991649c0fc1d7657857a88a5ff8234cb81248aa90046"} 02:53:24 INFO - Running post-run listener: copy_logs_to_upload_dir 02:53:24 INFO - Copying logs to upload dir... 02:53:24 INFO - mkdir: /builds/slave/test/build/upload/logs 02:53:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.315304 ========= master_lag: 15.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-03-15 02:53:39.559211) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-03-15 02:53:39.560340) ========= 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.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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/Fx-Team/sha512/24e324da0db666700642aa9d7d8bafe132b3cb9637c7d83513fc1af5c6bd9bf2654a7eb693716520ed88c30565ae855aaacb0475ddca5a406406bafc490497f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/217e003289f5b0ae639decc1d6f51ca1c6d6b1c1f7f4e0520b9f3ce79ef22ad9c386064eee87e25e2b13991649c0fc1d7657857a88a5ff8234cb81248aa90046"} build_url:https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/aG6SZjAdQ1WnShE6twCN5Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24e324da0db666700642aa9d7d8bafe132b3cb9637c7d83513fc1af5c6bd9bf2654a7eb693716520ed88c30565ae855aaacb0475ddca5a406406bafc490497f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/217e003289f5b0ae639decc1d6f51ca1c6d6b1c1f7f4e0520b9f3ce79ef22ad9c386064eee87e25e2b13991649c0fc1d7657857a88a5ff8234cb81248aa90046"}' ========= master_lag: 10.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-03-15 02:53:49.703345) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2016-03-15 02:53:49.703661) ========= 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.A66NPDuPBY/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.UL9wOgSgtl/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005352 ========= master_lag: 10.00 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2016-03-15 02:53:59.705750) ========= ========= Started reboot skipped (results: 3, elapsed: 14 secs) (at 2016-03-15 02:53:59.710108) ========= ========= Finished reboot skipped (results: 3, elapsed: 14 secs) (at 2016-03-15 02:54:14.077502) ========= ========= Total master_lag: 40.20 =========