builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0125 starttime: 1457576624.3 results: success (0) buildid: 20160309162727 builduid: 90ca3250ccc0404cbd55735bc7241a23 revision: 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.298583) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.299089) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.299383) ========= 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.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.005896 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.322787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.323167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.339672) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.339973) ========= 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.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.005351 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.388933) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.389257) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.389640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.389937) ========= 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.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-09 18:23:44-- 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.29M=0.001s 2016-03-09 18:23:44 (8.29 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.552978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.958980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:44.959297) ========= 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.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.019806 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:45.007534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 18:23:45.007876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e --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 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-09 18:23:45,098 truncating revision to first 12 chars 2016-03-09 18:23:45,098 Setting DEBUG logging. 2016-03-09 18:23:45,099 attempt 1/10 2016-03-09 18:23:45,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c3790398ff5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 18:23:46,202 unpacking tar archive at: fx-team-5c3790398ff5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 18:23:46.379789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:46.380163) ========= echo 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e program finished with exit code 0 elapsedTime=0.005182 script_repo_revision: '5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:46.429884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:46.430200) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 18:23:46.443774) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-09 18:23:46.444090) ========= /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.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:23:46 INFO - MultiFileLogger online at 20160309 18:23:46 in /builds/slave/test 18:23:46 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 18:23:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:23:46 INFO - {'append_to_log': False, 18:23:46 INFO - 'base_work_dir': '/builds/slave/test', 18:23:46 INFO - 'blob_upload_branch': 'Fx-Team', 18:23:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:23:46 INFO - 'branch': 'Fx-Team', 18:23:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:23:46 INFO - 'config_files': ('talos/mac_config.py',), 18:23:46 INFO - 'default_actions': ('clobber', 18:23:46 INFO - 'read-buildbot-config', 18:23:46 INFO - 'download-and-extract', 18:23:46 INFO - 'populate-webroot', 18:23:46 INFO - 'create-virtualenv', 18:23:46 INFO - 'install', 18:23:46 INFO - 'run-tests'), 18:23:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:23:46 INFO - 'download_minidump_stackwalk': True, 18:23:46 INFO - 'download_symbols': 'ondemand', 18:23:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:23:46 INFO - 'tooltool.py': '/tools/tooltool.py', 18:23:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:23:46 INFO - '/tools/misc-python/virtualenv.py')}, 18:23:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:23:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:23:46 INFO - 'installer_path': 'installer.exe', 18:23:46 INFO - 'log_level': 'info', 18:23:46 INFO - 'log_name': 'talos', 18:23:46 INFO - 'log_to_console': True, 18:23:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:23:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:23:46 INFO - 'opt_config_files': (), 18:23:46 INFO - 'pip_index': False, 18:23:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:23:46 INFO - 'cmd': ('bash', 18:23:46 INFO - '-c', 18:23:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:23:46 INFO - 'enabled': True, 18:23:46 INFO - 'halt_on_failure': False, 18:23:46 INFO - 'name': 'check_screen_resolution'},), 18:23:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:23:46 INFO - 'cmd': ('bash', 18:23:46 INFO - '-c', 18:23:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:23:46 INFO - 'enabled': True, 18:23:46 INFO - 'halt_on_failure': False, 18:23:46 INFO - 'name': 'check_screen_resolution'},), 18:23:46 INFO - 'run_cmd_checks_enabled': True, 18:23:46 INFO - 'sps_profile': False, 18:23:46 INFO - 'sps_profile_interval': 0, 18:23:46 INFO - 'suite': 'dromaeojs', 18:23:46 INFO - 'system_bits': '32', 18:23:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:23:46 INFO - 'title': 't-yosemite-r7-0125', 18:23:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:23:46 INFO - 'use_talos_json': True, 18:23:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:23:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:23:46 INFO - 'work_dir': 'build'} 18:23:46 INFO - ##### 18:23:46 INFO - ##### Running clobber step. 18:23:46 INFO - ##### 18:23:46 INFO - Running pre-action listener: _resource_record_pre_action 18:23:46 INFO - Running main action method: clobber 18:23:46 INFO - rmtree: /builds/slave/test/build 18:23:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:23:48 INFO - Running post-action listener: _resource_record_post_action 18:23:48 INFO - ##### 18:23:48 INFO - ##### Running read-buildbot-config step. 18:23:48 INFO - ##### 18:23:48 INFO - Running pre-action listener: _resource_record_pre_action 18:23:48 INFO - Running main action method: read_buildbot_config 18:23:48 INFO - Using buildbot properties: 18:23:48 INFO - { 18:23:48 INFO - "project": "", 18:23:48 INFO - "product": "firefox", 18:23:48 INFO - "script_repo_revision": "production", 18:23:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:23:48 INFO - "repository": "", 18:23:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:23:48 INFO - "buildid": "20160309162727", 18:23:48 INFO - "pgo_build": "False", 18:23:48 INFO - "basedir": "/builds/slave/test", 18:23:48 INFO - "buildnumber": 481, 18:23:48 INFO - "slavename": "t-yosemite-r7-0125", 18:23:48 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:23:48 INFO - "platform": "yosemite_r7", 18:23:48 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:23:48 INFO - "branch": "fx-team", 18:23:48 INFO - "repo_path": "integration/fx-team", 18:23:48 INFO - "revision": "5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e", 18:23:48 INFO - "stage_platform": "macosx64", 18:23:48 INFO - "builduid": "90ca3250ccc0404cbd55735bc7241a23", 18:23:48 INFO - "slavebuilddir": "test" 18:23:48 INFO - } 18:23:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:23:48 INFO - Running post-action listener: _resource_record_post_action 18:23:48 INFO - ##### 18:23:48 INFO - ##### Running download-and-extract step. 18:23:48 INFO - ##### 18:23:48 INFO - Running pre-action listener: _resource_record_pre_action 18:23:48 INFO - Running main action method: download_and_extract 18:23:48 INFO - mkdir: /builds/slave/test/build/tests 18:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:23:48 INFO - https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:23:49 INFO - Downloaded 1199 bytes. 18:23:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:23:49 INFO - Using the following test package requirements: 18:23:49 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:23:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:49 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:23:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:49 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:23:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:49 INFO - u'jsshell-mac.zip'], 18:23:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:49 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:23:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:23:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:49 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:23:49 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:49 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:23:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:49 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:23:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:23:49 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:23:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:23:49 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')]} 18:23:49 INFO - https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:23:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:23:51 INFO - Downloaded 17866290 bytes. 18:23:51 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'] 18:23:51 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 18:23:54 INFO - Return code: 0 18:23:54 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 18:23:54 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')]} 18:23:54 INFO - https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:23:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:23:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:23:55 INFO - Downloaded 17866290 bytes. 18:23:55 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'] 18:23:55 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 18:23:59 INFO - Return code: 0 18:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:59 INFO - https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:23:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:23:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:23:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:24:00 INFO - Downloaded 10845161 bytes. 18:24:00 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'] 18:24:00 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 18:24:00 INFO - Return code: 0 18:24:00 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')]} 18:24:00 INFO - https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:24:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:24:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:24:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:24:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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 18:24:03 INFO - Downloaded 110927842 bytes. 18:24:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:24:03 INFO - mkdir: /builds/slave/test/properties 18:24:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:24:03 INFO - Writing to file /builds/slave/test/properties/build_url 18:24:03 INFO - Contents: 18:24:03 INFO - build_url:https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:24:04 INFO - Running post-action listener: _resource_record_post_action 18:24:04 INFO - Running post-action listener: set_extra_try_arguments 18:24:04 INFO - ##### 18:24:04 INFO - ##### Running populate-webroot step. 18:24:04 INFO - ##### 18:24:04 INFO - Running pre-action listener: _resource_record_pre_action 18:24:04 INFO - Running main action method: populate_webroot 18:24:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:24:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:24:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:24:04 INFO - '--tppagecycles', 18:24:04 INFO - '7'], 18:24:04 INFO - 'tests': ['tsvgm']}}, 18:24:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:24:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:24:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:24:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:24:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:24:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:04 INFO - 'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:24:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:04 INFO - 'tests': ['damp', 'tps']}, 18:24:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:04 INFO - 'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['damp', 'tps']}, 18:24:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:24:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:24:04 INFO - 'other': {'tests': ['a11yr', 18:24:04 INFO - 'ts_paint', 18:24:04 INFO - 'tpaint', 18:24:04 INFO - 'sessionrestore', 18:24:04 INFO - 'sessionrestore_no_auto_restore', 18:24:04 INFO - 'tabpaint']}, 18:24:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['a11yr', 18:24:04 INFO - 'ts_paint', 18:24:04 INFO - 'tpaint', 18:24:04 INFO - 'sessionrestore', 18:24:04 INFO - 'sessionrestore_no_auto_restore', 18:24:04 INFO - 'tabpaint']}, 18:24:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['a11yr', 18:24:04 INFO - 'ts_paint', 18:24:04 INFO - 'tpaint', 18:24:04 INFO - 'sessionrestore', 18:24:04 INFO - 'sessionrestore_no_auto_restore', 18:24:04 INFO - 'tabpaint']}, 18:24:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['a11yr', 18:24:04 INFO - 'ts_paint', 18:24:04 INFO - 'tpaint', 18:24:04 INFO - 'sessionrestore', 18:24:04 INFO - 'sessionrestore_no_auto_restore', 18:24:04 INFO - 'tabpaint']}, 18:24:04 INFO - 'other_l64': {'tests': ['a11yr', 18:24:04 INFO - 'ts_paint', 18:24:04 INFO - 'tpaint', 18:24:04 INFO - 'sessionrestore', 18:24:04 INFO - 'sessionrestore_no_auto_restore', 18:24:04 INFO - 'tabpaint']}, 18:24:04 INFO - 'other_nol64': {'tests': ['a11yr', 18:24:04 INFO - 'ts_paint', 18:24:04 INFO - 'tpaint', 18:24:04 INFO - 'sessionrestore', 18:24:04 INFO - 'sessionrestore_no_auto_restore', 18:24:04 INFO - 'tabpaint']}, 18:24:04 INFO - 'svgr': {'tests': ['tsvgx', 18:24:04 INFO - 'tsvgr_opacity', 18:24:04 INFO - 'tart', 18:24:04 INFO - 'tscrollx', 18:24:04 INFO - 'cart']}, 18:24:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['tsvgx', 18:24:04 INFO - 'tsvgr_opacity', 18:24:04 INFO - 'tart', 18:24:04 INFO - 'tscrollx', 18:24:04 INFO - 'cart']}, 18:24:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:04 INFO - 'tests': ['tp5o']}, 18:24:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:04 INFO - 'talos_options': ['--e10s'], 18:24:04 INFO - 'tests': ['tp5o']}, 18:24:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:04 INFO - 'talos_options': ['--xperf_path', 18:24:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:24:04 INFO - 'tests': ['tp5n']}, 18:24:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:04 INFO - 'talos_options': ['--e10s', 18:24:04 INFO - '--xperf_path', 18:24:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:24:04 INFO - 'tests': ['tp5n']}}, 18:24:04 INFO - 'talos.zip': {'path': '', 18:24:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:24:04 INFO - Running post-action listener: _resource_record_post_action 18:24:04 INFO - ##### 18:24:04 INFO - ##### Running create-virtualenv step. 18:24:04 INFO - ##### 18:24:04 INFO - Running pre-action listener: _resource_record_pre_action 18:24:04 INFO - Running main action method: create_virtualenv 18:24:04 INFO - Creating virtualenv /builds/slave/test/build/venv 18:24:04 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 18:24:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:24:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:24:05 INFO - Using real prefix '/tools/python27' 18:24:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:24:05 INFO - Installing distribute.............................................................................................................................................................................................done. 18:24:08 INFO - Installing pip.................done. 18:24:08 INFO - Return code: 0 18:24:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:08 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:08 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 18:24:08 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 18:24:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:08 INFO - 'HOME': '/Users/cltbld', 18:24:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:08 INFO - 'LOGNAME': 'cltbld', 18:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:08 INFO - 'MOZ_NO_REMOTE': '1', 18:24:08 INFO - 'NO_EM_RESTART': '1', 18:24:08 INFO - 'PAGER': '/bin/cat', 18:24:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:08 INFO - 'PWD': '/builds/slave/test', 18:24:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:08 INFO - 'SHELL': '/bin/bash', 18:24:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:08 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:08 INFO - 'USER': 'cltbld', 18:24:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:08 INFO - 'XPC_FLAGS': '0x0', 18:24:08 INFO - 'XPC_SERVICE_NAME': '0', 18:24:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:08 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 18:24:08 INFO - Cleaning up... 18:24:08 INFO - Return code: 0 18:24:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:08 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:08 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 18:24:08 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 18:24:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:08 INFO - 'HOME': '/Users/cltbld', 18:24:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:08 INFO - 'LOGNAME': 'cltbld', 18:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:08 INFO - 'MOZ_NO_REMOTE': '1', 18:24:08 INFO - 'NO_EM_RESTART': '1', 18:24:08 INFO - 'PAGER': '/bin/cat', 18:24:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:08 INFO - 'PWD': '/builds/slave/test', 18:24:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:08 INFO - 'SHELL': '/bin/bash', 18:24:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:08 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:08 INFO - 'USER': 'cltbld', 18:24:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:08 INFO - 'XPC_FLAGS': '0x0', 18:24:08 INFO - 'XPC_SERVICE_NAME': '0', 18:24:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:09 INFO - Downloading/unpacking psutil>=0.7.1 18:24:09 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 18:24:09 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 18:24:09 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 18:24:09 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 18:24:09 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 18:24:09 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 18:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:24:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:11 INFO - Installing collected packages: psutil 18:24:11 INFO - Running setup.py install for psutil 18:24:11 INFO - building 'psutil._psutil_osx' extension 18:24:11 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 18:24:12 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 18:24:12 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 18:24:12 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 18:24:12 INFO - building 'psutil._psutil_posix' extension 18:24:12 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 18:24:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:24:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:24:12 INFO - ^ 18:24:12 INFO - 1 warning generated. 18:24:12 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 18:24:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:12 INFO - Successfully installed psutil 18:24:12 INFO - Cleaning up... 18:24:12 INFO - Return code: 0 18:24:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:12 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:12 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 18:24:12 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 18:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:12 INFO - 'HOME': '/Users/cltbld', 18:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:12 INFO - 'LOGNAME': 'cltbld', 18:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:12 INFO - 'MOZ_NO_REMOTE': '1', 18:24:12 INFO - 'NO_EM_RESTART': '1', 18:24:12 INFO - 'PAGER': '/bin/cat', 18:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:12 INFO - 'PWD': '/builds/slave/test', 18:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:12 INFO - 'SHELL': '/bin/bash', 18:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:12 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:12 INFO - 'USER': 'cltbld', 18:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:12 INFO - 'XPC_FLAGS': '0x0', 18:24:12 INFO - 'XPC_SERVICE_NAME': '0', 18:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:24:12 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 18:24:12 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 18:24:12 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 18:24:12 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 18:24:12 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 18:24:12 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 18:24:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:24:15 INFO - Installing collected packages: mozsystemmonitor 18:24:15 INFO - Running setup.py install for mozsystemmonitor 18:24:15 INFO - Successfully installed mozsystemmonitor 18:24:15 INFO - Cleaning up... 18:24:15 INFO - Return code: 0 18:24:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:24:15 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')]} 18:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:15 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')]} 18:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:15 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:15 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 18:24:15 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 18:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:15 INFO - 'HOME': '/Users/cltbld', 18:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:15 INFO - 'LOGNAME': 'cltbld', 18:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:15 INFO - 'MOZ_NO_REMOTE': '1', 18:24:15 INFO - 'NO_EM_RESTART': '1', 18:24:15 INFO - 'PAGER': '/bin/cat', 18:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:15 INFO - 'PWD': '/builds/slave/test', 18:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:15 INFO - 'SHELL': '/bin/bash', 18:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:15 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:15 INFO - 'USER': 'cltbld', 18:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:15 INFO - 'XPC_FLAGS': '0x0', 18:24:15 INFO - 'XPC_SERVICE_NAME': '0', 18:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:15 INFO - Downloading/unpacking blobuploader==1.2.4 18:24:15 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 18:24:15 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 18:24:15 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 18:24:15 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 18:24:15 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 18:24:15 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 18:24:18 INFO - Downloading blobuploader-1.2.4.tar.gz 18:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:24:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:24:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:19 INFO - Downloading docopt-0.6.1.tar.gz 18:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:24:19 INFO - Installing collected packages: blobuploader, requests, docopt 18:24:19 INFO - Running setup.py install for blobuploader 18:24:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:24:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:24:19 INFO - Running setup.py install for requests 18:24:20 INFO - Running setup.py install for docopt 18:24:20 INFO - Successfully installed blobuploader requests docopt 18:24:20 INFO - Cleaning up... 18:24:20 INFO - Return code: 0 18:24:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:20 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')]} 18:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:20 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')]} 18:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:20 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:20 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 18:24:20 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 18:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:20 INFO - 'HOME': '/Users/cltbld', 18:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:20 INFO - 'LOGNAME': 'cltbld', 18:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:20 INFO - 'MOZ_NO_REMOTE': '1', 18:24:20 INFO - 'NO_EM_RESTART': '1', 18:24:20 INFO - 'PAGER': '/bin/cat', 18:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:20 INFO - 'PWD': '/builds/slave/test', 18:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:20 INFO - 'SHELL': '/bin/bash', 18:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:20 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:20 INFO - 'USER': 'cltbld', 18:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:20 INFO - 'XPC_FLAGS': '0x0', 18:24:20 INFO - 'XPC_SERVICE_NAME': '0', 18:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:20 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-9P6X4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:20 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-jFsjnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:20 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-GAuxDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:20 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-p7zq63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:20 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-LSgaiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-99upUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-GeujTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-bjhSC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ou5syx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-i15mVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-w8OnO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-QFuIgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-F5X0Dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-VazfP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:21 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-hhCN8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ZDpvfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ug9ylY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:24:22 INFO - Running setup.py install for manifestparser 18:24:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:24:22 INFO - Running setup.py install for mozcrash 18:24:22 INFO - Running setup.py install for mozdebug 18:24:22 INFO - Running setup.py install for mozdevice 18:24:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:24:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:24:22 INFO - Running setup.py install for mozfile 18:24:23 INFO - Running setup.py install for mozhttpd 18:24:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:24:23 INFO - Running setup.py install for mozinfo 18:24:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:24:23 INFO - Running setup.py install for mozInstall 18:24:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:24:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:24:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:24:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:24:23 INFO - Running setup.py install for mozleak 18:24:23 INFO - Running setup.py install for mozlog 18:24:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:24:23 INFO - Running setup.py install for moznetwork 18:24:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:24:23 INFO - Running setup.py install for mozprocess 18:24:24 INFO - Running setup.py install for mozprofile 18:24:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:24:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:24:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:24:24 INFO - Running setup.py install for mozrunner 18:24:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:24:24 INFO - Running setup.py install for mozscreenshot 18:24:24 INFO - Running setup.py install for moztest 18:24:24 INFO - Running setup.py install for mozversion 18:24:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:24:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:24:24 INFO - Cleaning up... 18:24:24 INFO - Return code: 0 18:24:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:24 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:24 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 18:24:24 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 18:24:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:24 INFO - 'HOME': '/Users/cltbld', 18:24:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:24 INFO - 'LOGNAME': 'cltbld', 18:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:24 INFO - 'MOZ_NO_REMOTE': '1', 18:24:24 INFO - 'NO_EM_RESTART': '1', 18:24:24 INFO - 'PAGER': '/bin/cat', 18:24:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:24 INFO - 'PWD': '/builds/slave/test', 18:24:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:24 INFO - 'SHELL': '/bin/bash', 18:24:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:24 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:24 INFO - 'USER': 'cltbld', 18:24:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:24 INFO - 'XPC_FLAGS': '0x0', 18:24:24 INFO - 'XPC_SERVICE_NAME': '0', 18:24:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:25 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-77_h46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:25 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)) 18:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:25 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-St8iIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:25 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)) 18:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:25 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-PUdHZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:25 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)) 18:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:25 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ek9LKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:25 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)) 18:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:25 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-znHBAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:25 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)) 18:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:25 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ujJ903-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:25 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)) 18:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:25 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-8aBDsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:25 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)) 18:24:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:25 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-sxe5qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-sSWt6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-QFi2RW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-07Acav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-l7Lanx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-t8AB16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-lpGub2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-8cJHhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-lI5kfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:26 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)) 18:24:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:26 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-cBflhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:27 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)) 18:24:27 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)) 18:24:27 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)) 18:24:27 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)) 18:24:27 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)) 18:24:27 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)) 18:24:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:29 INFO - Downloading blessings-1.6.tar.gz 18:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:24:29 INFO - Installing collected packages: blessings 18:24:29 INFO - Running setup.py install for blessings 18:24:29 INFO - Successfully installed blessings 18:24:29 INFO - Cleaning up... 18:24:29 INFO - Return code: 0 18:24:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:24:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:30 INFO - Reading from file tmpfile_stdout 18:24:30 INFO - Current package versions: 18:24:30 INFO - blessings == 1.6 18:24:30 INFO - blobuploader == 1.2.4 18:24:30 INFO - docopt == 0.6.1 18:24:30 INFO - manifestparser == 1.1 18:24:30 INFO - mozInstall == 1.12 18:24:30 INFO - mozcrash == 0.17 18:24:30 INFO - mozdebug == 0.1 18:24:30 INFO - mozdevice == 0.48 18:24:30 INFO - mozfile == 1.2 18:24:30 INFO - mozhttpd == 0.7 18:24:30 INFO - mozinfo == 0.9 18:24:30 INFO - mozleak == 0.1 18:24:30 INFO - mozlog == 3.1 18:24:30 INFO - moznetwork == 0.27 18:24:30 INFO - mozprocess == 0.22 18:24:30 INFO - mozprofile == 0.28 18:24:30 INFO - mozrunner == 6.11 18:24:30 INFO - mozscreenshot == 0.1 18:24:30 INFO - mozsystemmonitor == 0.0 18:24:30 INFO - moztest == 0.7 18:24:30 INFO - mozversion == 1.4 18:24:30 INFO - psutil == 3.1.1 18:24:30 INFO - requests == 1.2.3 18:24:30 INFO - wsgiref == 0.1.2 18:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24:30 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')]} 18:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:30 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')]} 18:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:30 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:30 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 18:24:30 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 18:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:30 INFO - 'HOME': '/Users/cltbld', 18:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:30 INFO - 'LOGNAME': 'cltbld', 18:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:30 INFO - 'MOZ_NO_REMOTE': '1', 18:24:30 INFO - 'NO_EM_RESTART': '1', 18:24:30 INFO - 'PAGER': '/bin/cat', 18:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:30 INFO - 'PWD': '/builds/slave/test', 18:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:30 INFO - 'SHELL': '/bin/bash', 18:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:30 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:30 INFO - 'USER': 'cltbld', 18:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:30 INFO - 'XPC_FLAGS': '0x0', 18:24:30 INFO - 'XPC_SERVICE_NAME': '0', 18:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 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)) 18:24:30 INFO - Cleaning up... 18:24:30 INFO - Return code: 0 18:24:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:24:30 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')]} 18:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:30 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')]} 18:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:30 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:30 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 18:24:30 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 18:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:30 INFO - 'HOME': '/Users/cltbld', 18:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:30 INFO - 'LOGNAME': 'cltbld', 18:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:30 INFO - 'MOZ_NO_REMOTE': '1', 18:24:30 INFO - 'NO_EM_RESTART': '1', 18:24:30 INFO - 'PAGER': '/bin/cat', 18:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:30 INFO - 'PWD': '/builds/slave/test', 18:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:30 INFO - 'SHELL': '/bin/bash', 18:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:30 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:30 INFO - 'USER': 'cltbld', 18:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:30 INFO - 'XPC_FLAGS': '0x0', 18:24:30 INFO - 'XPC_SERVICE_NAME': '0', 18:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:30 INFO - Downloading/unpacking jsonschema 18:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:24:32 INFO - Downloading/unpacking functools32 (from jsonschema) 18:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:24:33 INFO - Downloading functools32-3.2.3-2.tar.gz 18:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:24:33 INFO - warning: no files found matching '*.txt' 18:24:33 INFO - no previously-included directories found matching 'build' 18:24:33 INFO - no previously-included directories found matching 'dist' 18:24:33 INFO - no previously-included directories found matching '.git*' 18:24:33 INFO - Installing collected packages: jsonschema, functools32 18:24:33 INFO - Running setup.py install for functools32 18:24:33 INFO - warning: no files found matching '*.txt' 18:24:33 INFO - no previously-included directories found matching 'build' 18:24:33 INFO - no previously-included directories found matching 'dist' 18:24:33 INFO - no previously-included directories found matching '.git*' 18:24:33 INFO - Successfully installed jsonschema functools32 18:24:33 INFO - Cleaning up... 18:24:33 INFO - Return code: 0 18:24:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:24:33 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')]} 18:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:33 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')]} 18:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:33 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 0x101297a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10129f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaf856d640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, '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.nXcPPwvny3/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.5OWfJuwX7l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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 18:24:33 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 18:24:33 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 18:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:24:33 INFO - 'HOME': '/Users/cltbld', 18:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:24:33 INFO - 'LOGNAME': 'cltbld', 18:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:33 INFO - 'MOZ_NO_REMOTE': '1', 18:24:33 INFO - 'NO_EM_RESTART': '1', 18:24:33 INFO - 'PAGER': '/bin/cat', 18:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:33 INFO - 'PWD': '/builds/slave/test', 18:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:24:33 INFO - 'SHELL': '/bin/bash', 18:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:24:33 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:24:33 INFO - 'USER': 'cltbld', 18:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:33 INFO - 'XPC_FLAGS': '0x0', 18:24:33 INFO - 'XPC_SERVICE_NAME': '0', 18:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:33 INFO - Downloading/unpacking flake8 18:24:33 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 18:24:33 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 18:24:33 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 18:24:33 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 18:24:33 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 18:24:33 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 18:24:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:24:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:24:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:36 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 18:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:24:37 INFO - no previously-included directories found matching 'docs/_build' 18:24:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:24:37 INFO - Running setup.py install for pep8 18:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:24:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:24:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:24:37 INFO - no previously-included directories found matching 'docs/_build' 18:24:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:24:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:24:37 INFO - Cleaning up... 18:24:37 INFO - Return code: 0 18:24:37 INFO - Running post-action listener: _resource_record_post_action 18:24:37 INFO - Running post-action listener: _start_resource_monitoring 18:24:37 INFO - Starting resource monitoring. 18:24:37 INFO - ##### 18:24:37 INFO - ##### Running install step. 18:24:37 INFO - ##### 18:24:37 INFO - Running pre-action listener: _resource_record_pre_action 18:24:37 INFO - Running main action method: install 18:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:24:38 INFO - Reading from file tmpfile_stdout 18:24:38 INFO - Detecting whether we're running mozinstall >=1.0... 18:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:24:38 INFO - Reading from file tmpfile_stdout 18:24:38 INFO - Output received: 18:24:38 INFO - Usage: mozinstall [options] installer 18:24:38 INFO - Options: 18:24:38 INFO - -h, --help show this help message and exit 18:24:38 INFO - -d DEST, --destination=DEST 18:24:38 INFO - Directory to install application into. [default: 18:24:38 INFO - "/builds/slave/test"] 18:24:38 INFO - --app=APP Application being installed. [default: firefox] 18:24:38 INFO - mkdir: /builds/slave/test/build/application 18:24:38 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'] 18:24:38 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 18:25:12 INFO - Reading from file tmpfile_stdout 18:25:12 INFO - Output received: 18:25:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:25:12 INFO - Running post-action listener: _resource_record_post_action 18:25:12 INFO - ##### 18:25:12 INFO - ##### Running run-tests step. 18:25:12 INFO - ##### 18:25:12 INFO - Running pre-action listener: _resource_record_pre_action 18:25:12 INFO - Running main action method: run_tests 18:25:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:25:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:25:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:25:12 INFO - 2016-03-09 18:25:12.409 screenresolution[2870:33396] starting screenresolution argv=screenresolution get 18:25:12 INFO - 2016-03-09 18:25:12.411 screenresolution[2870:33396] Display 0: 1600x1200x32@60 18:25:12 INFO - 2016-03-09 18:25:12.417 screenresolution[2871:33398] starting screenresolution argv=screenresolution list 18:25:12 INFO - Available Modes on Display 0 18:25:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:25:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:25:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:25:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:25:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:25:12 INFO - Intel Iris: 18:25:12 INFO - Chipset Model: Intel Iris 18:25:12 INFO - Type: GPU 18:25:12 INFO - Bus: Built-In 18:25:12 INFO - VRAM (Dynamic, Max): 1536 MB 18:25:12 INFO - Vendor: Intel (0x8086) 18:25:12 INFO - Device ID: 0x0a2e 18:25:12 INFO - Revision ID: 0x0009 18:25:12 INFO - Displays: 18:25:12 INFO - Display: 18:25:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:25:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:25:12 INFO - Display Serial Number: 1600x1200 60 18:25:12 INFO - Main Display: Yes 18:25:12 INFO - Mirror: Off 18:25:12 INFO - Online: Yes 18:25:12 INFO - Rotation: Supported 18:25:12 INFO - Return code: 0 18:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:25:12 INFO - Python 2.7.3 18:25:12 INFO - Return code: 0 18:25:12 INFO - grabbing minidump binary from tooltool 18:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:25:12 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10113bd30>, '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 0x100f5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101132b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:25:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:25:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:25:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:25:12 INFO - Return code: 0 18:25:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:25:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:25:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:25:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:25:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:25:13 INFO - Return code: 0 18:25:13 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/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--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 18:25:13 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/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0125 --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 18:25:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXcPPwvny3/Render', 18:25:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:25:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:25:13 INFO - 'HOME': '/Users/cltbld', 18:25:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:25:13 INFO - 'LOGNAME': 'cltbld', 18:25:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:13 INFO - 'MOZ_NO_REMOTE': '1', 18:25:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:13 INFO - 'NO_EM_RESTART': '1', 18:25:13 INFO - 'PAGER': '/bin/cat', 18:25:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:13 INFO - 'PWD': '/builds/slave/test', 18:25:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:25:13 INFO - 'SHELL': '/bin/bash', 18:25:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5OWfJuwX7l/Listeners', 18:25:13 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 18:25:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:25:13 INFO - 'USER': 'cltbld', 18:25:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:25:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:13 INFO - 'XPC_FLAGS': '0x0', 18:25:13 INFO - 'XPC_SERVICE_NAME': '0', 18:25:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:25:13 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/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--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 18:25:14 INFO - mozversion application_buildid: 20160309162727 18:25:14 INFO - mozversion application_changeset: 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e 18:25:14 INFO - mozversion application_display_name: Nightly 18:25:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:25:14 INFO - mozversion application_name: Firefox 18:25:14 INFO - mozversion application_remotingname: firefox 18:25:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:25:14 INFO - mozversion application_vendor: Mozilla 18:25:14 INFO - mozversion application_version: 48.0a1 18:25:14 INFO - mozversion platform_buildid: 20160309162727 18:25:14 INFO - mozversion platform_changeset: 5c3790398ff5a5d8ed214c4cbf3d17d3438cdf7e 18:25:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:25:14 INFO - mozversion platform_version: 48.0a1 18:25:14 INFO - using testdate: 1457576714 18:25:14 INFO - actual date: 1457576714 18:25:14 INFO - starting webserver on 'localhost:64485' 18:25:14 INFO - SUITE-START | Running 2 tests 18:25:14 INFO - TEST-START | dromaeo_css 18:25:14 INFO - operating with platform_type : mac_ 18:25:14 INFO - Initialising browser for dromaeo_css test... 18:25:14 INFO - TEST-INFO | started process 2889 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpZzLFS1/profile http://localhost:64485/getInfo.html) 18:25:16 INFO - PROCESS | 2889 | __metrics Screen width/height:1600/1200 18:25:16 INFO - PROCESS | 2889 | colorDepth:24 18:25:16 INFO - PROCESS | 2889 | Browser inner width/height: 1024/689 18:25:16 INFO - PROCESS | 2889 | __metrics 18:25:16 INFO - PROCESS | 2889 | 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" 18:25:16 ERROR - PROCESS | 2889 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:25:17 INFO - TEST-INFO | 2889: exit 0 18:25:17 INFO - Browser initialized. 18:25:17 INFO - Running cycle 1/1 for dromaeo_css test... 18:25:17 INFO - TEST-INFO | started process 2892 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpZzLFS1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:25:28 INFO - PROCESS | 2892 | RSS: Main: 242814976 18:25:28 INFO - PROCESS | 2892 | 18:26:19 INFO - PROCESS | 2892 | 1457576779887 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] 18:28:29 INFO - PROCESS | 2892 | Cycle 1(1): loaded http://localhost:64485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64485/tests/dromaeo/cssquery-ext.html) 18:28:31 INFO - PROCESS | 2892 | RSS: Main: 346746880 18:28:31 INFO - PROCESS | 2892 | 18:31:33 INFO - PROCESS | 2892 | Cycle 1(1): loaded http://localhost:64485/tests/dromaeo/cssquery-ext.html (next: http://localhost:64485/tests/dromaeo/cssquery-jquery.html) 18:31:34 INFO - PROCESS | 2892 | RSS: Main: 375443456 18:31:34 INFO - PROCESS | 2892 | 18:34:36 INFO - PROCESS | 2892 | Cycle 1(1): loaded http://localhost:64485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64485/tests/dromaeo/cssquery-mootools.html) 18:34:36 INFO - PROCESS | 2892 | RSS: Main: 376913920 18:34:36 INFO - PROCESS | 2892 | 18:37:38 INFO - PROCESS | 2892 | Cycle 1(1): loaded http://localhost:64485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64485/tests/dromaeo/cssquery-prototype.html) 18:37:39 INFO - PROCESS | 2892 | RSS: Main: 332148736 18:37:39 INFO - PROCESS | 2892 | 18:40:42 INFO - PROCESS | 2892 | Cycle 1(1): loaded http://localhost:64485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64485/tests/dromaeo/cssquery-yui.html) 18:40:43 INFO - PROCESS | 2892 | RSS: Main: 333791232 18:40:43 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | Cycle 1(1): loaded http://localhost:64485/tests/dromaeo/cssquery-yui.html (next: http://localhost:64485/tests/dromaeo/cssquery-dojo.html) 18:43:46 INFO - PROCESS | 2892 | RSS: Main: 406122496 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | __start_tp_report 18:43:46 INFO - PROCESS | 2892 | _x_x_mozilla_page_load 18:43:46 INFO - PROCESS | 2892 | _x_x_mozilla_page_load_details 18:43:46 INFO - PROCESS | 2892 | |i|pagename|runs| 18:43:46 INFO - PROCESS | 2892 | |0;dojo.html;3355.530225768392;3432.7597068205237;3467.9653203467956;3475.947860782088;3520.6655367740073;5551.417101204376;5617.662940223589;5656.660600363976;5691.9146212806845;5697.259356283683;5685.573581981347;5706.229658996034;5746.7413966371505;5813.128030795383;5821.18503409523;5084.872878178038;5139.25480805283;5153.252778347156;5156.149235376159;5249.711265880375;5287.920681189786;5288.2596436498925;5316;5348.91976620351;5375.946240537603;4335.241332766785;5080.491950804909;5134.255532947702;5177.559907407856;5241.606879484016;5202.92195617066;5215.269862219292;5218.791248350061;5237.397699264595;5252.579793616502;4201.474815648044;5167.9224811627855;5196.272521846944;5201.505856943584;5229.450907654679;5489.231507588941;5569.331680198362;5640.774369025234;5663.801766938137;5666.433356664342;6226.906596401058;6231.470325022378;6245.718942647592;6253.312135665074;6264.561480696353;6306.085617585424;6311.400416960381;6319;6319.4312511873695;6328.240611126648;5666.150077488369;5677.347105082886;5753.194552762617;5784.479396854261;5798.246227990334;6218.22272215973;6250.249970003629;6269.811905642838;6288.591241569284;6308.905366419507;6055.757769689163;6106.6336019838955;6125.1731016313115;6133.3866613338305;6146;6210.4100110489435;6259.061140828912;6268.09112678659;6275.090111933744;6287.119803227461;6070.271567411939;6095.05526643371;6128.228138398679;6144.41628045335;6158.876822463526;6233.657148856856;6235.719392627252;6242.375762423721;6250.4374606285655;6250.562460627712;4858.416989961227;4908.263760435963;4917.336159618406;4935.555799978019;4944.258361245842;4331.242032644274;4335.783210839509;4421.668374871898;4448.399466072039;4493.1013797240685;5630.352509461382;5681.34664513578;5687.829365119053;5699.031164701928;5718.628289161191;6253.843653908689;6277.654728989949;6279.183706118175;6293.402126797947;6304.621722696653;4952.4057113146655;5582.804601838998;5680.375158732536;5748.338941021752;5764.365919748824;5303.071962406563;5308.097623404031;5310.097283461821;5318.44156363584;5326;6266.655333956585;6271.905921411091;6273.059041143773;6273.811785646438;6279.466245369194;6108.797423689751;6187.9480488317995;6274;6292.9370706294185;6298.527610429328;6216.409441103088;6232.937670623236;6274.341194174546;6278.309385967448;6284.905726414199;6059.545534084873;6168.35232300602;6205.6586887721605;6217.222847144107;6217.316095229431;6185.721642526007;6208.813735587759;6217.253929528486;6227.813165605039;6262.342454042442;5074.644774865724;6093.625290627054;6103.216452666749;6120.9347721082095;6129.632222066691;6033.3061697905305;6067.939320606737;6091.299500557493;6106.419890110433;6108.908366374597;4846.297286893451;5738.340090889601;5883.382244864228;5929.110633405024;5929.377415371324;6097.207363042776;6106.2061931948565;6118.449339559461;6130.969345153424;6134.202553667995;5970.731317090655;5977.701114944322;6006.099085137264;6006.129111278928;6008.639481631116 18:43:46 INFO - PROCESS | 2892 | |1;ext.html;459.7816037382242;549.966063800056;592.3707229593736;593.623049363654;644.8678021005694;30473.390532189344;30887.227819304528;30906.690933090664;30911.84544077282;30934.69065309346;39219;40059.198816023665;40120.996975075635;40227;40332.99167520813;9590.23278137749;9780.55987480565;9797.363171393836;9804.607815687365;9851.458169800693;9613.038696130401;9755.707328780112;9757.658481953133;9765.804683906317;9767.316287859852;9689.127978481934;9707.70876873695;9722.173615242678;9730.610775568968;9740;9690.854637180413;9745.707628771148;9748.95125524375;9751.073648003428;9751.804963900753;9638.903610963871;9759.560819763057;9761.219102471785;9766;9769;40632.39051414231;41008.179836403106;41030.79484602558;41031.384529231786;41138.794306028576;3198.184462961953;3238.1742655622666;3360.025592578174;3465.6534346565395;3589.730770192246;27645;30257;31118.53322200169;31187.532187017212;31213.063608091794;2741.4105967217142;2749.931251718703;2824.6751623563346;2891.0459548348995;2910.185148158519;490525;497457;497677;498579;499734;73979.63010184915;73991;74827.62586187034;74966;75088.62455687686;79748.20251797407;80425;80489.59755201187;80506;80632.19367806365;14587.708245835023;17502.649947000988;17716.025618591102;17723.556911077067;17771.289148434178;12562.748745025048;13281.26953017574;13285.73428531424;13301.06892517534;13313.068085234134;22183.66724499134;23149.7685023151;23685.526289474114;23714.644280335808;23724.881375593013;7482.401407887356;8989.370744047854;9523.52382380892;9849.803003940024;10302.557641930136;955.3264948211494;1019.2864994503728;1079.63292480557;1095.8055719266038;1146.8165093584987;29227.179848423468;29264.414711705645;29742.553861692093;30143;30190.849045754632;1107.3687997841153;1144.9370284634258;1164.6913567904512;1178.1517307538559;1184.656449629615;14860.925695371454;14936.626584335478;15160.393584256726;15195.544133676007;15243.847561524464;534643;538373;538898;539737;543557;58316.708416457644;59317.813643726884;59358.81282374328;59368;59399;1329.1427029566069;1337.7859542473157;1460.4085345435117;1461.4300422835104;1486.3385793322084;28421.715782842733;28682.42635147327;28949.35412137987;29147.979820706172;29710.663020163713;37033.81483092567;46126.769366152956;47150.528494714614;47779;47956.280655789495;368814;370694;371125;371361;372386;28856.422871542873;29306.413871722874;32368.83815580907;32994.54573632625;33401.66598334083;41480.58519414888;42040.579594203664;42354;42506;42655.50705725285;34970;36272.81863590665;36280.63719362878;36538.63461365458;37339.62660373362;35583.288334233686;35639.75260865857;36199.27601448009;36381.63618363888;36544.81727591345;29449.11652650424;34850;35416.64583354133;36165.27669446649;36482;31129;31795.84102079475;31858.840705796323;31904.840475798403;32906.01281961545;21137.471563211042;22323.77676223282;23754.881225594454;24088;24202.636960445958 18:43:46 INFO - PROCESS | 2892 | |2;jquery.html;359.40159634209044;364.13881171030505;365.5430711610488;369.62852333404925;374.07603220046474;15903.761443578342;20304.593908121846;21267.97954194351;21781.64367126573;21885.343439696833;12291.815622765644;17601;20045.1981920723;20729.378118656427;20753.688694669592;5200.8699782505455;5307.761150748225;5368.543673787733;5376.704281264529;5377.838664840042;3907.4138879168067;4111.259973204822;5243.187305967562;5627.212190293362;5865.7360418781045;5843.912341314884;5845.415458454163;5848.976429124908;5856.882862342751;5859.296884373881;5633.57748168889;5712.057510510761;5786.942130578725;5803.013487707079;5825.126231065332;5540.307461567304;5552.472515111058;5553.8333849984565;5556.749946252428;5564.527015203713;15791.684166316609;24816.875915620487;25382.746172538224;25873.741262587322;25875.61186582203;1930.5270208798934;2071.4153672440593;2114.619368513667;2144.356692992096;2152.7416709994745;9992.150667193297;10328.070473657332;14176.078554893898;14616.780748288784;14874.776878346833;1758.1121533625565;1763.2946821271466;1776.5558610347414;1811.6467288878673;1835.3943198744516;103333;109653.80692386108;114525.99999999917;115513.42243288814;116190.83809161969;11381.943090284496;11426.885731142582;11482.96653301207;11519;11568.305901645928;13712.725745485035;13798.586042418743;13799.724005520035;13844.930775346058;13849.099808512414;8533.786655333543;8607.870881936651;8611.39720219591;8615;8713.128687131362;8796.47221166732;8818.29453643707;8842.778930526789;8888.022317545065;8925.241354484811;3688.8524459021874;4485.416895803524;4507.57178068083;4508.143452744033;4545.38637283969;1592.2118551317171;1665.292250793408;1763.5502946748497;1817.7909540403023;1867.3930972434014;837.388706244445;869.860822268434;910.8542633178793;975.7560609847538;980.475445636581;18919.81080189208;19296.61406771885;19490.610187796166;19770.802291976896;20027.59944801096;908.5230254116642;932.8320902237663;982.9017098290113;984.7538115471132;1029.3566520924421;10203.234757393077;10647.680569582924;10710.678679639623;10735;10846.969537893887;619087;623029;626656;643427;645518;113507;121112.57774844454;121331;121384.17923731152;125030;1011.5650270383805;1028.4857571214243;1037.7924415117006;1057.1701214546545;1058.8147074261974;17369.957802531888;17462.388816391365;17612.119394030502;18016.91898486095;18080.367187148386;49917;50736;51502.74248628733;51572.48427515827;52510;71085.64457177681;71296;71950;72764;72805;7871.567063811545;7875.684972601031;8053.154418786177;8057.355411566943;8198.1391953844;12577.496900124259;12794.552190673281;12920.483180672667;13175.736485270432;13198.340082995619;9850.950745246515;10251.641192558225;11277.71805704864;11567;11606.767864642828;10832.24174307791;11009.449527523751;11173.664790055986;11387.544498219979;11439.714007149887;11186;11689.532418703157;11904.642860714192;11939.223950443193;11946;8035.236652518235;8057.395695322757;8127.837443250984;8155.632996515053;8358.45670031446;11533.365664888512;11559.017483513659;11589.130815188726;11659.475323610288;11859.34773587461 18:43:46 INFO - PROCESS | 2892 | |3;mootools.html;1433.7562614355559;1557.1902610642464;1593.1874743880621;1878.2111513164477;2035.063870619515;8145.674173033079;8741.825163496735;8915.1976322131;8924.866127008085;8960.148785865349;8610.138986101387;8854.734357969255;8859.822803543926;8867.733967980956;8875.91124088759;2472.369545765832;2498.3129639349145;2499.5000999800022;2501.4871951250043;2502.099244272061;2443.8655873926928;2516.7609077137645;2521.8612976286295;2523.987380063097;2543.885525151373;2478.9008439662393;2511.7739403453684;2539.8349107307968;2544.656471376359;2546.1852207293673;2131.989340053305;2500.1874390822964;2513.7863281621085;2528.886200120999;2529.696436427622;2462.162864626018;2480.5659009673236;2486.539990101837;2489.4896546208165;2537.314924970248;9003.684871029482;9065.184133428023;9066.54667266634;9081.500517471537;9103.544822758902;5400.972995135038;5613.382527921925;5615.241942337773;5616.438356164351;5632.971835140839;3597.2805438912324;3690.464882592036;3742.925141497182;3749.8687545936036;3750.062484378905;887.2901678657048;1068.5725709716098;1070.0743856564015;1071.0735214039798;1077.380506208933;12233.571824986082;12285.938570307091;12292.569760058355;12301.69245768854;12324.260544367367;4908.263760435963;4935.8025678972435;4973.55238028572;4979.0788704089855;5033.119204139261;10383.584656613803;10395.636152734618;10420.426876521864;10427.113695335982;10454.32046916948;5579.414161513064;5587.8603034923635;5596.160575913564;5599;5599.636023658449;4506.211413002711;4561.749103799323;4590.104929538707;4623.791929363119;5147.510986456281;3904.4533765272886;3910.9608903911167;4005.1589166275407;4010.5187377514303;4010.8997275068355;1303.3808940753067;1304.1979182802509;1306.5427100514935;1317.0188209783773;1320.2078752748275;979.2655508368723;1016.4561959351711;1180.527788884453;1267.518343029643;1416.7591509443419;7949.324307433817;7950.3242224410415;8071.677132914735;8079.4344395892895;8085.878711819328;1184.8755880632582;1192.4693511387522;1194.1760185471996;1203.1096988228649;1218.9939050304693;6245.219347581552;6248.593841400385;6325.778597749057;6335.334789847092;6342.651154186472;10575.62985295511;11068.944655276833;11077.279976801483;11092.722681933015;11122;9688.90311096894;10560.996705312982;10855.348679079123;10937.671869843918;10947.014768670859;8531.530765807816;8580.613872375758;8616.310695144373;8618.482891026559;8636.877205963185;7780.805479863048;8024.157463466252;8059.83880322402;8071.23323284287;8112.513249205066;9420.481873497023;9747.463889486145;9805.460699661588;9848.458334791656;9854.950725246328;9802.50987450639;10121.493925303557;10122.89877101249;10282.280240383101;10305.175585953255;6671.799846004627;7471.626418679153;7482.738104166328;7522.887156692764;7554.697812087455;8103.1491693371345;8361.456505327134;8398;8424.452410593292;8443.746687599381;7425.443091768247;7468.477206595486;7524.623768811428;7610.961945190239;7739.187385324685;7431.516951398142;7471;7473;7546.584937828472;7645.426593005435;7861.921380786348;7899.0126234220725;7932.960335198287;7957.124716281321;7957.124716281321;7120.964395177991;7121.430285577245;7192.8921066183;7202.135743710788;7209.387202087882;7261.636918154177;7297.306755858185;7326.780196594111;7329.706811727685;7349.595772232578 18:43:46 INFO - PROCESS | 2892 | |4;prototype.html;285.8299311909413;319.88963807486414;320.31612507296927;331.1671147065131;334.07961067259697;6421.711023003964;6605.900911486319;6609.900851487231;6625.569337993039;6681.164854393201;6394.136791533142;6511.902321465182;6516.152900122989;6538.803835884919;6540.771073012445;4550.408446901898;4663.976680116594;4678.298255261721;4780.784864681098;4810.470848206694;3886.805659717017;4747.572718455338;4769.284607308897;4781.115493633689;4787.066522028206;4673.158831410345;4709.62323014158;4710.62315014798;4719.811207551694;4760.880977975544;3919.529656441231;4516.277395616718;4594.104149690778;4704.082703872747;4712.010477799666;4021.336479480882;4023.6982226333143;4042.8180731867137;4044.4539987101657;4046.858359957387;6161.353057928943;6179.5674302798825;6224.62652240867;6226.346233645448;6229.688515574203;5507.531859791922;5530.281063461724;5531.1426728857095;5536.197251398525;5537.833864984057;5922.58541902067;6904.13698287714;6904.930950690479;6909.550879192836;6913.239543650195;3921.764644137116;4126.731762435432;4450.465944086698;4472.418585583886;4480.19356515827;5528.723563821793;7161.641917904084;7305.926940730577;7368.668409921566;7430.702771889172;4562.201614717411;4586.747728874877;4590.70160439577;4594.19601569724;4595.310703394518;4643.791029403685;4649.837255696035;4658.3711198988385;4663.253879379283;4668.85993420198;5513.5037846594;5516.420775818481;5516.696581688046;5518.144687573433;5527.198556209327;5968.46283834457;6696.363845434676;6767.492438067165;7006.01915731798;7025.683844227022;1298.785700359449;1595.1386251424333;1602.3430393538592;1604.751263554151;1609.6136927137636;1014.9543270552842;1015.9288849780593;1032.1639472027682;1042.3849928542197;1043.0664555223034;6241.095041218998;6378.107065010902;6420.7431702731365;6552.868942621121;6566.737330506822;5966.522678185735;7205.775018246806;7266.055412796409;7268.164161121433;7296.12446506412;6508.576942498722;6515.641639709766;6519.282878883319;6522.64125473094;6529.465575589733;3127.4839651457255;3794.962050379516;3816.580176180618;3846;3853.306404847154;7253.637318134178;7610.277023682741;7618.733344332922;7636.31273185416;7683.769486915401;7499.325060744559;7542;7553.962230188814;7566.583837888859;7567.394608431422;6156.476699480505;7657.693692252359;7669.578173200416;7681.731139410093;7714.382849372149;7331.266873312626;7333.230010848784;7335.376492997942;7347.889781653386;7380.852382952204;6901.275366086689;7106.822329441805;7130.786076417716;7132.607706575981;7146.9285307146265;6142.846428839315;7531.849363012819;7595.012648355679;7597.354224890946;7612.162662107275;4524.932126018178;4570.702904311209;4574.199515084913;4576.771161441848;4579.38178345919;7220.927790722236;7225.205227424874;7231.349178573953;7235.384992275505;7238.23998480152;6734.696938637675;6951.16586009682;7008.264132266243;7018.649067546704;7024.964875175591;6952.339527744856;6957.443404527525;6968.3728464438445;6978.232394436709;6981.930180698128;6096.634201947897;6302.89699302611;6828.248892621708;6830.556013859084;6836.555623884432;5639.464250896158;6728.327167283428;6972.616506092214;6984.650767461708;6993.8251543709775;6563.803085907431;6667.733290668319;6692.732290708317;6794.184697836291;6838.7264509419065 18:43:46 INFO - PROCESS | 2892 | |5;yui.html;693.9618320992345;706.636082417555;739.1795107430751;779.7933547609884;792.1698587330258;15276.618084547878;15292.006019608732;15357.232138393063;15416.383344666228;15438.228088595568;14005.719885602282;14118.505852295171;14161.22113283769;14165.78751318731;14185.503507377243;745.057502259642;913.6710784117696;932.5337331334333;933.286036182321;934.0799312677008;752.1613401057808;899.5322432335182;935.6958988328786;936.2135805923024;940.6425558287841;988.6490295944944;992.7964767222738;998.4159266828914;999.5252255178805;1000.3897622450299;785.4698078796846;948.5115165689675;987.0573602209909;990.8018396320729;993.9105480506753;726.1576571177409;726.887332463469;728.8542291541713;730.087390761548;730.1858427852959;14910.552683419515;14988.625284367869;14990.850091499055;14991.32539035746;15005.474808381654;12432.502699891993;12434.316112613802;12532.248065116122;12663.62009139718;13011.804822927663;8440.57797110142;9903.306768526207;10412.68761937143;10618.57525698971;10854.72863178419;3502.7548071634997;3654.8720794772057;3732.701383889282;3761.924761504782;3769.641884021041;76793.61603191949;77557.22442775613;77793;77814.61092694501;79128;9337;9343;9370.203532699661;9617.471039092918;9688.224942004623;22325.99533021018;22337;22361.55276894453;22369;22401.21595744174;7339.376153027052;7530.623468826537;7533.849323013509;7555.811104722426;7606;4047.2917239483563;4118.073433477443;4118.5057793065025;4214.957850421518;4365.912681746411;3596.6223546527763;3648.1426864686778;3649.525561676965;3652.7625704329134;3657.707383409374;644.8968165093562;659.3340725866909;662.2053535757015;662.9337066293429;667.4935616759038;556.9443055694398;595.2083728640897;596.4572239262251;603.405645439242;611.0864257934417;8270.2556769891;8273.172682731678;8314.210150035737;8421.073681894986;8520.488770673655;526.9314989051476;592.4401440638555;603.6800495737266;604.1934018085817;614.7018695932469;3762.567304759933;3816.7709937403843;3830.6743926766535;3929.390944403622;4059.9797001014804;90932.09067909369;92396.53801730949;92990;93286.53356733173;95553;69173.2706682337;72373.638131809;80191;80392.59803701061;81404.18595814085;70596.64701676561;71362;71648.28351716416;73497;74901;6140.13171701825;7786.727464538941;7796.181400953045;7945.920540794749;8222.136675648972;50206;51010.48989510206;51208;51866.74066629643;52893.65276166885;68912.3108768906;70056;70850;71019;71254.57490850257;10273.74315642115;10309.329893557195;10416.010479004482;10824.891751082703;10895.400752958663;10747.570097196025;10859.83710244331;10928.672139835817;11140.610078647209;11334.773304534028;10251.538680759235;10439.791204176026;10476.319039262424;10476.738081548023;10558.366498010144;10397;10409.895901041196;10539.57841686324;10715.892841071802;10717;9550.351195643661;9611.951940240255;10209.591616335263;10279;10517.316374435637;8685.913140868763;8790.648374065222;8858.24319813476;9041.77395565116;9208.769780755267;8151.63317650719;8315.293200077818;8894.599743011451;9035.299287422935;9063.365564410427 18:43:46 INFO - PROCESS | 2892 | __end_tp_report 18:43:46 INFO - PROCESS | 2892 | __start_cc_report 18:43:46 INFO - PROCESS | 2892 | _x_x_mozilla_cycle_collect,1011 18:43:46 INFO - PROCESS | 2892 | __end_cc_report 18:43:46 INFO - PROCESS | 2892 | __startTimestamp1457577826258__endTimestamp 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | ------- Summary: start ------- 18:43:46 INFO - PROCESS | 2892 | Number of tests: 6 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | [#0] dojo.html Cycles:165 Average:5712.56 Median:5977.70 stddev:655.64 (11.0%) stddev-sans-first:631.04 18:43:46 INFO - PROCESS | 2892 | Values: 3355.5 3432.8 3468.0 3475.9 3520.7 5551.4 5617.7 5656.7 5691.9 5697.3 5685.6 5706.2 5746.7 5813.1 5821.2 5084.9 5139.3 5153.3 5156.1 5249.7 5287.9 5288.3 5316.0 5348.9 5375.9 4335.2 5080.5 5134.3 5177.6 5241.6 5202.9 5215.3 5218.8 5237.4 5252.6 4201.5 5167.9 5196.3 5201.5 5229.5 5489.2 5569.3 5640.8 5663.8 5666.4 6226.9 6231.5 6245.7 6253.3 6264.6 6306.1 6311.4 6319.0 6319.4 6328.2 5666.2 5677.3 5753.2 5784.5 5798.2 6218.2 6250.2 6269.8 6288.6 6308.9 6055.8 6106.6 6125.2 6133.4 6146.0 6210.4 6259.1 6268.1 6275.1 6287.1 6070.3 6095.1 6128.2 6144.4 6158.9 6233.7 6235.7 6242.4 6250.4 6250.6 4858.4 4908.3 4917.3 4935.6 4944.3 4331.2 4335.8 4421.7 4448.4 4493.1 5630.4 5681.3 5687.8 5699.0 5718.6 6253.8 6277.7 6279.2 6293.4 6304.6 4952.4 5582.8 5680.4 5748.3 5764.4 5303.1 5308.1 5310.1 5318.4 5326.0 6266.7 6271.9 6273.1 6273.8 6279.5 6108.8 6187.9 6274.0 6292.9 6298.5 6216.4 6232.9 6274.3 6278.3 6284.9 6059.5 6168.4 6205.7 6217.2 6217.3 6185.7 6208.8 6217.3 6227.8 6262.3 5074.6 6093.6 6103.2 6120.9 6129.6 6033.3 6067.9 6091.3 6106.4 6108.9 4846.3 5738.3 5883.4 5929.1 5929.4 6097.2 6106.2 6118.4 6131.0 6134.2 5970.7 5977.7 6006.1 6006.1 6008.6 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | [#1] ext.html Cycles:180 Average:62197.12 Median:36431.82 stddev:126190.57 (346.4%) stddev-sans-first:126459.43 18:43:46 INFO - PROCESS | 2892 | Values: 459.8 550.0 592.4 593.6 644.9 30473.4 30887.2 30906.7 30911.8 30934.7 39219.0 40059.2 40121.0 40227.0 40333.0 9590.2 9780.6 9797.4 9804.6 9851.5 9613.0 9755.7 9757.7 9765.8 9767.3 9689.1 9707.7 9722.2 9730.6 9740.0 9690.9 9745.7 9749.0 9751.1 9751.8 9638.9 9759.6 9761.2 9766.0 9769.0 40632.4 41008.2 41030.8 41031.4 41138.8 3198.2 3238.2 3360.0 3465.7 3589.7 27645.0 30257.0 31118.5 31187.5 31213.1 2741.4 2749.9 2824.7 2891.0 2910.2 490525.0 497457.0 497677.0 498579.0 499734.0 73979.6 73991.0 74827.6 74966.0 75088.6 79748.2 80425.0 80489.6 80506.0 80632.2 14587.7 17502.6 17716.0 17723.6 17771.3 12562.7 13281.3 13285.7 13301.1 13313.1 22183.7 23149.8 23685.5 23714.6 23724.9 7482.4 8989.4 9523.5 9849.8 10302.6 955.3 1019.3 1079.6 1095.8 1146.8 29227.2 29264.4 29742.6 30143.0 30190.8 1107.4 1144.9 1164.7 1178.2 1184.7 14860.9 14936.6 15160.4 15195.5 15243.8 534643.0 538373.0 538898.0 539737.0 543557.0 58316.7 59317.8 59358.8 59368.0 59399.0 1329.1 1337.8 1460.4 1461.4 1486.3 28421.7 28682.4 28949.4 29148.0 29710.7 37033.8 46126.8 47150.5 47779.0 47956.3 368814.0 370694.0 371125.0 371361.0 372386.0 28856.4 29306.4 32368.8 32994.5 33401.7 41480.6 42040.6 42354.0 42506.0 42655.5 34970.0 36272.8 36280.6 36538.6 37339.6 35583.3 35639.8 36199.3 36381.6 36544.8 29449.1 34850.0 35416.6 36165.3 36482.0 31129.0 31795.8 31858.8 31904.8 32906.0 21137.5 22323.8 23754.9 24088.0 24202.6 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | [#2] jquery.html Cycles:180 Average:35215.48 Median:11706.17 stddev:104770.00 (895.0%) stddev-sans-first:105031.21 18:43:46 INFO - PROCESS | 2892 | Values: 359.4 364.1 365.5 369.6 374.1 15903.8 20304.6 21268.0 21781.6 21885.3 12291.8 17601.0 20045.2 20729.4 20753.7 5200.9 5307.8 5368.5 5376.7 5377.8 3907.4 4111.3 5243.2 5627.2 5865.7 5843.9 5845.4 5849.0 5856.9 5859.3 5633.6 5712.1 5786.9 5803.0 5825.1 5540.3 5552.5 5553.8 5556.7 5564.5 15791.7 24816.9 25382.7 25873.7 25875.6 1930.5 2071.4 2114.6 2144.4 2152.7 9992.2 10328.1 14176.1 14616.8 14874.8 1758.1 1763.3 1776.6 1811.6 1835.4 103333.0 109653.8 114526.0 115513.4 116190.8 11381.9 11426.9 11483.0 11519.0 11568.3 13712.7 13798.6 13799.7 13844.9 13849.1 8533.8 8607.9 8611.4 8615.0 8713.1 8796.5 8818.3 8842.8 8888.0 8925.2 3688.9 4485.4 4507.6 4508.1 4545.4 1592.2 1665.3 1763.6 1817.8 1867.4 837.4 869.9 910.9 975.8 980.5 18919.8 19296.6 19490.6 19770.8 20027.6 908.5 932.8 982.9 984.8 1029.4 10203.2 10647.7 10710.7 10735.0 10847.0 619087.0 623029.0 626656.0 643427.0 645518.0 113507.0 121112.6 121331.0 121384.2 125030.0 1011.6 1028.5 1037.8 1057.2 1058.8 17370.0 17462.4 17612.1 18016.9 18080.4 49917.0 50736.0 51502.7 51572.5 52510.0 71085.6 71296.0 71950.0 72764.0 72805.0 7871.6 7875.7 8053.2 8057.4 8198.1 12577.5 12794.6 12920.5 13175.7 13198.3 9851.0 10251.6 11277.7 11567.0 11606.8 10832.2 11009.4 11173.7 11387.5 11439.7 11186.0 11689.5 11904.6 11939.2 11946.0 8035.2 8057.4 8127.8 8155.6 8358.5 11533.4 11559.0 11589.1 11659.5 11859.3 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | [#3] mootools.html Cycles:180 Average:6173.04 Median:5274.24 stddev:3257.44 (61.8%) stddev-sans-first:3247.10 18:43:46 INFO - PROCESS | 2892 | Values: 1433.8 1557.2 1593.2 1878.2 2035.1 8145.7 8741.8 8915.2 8924.9 8960.1 8610.1 8854.7 8859.8 8867.7 8875.9 2472.4 2498.3 2499.5 2501.5 2502.1 2443.9 2516.8 2521.9 2524.0 2543.9 2478.9 2511.8 2539.8 2544.7 2546.2 2132.0 2500.2 2513.8 2528.9 2529.7 2462.2 2480.6 2486.5 2489.5 2537.3 9003.7 9065.2 9066.5 9081.5 9103.5 5401.0 5613.4 5615.2 5616.4 5633.0 3597.3 3690.5 3742.9 3749.9 3750.1 887.3 1068.6 1070.1 1071.1 1077.4 12233.6 12285.9 12292.6 12301.7 12324.3 4908.3 4935.8 4973.6 4979.1 5033.1 10383.6 10395.6 10420.4 10427.1 10454.3 5579.4 5587.9 5596.2 5599.0 5599.6 4506.2 4561.7 4590.1 4623.8 5147.5 3904.5 3911.0 4005.2 4010.5 4010.9 1303.4 1304.2 1306.5 1317.0 1320.2 979.3 1016.5 1180.5 1267.5 1416.8 7949.3 7950.3 8071.7 8079.4 8085.9 1184.9 1192.5 1194.2 1203.1 1219.0 6245.2 6248.6 6325.8 6335.3 6342.7 10575.6 11068.9 11077.3 11092.7 11122.0 9688.9 10561.0 10855.3 10937.7 10947.0 8531.5 8580.6 8616.3 8618.5 8636.9 7780.8 8024.2 8059.8 8071.2 8112.5 9420.5 9747.5 9805.5 9848.5 9855.0 9802.5 10121.5 10122.9 10282.3 10305.2 6671.8 7471.6 7482.7 7522.9 7554.7 8103.1 8361.5 8398.0 8424.5 8443.7 7425.4 7468.5 7524.6 7611.0 7739.2 7431.5 7471.0 7473.0 7546.6 7645.4 7861.9 7899.0 7933.0 7957.1 7957.1 7121.0 7121.4 7192.9 7202.1 7209.4 7261.6 7297.3 7326.8 7329.7 7349.6 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | [#4] prototype.html Cycles:180 Average:5643.59 Median:6386.12 stddev:1838.22 (28.8%) stddev-sans-first:1798.85 18:43:46 INFO - PROCESS | 2892 | Values: 285.8 319.9 320.3 331.2 334.1 6421.7 6605.9 6609.9 6625.6 6681.2 6394.1 6511.9 6516.2 6538.8 6540.8 4550.4 4664.0 4678.3 4780.8 4810.5 3886.8 4747.6 4769.3 4781.1 4787.1 4673.2 4709.6 4710.6 4719.8 4760.9 3919.5 4516.3 4594.1 4704.1 4712.0 4021.3 4023.7 4042.8 4044.5 4046.9 6161.4 6179.6 6224.6 6226.3 6229.7 5507.5 5530.3 5531.1 5536.2 5537.8 5922.6 6904.1 6904.9 6909.6 6913.2 3921.8 4126.7 4450.5 4472.4 4480.2 5528.7 7161.6 7305.9 7368.7 7430.7 4562.2 4586.7 4590.7 4594.2 4595.3 4643.8 4649.8 4658.4 4663.3 4668.9 5513.5 5516.4 5516.7 5518.1 5527.2 5968.5 6696.4 6767.5 7006.0 7025.7 1298.8 1595.1 1602.3 1604.8 1609.6 1015.0 1015.9 1032.2 1042.4 1043.1 6241.1 6378.1 6420.7 6552.9 6566.7 5966.5 7205.8 7266.1 7268.2 7296.1 6508.6 6515.6 6519.3 6522.6 6529.5 3127.5 3795.0 3816.6 3846.0 3853.3 7253.6 7610.3 7618.7 7636.3 7683.8 7499.3 7542.0 7554.0 7566.6 7567.4 6156.5 7657.7 7669.6 7681.7 7714.4 7331.3 7333.2 7335.4 7347.9 7380.9 6901.3 7106.8 7130.8 7132.6 7146.9 6142.8 7531.8 7595.0 7597.4 7612.2 4524.9 4570.7 4574.2 4576.8 4579.4 7220.9 7225.2 7231.3 7235.4 7238.2 6734.7 6951.2 7008.3 7018.6 7025.0 6952.3 6957.4 6968.4 6978.2 6981.9 6096.6 6302.9 6828.2 6830.6 6836.6 5639.5 6728.3 6972.6 6984.7 6993.8 6563.8 6667.7 6692.7 6794.2 6838.7 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - PROCESS | 2892 | [#5] yui.html Cycles:180 Average:18244.77 Median:662.57 stddev:25868.89 (3904.3%) stddev-sans-first:25907.89 18:43:46 INFO - PROCESS | 2892 | Values: 694.0 706.6 739.2 779.8 792.2 15276.6 15292.0 15357.2 15416.4 15438.2 14005.7 14118.5 14161.2 14165.8 14185.5 745.1 913.7 932.5 933.3 934.1 752.2 899.5 935.7 936.2 940.6 988.6 992.8 998.4 999.5 1000.4 785.5 948.5 987.1 990.8 993.9 726.2 726.9 728.9 730.1 730.2 14910.6 14988.6 14990.9 14991.3 15005.5 12432.5 12434.3 12532.2 12663.6 13011.8 8440.6 9903.3 10412.7 10618.6 10854.7 3502.8 3654.9 3732.7 3761.9 3769.6 76793.6 77557.2 77793.0 77814.6 79128.0 9337.0 9343.0 9370.2 9617.5 9688.2 22326.0 22337.0 22361.6 22369.0 22401.2 7339.4 7530.6 7533.8 7555.8 7606.0 4047.3 4118.1 4118.5 4215.0 4365.9 3596.6 3648.1 3649.5 3652.8 3657.7 644.9 659.3 662.2 662.9 667.5 556.9 595.2 596.5 603.4 611.1 8270.3 8273.2 8314.2 8421.1 8520.5 526.9 592.4 603.7 604.2 614.7 3762.6 3816.8 3830.7 3929.4 4060.0 90932.1 92396.5 92990.0 93286.5 95553.0 69173.3 72373.6 80191.0 80392.6 81404.2 70596.6 71362.0 71648.3 73497.0 74901.0 6140.1 7786.7 7796.2 7945.9 8222.1 50206.0 51010.5 51208.0 51866.7 52893.7 68912.3 70056.0 70850.0 71019.0 71254.6 10273.7 10309.3 10416.0 10824.9 10895.4 10747.6 10859.8 10928.7 11140.6 11334.8 10251.5 10439.8 10476.3 10476.7 10558.4 10397.0 10409.9 10539.6 10715.9 10717.0 9550.4 9612.0 10209.6 10279.0 10517.3 8685.9 8790.6 8858.2 9041.8 9208.8 8151.6 8315.3 8894.6 9035.3 9063.4 18:43:46 INFO - PROCESS | 2892 | -------- Summary: end -------- 18:43:46 INFO - PROCESS | 2892 | 18:43:46 INFO - TEST-INFO | 2892: exit 0 18:43:46 INFO - TEST-OK | dromaeo_css | took 1112691ms 18:43:46 INFO - TEST-START | kraken 18:43:46 INFO - operating with platform_type : mac_ 18:43:46 INFO - Initialising browser for kraken test... 18:43:46 INFO - TEST-INFO | started process 2897 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpJp9tLW/profile http://localhost:64485/getInfo.html) 18:43:48 INFO - PROCESS | 2897 | __metrics Screen width/height:1600/1200 18:43:48 INFO - PROCESS | 2897 | colorDepth:24 18:43:48 INFO - PROCESS | 2897 | Browser inner width/height: 1024/689 18:43:48 INFO - PROCESS | 2897 | __metrics 18:43:49 INFO - PROCESS | 2897 | 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" 18:43:49 ERROR - PROCESS | 2897 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:43:49 INFO - TEST-INFO | 2897: exit 0 18:43:49 INFO - Browser initialized. 18:43:49 INFO - Running cycle 1/1 for kraken test... 18:43:49 INFO - TEST-INFO | started process 2899 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpJp9tLW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:01 INFO - PROCESS | 2899 | RSS: Main: 242950144 18:44:01 INFO - PROCESS | 2899 | 18:44:04 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64485/tests/kraken/driver.html?testName=audio-beat-detection) 18:44:04 INFO - PROCESS | 2899 | RSS: Main: 289566720 18:44:04 INFO - PROCESS | 2899 | 18:44:07 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64485/tests/kraken/driver.html?testName=audio-dft) 18:44:07 INFO - PROCESS | 2899 | RSS: Main: 300191744 18:44:07 INFO - PROCESS | 2899 | 18:44:11 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64485/tests/kraken/driver.html?testName=audio-fft) 18:44:11 INFO - PROCESS | 2899 | RSS: Main: 288768000 18:44:11 INFO - PROCESS | 2899 | 18:44:13 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64485/tests/kraken/driver.html?testName=audio-oscillator) 18:44:14 INFO - PROCESS | 2899 | RSS: Main: 290975744 18:44:14 INFO - PROCESS | 2899 | 18:44:16 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:44:17 INFO - PROCESS | 2899 | RSS: Main: 292540416 18:44:17 INFO - PROCESS | 2899 | 18:44:19 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64485/tests/kraken/driver.html?testName=imaging-darkroom) 18:44:20 INFO - PROCESS | 2899 | RSS: Main: 290807808 18:44:20 INFO - PROCESS | 2899 | 18:44:23 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64485/tests/kraken/driver.html?testName=imaging-desaturate) 18:44:24 INFO - PROCESS | 2899 | RSS: Main: 291086336 18:44:24 INFO - PROCESS | 2899 | 18:44:26 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64485/tests/kraken/driver.html?testName=json-parse-financial) 18:44:27 INFO - PROCESS | 2899 | RSS: Main: 291479552 18:44:27 INFO - PROCESS | 2899 | 18:44:29 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:44:29 INFO - PROCESS | 2899 | RSS: Main: 325705728 18:44:29 INFO - PROCESS | 2899 | 18:44:31 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64485/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:44:32 INFO - PROCESS | 2899 | RSS: Main: 325697536 18:44:32 INFO - PROCESS | 2899 | 18:44:34 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:44:34 INFO - PROCESS | 2899 | RSS: Main: 331460608 18:44:34 INFO - PROCESS | 2899 | 18:44:37 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:44:37 INFO - PROCESS | 2899 | RSS: Main: 331575296 18:44:37 INFO - PROCESS | 2899 | 18:44:40 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:44:40 INFO - PROCESS | 2899 | RSS: Main: 333090816 18:44:40 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | Cycle 1(1): loaded http://localhost:64485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64485/tests/kraken/driver.html?testName=ai-astar) 18:44:42 INFO - PROCESS | 2899 | RSS: Main: 392798208 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | __start_tp_report 18:44:42 INFO - PROCESS | 2899 | _x_x_mozilla_page_load 18:44:42 INFO - PROCESS | 2899 | _x_x_mozilla_page_load_details 18:44:42 INFO - PROCESS | 2899 | |i|pagename|runs| 18:44:42 INFO - PROCESS | 2899 | |0;ai-astar;112;107;112;111;113;112;118;112;111;112 18:44:42 INFO - PROCESS | 2899 | |1;audio-beat-detection;155;121;143;157;119;140;138;118;162;117 18:44:42 INFO - PROCESS | 2899 | |2;audio-dft;189;187;186;186;188;185;186;187;184;187 18:44:42 INFO - PROCESS | 2899 | |3;audio-fft;73;77;86;76;58;58;58;78;79;76 18:44:42 INFO - PROCESS | 2899 | |4;audio-oscillator;94;99;131;79;78;85;116;102;116;154 18:44:42 INFO - PROCESS | 2899 | |5;imaging-gaussian-blur;89;85;90;86;89;85;90;86;88;85 18:44:42 INFO - PROCESS | 2899 | |6;imaging-darkroom;93;94;108;145;93;96;95;95;107;146 18:44:42 INFO - PROCESS | 2899 | |7;imaging-desaturate;85;85;85;105;121;142;141;86;85;87 18:44:42 INFO - PROCESS | 2899 | |8;json-parse-financial;53;54;53;53;53;53;54;63;57;74 18:44:42 INFO - PROCESS | 2899 | |9;json-stringify-tinderbox;65;70;67;74;71;67;66;67;69;68 18:44:42 INFO - PROCESS | 2899 | |10;stanford-crypto-aes;82;82;82;82;81;83;82;82;81;84 18:44:42 INFO - PROCESS | 2899 | |11;stanford-crypto-ccm;120;124;121;115;124;114;148;155;121;112 18:44:42 INFO - PROCESS | 2899 | |12;stanford-crypto-pbkdf2;133;129;136;135;141;124;138;137;137;137 18:44:42 INFO - PROCESS | 2899 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;66;67;67;67;69 18:44:42 INFO - PROCESS | 2899 | __end_tp_report 18:44:42 INFO - PROCESS | 2899 | __start_cc_report 18:44:42 INFO - PROCESS | 2899 | _x_x_mozilla_cycle_collect,1224 18:44:42 INFO - PROCESS | 2899 | __end_cc_report 18:44:42 INFO - PROCESS | 2899 | __startTimestamp1457577882910__endTimestamp 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | ------- Summary: start ------- 18:44:42 INFO - PROCESS | 2899 | Number of tests: 14 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:2.83 18:44:42 INFO - PROCESS | 2899 | Values: 112.0 107.0 112.0 111.0 113.0 112.0 118.0 112.0 111.0 112.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:141.50 stddev:17.44 (12.3%) stddev-sans-first:17.23 18:44:42 INFO - PROCESS | 2899 | Values: 155.0 121.0 143.0 157.0 119.0 140.0 138.0 118.0 162.0 117.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#2] audio-dft Cycles:10 Average:186.50 Median:187.00 stddev:1.43 (0.8%) stddev-sans-first:1.20 18:44:42 INFO - PROCESS | 2899 | Values: 189.0 187.0 186.0 186.0 188.0 185.0 186.0 187.0 184.0 187.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#3] audio-fft Cycles:10 Average:71.90 Median:76.50 stddev:10.15 (13.3%) stddev-sans-first:10.76 18:44:42 INFO - PROCESS | 2899 | Values: 73.0 77.0 86.0 76.0 58.0 58.0 58.0 78.0 79.0 76.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:78.50 stddev:24.24 (30.9%) stddev-sans-first:25.36 18:44:42 INFO - PROCESS | 2899 | Values: 94.0 99.0 131.0 79.0 78.0 85.0 116.0 102.0 116.0 154.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.50 stddev:2.11 (2.4%) stddev-sans-first:2.15 18:44:42 INFO - PROCESS | 2899 | Values: 89.0 85.0 90.0 86.0 89.0 85.0 90.0 86.0 88.0 85.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:93.50 stddev:20.91 (22.4%) stddev-sans-first:21.54 18:44:42 INFO - PROCESS | 2899 | Values: 93.0 94.0 108.0 145.0 93.0 96.0 95.0 95.0 107.0 146.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:85.00 stddev:23.87 (28.1%) stddev-sans-first:24.49 18:44:42 INFO - PROCESS | 2899 | Values: 85.0 85.0 85.0 105.0 121.0 142.0 141.0 86.0 85.0 87.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:54.00 stddev:6.85 (12.7%) stddev-sans-first:7.13 18:44:42 INFO - PROCESS | 2899 | Values: 53.0 54.0 53.0 53.0 53.0 53.0 54.0 63.0 57.0 74.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:2.67 (3.9%) stddev-sans-first:2.54 18:44:42 INFO - PROCESS | 2899 | Values: 65.0 70.0 67.0 74.0 71.0 67.0 66.0 67.0 69.0 68.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 18:44:42 INFO - PROCESS | 2899 | Values: 82.0 82.0 82.0 82.0 81.0 83.0 82.0 82.0 81.0 84.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:122.50 stddev:14.44 (11.8%) stddev-sans-first:15.18 18:44:42 INFO - PROCESS | 2899 | Values: 120.0 124.0 121.0 115.0 124.0 114.0 148.0 155.0 121.0 112.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.70 Median:137.00 stddev:4.92 (3.6%) stddev-sans-first:5.18 18:44:42 INFO - PROCESS | 2899 | Values: 133.0 129.0 136.0 135.0 141.0 124.0 138.0 137.0 137.0 137.0 18:44:42 INFO - PROCESS | 2899 | 18:44:42 INFO - PROCESS | 2899 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 18:44:42 INFO - PROCESS | 2899 | Values: 67.0 67.0 67.0 66.0 67.0 66.0 67.0 67.0 67.0 69.0 18:44:42 INFO - PROCESS | 2899 | -------- Summary: end -------- 18:44:42 INFO - PROCESS | 2899 | 18:44:43 INFO - TEST-INFO | 2899: exit 0 18:44:43 INFO - TEST-OK | kraken | took 56784ms 18:44:43 INFO - SUITE-END | took 1169s 18:44:44 INFO - Completed test suite (00:19:29) 18:44:44 INFO - javascript benchmark 18:44:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3355.530225768392, 3432.7597068205237, 3467.9653203467956, 3475.947860782088, 3520.6655367740073, 5551.417101204376, 5617.662940223589, 5656.660600363976, 5691.9146212806845, 5697.259356283683, 5685.573581981347, 5706.229658996034, 5746.7413966371505, 5813.128030795383, 5821.18503409523, 5084.872878178038, 5139.25480805283, 5153.252778347156, 5156.149235376159, 5249.711265880375, 5287.920681189786, 5288.2596436498925, 5316.0, 5348.91976620351, 5375.946240537603, 4335.241332766785, 5080.491950804909, 5134.255532947702, 5177.559907407856, 5241.606879484016, 5202.92195617066, 5215.269862219292, 5218.791248350061, 5237.397699264595, 5252.579793616502, 4201.474815648044, 5167.9224811627855, 5196.272521846944, 5201.505856943584, 5229.450907654679, 5489.231507588941, 5569.331680198362, 5640.774369025234, 5663.801766938137, 5666.433356664342, 6226.906596401058, 6231.470325022378, 6245.718942647592, 6253.312135665074, 6264.561480696353, 6306.085617585424, 6311.400416960381, 6319.0, 6319.4312511873695, 6328.240611126648, 5666.150077488369, 5677.347105082886, 5753.194552762617, 5784.479396854261, 5798.246227990334, 6218.22272215973, 6250.249970003629, 6269.811905642838, 6288.591241569284, 6308.905366419507, 6055.757769689163, 6106.6336019838955, 6125.1731016313115, 6133.3866613338305, 6146.0, 6210.4100110489435, 6259.061140828912, 6268.09112678659, 6275.090111933744, 6287.119803227461, 6070.271567411939, 6095.05526643371, 6128.228138398679, 6144.41628045335, 6158.876822463526, 6233.657148856856, 6235.719392627252, 6242.375762423721, 6250.4374606285655, 6250.562460627712, 4858.416989961227, 4908.263760435963, 4917.336159618406, 4935.555799978019, 4944.258361245842, 4331.242032644274, 4335.783210839509, 4421.668374871898, 4448.399466072039, 4493.1013797240685, 5630.352509461382, 5681.34664513578, 5687.829365119053, 5699.031164701928, 5718.628289161191, 6253.843653908689, 6277.654728989949, 6279.183706118175, 6293.402126797947, 6304.621722696653, 4952.4057113146655, 5582.804601838998, 5680.375158732536, 5748.338941021752, 5764.365919748824, 5303.071962406563, 5308.097623404031, 5310.097283461821, 5318.44156363584, 5326.0, 6266.655333956585, 6271.905921411091, 6273.059041143773, 6273.811785646438, 6279.466245369194, 6108.797423689751, 6187.9480488317995, 6274.0, 6292.9370706294185, 6298.527610429328, 6216.409441103088, 6232.937670623236, 6274.341194174546, 6278.309385967448, 6284.905726414199, 6059.545534084873, 6168.35232300602, 6205.6586887721605, 6217.222847144107, 6217.316095229431, 6185.721642526007, 6208.813735587759, 6217.253929528486, 6227.813165605039, 6262.342454042442, 5074.644774865724, 6093.625290627054, 6103.216452666749, 6120.9347721082095, 6129.632222066691, 6033.3061697905305, 6067.939320606737, 6091.299500557493, 6106.419890110433, 6108.908366374597, 4846.297286893451, 5738.340090889601, 5883.382244864228, 5929.110633405024, 5929.377415371324, 6097.207363042776, 6106.2061931948565, 6118.449339559461, 6130.969345153424, 6134.202553667995, 5970.731317090655, 5977.701114944322, 6006.099085137264, 6006.129111278928, 6008.639481631116], "unit": "score", "name": "dojo.html", "value": 5671.339795669595}, {"lowerIsBetter": false, "replicates": [459.7816037382242, 549.966063800056, 592.3707229593736, 593.623049363654, 644.8678021005694, 30473.390532189344, 30887.227819304528, 30906.690933090664, 30911.84544077282, 30934.69065309346, 39219.0, 40059.198816023665, 40120.996975075635, 40227.0, 40332.99167520813, 9590.23278137749, 9780.55987480565, 9797.363171393836, 9804.607815687365, 9851.458169800693, 9613.038696130401, 9755.707328780112, 9757.658481953133, 9765.804683906317, 9767.316287859852, 9689.127978481934, 9707.70876873695, 9722.173615242678, 9730.610775568968, 9740.0, 9690.854637180413, 9745.707628771148, 9748.95125524375, 9751.073648003428, 9751.804963900753, 9638.903610963871, 9759.560819763057, 9761.219102471785, 9766.0, 9769.0, 40632.39051414231, 41008.179836403106, 41030.79484602558, 41031.384529231786, 41138.794306028576, 3198.184462961953, 3238.1742655622666, 3360.025592578174, 3465.6534346565395, 3589.730770192246, 27645.0, 30257.0, 31118.53322200169, 31187.532187017212, 31213.063608091794, 2741.4105967217142, 2749.931251718703, 2824.6751623563346, 2891.0459548348995, 2910.185148158519, 490525.0, 497457.0, 497677.0, 498579.0, 499734.0, 73979.63010184915, 73991.0, 74827.62586187034, 74966.0, 75088.62455687686, 79748.20251797407, 80425.0, 80489.59755201187, 80506.0, 80632.19367806365, 14587.708245835023, 17502.649947000988, 17716.025618591102, 17723.556911077067, 17771.289148434178, 12562.748745025048, 13281.26953017574, 13285.73428531424, 13301.06892517534, 13313.068085234134, 22183.66724499134, 23149.7685023151, 23685.526289474114, 23714.644280335808, 23724.881375593013, 7482.401407887356, 8989.370744047854, 9523.52382380892, 9849.803003940024, 10302.557641930136, 955.3264948211494, 1019.2864994503728, 1079.63292480557, 1095.8055719266038, 1146.8165093584987, 29227.179848423468, 29264.414711705645, 29742.553861692093, 30143.0, 30190.849045754632, 1107.3687997841153, 1144.9370284634258, 1164.6913567904512, 1178.1517307538559, 1184.656449629615, 14860.925695371454, 14936.626584335478, 15160.393584256726, 15195.544133676007, 15243.847561524464, 534643.0, 538373.0, 538898.0, 539737.0, 543557.0, 58316.708416457644, 59317.813643726884, 59358.81282374328, 59368.0, 59399.0, 1329.1427029566069, 1337.7859542473157, 1460.4085345435117, 1461.4300422835104, 1486.3385793322084, 28421.715782842733, 28682.42635147327, 28949.35412137987, 29147.979820706172, 29710.663020163713, 37033.81483092567, 46126.769366152956, 47150.528494714614, 47779.0, 47956.280655789495, 368814.0, 370694.0, 371125.0, 371361.0, 372386.0, 28856.422871542873, 29306.413871722874, 32368.83815580907, 32994.54573632625, 33401.66598334083, 41480.58519414888, 42040.579594203664, 42354.0, 42506.0, 42655.50705725285, 34970.0, 36272.81863590665, 36280.63719362878, 36538.63461365458, 37339.62660373362, 35583.288334233686, 35639.75260865857, 36199.27601448009, 36381.63618363888, 36544.81727591345, 29449.11652650424, 34850.0, 35416.64583354133, 36165.27669446649, 36482.0, 31129.0, 31795.84102079475, 31858.840705796323, 31904.840475798403, 32906.01281961545, 21137.471563211042, 22323.77676223282, 23754.881225594454, 24088.0, 24202.636960445958], "unit": "score", "name": "ext.html", "value": 19880.20206266433}, {"lowerIsBetter": false, "replicates": [359.40159634209044, 364.13881171030505, 365.5430711610488, 369.62852333404925, 374.07603220046474, 15903.761443578342, 20304.593908121846, 21267.97954194351, 21781.64367126573, 21885.343439696833, 12291.815622765644, 17601.0, 20045.1981920723, 20729.378118656427, 20753.688694669592, 5200.8699782505455, 5307.761150748225, 5368.543673787733, 5376.704281264529, 5377.838664840042, 3907.4138879168067, 4111.259973204822, 5243.187305967562, 5627.212190293362, 5865.7360418781045, 5843.912341314884, 5845.415458454163, 5848.976429124908, 5856.882862342751, 5859.296884373881, 5633.57748168889, 5712.057510510761, 5786.942130578725, 5803.013487707079, 5825.126231065332, 5540.307461567304, 5552.472515111058, 5553.8333849984565, 5556.749946252428, 5564.527015203713, 15791.684166316609, 24816.875915620487, 25382.746172538224, 25873.741262587322, 25875.61186582203, 1930.5270208798934, 2071.4153672440593, 2114.619368513667, 2144.356692992096, 2152.7416709994745, 9992.150667193297, 10328.070473657332, 14176.078554893898, 14616.780748288784, 14874.776878346833, 1758.1121533625565, 1763.2946821271466, 1776.5558610347414, 1811.6467288878673, 1835.3943198744516, 103333.0, 109653.80692386108, 114525.99999999917, 115513.42243288814, 116190.83809161969, 11381.943090284496, 11426.885731142582, 11482.96653301207, 11519.0, 11568.305901645928, 13712.725745485035, 13798.586042418743, 13799.724005520035, 13844.930775346058, 13849.099808512414, 8533.786655333543, 8607.870881936651, 8611.39720219591, 8615.0, 8713.128687131362, 8796.47221166732, 8818.29453643707, 8842.778930526789, 8888.022317545065, 8925.241354484811, 3688.8524459021874, 4485.416895803524, 4507.57178068083, 4508.143452744033, 4545.38637283969, 1592.2118551317171, 1665.292250793408, 1763.5502946748497, 1817.7909540403023, 1867.3930972434014, 837.388706244445, 869.860822268434, 910.8542633178793, 975.7560609847538, 980.475445636581, 18919.81080189208, 19296.61406771885, 19490.610187796166, 19770.802291976896, 20027.59944801096, 908.5230254116642, 932.8320902237663, 982.9017098290113, 984.7538115471132, 1029.3566520924421, 10203.234757393077, 10647.680569582924, 10710.678679639623, 10735.0, 10846.969537893887, 619087.0, 623029.0, 626656.0, 643427.0, 645518.0, 113507.0, 121112.57774844454, 121331.0, 121384.17923731152, 125030.0, 1011.5650270383805, 1028.4857571214243, 1037.7924415117006, 1057.1701214546545, 1058.8147074261974, 17369.957802531888, 17462.388816391365, 17612.119394030502, 18016.91898486095, 18080.367187148386, 49917.0, 50736.0, 51502.74248628733, 51572.48427515827, 52510.0, 71085.64457177681, 71296.0, 71950.0, 72764.0, 72805.0, 7871.567063811545, 7875.684972601031, 8053.154418786177, 8057.355411566943, 8198.1391953844, 12577.496900124259, 12794.552190673281, 12920.483180672667, 13175.736485270432, 13198.340082995619, 9850.950745246515, 10251.641192558225, 11277.71805704864, 11567.0, 11606.767864642828, 10832.24174307791, 11009.449527523751, 11173.664790055986, 11387.544498219979, 11439.714007149887, 11186.0, 11689.532418703157, 11904.642860714192, 11939.223950443193, 11946.0, 8035.236652518235, 8057.395695322757, 8127.837443250984, 8155.632996515053, 8358.45670031446, 11533.365664888512, 11559.017483513659, 11589.130815188726, 11659.475323610288, 11859.34773587461], "unit": "score", "name": "jquery.html", "value": 9387.581374331394}, {"lowerIsBetter": false, "replicates": [1433.7562614355559, 1557.1902610642464, 1593.1874743880621, 1878.2111513164477, 2035.063870619515, 8145.674173033079, 8741.825163496735, 8915.1976322131, 8924.866127008085, 8960.148785865349, 8610.138986101387, 8854.734357969255, 8859.822803543926, 8867.733967980956, 8875.91124088759, 2472.369545765832, 2498.3129639349145, 2499.5000999800022, 2501.4871951250043, 2502.099244272061, 2443.8655873926928, 2516.7609077137645, 2521.8612976286295, 2523.987380063097, 2543.885525151373, 2478.9008439662393, 2511.7739403453684, 2539.8349107307968, 2544.656471376359, 2546.1852207293673, 2131.989340053305, 2500.1874390822964, 2513.7863281621085, 2528.886200120999, 2529.696436427622, 2462.162864626018, 2480.5659009673236, 2486.539990101837, 2489.4896546208165, 2537.314924970248, 9003.684871029482, 9065.184133428023, 9066.54667266634, 9081.500517471537, 9103.544822758902, 5400.972995135038, 5613.382527921925, 5615.241942337773, 5616.438356164351, 5632.971835140839, 3597.2805438912324, 3690.464882592036, 3742.925141497182, 3749.8687545936036, 3750.062484378905, 887.2901678657048, 1068.5725709716098, 1070.0743856564015, 1071.0735214039798, 1077.380506208933, 12233.571824986082, 12285.938570307091, 12292.569760058355, 12301.69245768854, 12324.260544367367, 4908.263760435963, 4935.8025678972435, 4973.55238028572, 4979.0788704089855, 5033.119204139261, 10383.584656613803, 10395.636152734618, 10420.426876521864, 10427.113695335982, 10454.32046916948, 5579.414161513064, 5587.8603034923635, 5596.160575913564, 5599.0, 5599.636023658449, 4506.211413002711, 4561.749103799323, 4590.104929538707, 4623.791929363119, 5147.510986456281, 3904.4533765272886, 3910.9608903911167, 4005.1589166275407, 4010.5187377514303, 4010.8997275068355, 1303.3808940753067, 1304.1979182802509, 1306.5427100514935, 1317.0188209783773, 1320.2078752748275, 979.2655508368723, 1016.4561959351711, 1180.527788884453, 1267.518343029643, 1416.7591509443419, 7949.324307433817, 7950.3242224410415, 8071.677132914735, 8079.4344395892895, 8085.878711819328, 1184.8755880632582, 1192.4693511387522, 1194.1760185471996, 1203.1096988228649, 1218.9939050304693, 6245.219347581552, 6248.593841400385, 6325.778597749057, 6335.334789847092, 6342.651154186472, 10575.62985295511, 11068.944655276833, 11077.279976801483, 11092.722681933015, 11122.0, 9688.90311096894, 10560.996705312982, 10855.348679079123, 10937.671869843918, 10947.014768670859, 8531.530765807816, 8580.613872375758, 8616.310695144373, 8618.482891026559, 8636.877205963185, 7780.805479863048, 8024.157463466252, 8059.83880322402, 8071.23323284287, 8112.513249205066, 9420.481873497023, 9747.463889486145, 9805.460699661588, 9848.458334791656, 9854.950725246328, 9802.50987450639, 10121.493925303557, 10122.89877101249, 10282.280240383101, 10305.175585953255, 6671.799846004627, 7471.626418679153, 7482.738104166328, 7522.887156692764, 7554.697812087455, 8103.1491693371345, 8361.456505327134, 8398.0, 8424.452410593292, 8443.746687599381, 7425.443091768247, 7468.477206595486, 7524.623768811428, 7610.961945190239, 7739.187385324685, 7431.516951398142, 7471.0, 7473.0, 7546.584937828472, 7645.426593005435, 7861.921380786348, 7899.0126234220725, 7932.960335198287, 7957.124716281321, 7957.124716281321, 7120.964395177991, 7121.430285577245, 7192.8921066183, 7202.135743710788, 7209.387202087882, 7261.636918154177, 7297.306755858185, 7326.780196594111, 7329.706811727685, 7349.595772232578], "unit": "score", "name": "mootools.html", "value": 5023.048102390498}, {"lowerIsBetter": false, "replicates": [285.8299311909413, 319.88963807486414, 320.31612507296927, 331.1671147065131, 334.07961067259697, 6421.711023003964, 6605.900911486319, 6609.900851487231, 6625.569337993039, 6681.164854393201, 6394.136791533142, 6511.902321465182, 6516.152900122989, 6538.803835884919, 6540.771073012445, 4550.408446901898, 4663.976680116594, 4678.298255261721, 4780.784864681098, 4810.470848206694, 3886.805659717017, 4747.572718455338, 4769.284607308897, 4781.115493633689, 4787.066522028206, 4673.158831410345, 4709.62323014158, 4710.62315014798, 4719.811207551694, 4760.880977975544, 3919.529656441231, 4516.277395616718, 4594.104149690778, 4704.082703872747, 4712.010477799666, 4021.336479480882, 4023.6982226333143, 4042.8180731867137, 4044.4539987101657, 4046.858359957387, 6161.353057928943, 6179.5674302798825, 6224.62652240867, 6226.346233645448, 6229.688515574203, 5507.531859791922, 5530.281063461724, 5531.1426728857095, 5536.197251398525, 5537.833864984057, 5922.58541902067, 6904.13698287714, 6904.930950690479, 6909.550879192836, 6913.239543650195, 3921.764644137116, 4126.731762435432, 4450.465944086698, 4472.418585583886, 4480.19356515827, 5528.723563821793, 7161.641917904084, 7305.926940730577, 7368.668409921566, 7430.702771889172, 4562.201614717411, 4586.747728874877, 4590.70160439577, 4594.19601569724, 4595.310703394518, 4643.791029403685, 4649.837255696035, 4658.3711198988385, 4663.253879379283, 4668.85993420198, 5513.5037846594, 5516.420775818481, 5516.696581688046, 5518.144687573433, 5527.198556209327, 5968.46283834457, 6696.363845434676, 6767.492438067165, 7006.01915731798, 7025.683844227022, 1298.785700359449, 1595.1386251424333, 1602.3430393538592, 1604.751263554151, 1609.6136927137636, 1014.9543270552842, 1015.9288849780593, 1032.1639472027682, 1042.3849928542197, 1043.0664555223034, 6241.095041218998, 6378.107065010902, 6420.7431702731365, 6552.868942621121, 6566.737330506822, 5966.522678185735, 7205.775018246806, 7266.055412796409, 7268.164161121433, 7296.12446506412, 6508.576942498722, 6515.641639709766, 6519.282878883319, 6522.64125473094, 6529.465575589733, 3127.4839651457255, 3794.962050379516, 3816.580176180618, 3846.0, 3853.306404847154, 7253.637318134178, 7610.277023682741, 7618.733344332922, 7636.31273185416, 7683.769486915401, 7499.325060744559, 7542.0, 7553.962230188814, 7566.583837888859, 7567.394608431422, 6156.476699480505, 7657.693692252359, 7669.578173200416, 7681.731139410093, 7714.382849372149, 7331.266873312626, 7333.230010848784, 7335.376492997942, 7347.889781653386, 7380.852382952204, 6901.275366086689, 7106.822329441805, 7130.786076417716, 7132.607706575981, 7146.9285307146265, 6142.846428839315, 7531.849363012819, 7595.012648355679, 7597.354224890946, 7612.162662107275, 4524.932126018178, 4570.702904311209, 4574.199515084913, 4576.771161441848, 4579.38178345919, 7220.927790722236, 7225.205227424874, 7231.349178573953, 7235.384992275505, 7238.23998480152, 6734.696938637675, 6951.16586009682, 7008.264132266243, 7018.649067546704, 7024.964875175591, 6952.339527744856, 6957.443404527525, 6968.3728464438445, 6978.232394436709, 6981.930180698128, 6096.634201947897, 6302.89699302611, 6828.248892621708, 6830.556013859084, 6836.555623884432, 5639.464250896158, 6728.327167283428, 6972.616506092214, 6984.650767461708, 6993.8251543709775, 6563.803085907431, 6667.733290668319, 6692.732290708317, 6794.184697836291, 6838.7264509419065], "unit": "score", "name": "prototype.html", "value": 5026.807109973293}, {"lowerIsBetter": false, "replicates": [693.9618320992345, 706.636082417555, 739.1795107430751, 779.7933547609884, 792.1698587330258, 15276.618084547878, 15292.006019608732, 15357.232138393063, 15416.383344666228, 15438.228088595568, 14005.719885602282, 14118.505852295171, 14161.22113283769, 14165.78751318731, 14185.503507377243, 745.057502259642, 913.6710784117696, 932.5337331334333, 933.286036182321, 934.0799312677008, 752.1613401057808, 899.5322432335182, 935.6958988328786, 936.2135805923024, 940.6425558287841, 988.6490295944944, 992.7964767222738, 998.4159266828914, 999.5252255178805, 1000.3897622450299, 785.4698078796846, 948.5115165689675, 987.0573602209909, 990.8018396320729, 993.9105480506753, 726.1576571177409, 726.887332463469, 728.8542291541713, 730.087390761548, 730.1858427852959, 14910.552683419515, 14988.625284367869, 14990.850091499055, 14991.32539035746, 15005.474808381654, 12432.502699891993, 12434.316112613802, 12532.248065116122, 12663.62009139718, 13011.804822927663, 8440.57797110142, 9903.306768526207, 10412.68761937143, 10618.57525698971, 10854.72863178419, 3502.7548071634997, 3654.8720794772057, 3732.701383889282, 3761.924761504782, 3769.641884021041, 76793.61603191949, 77557.22442775613, 77793.0, 77814.61092694501, 79128.0, 9337.0, 9343.0, 9370.203532699661, 9617.471039092918, 9688.224942004623, 22325.99533021018, 22337.0, 22361.55276894453, 22369.0, 22401.21595744174, 7339.376153027052, 7530.623468826537, 7533.849323013509, 7555.811104722426, 7606.0, 4047.2917239483563, 4118.073433477443, 4118.5057793065025, 4214.957850421518, 4365.912681746411, 3596.6223546527763, 3648.1426864686778, 3649.525561676965, 3652.7625704329134, 3657.707383409374, 644.8968165093562, 659.3340725866909, 662.2053535757015, 662.9337066293429, 667.4935616759038, 556.9443055694398, 595.2083728640897, 596.4572239262251, 603.405645439242, 611.0864257934417, 8270.2556769891, 8273.172682731678, 8314.210150035737, 8421.073681894986, 8520.488770673655, 526.9314989051476, 592.4401440638555, 603.6800495737266, 604.1934018085817, 614.7018695932469, 3762.567304759933, 3816.7709937403843, 3830.6743926766535, 3929.390944403622, 4059.9797001014804, 90932.09067909369, 92396.53801730949, 92990.0, 93286.53356733173, 95553.0, 69173.2706682337, 72373.638131809, 80191.0, 80392.59803701061, 81404.18595814085, 70596.64701676561, 71362.0, 71648.28351716416, 73497.0, 74901.0, 6140.13171701825, 7786.727464538941, 7796.181400953045, 7945.920540794749, 8222.136675648972, 50206.0, 51010.48989510206, 51208.0, 51866.74066629643, 52893.65276166885, 68912.3108768906, 70056.0, 70850.0, 71019.0, 71254.57490850257, 10273.74315642115, 10309.329893557195, 10416.010479004482, 10824.891751082703, 10895.400752958663, 10747.570097196025, 10859.83710244331, 10928.672139835817, 11140.610078647209, 11334.773304534028, 10251.538680759235, 10439.791204176026, 10476.319039262424, 10476.738081548023, 10558.366498010144, 10397.0, 10409.895901041196, 10539.57841686324, 10715.892841071802, 10717.0, 9550.351195643661, 9611.951940240255, 10209.591616335263, 10279.0, 10517.316374435637, 8685.913140868763, 8790.648374065222, 8858.24319813476, 9041.77395565116, 9208.769780755267, 8151.63317650719, 8315.293200077818, 8894.599743011451, 9035.299287422935, 9063.365564410427], "unit": "score", "name": "yui.html", "value": 6851.04837991927}], "name": "dromaeo_css", "value": 7535.614098161933}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 111.0, 113.0, 112.0, 118.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 143.0, 157.0, 119.0, 140.0, 138.0, 118.0, 162.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 137.0}, {"lowerIsBetter": true, "replicates": [189.0, 187.0, 186.0, 186.0, 188.0, 185.0, 186.0, 187.0, 184.0, 187.0], "unit": "score", "name": "audio-dft", "value": 186.5}, {"lowerIsBetter": true, "replicates": [73.0, 77.0, 86.0, 76.0, 58.0, 58.0, 58.0, 78.0, 79.0, 76.0], "unit": "score", "name": "audio-fft", "value": 71.9}, {"lowerIsBetter": true, "replicates": [94.0, 99.0, 131.0, 79.0, 78.0, 85.0, 116.0, 102.0, 116.0, 154.0], "unit": "score", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 90.0, 86.0, 89.0, 85.0, 90.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 108.0, 145.0, 93.0, 96.0, 95.0, 95.0, 107.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 107.2}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 105.0, 121.0, 142.0, 141.0, 86.0, 85.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 102.2}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 63.0, 57.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [65.0, 70.0, 67.0, 74.0, 71.0, 67.0, 66.0, 67.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 82.0, 81.0, 83.0, 82.0, 82.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [120.0, 124.0, 121.0, 115.0, 124.0, 114.0, 148.0, 155.0, 121.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [133.0, 129.0, 136.0, 135.0, 141.0, 124.0, 138.0, 137.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1443.8000000000002}]} 18:44:44 INFO - Return code: 0 18:44:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:44:44 ERROR - # TBPL SUCCESS # 18:44:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:44:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:44:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:44:44 INFO - 2016-03-09 18:44:44.199 screenresolution[2903:35251] starting screenresolution argv=screenresolution get 18:44:44 INFO - 2016-03-09 18:44:44.202 screenresolution[2903:35251] Display 0: 1600x1200x32@60 18:44:44 INFO - 2016-03-09 18:44:44.208 screenresolution[2904:35254] starting screenresolution argv=screenresolution list 18:44:44 INFO - Available Modes on Display 0 18:44:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:44:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:44:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:44:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:44:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:44:44 INFO - Intel Iris: 18:44:44 INFO - Chipset Model: Intel Iris 18:44:44 INFO - Type: GPU 18:44:44 INFO - Bus: Built-In 18:44:44 INFO - VRAM (Dynamic, Max): 1536 MB 18:44:44 INFO - Vendor: Intel (0x8086) 18:44:44 INFO - Device ID: 0x0a2e 18:44:44 INFO - Revision ID: 0x0009 18:44:44 INFO - Displays: 18:44:44 INFO - Display: 18:44:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:44:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:44:44 INFO - Display Serial Number: 1600x1200 60 18:44:44 INFO - Main Display: Yes 18:44:44 INFO - Mirror: Off 18:44:44 INFO - Online: Yes 18:44:44 INFO - Rotation: Supported 18:44:44 INFO - Return code: 0 18:44:44 INFO - Running post-action listener: _resource_record_post_action 18:44:44 INFO - Running post-run listener: _resource_record_post_run 18:44:45 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 20480; Write bytes: 702976000; Read time: 1; Write time: 2829 18:44:45 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390849024; Write bytes: 384689664; Read time: 29624; Write time: 742 18:44:45 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 20480; Write bytes: 298916352; Read time: 1; Write time: 2040 18:44:45 INFO - Running post-run listener: _upload_blobber_files 18:44:45 INFO - Blob upload gear active. 18:44:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:44:45 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 18:44:45 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'] 18:44:45 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 18:44:45 INFO - (blobuploader) - INFO - Open directory for files ... 18:44:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:44:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:44:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:47 INFO - (blobuploader) - INFO - Done attempting. 18:44:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:44:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:44:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:44:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:44:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:44:48 INFO - (blobuploader) - INFO - Done attempting. 18:44:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:44:48 INFO - Return code: 0 18:44:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:44:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:44:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81326946adfec4922fc6dca9bcdf1f25a841d057c356d954c39115298f60df8f7c94656b9f96a898b55321c48482ccaced7c7db55fec79e9e7d4c431abad931c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65c22725246dddec04b37808cee79314909d85d8449aacee4d0f2e71604683ae8f1b3f5f7b8c4f2cf8c071deca4a2829b6c9a9da13256d825482894d575c24f6"} 18:44:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:44:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:44:48 INFO - Contents: 18:44:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81326946adfec4922fc6dca9bcdf1f25a841d057c356d954c39115298f60df8f7c94656b9f96a898b55321c48482ccaced7c7db55fec79e9e7d4c431abad931c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65c22725246dddec04b37808cee79314909d85d8449aacee4d0f2e71604683ae8f1b3f5f7b8c4f2cf8c071deca4a2829b6c9a9da13256d825482894d575c24f6"} 18:44:48 INFO - Running post-run listener: copy_logs_to_upload_dir 18:44:48 INFO - Copying logs to upload dir... 18:44:48 INFO - mkdir: /builds/slave/test/build/upload/logs 18:44:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.823024 ========= master_lag: 1.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-09 18:44:49.301208) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 18:44:49.304237) ========= 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.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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/81326946adfec4922fc6dca9bcdf1f25a841d057c356d954c39115298f60df8f7c94656b9f96a898b55321c48482ccaced7c7db55fec79e9e7d4c431abad931c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65c22725246dddec04b37808cee79314909d85d8449aacee4d0f2e71604683ae8f1b3f5f7b8c4f2cf8c071deca4a2829b6c9a9da13256d825482894d575c24f6"} build_url:https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/PVdhvc4pRUW3nPSVqDC_1w/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/81326946adfec4922fc6dca9bcdf1f25a841d057c356d954c39115298f60df8f7c94656b9f96a898b55321c48482ccaced7c7db55fec79e9e7d4c431abad931c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65c22725246dddec04b37808cee79314909d85d8449aacee4d0f2e71604683ae8f1b3f5f7b8c4f2cf8c071deca4a2829b6c9a9da13256d825482894d575c24f6"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 18:44:49.369562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:44:49.369916) ========= 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.nXcPPwvny3/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.5OWfJuwX7l/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.005471 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 18:44:49.419741) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 18:44:49.420076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 18:44:49.420471) ========= ========= Total master_lag: 1.30 =========