builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0114 starttime: 1454579922.32 results: success (0) buildid: 20160204000827 builduid: 73330ec6182c4fc78debf784ca0688f0 revision: 3d2eace770d1a64ebd3056affac1806c37ebbf71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.317926) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.318724) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.319081) ========= 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.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005746 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.348899) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.349183) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.366167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.366427) ========= 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.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005384 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.416826) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.417087) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.417427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:42.417695) ========= 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.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-02-04 01:58:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-02-04 01:58:42 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.568349 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:43.004960) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:43.005297) ========= 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.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.020376 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:43.055428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-04 01:58:43.055777) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3d2eace770d1a64ebd3056affac1806c37ebbf71 --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 3d2eace770d1a64ebd3056affac1806c37ebbf71 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-02-04 01:58:43,127 truncating revision to first 12 chars 2016-02-04 01:58:43,128 Setting DEBUG logging. 2016-02-04 01:58:43,128 attempt 1/10 2016-02-04 01:58:43,128 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3d2eace770d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-04 01:58:44,318 unpacking tar archive at: fx-team-3d2eace770d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.440043 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-04 01:58:44.510936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:44.511241) ========= echo 3d2eace770d1a64ebd3056affac1806c37ebbf71 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3d2eace770d1a64ebd3056affac1806c37ebbf71'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 3d2eace770d1a64ebd3056affac1806c37ebbf71 program finished with exit code 0 elapsedTime=0.005524 script_repo_revision: '3d2eace770d1a64ebd3056affac1806c37ebbf71' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:44.560405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:44.560704) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-04 01:58:44.574346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-02-04 01:58:44.574668) ========= /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.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:58:44 INFO - MultiFileLogger online at 20160204 01:58:44 in /builds/slave/test 01:58:44 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 01:58:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:58:44 INFO - {'append_to_log': False, 01:58:44 INFO - 'base_work_dir': '/builds/slave/test', 01:58:44 INFO - 'blob_upload_branch': 'Fx-Team', 01:58:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:58:44 INFO - 'branch': 'Fx-Team', 01:58:44 INFO - 'buildbot_json_path': 'buildprops.json', 01:58:44 INFO - 'config_files': ('talos/mac_config.py',), 01:58:44 INFO - 'default_actions': ('clobber', 01:58:44 INFO - 'read-buildbot-config', 01:58:44 INFO - 'download-and-extract', 01:58:44 INFO - 'populate-webroot', 01:58:44 INFO - 'create-virtualenv', 01:58:44 INFO - 'install', 01:58:44 INFO - 'run-tests'), 01:58:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:58:44 INFO - 'download_minidump_stackwalk': True, 01:58:44 INFO - 'download_symbols': 'ondemand', 01:58:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:58:44 INFO - 'tooltool.py': '/tools/tooltool.py', 01:58:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:58:44 INFO - '/tools/misc-python/virtualenv.py')}, 01:58:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:58:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:58:44 INFO - 'installer_path': 'installer.exe', 01:58:44 INFO - 'log_level': 'info', 01:58:44 INFO - 'log_name': 'talos', 01:58:44 INFO - 'log_to_console': True, 01:58:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:58:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:58:44 INFO - 'opt_config_files': (), 01:58:44 INFO - 'pip_index': False, 01:58:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:58:44 INFO - 'cmd': ('bash', 01:58:44 INFO - '-c', 01:58:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:58:44 INFO - 'enabled': True, 01:58:44 INFO - 'halt_on_failure': False, 01:58:44 INFO - 'name': 'check_screen_resolution'},), 01:58:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:58:44 INFO - 'cmd': ('bash', 01:58:44 INFO - '-c', 01:58:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:58:44 INFO - 'enabled': True, 01:58:44 INFO - 'halt_on_failure': False, 01:58:44 INFO - 'name': 'check_screen_resolution'},), 01:58:44 INFO - 'run_cmd_checks_enabled': True, 01:58:44 INFO - 'sps_profile': False, 01:58:44 INFO - 'sps_profile_interval': 0, 01:58:44 INFO - 'suite': 'dromaeojs', 01:58:44 INFO - 'system_bits': '32', 01:58:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:58:44 INFO - 'title': 't-yosemite-r7-0114', 01:58:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:58:44 INFO - 'use_talos_json': True, 01:58:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:58:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:58:44 INFO - 'work_dir': 'build'} 01:58:44 INFO - ##### 01:58:44 INFO - ##### Running clobber step. 01:58:44 INFO - ##### 01:58:44 INFO - Running pre-action listener: _resource_record_pre_action 01:58:44 INFO - Running main action method: clobber 01:58:44 INFO - rmtree: /builds/slave/test/build 01:58:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:58:45 INFO - Running post-action listener: _resource_record_post_action 01:58:45 INFO - ##### 01:58:45 INFO - ##### Running read-buildbot-config step. 01:58:45 INFO - ##### 01:58:45 INFO - Running pre-action listener: _resource_record_pre_action 01:58:45 INFO - Running main action method: read_buildbot_config 01:58:45 INFO - Using buildbot properties: 01:58:45 INFO - { 01:58:45 INFO - "project": "", 01:58:45 INFO - "product": "firefox", 01:58:45 INFO - "script_repo_revision": "production", 01:58:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:58:45 INFO - "repository": "", 01:58:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:58:45 INFO - "buildid": "20160204000827", 01:58:45 INFO - "pgo_build": "False", 01:58:45 INFO - "basedir": "/builds/slave/test", 01:58:45 INFO - "buildnumber": 308, 01:58:45 INFO - "slavename": "t-yosemite-r7-0114", 01:58:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:58:45 INFO - "platform": "yosemite_r7", 01:58:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:58:45 INFO - "branch": "fx-team", 01:58:45 INFO - "repo_path": "integration/fx-team", 01:58:45 INFO - "revision": "3d2eace770d1a64ebd3056affac1806c37ebbf71", 01:58:45 INFO - "stage_platform": "macosx64", 01:58:45 INFO - "builduid": "73330ec6182c4fc78debf784ca0688f0", 01:58:45 INFO - "slavebuilddir": "test" 01:58:45 INFO - } 01:58:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:58:45 INFO - Running post-action listener: _resource_record_post_action 01:58:45 INFO - ##### 01:58:45 INFO - ##### Running download-and-extract step. 01:58:45 INFO - ##### 01:58:45 INFO - Running pre-action listener: _resource_record_pre_action 01:58:45 INFO - Running main action method: download_and_extract 01:58:45 INFO - mkdir: /builds/slave/test/build/tests 01:58:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:58:45 INFO - https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:58:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/test_packages.json 01:58:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/test_packages.json 01:58:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:58:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:58:52 INFO - Downloaded 1277 bytes. 01:58:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:58:52 INFO - Using the following test package requirements: 01:58:52 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:58:52 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:58:52 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:58:52 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:58:52 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:58:52 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:58:52 INFO - u'jsshell-mac.zip'], 01:58:52 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:58:52 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:58:52 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:58:52 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:58:52 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:58:52 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:58:52 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:58:52 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:58:52 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:58:52 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:58:52 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:58:52 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:58:52 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:58:52 INFO - https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:58:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:58:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:58:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:59:00 INFO - Downloaded 17118775 bytes. 01:59:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:59:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:59:03 INFO - Return code: 0 01:59:03 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:59:03 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')]} 01:59:03 INFO - https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:59:05 INFO - Downloaded 17118775 bytes. 01:59:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:59:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:59:09 INFO - Return code: 0 01:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:09 INFO - https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:59:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:59:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:59:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:59:11 INFO - Downloaded 10706582 bytes. 01:59:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:59:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:59:11 INFO - Return code: 0 01:59:11 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')]} 01:59:11 INFO - https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:59:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:59:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:59:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:59:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 01:59:14 INFO - Downloaded 111123606 bytes. 01:59:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:59:14 INFO - mkdir: /builds/slave/test/properties 01:59:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:59:14 INFO - Writing to file /builds/slave/test/properties/build_url 01:59:14 INFO - Contents: 01:59:14 INFO - build_url:https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:59:15 INFO - Running post-action listener: _resource_record_post_action 01:59:15 INFO - Running post-action listener: set_extra_try_arguments 01:59:15 INFO - ##### 01:59:15 INFO - ##### Running populate-webroot step. 01:59:15 INFO - ##### 01:59:15 INFO - Running pre-action listener: _resource_record_pre_action 01:59:15 INFO - Running main action method: populate_webroot 01:59:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:59:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:59:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:59:15 INFO - '--tppagecycles', 01:59:15 INFO - '7'], 01:59:15 INFO - 'tests': ['tsvgm']}}, 01:59:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:59:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:59:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:59:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:59:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:15 INFO - 'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:59:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:15 INFO - 'tests': ['damp', 'tps']}, 01:59:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:15 INFO - 'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['damp', 'tps']}, 01:59:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:59:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:59:15 INFO - 'other': {'tests': ['a11yr', 01:59:15 INFO - 'ts_paint', 01:59:15 INFO - 'tpaint', 01:59:15 INFO - 'sessionrestore', 01:59:15 INFO - 'sessionrestore_no_auto_restore']}, 01:59:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['a11yr', 01:59:15 INFO - 'ts_paint', 01:59:15 INFO - 'tpaint', 01:59:15 INFO - 'sessionrestore', 01:59:15 INFO - 'sessionrestore_no_auto_restore']}, 01:59:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['a11yr', 01:59:15 INFO - 'ts_paint', 01:59:15 INFO - 'tpaint', 01:59:15 INFO - 'sessionrestore', 01:59:15 INFO - 'sessionrestore_no_auto_restore']}, 01:59:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['a11yr', 01:59:15 INFO - 'ts_paint', 01:59:15 INFO - 'tpaint', 01:59:15 INFO - 'sessionrestore', 01:59:15 INFO - 'sessionrestore_no_auto_restore']}, 01:59:15 INFO - 'other_l64': {'tests': ['a11yr', 01:59:15 INFO - 'ts_paint', 01:59:15 INFO - 'tpaint', 01:59:15 INFO - 'sessionrestore', 01:59:15 INFO - 'sessionrestore_no_auto_restore']}, 01:59:15 INFO - 'other_nol64': {'tests': ['a11yr', 01:59:15 INFO - 'ts_paint', 01:59:15 INFO - 'tpaint', 01:59:15 INFO - 'sessionrestore', 01:59:15 INFO - 'sessionrestore_no_auto_restore']}, 01:59:15 INFO - 'svgr': {'tests': ['tsvgx', 01:59:15 INFO - 'tsvgr_opacity', 01:59:15 INFO - 'tart', 01:59:15 INFO - 'tscrollx', 01:59:15 INFO - 'cart']}, 01:59:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['tsvgx', 01:59:15 INFO - 'tsvgr_opacity', 01:59:15 INFO - 'tart', 01:59:15 INFO - 'tscrollx', 01:59:15 INFO - 'cart']}, 01:59:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:15 INFO - 'tests': ['tp5o']}, 01:59:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:15 INFO - 'talos_options': ['--e10s'], 01:59:15 INFO - 'tests': ['tp5o']}, 01:59:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:15 INFO - 'talos_options': ['--xperf_path', 01:59:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:15 INFO - 'tests': ['tp5n']}, 01:59:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:59:15 INFO - 'talos_options': ['--e10s', 01:59:15 INFO - '--xperf_path', 01:59:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:59:15 INFO - 'tests': ['tp5n']}}, 01:59:15 INFO - 'talos.zip': {'path': '', 01:59:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:59:15 INFO - Running post-action listener: _resource_record_post_action 01:59:15 INFO - ##### 01:59:15 INFO - ##### Running create-virtualenv step. 01:59:15 INFO - ##### 01:59:15 INFO - Running pre-action listener: _resource_record_pre_action 01:59:15 INFO - Running main action method: create_virtualenv 01:59:15 INFO - Creating virtualenv /builds/slave/test/build/venv 01:59:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:59:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:59:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:59:16 INFO - Using real prefix '/tools/python27' 01:59:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:59:16 INFO - Installing distribute.............................................................................................................................................................................................done. 01:59:19 INFO - Installing pip.................done. 01:59:19 INFO - Return code: 0 01:59:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:19 INFO - 'HOME': '/Users/cltbld', 01:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:19 INFO - 'LOGNAME': 'cltbld', 01:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:19 INFO - 'MOZ_NO_REMOTE': '1', 01:59:19 INFO - 'NO_EM_RESTART': '1', 01:59:19 INFO - 'PAGER': '/bin/cat', 01:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:19 INFO - 'PWD': '/builds/slave/test', 01:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:19 INFO - 'SHELL': '/bin/bash', 01:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:19 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:19 INFO - 'USER': 'cltbld', 01:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:19 INFO - 'XPC_FLAGS': '0x0', 01:59:19 INFO - 'XPC_SERVICE_NAME': '0', 01:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:59:19 INFO - Cleaning up... 01:59:19 INFO - Return code: 0 01:59:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:19 INFO - 'HOME': '/Users/cltbld', 01:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:19 INFO - 'LOGNAME': 'cltbld', 01:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:19 INFO - 'MOZ_NO_REMOTE': '1', 01:59:19 INFO - 'NO_EM_RESTART': '1', 01:59:19 INFO - 'PAGER': '/bin/cat', 01:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:19 INFO - 'PWD': '/builds/slave/test', 01:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:19 INFO - 'SHELL': '/bin/bash', 01:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:19 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:19 INFO - 'USER': 'cltbld', 01:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:19 INFO - 'XPC_FLAGS': '0x0', 01:59:19 INFO - 'XPC_SERVICE_NAME': '0', 01:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:20 INFO - Downloading/unpacking psutil>=0.7.1 01:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:59:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:22 INFO - Installing collected packages: psutil 01:59:22 INFO - Running setup.py install for psutil 01:59:23 INFO - building 'psutil._psutil_osx' extension 01:59:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:59:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:59:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:59:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:59:23 INFO - building 'psutil._psutil_posix' extension 01:59:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:59:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:59:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:59:23 INFO - ^ 01:59:23 INFO - 1 warning generated. 01:59:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:59:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:59:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:59:23 INFO - Successfully installed psutil 01:59:23 INFO - Cleaning up... 01:59:23 INFO - Return code: 0 01:59:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:59:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:59:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:23 INFO - 'HOME': '/Users/cltbld', 01:59:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:23 INFO - 'LOGNAME': 'cltbld', 01:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:23 INFO - 'MOZ_NO_REMOTE': '1', 01:59:23 INFO - 'NO_EM_RESTART': '1', 01:59:23 INFO - 'PAGER': '/bin/cat', 01:59:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:23 INFO - 'PWD': '/builds/slave/test', 01:59:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:23 INFO - 'SHELL': '/bin/bash', 01:59:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:23 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:23 INFO - 'USER': 'cltbld', 01:59:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:23 INFO - 'XPC_FLAGS': '0x0', 01:59:23 INFO - 'XPC_SERVICE_NAME': '0', 01:59:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:59:26 INFO - Installing collected packages: mozsystemmonitor 01:59:26 INFO - Running setup.py install for mozsystemmonitor 01:59:26 INFO - Successfully installed mozsystemmonitor 01:59:26 INFO - Cleaning up... 01:59:26 INFO - Return code: 0 01:59:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:26 INFO - 'HOME': '/Users/cltbld', 01:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:26 INFO - 'LOGNAME': 'cltbld', 01:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:26 INFO - 'MOZ_NO_REMOTE': '1', 01:59:26 INFO - 'NO_EM_RESTART': '1', 01:59:26 INFO - 'PAGER': '/bin/cat', 01:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:26 INFO - 'PWD': '/builds/slave/test', 01:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:26 INFO - 'SHELL': '/bin/bash', 01:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:26 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:26 INFO - 'USER': 'cltbld', 01:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:26 INFO - 'XPC_FLAGS': '0x0', 01:59:26 INFO - 'XPC_SERVICE_NAME': '0', 01:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:26 INFO - Downloading/unpacking blobuploader==1.2.4 01:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:29 INFO - Downloading blobuploader-1.2.4.tar.gz 01:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:59:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:59:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:30 INFO - Downloading docopt-0.6.1.tar.gz 01:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:59:30 INFO - Installing collected packages: blobuploader, requests, docopt 01:59:30 INFO - Running setup.py install for blobuploader 01:59:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:59:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:59:30 INFO - Running setup.py install for requests 01:59:31 INFO - Running setup.py install for docopt 01:59:31 INFO - Successfully installed blobuploader requests docopt 01:59:31 INFO - Cleaning up... 01:59:31 INFO - Return code: 0 01:59:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:59:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:31 INFO - 'HOME': '/Users/cltbld', 01:59:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:31 INFO - 'LOGNAME': 'cltbld', 01:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:31 INFO - 'MOZ_NO_REMOTE': '1', 01:59:31 INFO - 'NO_EM_RESTART': '1', 01:59:31 INFO - 'PAGER': '/bin/cat', 01:59:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:31 INFO - 'PWD': '/builds/slave/test', 01:59:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:31 INFO - 'SHELL': '/bin/bash', 01:59:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:31 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:31 INFO - 'USER': 'cltbld', 01:59:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:31 INFO - 'XPC_FLAGS': '0x0', 01:59:31 INFO - 'XPC_SERVICE_NAME': '0', 01:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:59:31 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-gUFGcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:59:31 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-eUTTmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:59:31 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-3UJvaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:59:31 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ISbSN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-b5pjgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-YcNESj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-dk0Qit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-EbXtA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-aBxFKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-cfVhp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-_4htcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-zz4IeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:59:32 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-4bqy9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:59:33 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-FDKVs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:59:33 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-oHUzRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:59:33 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-C17krD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:59:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:59:33 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-nigoCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:59:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:59:33 INFO - Running setup.py install for manifestparser 01:59:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:59:33 INFO - Running setup.py install for mozcrash 01:59:33 INFO - Running setup.py install for mozdebug 01:59:33 INFO - Running setup.py install for mozdevice 01:59:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Running setup.py install for mozfile 01:59:34 INFO - Running setup.py install for mozhttpd 01:59:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Running setup.py install for mozinfo 01:59:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Running setup.py install for mozInstall 01:59:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Running setup.py install for mozleak 01:59:34 INFO - Running setup.py install for mozlog 01:59:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:59:34 INFO - Running setup.py install for moznetwork 01:59:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:59:35 INFO - Running setup.py install for mozprocess 01:59:35 INFO - Running setup.py install for mozprofile 01:59:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:59:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:59:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:59:35 INFO - Running setup.py install for mozrunner 01:59:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:59:35 INFO - Running setup.py install for mozscreenshot 01:59:35 INFO - Running setup.py install for moztest 01:59:35 INFO - Running setup.py install for mozversion 01:59:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:59:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:59:36 INFO - Cleaning up... 01:59:36 INFO - Return code: 0 01:59:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:36 INFO - 'HOME': '/Users/cltbld', 01:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:36 INFO - 'LOGNAME': 'cltbld', 01:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:36 INFO - 'MOZ_NO_REMOTE': '1', 01:59:36 INFO - 'NO_EM_RESTART': '1', 01:59:36 INFO - 'PAGER': '/bin/cat', 01:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:36 INFO - 'PWD': '/builds/slave/test', 01:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:36 INFO - 'SHELL': '/bin/bash', 01:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:36 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:36 INFO - 'USER': 'cltbld', 01:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:36 INFO - 'XPC_FLAGS': '0x0', 01:59:36 INFO - 'XPC_SERVICE_NAME': '0', 01:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:59:36 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-EbzWGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:59:36 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-cdplCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:59:36 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-zH6e3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:59:36 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-4BNdsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:59:36 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-NkRAEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:59:36 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-HKFcGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:59:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:59:36 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-yhbIfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-pGYuBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-6MFFjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ljgTSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Ww2w15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-VF4fc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-l9jkKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-FaU5DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-g5CTS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:59:37 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-vPf6W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:59:38 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ofQMBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:59:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:40 INFO - Downloading blessings-1.6.tar.gz 01:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:59:40 INFO - Installing collected packages: blessings 01:59:40 INFO - Running setup.py install for blessings 01:59:40 INFO - Successfully installed blessings 01:59:40 INFO - Cleaning up... 01:59:40 INFO - Return code: 0 01:59:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:59:41 INFO - Reading from file tmpfile_stdout 01:59:41 INFO - Current package versions: 01:59:41 INFO - blessings == 1.6 01:59:41 INFO - blobuploader == 1.2.4 01:59:41 INFO - docopt == 0.6.1 01:59:41 INFO - manifestparser == 1.1 01:59:41 INFO - mozInstall == 1.12 01:59:41 INFO - mozcrash == 0.16 01:59:41 INFO - mozdebug == 0.1 01:59:41 INFO - mozdevice == 0.48 01:59:41 INFO - mozfile == 1.2 01:59:41 INFO - mozhttpd == 0.7 01:59:41 INFO - mozinfo == 0.9 01:59:41 INFO - mozleak == 0.1 01:59:41 INFO - mozlog == 3.1 01:59:41 INFO - moznetwork == 0.27 01:59:41 INFO - mozprocess == 0.22 01:59:41 INFO - mozprofile == 0.28 01:59:41 INFO - mozrunner == 6.11 01:59:41 INFO - mozscreenshot == 0.1 01:59:41 INFO - mozsystemmonitor == 0.0 01:59:41 INFO - moztest == 0.7 01:59:41 INFO - mozversion == 1.4 01:59:41 INFO - psutil == 3.1.1 01:59:41 INFO - requests == 1.2.3 01:59:41 INFO - wsgiref == 0.1.2 01:59:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:41 INFO - 'HOME': '/Users/cltbld', 01:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:41 INFO - 'LOGNAME': 'cltbld', 01:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:41 INFO - 'MOZ_NO_REMOTE': '1', 01:59:41 INFO - 'NO_EM_RESTART': '1', 01:59:41 INFO - 'PAGER': '/bin/cat', 01:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:41 INFO - 'PWD': '/builds/slave/test', 01:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:41 INFO - 'SHELL': '/bin/bash', 01:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:41 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:41 INFO - 'USER': 'cltbld', 01:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:41 INFO - 'XPC_FLAGS': '0x0', 01:59:41 INFO - 'XPC_SERVICE_NAME': '0', 01:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:59:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:59:41 INFO - Cleaning up... 01:59:41 INFO - Return code: 0 01:59:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:41 INFO - 'HOME': '/Users/cltbld', 01:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:41 INFO - 'LOGNAME': 'cltbld', 01:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:41 INFO - 'MOZ_NO_REMOTE': '1', 01:59:41 INFO - 'NO_EM_RESTART': '1', 01:59:41 INFO - 'PAGER': '/bin/cat', 01:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:41 INFO - 'PWD': '/builds/slave/test', 01:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:41 INFO - 'SHELL': '/bin/bash', 01:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:41 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:41 INFO - 'USER': 'cltbld', 01:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:41 INFO - 'XPC_FLAGS': '0x0', 01:59:41 INFO - 'XPC_SERVICE_NAME': '0', 01:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:41 INFO - Downloading/unpacking jsonschema 01:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:59:43 INFO - Downloading/unpacking functools32 (from jsonschema) 01:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:44 INFO - Downloading functools32-3.2.3-2.tar.gz 01:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:59:44 INFO - warning: no files found matching '*.txt' 01:59:44 INFO - no previously-included directories found matching 'build' 01:59:44 INFO - no previously-included directories found matching 'dist' 01:59:44 INFO - no previously-included directories found matching '.git*' 01:59:44 INFO - Installing collected packages: jsonschema, functools32 01:59:44 INFO - Running setup.py install for functools32 01:59:44 INFO - warning: no files found matching '*.txt' 01:59:44 INFO - no previously-included directories found matching 'build' 01:59:44 INFO - no previously-included directories found matching 'dist' 01:59:44 INFO - no previously-included directories found matching '.git*' 01:59:44 INFO - Successfully installed jsonschema functools32 01:59:44 INFO - Cleaning up... 01:59:44 INFO - Return code: 0 01:59:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8aad97fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, '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.7DQRTIsrgH/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.hv6g602r2d/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 01:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:59:44 INFO - 'HOME': '/Users/cltbld', 01:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:59:44 INFO - 'LOGNAME': 'cltbld', 01:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:59:44 INFO - 'MOZ_NO_REMOTE': '1', 01:59:44 INFO - 'NO_EM_RESTART': '1', 01:59:44 INFO - 'PAGER': '/bin/cat', 01:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:59:44 INFO - 'PWD': '/builds/slave/test', 01:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:59:44 INFO - 'SHELL': '/bin/bash', 01:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 01:59:44 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 01:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:59:44 INFO - 'USER': 'cltbld', 01:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:59:44 INFO - 'XPC_FLAGS': '0x0', 01:59:44 INFO - 'XPC_SERVICE_NAME': '0', 01:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:59:44 INFO - Downloading/unpacking flake8 01:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:59:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:59:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:59:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:59:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:59:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:59:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:59:48 INFO - no previously-included directories found matching 'docs/_build' 01:59:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:59:48 INFO - Running setup.py install for pep8 01:59:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:59:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:59:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:59:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:59:48 INFO - no previously-included directories found matching 'docs/_build' 01:59:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:59:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:59:48 INFO - Cleaning up... 01:59:48 INFO - Return code: 0 01:59:48 INFO - Running post-action listener: _resource_record_post_action 01:59:48 INFO - Running post-action listener: _start_resource_monitoring 01:59:48 INFO - Starting resource monitoring. 01:59:48 INFO - ##### 01:59:48 INFO - ##### Running install step. 01:59:48 INFO - ##### 01:59:48 INFO - Running pre-action listener: _resource_record_pre_action 01:59:48 INFO - Running main action method: install 01:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:59:49 INFO - Reading from file tmpfile_stdout 01:59:49 INFO - Detecting whether we're running mozinstall >=1.0... 01:59:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:59:49 INFO - Reading from file tmpfile_stdout 01:59:49 INFO - Output received: 01:59:49 INFO - Usage: mozinstall [options] installer 01:59:49 INFO - Options: 01:59:49 INFO - -h, --help show this help message and exit 01:59:49 INFO - -d DEST, --destination=DEST 01:59:49 INFO - Directory to install application into. [default: 01:59:49 INFO - "/builds/slave/test"] 01:59:49 INFO - --app=APP Application being installed. [default: firefox] 01:59:49 INFO - mkdir: /builds/slave/test/build/application 01:59:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:00:22 INFO - Reading from file tmpfile_stdout 02:00:22 INFO - Output received: 02:00:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:00:22 INFO - Running post-action listener: _resource_record_post_action 02:00:22 INFO - ##### 02:00:22 INFO - ##### Running run-tests step. 02:00:22 INFO - ##### 02:00:22 INFO - Running pre-action listener: _resource_record_pre_action 02:00:22 INFO - Running main action method: run_tests 02:00:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:00:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:00:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:00:22 INFO - 2016-02-04 02:00:22.994 screenresolution[3527:96795] starting screenresolution argv=screenresolution get 02:00:22 INFO - 2016-02-04 02:00:22.997 screenresolution[3527:96795] Display 0: 1600x1200x32@60 02:00:23 INFO - 2016-02-04 02:00:23.003 screenresolution[3528:96797] starting screenresolution argv=screenresolution list 02:00:23 INFO - Available Modes on Display 0 02:00:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:00:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:00:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:00:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:00:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:00:23 INFO - Intel Iris: 02:00:23 INFO - Chipset Model: Intel Iris 02:00:23 INFO - Type: GPU 02:00:23 INFO - Bus: Built-In 02:00:23 INFO - VRAM (Dynamic, Max): 1536 MB 02:00:23 INFO - Vendor: Intel (0x8086) 02:00:23 INFO - Device ID: 0x0a2e 02:00:23 INFO - Revision ID: 0x0009 02:00:23 INFO - Displays: 02:00:23 INFO - Display: 02:00:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:00:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:00:23 INFO - Display Serial Number: 1600x1200 60 02:00:23 INFO - Main Display: Yes 02:00:23 INFO - Mirror: Off 02:00:23 INFO - Online: Yes 02:00:23 INFO - Rotation: Supported 02:00:23 INFO - Return code: 0 02:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:00:23 INFO - Python 2.7.3 02:00:23 INFO - Return code: 0 02:00:23 INFO - grabbing minidump binary from tooltool 02:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:23 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 0x10359ed30>, '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 0x1033c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103594b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:00:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:00:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:00:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:00:23 INFO - Return code: 0 02:00:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:00:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:00:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:00:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:00:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:00:24 INFO - Return code: 0 02:00:24 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/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:00:24 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/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DQRTIsrgH/Render', 02:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:00:24 INFO - 'HOME': '/Users/cltbld', 02:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:00:24 INFO - 'LOGNAME': 'cltbld', 02:00:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:00:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:24 INFO - 'MOZ_NO_REMOTE': '1', 02:00:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:00:24 INFO - 'NO_EM_RESTART': '1', 02:00:24 INFO - 'PAGER': '/bin/cat', 02:00:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:00:24 INFO - 'PWD': '/builds/slave/test', 02:00:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:00:24 INFO - 'SHELL': '/bin/bash', 02:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hv6g602r2d/Listeners', 02:00:24 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:00:24 INFO - 'USER': 'cltbld', 02:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:24 INFO - 'XPC_FLAGS': '0x0', 02:00:24 INFO - 'XPC_SERVICE_NAME': '0', 02:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:00:24 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/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:00:24 INFO - mozversion application_buildid: 20160204000827 02:00:24 INFO - mozversion application_changeset: 3d2eace770d1a64ebd3056affac1806c37ebbf71 02:00:24 INFO - mozversion application_display_name: Nightly 02:00:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:00:24 INFO - mozversion application_name: Firefox 02:00:24 INFO - mozversion application_remotingname: firefox 02:00:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:00:24 INFO - mozversion application_vendor: Mozilla 02:00:24 INFO - mozversion application_version: 47.0a1 02:00:24 INFO - mozversion platform_buildid: 20160204000827 02:00:24 INFO - mozversion platform_changeset: 3d2eace770d1a64ebd3056affac1806c37ebbf71 02:00:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:00:24 INFO - mozversion platform_version: 47.0a1 02:00:24 INFO - using testdate: 1454580024 02:00:24 INFO - actual date: 1454580024 02:00:25 INFO - starting webserver on 'localhost:61739' 02:00:25 INFO - SUITE-START | Running 2 tests 02:00:25 INFO - TEST-START | dromaeo_css 02:00:25 INFO - operating with platform_type : mac_ 02:00:25 INFO - Initialising browser for dromaeo_css test... 02:00:25 INFO - TEST-INFO | started process 3546 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpgFcXWH/profile http://localhost:61739/getInfo.html) 02:00:25 INFO - PROCESS | 3546 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 02:00:27 INFO - PROCESS | 3546 | __metrics Screen width/height:1600/1200 02:00:27 INFO - PROCESS | 3546 | colorDepth:24 02:00:27 INFO - PROCESS | 3546 | Browser inner width/height: 1024/689 02:00:27 INFO - PROCESS | 3546 | __metrics 02:00:27 INFO - PROCESS | 3546 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:00:27 INFO - PROCESS | 3546 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:00:28 INFO - TEST-INFO | 3546: exit 0 02:00:28 INFO - Browser initialized. 02:00:28 INFO - Running cycle 1/1 for dromaeo_css test... 02:00:28 INFO - TEST-INFO | started process 3549 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpgFcXWH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:00:40 INFO - PROCESS | 3549 | RSS: Main: 243535872 02:00:40 INFO - PROCESS | 3549 | 02:01:31 INFO - PROCESS | 3549 | 1454580091692 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:03:41 INFO - PROCESS | 3549 | Cycle 1(1): loaded http://localhost:61739/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61739/tests/dromaeo/cssquery-ext.html) 02:03:42 INFO - PROCESS | 3549 | RSS: Main: 346574848 02:03:42 INFO - PROCESS | 3549 | 02:06:45 INFO - PROCESS | 3549 | Cycle 1(1): loaded http://localhost:61739/tests/dromaeo/cssquery-ext.html (next: http://localhost:61739/tests/dromaeo/cssquery-jquery.html) 02:06:46 INFO - PROCESS | 3549 | RSS: Main: 382070784 02:06:46 INFO - PROCESS | 3549 | 02:09:48 INFO - PROCESS | 3549 | Cycle 1(1): loaded http://localhost:61739/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61739/tests/dromaeo/cssquery-mootools.html) 02:09:49 INFO - PROCESS | 3549 | RSS: Main: 381042688 02:09:49 INFO - PROCESS | 3549 | 02:12:51 INFO - PROCESS | 3549 | Cycle 1(1): loaded http://localhost:61739/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61739/tests/dromaeo/cssquery-prototype.html) 02:12:51 INFO - PROCESS | 3549 | RSS: Main: 343162880 02:12:51 INFO - PROCESS | 3549 | 02:15:55 INFO - PROCESS | 3549 | Cycle 1(1): loaded http://localhost:61739/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61739/tests/dromaeo/cssquery-yui.html) 02:15:55 INFO - PROCESS | 3549 | RSS: Main: 342872064 02:15:55 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | Cycle 1(1): loaded http://localhost:61739/tests/dromaeo/cssquery-yui.html (next: http://localhost:61739/tests/dromaeo/cssquery-dojo.html) 02:18:58 INFO - PROCESS | 3549 | RSS: Main: 391393280 02:18:58 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | __start_tp_report 02:18:58 INFO - PROCESS | 3549 | _x_x_mozilla_page_load 02:18:58 INFO - PROCESS | 3549 | _x_x_mozilla_page_load_details 02:18:58 INFO - PROCESS | 3549 | |i|pagename|runs| 02:18:58 INFO - PROCESS | 3549 | |0;dojo.html;2861.9570706439395;3369.679880411361;3438;3444.3111377724454;3476.72186225102;5553.555715542757;5666.348369937453;5669.829905102848;5673.631213971099;5689.431056894314;5615.298087739033;5688.544916406688;5755.942440575593;5832.62087964282;5839.153322768196;5106.974465127669;5150.793968241266;5156.948430515685;5189.558887494568;5223.320968274119;5287.101192797234;5294.338207724035;5295.443978382272;5295.4969277918535;5325.760340784674;5119.436861945183;5201.661891977009;5215.530602245816;5227.79088836446;5294.232336311233;5172.612054095958;5207.140821764404;5213.087709650796;5215.8174463893965;5221.321228240343;5110.6422550421485;5206.869828254286;5210.400803907562;5221.981713565856;5225.581953443715;5579.832605021856;5667.178259152441;5684.175794509773;5687.516561092312;5697.914531282034;6189.628622282632;6229.4393504584805;6232.25212974446;6240.656763877985;6252.968735156295;5404.729763511848;6192.752289908398;6215.409536094109;6232.781852635181;6240.251169859601;5673.432656734376;5697.430256974311;5781.942180578225;5835;5838.649681019152;6202.1937148171355;6222.253329600477;6325.082862984841;6329.113924050636;6330.335314791972;6142.140100385949;6160.599561028519;6178.042403427476;6182.28903676074;6198;4709.882252943704;6140.17107690456;6212.4408803207025;6215.098810672427;6223.875522489525;6120.17287048654;6131.040261761288;6214.130021796952;6247.219097612799;6248.781292654735;6229.56393052482;6262.279837818618;6266;6271.341509141565;6286.937130628635;4791.616670666338;4873.537013983666;4898.559129678346;4908;4924.285978533093;4335.783210839509;4347.804348804311;4363.345498175299;4391.802368893407;4405.581469760367;5686.943130568641;5688.459596338341;5733.0906733814;5736.196932429463;5782.045962416154;6144.3717414885095;6227.034809604518;6248.250209974832;6267.9373206268265;6292.2134733158355;5677.51741102011;5682.431756824284;5722.227499287626;5738.942610573924;5770.278715160605;5302.655327403706;5336.67979921206;5348.277982472394;5351.117065684196;5354.705491198021;6269.5611307208055;6291.559590828598;6292.307846136921;6294.65379404128;6322.367763223733;6181.474574661024;6213.1922850029205;6274.623522588659;6277.623342599459;6311.147995020797;6239.1577137085915;6280.591761535486;6285.654289014148;6298.275698294571;6298.968505157445;6057.212562366864;6131.254333328352;6158.846028849314;6168.691565421801;6195.4424101829245;5697.3448053474385;5816.76732930678;6207.81376558704;6215.192025036717;6244.875102498016;4904.411470623548;5972.581919265784;6110.1638887921135;6123.313124872426;6138.848241798255;6026.909596356146;6071.817845464643;6076.8784624308155;6078.149059131637;6114.266288045463;5788.160716695971;5899.292084949833;5917.289925209003;5927.733252003584;5935.525157987437;5961.225040744675;6005.099235114768;6025.879482410415;6104.913929256043;6108.0688921796145;5918.17145599625;5940.138679891478;5942;5946.07835785454;5972.8805423892145 02:18:58 INFO - PROCESS | 3549 | |1;ext.html;447.40271737230796;488.6994498383495;555.2864569028798;580.3181262017132;601.882632886587;25163;36516.81741591292;37079.258414831755;37210.44184337237;37216.62783372166;36822.63177368225;39269.41095883564;39549.802250988774;39621;39633.80183099081;8768.254698350633;9683.903160968406;9688.66089686861;9700.417974921527;9703.611855525805;9523.761905952337;9667.12995830375;9670.32307738455;9674.951625241863;9798.706038818847;9737.561809718543;9819.01809819016;9832.410055396664;9837.016298370141;9842.753931151743;9729.124378805906;9798;9808.852867206962;9812.754681132958;9813.656522021694;9555.952220238854;9694.806103877883;9699.757506062335;9701.757456063584;9723.805523889483;38651.22697546033;38811;38867.41698874491;38956;39042.609573904185;2569.331973686836;2844.132539575429;3215.057234375374;3435.6220815710253;3512.841922113511;27206;27881.86059069712;28143.43713125726;28515.287117822012;28559.57160642592;2781.5966684830787;2817.112609527992;2823.026056010673;2863.541833306661;2949.410117976392;500155;506105;506162;506581;506701;52707.73646131745;53932.92134157295;55059.17411238835;55076.72461637746;65389.67305163444;61048.084278735856;61684.45788855225;61703.38296617066;61746;61801.45496362537;15892.52322430329;16050.839491605167;16080.758788618181;16104.516864494084;16124.677506449805;11407.315561066363;11521.596744113916;11662.53349865996;12266.81599776004;12424.813627795591;19491.026625831677;20156.89921550383;20167.29414470516;20170.495737606383;20179.091940862698;7629.656665450068;8876.644934202559;9007.459552426744;9026.729198124067;9041.276697864156;887.5074333744705;966.4008314844841;1009.6617633092849;1078.487718333785;1088.363307465126;28509.857450712614;28678.85284588593;28704.856475717486;28974;29164;1044.38903241603;1073.7208325835338;1082.155918383662;1088.8584484017185;1131.6152508147104;13915.860841391457;14042.227677477633;14106.753812636125;14126.717465650834;14315;646872;654777;655105;655694;659171;54742.17886731702;55153.72423137858;55306.17040744392;55336.16995744986;55351.72324138354;1136.1933027550367;1243.9564615238423;1363.454618152727;1406.5428735660746;1426.3866537389022;27441.588376173975;27998;28143.43713125767;29231.85384073066;29762.255943601584;46137.07725845531;50951.23573146332;51397.74301128471;51452.742736286076;51549.74225129;462478;529752;537545;538304;538662;39175.216495670495;39242.2151556973;40493.39259911163;40506.594934050285;40658.78023659295;37592.87221383363;42252.57747422486;42272.788636056626;43398.91502712331;43439;34938.82530587432;37042.25915481729;37621.05947351229;37733.4339984895;37987.81006095062;36439;36651;36758.816205918796;37838.62161378461;37902.0524486879;36428.63571364252;36749;37683;37687.434688479145;37694.246115076996;21759.456013599785;30389.310852188988;31064;31909.521357179197;32076.5188522177;24157.79350821874;24389.756102438747;24570.262892113264;25131;25228.873855630605 02:18:58 INFO - PROCESS | 3549 | |2;jquery.html;360.3999341097074;365.61792926391917;366.1870647163298;367.47451144862833;372.0735368931362;15058.54824355271;15515.534533963999;18589.442316730503;19107.713384299248;19923.302684406066;11498.19512634116;11735.941320293387;11740.530378784859;11761.411929403517;18901.43295701131;3651.8904432867057;5099.311592934962;5284.101702710548;5286.947130528684;5293.04725149473;4033.1328764315813;4063.2279866825356;4592.242280023809;5868.471837534621;5882.823515294526;5815.62198457101;5866.589338746268;6091.664958427285;6165.229346331708;6331.081993110996;5564.777408903639;6309.526785491106;6314.905276420857;6324.525660575452;6336.778212762554;5492.588055895823;5521.116621340566;5527.419620939824;5528.944710552923;5536.529395001429;12656.873431265754;13264.204147751167;13595.252261125634;13603.931980340134;13606.183628982293;2117.2907076129513;2172.435166856613;2289.347535952262;2547.4905018996274;2737.3156710822295;8666.22004019635;9460.006699296544;9510.524473776284;9636.22910167185;9905.702828915144;1669.3406104588742;1754.4473490850341;1794.1298470241923;1804.0709034847064;1821.0257512231026;93687;97768;99223;100673;100948;11033.668989930315;11044.171687123498;11046.392448415414;11104.833427498594;11211.495482703298;13259.801102983463;13387.397567109503;13432.328383580782;13444.260565668787;13487;8414.49513029208;8433.451825631315;8450;8508.532030738244;8520.446170998865;8589.012263589642;8598.785030374165;8604.010538787994;8665.306775457948;8701.651933922698;3973.602639736061;4168.499780026355;4172.4784401949755;4308.482982042175;4424.579664931826;1761.4803632928317;1808.9638207235782;1825.8265464780825;1830.7162389829598;1841.3095089341498;863.2705363967438;914.2229105260475;986.3835103060587;993.2054356514759;1010.888802231754;15146.621334466727;17467.912660436872;19893.403197904085;19899.900500497693;19926.70109948352;774.2219069834892;853.3770347646129;934.2946075712794;984.7045886234101;993.9155171810332;10588.311759735592;10740.087092597218;10768.515416806262;10769.83845242322;10815.35107893529;681206;713425.4328728323;726101;747213.2639336877;750738;76504;94173;97612;105374;106954;1115.4924509348227;1142.5258517715222;1187.0681515010674;1190.1490434339316;1192.5170306026073;17931.551711207325;18234.088295585432;18269.269229231213;18346.990915499777;18629.18101789157;47769;48770;49021;49291.85268136172;49778.751106244235;63269;64718.38204044748;64921.67539162274;65066.37334066686;65341.67329163324;7228.855422891618;7526.172121066787;7542.208068152765;7576.7348142816945;7600.239976002576;7413.554356900353;7802.843943120993;9395.953020234854;11761.529538818351;11878.584249551224;10168.135708464863;10171.847422288523;10243.23175761806;10478.214133939833;10524.263301568817;7345.669444874887;7409.740659076906;7444.240658467439;7483.812904677427;7638.388928885787;6499.28507864144;6942.166939967236;7549;7725.806854828675;7762.301392874669;10515.631952881613;10750.784984300113;10820.242583019113;10829.620963266249;10891.945540272249;8960.507172105335;10855.728606784893;10906.509207085859;11007.339559626447;11135.99776020162 02:18:58 INFO - PROCESS | 3549 | |3;mootools.html;1403.796449514821;1533.5092770313497;1560.4538411555952;1795.7396177554256;1950.278396993112;7897.802554936122;8090.595470226487;8510.319174466036;8617.612207450664;8640.611172497236;8470.449420787645;8581.227689507943;8655.480671159736;8661;8681.175288347613;2151.8708877467325;2212.8561643493204;2462.704475462947;2487.6268559716004;2496.1388321029217;2227.5520911407552;2232.229880691159;2237.2505210754334;2239.317008312464;2437.987810060947;2426.5887071829743;2456.91400800972;2457.803375729937;2462.741412151725;2464.0143942422997;2075.4915045813723;2423.079229892647;2444.1689825459252;2460.2988148377626;2468.740782217877;2167.4581354661336;2221.4113259986116;2224.8442609017375;2426.34488688055;2478.6158145487298;8540.14598540141;8623.180797824196;8628.611712472954;8643;8643.611037503328;5220.8694782630355;5348.251244825728;5374.462553744634;5379.596530260246;5385.78456861725;3520.295940811822;3617.5478065241846;3648.7263455240964;3655.342038433081;3670.3026424979435;1035.6219979707353;1051.5478344311944;1051.9421431821247;1081.3185496552858;1081.783643271341;11740.236884602558;11798.646040618794;11802.64592062231;11819.704507387383;11839.467223974942;4769.286389952277;4784.760761961888;4837.685550439211;4869.488703686133;4909.582685471775;10024.298299118991;10045.69862904114;10046.19630429564;10049.497525123861;10051.899481005243;5389.595780316492;5428.185772134211;5435.266239057677;5436.10304299794;5438.129899216106;4896.730679812573;4928.556429921325;4936.358273424432;4938;4958.975205124024;3612.8012959287494;3733.663970242691;3751.0622344413896;3765.644368027508;3774.981125094357;1159.1306520109918;1160.7794519041356;1167.9240849344765;1168.1122347016328;1170.5368289637952;1334.0794851552398;1345.4281930179634;1377.8346598408255;1380.9102408343426;1384.6053874645677;7988.480748751313;8098.109207987117;8112.594370281462;8123.268905798506;8209;1200.5197920831738;1201.6214892308894;1203.6750077479032;1215.10689643114;1232.1990706041145;5991.880162396815;5993.700314984233;6141.84645383869;6272.560920735596;6389.8722025560155;10337.328073675188;10568.682939511827;10631.681049568526;10717.142628589694;10727.946360268148;10649.84025239622;10850.186236032328;10879.401632910107;10887.782244355069;10928.890711092947;8105;8184.140665230184;8292.792680182924;8324.209200125979;8348.707795227137;8084.595770211584;8142.267195952392;8158.224968627971;8160.347172226327;8160.755177344689;9373.765655858659;9464.479453630116;9608.75978100553;9640.807183856143;9789.85315220258;7261.636918153966;9879.753006174904;9898.10917017472;9987.850182247417;10006.448355669549;7018.649067546704;7111.715531378687;7120.1099862517185;7125.643717814192;7137.678804453916;8145.307648849915;8200.42597018203;8253.83492330138;8269.710560130367;8296.294814940798;7759.844803104019;7800.336971357498;7812.140664527011;7938.64276107565;7955.4828936118965;7419.332260096401;7572.432067594842;7666.884996725165;7672.309492145734;7810.10183828867;7777.261160189773;7830.843383132192;7878;7889.960550197212;7905.407094467823;7064.540804847874;7181.676824542804;7182.281771822776;7189.029481020205;7198.316159964795;7157.427405807627;7230.023946767329;7232.674529646284;7249.166345870081;7318.487705860539 02:18:58 INFO - PROCESS | 3549 | |4;prototype.html;291.562656015976;319.4712750398092;320.365675961596;333.8280785395521;337.133566733495;6427.807165785034;6616.966915165423;6647.302033286508;6652.9002064968945;6681.53229273951;6447.323031081739;6563.671816409184;6571.934280657204;6574.94800831867;6582.045603387506;4281.871543853682;4634.1195172917205;4638.211504044304;4929.580985616227;4946.752662366867;4748.477667456577;4792.281157826319;4912.877178070559;4934.680700070979;4974.900501989976;4911.533404326583;4936.876578085541;4947.9505204947845;4950.762309422645;4964.702117872921;4935.925961110586;4943.579795717368;4949.901001979976;4955.306257124005;4960.131976904046;4083.8774836754947;4200.096979149467;4201.222773786829;4209.684273679486;4225.556316586745;5417.241586177938;6136.6011209271255;6359.491240700733;6385.553011289212;6391.360863913618;5744.712764361807;5750.913736293959;5752.424757524214;5760.53915686744;5768.769249230026;5461.890762184734;6619.304972977864;6687.030380594835;6770.763023294161;7012.894806577905;4266.210751011042;4572.359869618256;4666.696664716783;4684.227102528079;4695.765211739399;5995.850103747398;7418.851622967564;7451.739189128409;7454.40364770817;7465.402767778619;4732.266498692708;4755.0727608116085;4756.429228492603;4759.643026773006;4780.904381912343;4690.835820746258;4832.202686556749;4832.975835120872;4837.250226214942;4844.128056949712;5801.216835727208;5801.361850196475;5804.9419505805245;5818.505427038749;5818.941810581925;6262.12330273762;6543.1821022372205;7061.576305421691;7071.82320441993;7083.2916708329785;1666.7499875018843;1694.9576010753299;1697.8981261124372;1698.150924537731;1698.6772513222447;922.8338898998111;1079.379356869803;1115.1803424482998;1126.752114534801;1137.294877176156;6435.131257280207;6652.334766523309;6655.600663960178;6657.833554161088;6663.666816659148;7197.100362454693;7312.853742925112;7321.926780732231;7414.295641914117;7417.664820332284;6700.195976482756;6724.529282950147;6741.258461569223;6751.898721519181;6752.662366881636;3510.578215822596;3654.853805847736;3786.1291902862495;3898.571157172709;3948.881533553998;7704.730334438268;7713.498622589514;7715.922840771633;7725.884111738328;7726.111497177896;7624.313811756969;7624.5425274482595;7625.847483050308;7628;7631.3894888408795;5407.432219616962;7525.7958726604575;7690.346320562703;7700.345470634835;7726.304632583095;7381.298776616213;7402.444816638881;7405.925940740523;7412.147603025505;7422;6241.812745617639;7288.96355518219;7291.526050806893;7292.671829767779;7293;7187.02975098355;7717.2282771722375;7717.498362606637;7726.1114971776715;7747.1090824555895;4821.855344339676;4824.228123500223;4824.565789079;4840.1529732296;4840.903181936271;5864.589478736618;7087.964560177373;7325.963370183328;7367.484276100836;7374.188839227788;7125.251848556034;7134.108236470442;7141.3572778448115;7143.464240182111;7149.892751608834;7072.2220555737795;7081.752138675121;7083.610401427764;7086.78739637791;7087.3267039631155;5619.522340601095;6746.4940129489505;6944.097267355413;6947.478939079489;6964.547304425196;6885.586864788129;7111.608861512666;7136.215016348301;7138.214796372291;7163.31948464895;5956.434138756811;6639.933600663931;6906.447484201151;6915.6887940043825;6926.965365173141 02:18:58 INFO - PROCESS | 3549 | |5;yui.html;655.2039272284176;738.047918185541;743.2901578992063;746.8282295072133;755.3617193471516;14618.195999220039;14715.558533243993;14741.48404805832;14839.258037098129;14847.183404912725;13604;13756.724865502683;13773.380197891094;13797.51708690196;13814.240216788072;690.1649004704313;696.5924933913667;705.3052743048094;851;872.5244741615803;840.0339609449121;865.9004214515348;871.5903525343078;875.8117004843957;876.1413814461831;901.3600343755941;911.1207684584375;913.4793167894303;914.1178762494192;917.2524392620027;727.9818004549876;733.1129333506464;733.339994005394;733.7358550921664;737.1301863800713;664.2228592546732;679.3987321220756;680.6630717794674;681.0057316318181;681.2131987554383;14605.561833145022;14694.11835289886;14697;14705.779413308808;14751.114933104049;12312.753744925141;12494.937525312314;12564.623061308175;12881.549145779853;12917.547885824046;9852.408855468695;9945.15466185375;9988.45063521506;10183.38899666015;10183.745406364826;2972.5986991756054;3000.7149320814488;3490.842912068963;3545.7340699447386;3565.4295312750096;77060;77324;77438.45123097507;79999.800003;80229.59885200595;9174.403663761834;9366.110219529133;9476.95261523688;9506.714798556055;9833.60665573369;20359.592808143756;20637.69043464319;20692.965351732353;20727.896360518404;20745.066472008493;7629.847403052019;7668.003159589218;7692.153863075057;7694.730684426018;7735;4131.690123240769;4136.44158038667;4141.047559061432;4144.150449157915;4165.645920096826;3442.225499262646;3479.6694314040633;3485.4597537381746;3494.3884820156372;3494.825258737053;621.3289647181034;633.5628416392674;633.56917296239;650.9218893732782;658.1016911915201;558.600600570594;599.6222379900722;603.471962033221;607.781198768443;624.6881548747684;8439.451435656785;8523.914760852436;8548.444351117158;8711.303095752324;8760.56197190138;461.3448902558375;566.1677334318545;602.807101727443;615.689077016104;625.8185126313318;3753.8031822035578;3991.660708839723;3994.840206391712;4111.506619205715;4140.730852494638;66181;88305;88877;89416;89525;74408;74835.62582187162;75581;76160.61919690366;76781;66340.6682966582;66949.09750358506;68000.31999680039;68011.65994169998;68831.96752048723;8122.161128376895;8267.255946964802;8522.616482258189;8728.607212675572;8728.912710873064;47769.76115119402;50791.49208507867;51106;51451;52663.21005185002;64585.51023163084;65183;65370.67314663396;72087;73548;11164;11533.82699259495;11709.946104850264;11720.961592805364;12535.749285014432;12026.75946481083;12043.397830108635;12068.818967715315;12400.81398779037;12642.747145056863;11092.10847788904;11256.493457794255;11635.47640356169;11638.70903227426;11796;11494.482748276514;11619.269471674319;11734.647960561197;11874.406279685809;11876.16866819349;10928.836067459153;11149;11281.661550153509;11435.371054592077;11551.595694150665;8973.82052358936;9059.592318345558;9178.036306187754;9367.5784589695;9378.577963991773;7604.771856844303;9536.618535258789;9689.660861869801;9808.950955245178;9830.361026533252 02:18:58 INFO - PROCESS | 3549 | __end_tp_report 02:18:58 INFO - PROCESS | 3549 | __start_cc_report 02:18:58 INFO - PROCESS | 3549 | _x_x_mozilla_cycle_collect,1432 02:18:58 INFO - PROCESS | 3549 | __end_cc_report 02:18:58 INFO - PROCESS | 3549 | __startTimestamp1454581138868__endTimestamp 02:18:58 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | ------- Summary: start ------- 02:18:58 INFO - PROCESS | 3549 | Number of tests: 6 02:18:58 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | [#0] dojo.html Cycles:165 Average:5708.81 Median:5917.29 stddev:649.18 (11.0%) stddev-sans-first:611.55 02:18:58 INFO - PROCESS | 3549 | Values: 2862.0 3369.7 3438.0 3444.3 3476.7 5553.6 5666.3 5669.8 5673.6 5689.4 5615.3 5688.5 5755.9 5832.6 5839.2 5107.0 5150.8 5156.9 5189.6 5223.3 5287.1 5294.3 5295.4 5295.5 5325.8 5119.4 5201.7 5215.5 5227.8 5294.2 5172.6 5207.1 5213.1 5215.8 5221.3 5110.6 5206.9 5210.4 5222.0 5225.6 5579.8 5667.2 5684.2 5687.5 5697.9 6189.6 6229.4 6232.3 6240.7 6253.0 5404.7 6192.8 6215.4 6232.8 6240.3 5673.4 5697.4 5781.9 5835.0 5838.6 6202.2 6222.3 6325.1 6329.1 6330.3 6142.1 6160.6 6178.0 6182.3 6198.0 4709.9 6140.2 6212.4 6215.1 6223.9 6120.2 6131.0 6214.1 6247.2 6248.8 6229.6 6262.3 6266.0 6271.3 6286.9 4791.6 4873.5 4898.6 4908.0 4924.3 4335.8 4347.8 4363.3 4391.8 4405.6 5686.9 5688.5 5733.1 5736.2 5782.0 6144.4 6227.0 6248.3 6267.9 6292.2 5677.5 5682.4 5722.2 5738.9 5770.3 5302.7 5336.7 5348.3 5351.1 5354.7 6269.6 6291.6 6292.3 6294.7 6322.4 6181.5 6213.2 6274.6 6277.6 6311.1 6239.2 6280.6 6285.7 6298.3 6299.0 6057.2 6131.3 6158.8 6168.7 6195.4 5697.3 5816.8 6207.8 6215.2 6244.9 4904.4 5972.6 6110.2 6123.3 6138.8 6026.9 6071.8 6076.9 6078.1 6114.3 5788.2 5899.3 5917.3 5927.7 5935.5 5961.2 6005.1 6025.9 6104.9 6108.1 5918.2 5940.1 5942.0 5946.1 5972.9 02:18:58 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | [#1] ext.html Cycles:180 Average:68852.06 Median:38731.11 stddev:150897.19 (389.6%) stddev-sans-first:151233.10 02:18:58 INFO - PROCESS | 3549 | Values: 447.4 488.7 555.3 580.3 601.9 25163.0 36516.8 37079.3 37210.4 37216.6 36822.6 39269.4 39549.8 39621.0 39633.8 8768.3 9683.9 9688.7 9700.4 9703.6 9523.8 9667.1 9670.3 9675.0 9798.7 9737.6 9819.0 9832.4 9837.0 9842.8 9729.1 9798.0 9808.9 9812.8 9813.7 9556.0 9694.8 9699.8 9701.8 9723.8 38651.2 38811.0 38867.4 38956.0 39042.6 2569.3 2844.1 3215.1 3435.6 3512.8 27206.0 27881.9 28143.4 28515.3 28559.6 2781.6 2817.1 2823.0 2863.5 2949.4 500155.0 506105.0 506162.0 506581.0 506701.0 52707.7 53932.9 55059.2 55076.7 65389.7 61048.1 61684.5 61703.4 61746.0 61801.5 15892.5 16050.8 16080.8 16104.5 16124.7 11407.3 11521.6 11662.5 12266.8 12424.8 19491.0 20156.9 20167.3 20170.5 20179.1 7629.7 8876.6 9007.5 9026.7 9041.3 887.5 966.4 1009.7 1078.5 1088.4 28509.9 28678.9 28704.9 28974.0 29164.0 1044.4 1073.7 1082.2 1088.9 1131.6 13915.9 14042.2 14106.8 14126.7 14315.0 646872.0 654777.0 655105.0 655694.0 659171.0 54742.2 55153.7 55306.2 55336.2 55351.7 1136.2 1244.0 1363.5 1406.5 1426.4 27441.6 27998.0 28143.4 29231.9 29762.3 46137.1 50951.2 51397.7 51452.7 51549.7 462478.0 529752.0 537545.0 538304.0 538662.0 39175.2 39242.2 40493.4 40506.6 40658.8 37592.9 42252.6 42272.8 43398.9 43439.0 34938.8 37042.3 37621.1 37733.4 37987.8 36439.0 36651.0 36758.8 37838.6 37902.1 36428.6 36749.0 37683.0 37687.4 37694.2 21759.5 30389.3 31064.0 31909.5 32076.5 24157.8 24389.8 24570.3 25131.0 25228.9 02:18:58 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | [#2] jquery.html Cycles:180 Average:35533.39 Median:4170.49 stddev:119052.03 (2854.6%) stddev-sans-first:119356.70 02:18:58 INFO - PROCESS | 3549 | Values: 360.4 365.6 366.2 367.5 372.1 15058.5 15515.5 18589.4 19107.7 19923.3 11498.2 11735.9 11740.5 11761.4 18901.4 3651.9 5099.3 5284.1 5286.9 5293.0 4033.1 4063.2 4592.2 5868.5 5882.8 5815.6 5866.6 6091.7 6165.2 6331.1 5564.8 6309.5 6314.9 6324.5 6336.8 5492.6 5521.1 5527.4 5528.9 5536.5 12656.9 13264.2 13595.3 13603.9 13606.2 2117.3 2172.4 2289.3 2547.5 2737.3 8666.2 9460.0 9510.5 9636.2 9905.7 1669.3 1754.4 1794.1 1804.1 1821.0 93687.0 97768.0 99223.0 100673.0 100948.0 11033.7 11044.2 11046.4 11104.8 11211.5 13259.8 13387.4 13432.3 13444.3 13487.0 8414.5 8433.5 8450.0 8508.5 8520.4 8589.0 8598.8 8604.0 8665.3 8701.7 3973.6 4168.5 4172.5 4308.5 4424.6 1761.5 1809.0 1825.8 1830.7 1841.3 863.3 914.2 986.4 993.2 1010.9 15146.6 17467.9 19893.4 19899.9 19926.7 774.2 853.4 934.3 984.7 993.9 10588.3 10740.1 10768.5 10769.8 10815.4 681206.0 713425.4 726101.0 747213.3 750738.0 76504.0 94173.0 97612.0 105374.0 106954.0 1115.5 1142.5 1187.1 1190.1 1192.5 17931.6 18234.1 18269.3 18347.0 18629.2 47769.0 48770.0 49021.0 49291.9 49778.8 63269.0 64718.4 64921.7 65066.4 65341.7 7228.9 7526.2 7542.2 7576.7 7600.2 7413.6 7802.8 9396.0 11761.5 11878.6 10168.1 10171.8 10243.2 10478.2 10524.3 7345.7 7409.7 7444.2 7483.8 7638.4 6499.3 6942.2 7549.0 7725.8 7762.3 10515.6 10750.8 10820.2 10829.6 10891.9 8960.5 10855.7 10906.5 11007.3 11136.0 02:18:58 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | [#3] mootools.html Cycles:180 Average:6046.42 Median:5089.92 stddev:3188.53 (62.6%) stddev-sans-first:3178.38 02:18:58 INFO - PROCESS | 3549 | Values: 1403.8 1533.5 1560.5 1795.7 1950.3 7897.8 8090.6 8510.3 8617.6 8640.6 8470.4 8581.2 8655.5 8661.0 8681.2 2151.9 2212.9 2462.7 2487.6 2496.1 2227.6 2232.2 2237.3 2239.3 2438.0 2426.6 2456.9 2457.8 2462.7 2464.0 2075.5 2423.1 2444.2 2460.3 2468.7 2167.5 2221.4 2224.8 2426.3 2478.6 8540.1 8623.2 8628.6 8643.0 8643.6 5220.9 5348.3 5374.5 5379.6 5385.8 3520.3 3617.5 3648.7 3655.3 3670.3 1035.6 1051.5 1051.9 1081.3 1081.8 11740.2 11798.6 11802.6 11819.7 11839.5 4769.3 4784.8 4837.7 4869.5 4909.6 10024.3 10045.7 10046.2 10049.5 10051.9 5389.6 5428.2 5435.3 5436.1 5438.1 4896.7 4928.6 4936.4 4938.0 4959.0 3612.8 3733.7 3751.1 3765.6 3775.0 1159.1 1160.8 1167.9 1168.1 1170.5 1334.1 1345.4 1377.8 1380.9 1384.6 7988.5 8098.1 8112.6 8123.3 8209.0 1200.5 1201.6 1203.7 1215.1 1232.2 5991.9 5993.7 6141.8 6272.6 6389.9 10337.3 10568.7 10631.7 10717.1 10727.9 10649.8 10850.2 10879.4 10887.8 10928.9 8105.0 8184.1 8292.8 8324.2 8348.7 8084.6 8142.3 8158.2 8160.3 8160.8 9373.8 9464.5 9608.8 9640.8 9789.9 7261.6 9879.8 9898.1 9987.9 10006.4 7018.6 7111.7 7120.1 7125.6 7137.7 8145.3 8200.4 8253.8 8269.7 8296.3 7759.8 7800.3 7812.1 7938.6 7955.5 7419.3 7572.4 7666.9 7672.3 7810.1 7777.3 7830.8 7878.0 7890.0 7905.4 7064.5 7181.7 7182.3 7189.0 7198.3 7157.4 7230.0 7232.7 7249.2 7318.5 02:18:58 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | [#4] prototype.html Cycles:180 Average:5770.74 Median:6553.43 stddev:1830.61 (27.9%) stddev-sans-first:1788.96 02:18:58 INFO - PROCESS | 3549 | Values: 291.6 319.5 320.4 333.8 337.1 6427.8 6617.0 6647.3 6652.9 6681.5 6447.3 6563.7 6571.9 6574.9 6582.0 4281.9 4634.1 4638.2 4929.6 4946.8 4748.5 4792.3 4912.9 4934.7 4974.9 4911.5 4936.9 4948.0 4950.8 4964.7 4935.9 4943.6 4949.9 4955.3 4960.1 4083.9 4200.1 4201.2 4209.7 4225.6 5417.2 6136.6 6359.5 6385.6 6391.4 5744.7 5750.9 5752.4 5760.5 5768.8 5461.9 6619.3 6687.0 6770.8 7012.9 4266.2 4572.4 4666.7 4684.2 4695.8 5995.9 7418.9 7451.7 7454.4 7465.4 4732.3 4755.1 4756.4 4759.6 4780.9 4690.8 4832.2 4833.0 4837.3 4844.1 5801.2 5801.4 5804.9 5818.5 5818.9 6262.1 6543.2 7061.6 7071.8 7083.3 1666.7 1695.0 1697.9 1698.2 1698.7 922.8 1079.4 1115.2 1126.8 1137.3 6435.1 6652.3 6655.6 6657.8 6663.7 7197.1 7312.9 7321.9 7414.3 7417.7 6700.2 6724.5 6741.3 6751.9 6752.7 3510.6 3654.9 3786.1 3898.6 3948.9 7704.7 7713.5 7715.9 7725.9 7726.1 7624.3 7624.5 7625.8 7628.0 7631.4 5407.4 7525.8 7690.3 7700.3 7726.3 7381.3 7402.4 7405.9 7412.1 7422.0 6241.8 7289.0 7291.5 7292.7 7293.0 7187.0 7717.2 7717.5 7726.1 7747.1 4821.9 4824.2 4824.6 4840.2 4840.9 5864.6 7088.0 7326.0 7367.5 7374.2 7125.3 7134.1 7141.4 7143.5 7149.9 7072.2 7081.8 7083.6 7086.8 7087.3 5619.5 6746.5 6944.1 6947.5 6964.5 6885.6 7111.6 7136.2 7138.2 7163.3 5956.4 6639.9 6906.4 6915.7 6927.0 02:18:58 INFO - PROCESS | 3549 | 02:18:58 INFO - PROCESS | 3549 | [#5] yui.html Cycles:180 Average:17889.83 Median:32618.22 stddev:24726.22 (75.8%) stddev-sans-first:24761.71 02:18:58 INFO - PROCESS | 3549 | Values: 655.2 738.0 743.3 746.8 755.4 14618.2 14715.6 14741.5 14839.3 14847.2 13604.0 13756.7 13773.4 13797.5 13814.2 690.2 696.6 705.3 851.0 872.5 840.0 865.9 871.6 875.8 876.1 901.4 911.1 913.5 914.1 917.3 728.0 733.1 733.3 733.7 737.1 664.2 679.4 680.7 681.0 681.2 14605.6 14694.1 14697.0 14705.8 14751.1 12312.8 12494.9 12564.6 12881.5 12917.5 9852.4 9945.2 9988.5 10183.4 10183.7 2972.6 3000.7 3490.8 3545.7 3565.4 77060.0 77324.0 77438.5 79999.8 80229.6 9174.4 9366.1 9477.0 9506.7 9833.6 20359.6 20637.7 20693.0 20727.9 20745.1 7629.8 7668.0 7692.2 7694.7 7735.0 4131.7 4136.4 4141.0 4144.2 4165.6 3442.2 3479.7 3485.5 3494.4 3494.8 621.3 633.6 633.6 650.9 658.1 558.6 599.6 603.5 607.8 624.7 8439.5 8523.9 8548.4 8711.3 8760.6 461.3 566.2 602.8 615.7 625.8 3753.8 3991.7 3994.8 4111.5 4140.7 66181.0 88305.0 88877.0 89416.0 89525.0 74408.0 74835.6 75581.0 76160.6 76781.0 66340.7 66949.1 68000.3 68011.7 68832.0 8122.2 8267.3 8522.6 8728.6 8728.9 47769.8 50791.5 51106.0 51451.0 52663.2 64585.5 65183.0 65370.7 72087.0 73548.0 11164.0 11533.8 11709.9 11721.0 12535.7 12026.8 12043.4 12068.8 12400.8 12642.7 11092.1 11256.5 11635.5 11638.7 11796.0 11494.5 11619.3 11734.6 11874.4 11876.2 10928.8 11149.0 11281.7 11435.4 11551.6 8973.8 9059.6 9178.0 9367.6 9378.6 7604.8 9536.6 9689.7 9809.0 9830.4 02:18:58 INFO - PROCESS | 3549 | -------- Summary: end -------- 02:18:58 INFO - PROCESS | 3549 | 02:18:59 INFO - TEST-INFO | 3549: exit 0 02:18:59 INFO - TEST-OK | dromaeo_css | took 1113999ms 02:18:59 INFO - TEST-START | kraken 02:18:59 INFO - operating with platform_type : mac_ 02:18:59 INFO - Initialising browser for kraken test... 02:18:59 INFO - TEST-INFO | started process 3551 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpaVAeFq/profile http://localhost:61739/getInfo.html) 02:18:59 INFO - PROCESS | 3551 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 02:19:01 INFO - PROCESS | 3551 | __metrics Screen width/height:1600/1200 02:19:01 INFO - PROCESS | 3551 | colorDepth:24 02:19:01 INFO - PROCESS | 3551 | Browser inner width/height: 1024/689 02:19:01 INFO - PROCESS | 3551 | __metrics 02:19:01 INFO - PROCESS | 3551 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:19:01 INFO - PROCESS | 3551 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:19:02 INFO - TEST-INFO | 3551: exit 0 02:19:02 INFO - Browser initialized. 02:19:02 INFO - Running cycle 1/1 for kraken test... 02:19:02 INFO - TEST-INFO | started process 3553 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpaVAeFq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:14 INFO - PROCESS | 3553 | RSS: Main: 243052544 02:19:14 INFO - PROCESS | 3553 | 02:19:17 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61739/tests/kraken/driver.html?testName=audio-beat-detection) 02:19:17 INFO - PROCESS | 3553 | RSS: Main: 291000320 02:19:17 INFO - PROCESS | 3553 | 02:19:20 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61739/tests/kraken/driver.html?testName=audio-dft) 02:19:20 INFO - PROCESS | 3553 | RSS: Main: 300711936 02:19:20 INFO - PROCESS | 3553 | 02:19:24 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61739/tests/kraken/driver.html?testName=audio-fft) 02:19:24 INFO - PROCESS | 3553 | RSS: Main: 287756288 02:19:24 INFO - PROCESS | 3553 | 02:19:26 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61739/tests/kraken/driver.html?testName=audio-oscillator) 02:19:27 INFO - PROCESS | 3553 | RSS: Main: 289878016 02:19:27 INFO - PROCESS | 3553 | 02:19:29 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61739/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:19:30 INFO - PROCESS | 3553 | RSS: Main: 291766272 02:19:30 INFO - PROCESS | 3553 | 02:19:32 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61739/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:33 INFO - PROCESS | 3553 | RSS: Main: 293044224 02:19:33 INFO - PROCESS | 3553 | 02:19:36 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61739/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:36 INFO - PROCESS | 3553 | RSS: Main: 292249600 02:19:36 INFO - PROCESS | 3553 | 02:19:39 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61739/tests/kraken/driver.html?testName=json-parse-financial) 02:19:40 INFO - PROCESS | 3553 | RSS: Main: 292446208 02:19:40 INFO - PROCESS | 3553 | 02:19:41 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61739/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:19:42 INFO - PROCESS | 3553 | RSS: Main: 325636096 02:19:42 INFO - PROCESS | 3553 | 02:19:44 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61739/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:19:44 INFO - PROCESS | 3553 | RSS: Main: 327925760 02:19:44 INFO - PROCESS | 3553 | 02:19:46 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61739/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:19:47 INFO - PROCESS | 3553 | RSS: Main: 332615680 02:19:47 INFO - PROCESS | 3553 | 02:19:50 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:19:50 INFO - PROCESS | 3553 | RSS: Main: 335118336 02:19:50 INFO - PROCESS | 3553 | 02:19:53 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:19:53 INFO - PROCESS | 3553 | RSS: Main: 334385152 02:19:53 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | Cycle 1(1): loaded http://localhost:61739/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61739/tests/kraken/driver.html?testName=ai-astar) 02:19:55 INFO - PROCESS | 3553 | RSS: Main: 395845632 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | __start_tp_report 02:19:55 INFO - PROCESS | 3553 | _x_x_mozilla_page_load 02:19:55 INFO - PROCESS | 3553 | _x_x_mozilla_page_load_details 02:19:55 INFO - PROCESS | 3553 | |i|pagename|runs| 02:19:55 INFO - PROCESS | 3553 | |0;ai-astar;103;109;110;110;110;111;114;111;111;111 02:19:55 INFO - PROCESS | 3553 | |1;audio-beat-detection;157;121;146;144;141;129;172;147;187;116 02:19:55 INFO - PROCESS | 3553 | |2;audio-dft;187;188;186;184;185;185;185;186;181;173 02:19:55 INFO - PROCESS | 3553 | |3;audio-fft;78;76;90;69;57;75;87;112;89;46 02:19:55 INFO - PROCESS | 3553 | |4;audio-oscillator;90;97;132;79;80;80;115;76;78;119 02:19:55 INFO - PROCESS | 3553 | |5;imaging-gaussian-blur;89;98;91;91;91;92;89;140;113;93 02:19:55 INFO - PROCESS | 3553 | |6;imaging-darkroom;94;94;94;96;95;93;94;94;95;95 02:19:55 INFO - PROCESS | 3553 | |7;imaging-desaturate;87;87;86;86;84;87;84;87;86;86 02:19:55 INFO - PROCESS | 3553 | |8;json-parse-financial;55;55;55;54;53;55;56;65;53;52 02:19:55 INFO - PROCESS | 3553 | |9;json-stringify-tinderbox;63;66;71;78;70;68;68;66;79;103 02:19:55 INFO - PROCESS | 3553 | |10;stanford-crypto-aes;84;109;108;108;83;82;83;83;82;83 02:19:55 INFO - PROCESS | 3553 | |11;stanford-crypto-ccm;124;125;122;129;122;119;121;120;125;122 02:19:55 INFO - PROCESS | 3553 | |12;stanford-crypto-pbkdf2;140;128;139;137;138;138;139;137;136;138 02:19:55 INFO - PROCESS | 3553 | |13;stanford-crypto-sha256-iterative;68;69;65;67;67;67;68;67;67;66 02:19:55 INFO - PROCESS | 3553 | __end_tp_report 02:19:55 INFO - PROCESS | 3553 | __start_cc_report 02:19:55 INFO - PROCESS | 3553 | _x_x_mozilla_cycle_collect,1141 02:19:55 INFO - PROCESS | 3553 | __end_cc_report 02:19:55 INFO - PROCESS | 3553 | __startTimestamp1454581195639__endTimestamp 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | ------- Summary: start ------- 02:19:55 INFO - PROCESS | 3553 | Number of tests: 14 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.79 (2.5%) stddev-sans-first:1.39 02:19:55 INFO - PROCESS | 3553 | Values: 103.0 109.0 110.0 110.0 110.0 111.0 114.0 111.0 111.0 111.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:146.50 stddev:21.91 (15.0%) stddev-sans-first:22.88 02:19:55 INFO - PROCESS | 3553 | Values: 157.0 121.0 146.0 144.0 141.0 129.0 172.0 147.0 187.0 116.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#2] audio-dft Cycles:10 Average:184.00 Median:185.50 stddev:4.29 (2.3%) stddev-sans-first:4.42 02:19:55 INFO - PROCESS | 3553 | Values: 187.0 188.0 186.0 184.0 185.0 185.0 185.0 186.0 181.0 173.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#3] audio-fft Cycles:10 Average:77.90 Median:77.00 stddev:18.44 (24.0%) stddev-sans-first:19.56 02:19:55 INFO - PROCESS | 3553 | Values: 78.0 76.0 90.0 69.0 57.0 75.0 87.0 112.0 89.0 46.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.50 stddev:20.35 (25.6%) stddev-sans-first:21.52 02:19:55 INFO - PROCESS | 3553 | Values: 90.0 97.0 132.0 79.0 80.0 80.0 115.0 76.0 78.0 119.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:91.00 stddev:16.17 (17.8%) stddev-sans-first:16.77 02:19:55 INFO - PROCESS | 3553 | Values: 89.0 98.0 91.0 91.0 91.0 92.0 89.0 140.0 113.0 93.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#6] imaging-darkroom Cycles:10 Average:94.40 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 02:19:55 INFO - PROCESS | 3553 | Values: 94.0 94.0 94.0 96.0 95.0 93.0 94.0 94.0 95.0 95.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.15 (1.3%) stddev-sans-first:1.17 02:19:55 INFO - PROCESS | 3553 | Values: 87.0 87.0 86.0 86.0 84.0 87.0 84.0 87.0 86.0 86.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:3.62 (6.6%) stddev-sans-first:3.84 02:19:55 INFO - PROCESS | 3553 | Values: 55.0 55.0 55.0 54.0 53.0 55.0 56.0 65.0 53.0 52.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:69.00 stddev:11.65 (16.9%) stddev-sans-first:11.76 02:19:55 INFO - PROCESS | 3553 | Values: 63.0 66.0 71.0 78.0 70.0 68.0 68.0 66.0 79.0 103.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:83.00 stddev:12.32 (14.8%) stddev-sans-first:12.84 02:19:55 INFO - PROCESS | 3553 | Values: 84.0 109.0 108.0 108.0 83.0 82.0 83.0 83.0 82.0 83.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.00 stddev:2.92 (2.4%) stddev-sans-first:3.07 02:19:55 INFO - PROCESS | 3553 | Values: 124.0 125.0 122.0 129.0 122.0 119.0 121.0 120.0 125.0 122.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.00 Median:138.00 stddev:3.37 (2.4%) stddev-sans-first:3.39 02:19:55 INFO - PROCESS | 3553 | Values: 140.0 128.0 139.0 137.0 138.0 138.0 139.0 137.0 136.0 138.0 02:19:55 INFO - PROCESS | 3553 | 02:19:55 INFO - PROCESS | 3553 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 02:19:55 INFO - PROCESS | 3553 | Values: 68.0 69.0 65.0 67.0 67.0 67.0 68.0 67.0 67.0 66.0 02:19:55 INFO - PROCESS | 3553 | -------- Summary: end -------- 02:19:55 INFO - PROCESS | 3553 | 02:19:56 INFO - TEST-INFO | 3553: exit 0 02:19:56 INFO - TEST-OK | kraken | took 56998ms 02:19:56 INFO - SUITE-END | took 1170s 02:19:56 INFO - Completed test suite (00:19:31) 02:19:56 INFO - Working with test: dromaeo_css 02:19:56 INFO - Generating results file: dromaeo_css 02:19:56 INFO - Working with test: kraken 02:19:56 INFO - Generating results file: kraken 02:19:56 INFO - javascript benchmark 02:19:56 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:19:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 02:19:57 INFO - process_Request line: dromaeo_css 7417.92 graph.html#tests=[[72,64,59]] 02:19:57 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:19:57 INFO - process_Request line: kraken 1437.60 graph.html#tests=[[232,64,59]] 02:19:57 INFO - RETURN: dromaeo_css: 7417.92 02:19:57 INFO - RETURN: kraken: 1437.60 02:19:57 INFO - javascript benchmark 02:19:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2861.9570706439395, 3369.679880411361, 3438.0, 3444.3111377724454, 3476.72186225102, 5553.555715542757, 5666.348369937453, 5669.829905102848, 5673.631213971099, 5689.431056894314, 5615.298087739033, 5688.544916406688, 5755.942440575593, 5832.62087964282, 5839.153322768196, 5106.974465127669, 5150.793968241266, 5156.948430515685, 5189.558887494568, 5223.320968274119, 5287.101192797234, 5294.338207724035, 5295.443978382272, 5295.4969277918535, 5325.760340784674, 5119.436861945183, 5201.661891977009, 5215.530602245816, 5227.79088836446, 5294.232336311233, 5172.612054095958, 5207.140821764404, 5213.087709650796, 5215.8174463893965, 5221.321228240343, 5110.6422550421485, 5206.869828254286, 5210.400803907562, 5221.981713565856, 5225.581953443715, 5579.832605021856, 5667.178259152441, 5684.175794509773, 5687.516561092312, 5697.914531282034, 6189.628622282632, 6229.4393504584805, 6232.25212974446, 6240.656763877985, 6252.968735156295, 5404.729763511848, 6192.752289908398, 6215.409536094109, 6232.781852635181, 6240.251169859601, 5673.432656734376, 5697.430256974311, 5781.942180578225, 5835.0, 5838.649681019152, 6202.1937148171355, 6222.253329600477, 6325.082862984841, 6329.113924050636, 6330.335314791972, 6142.140100385949, 6160.599561028519, 6178.042403427476, 6182.28903676074, 6198.0, 4709.882252943704, 6140.17107690456, 6212.4408803207025, 6215.098810672427, 6223.875522489525, 6120.17287048654, 6131.040261761288, 6214.130021796952, 6247.219097612799, 6248.781292654735, 6229.56393052482, 6262.279837818618, 6266.0, 6271.341509141565, 6286.937130628635, 4791.616670666338, 4873.537013983666, 4898.559129678346, 4908.0, 4924.285978533093, 4335.783210839509, 4347.804348804311, 4363.345498175299, 4391.802368893407, 4405.581469760367, 5686.943130568641, 5688.459596338341, 5733.0906733814, 5736.196932429463, 5782.045962416154, 6144.3717414885095, 6227.034809604518, 6248.250209974832, 6267.9373206268265, 6292.2134733158355, 5677.51741102011, 5682.431756824284, 5722.227499287626, 5738.942610573924, 5770.278715160605, 5302.655327403706, 5336.67979921206, 5348.277982472394, 5351.117065684196, 5354.705491198021, 6269.5611307208055, 6291.559590828598, 6292.307846136921, 6294.65379404128, 6322.367763223733, 6181.474574661024, 6213.1922850029205, 6274.623522588659, 6277.623342599459, 6311.147995020797, 6239.1577137085915, 6280.591761535486, 6285.654289014148, 6298.275698294571, 6298.968505157445, 6057.212562366864, 6131.254333328352, 6158.846028849314, 6168.691565421801, 6195.4424101829245, 5697.3448053474385, 5816.76732930678, 6207.81376558704, 6215.192025036717, 6244.875102498016, 4904.411470623548, 5972.581919265784, 6110.1638887921135, 6123.313124872426, 6138.848241798255, 6026.909596356146, 6071.817845464643, 6076.8784624308155, 6078.149059131637, 6114.266288045463, 5788.160716695971, 5899.292084949833, 5917.289925209003, 5927.733252003584, 5935.525157987437, 5961.225040744675, 6005.099235114768, 6025.879482410415, 6104.913929256043, 6108.0688921796145, 5918.17145599625, 5940.138679891478, 5942.0, 5946.07835785454, 5972.8805423892145], "unit": "score", "name": "dojo.html", "value": 5667.4394792491485}, {"lowerIsBetter": false, "replicates": [447.40271737230796, 488.6994498383495, 555.2864569028798, 580.3181262017132, 601.882632886587, 25163.0, 36516.81741591292, 37079.258414831755, 37210.44184337237, 37216.62783372166, 36822.63177368225, 39269.41095883564, 39549.802250988774, 39621.0, 39633.80183099081, 8768.254698350633, 9683.903160968406, 9688.66089686861, 9700.417974921527, 9703.611855525805, 9523.761905952337, 9667.12995830375, 9670.32307738455, 9674.951625241863, 9798.706038818847, 9737.561809718543, 9819.01809819016, 9832.410055396664, 9837.016298370141, 9842.753931151743, 9729.124378805906, 9798.0, 9808.852867206962, 9812.754681132958, 9813.656522021694, 9555.952220238854, 9694.806103877883, 9699.757506062335, 9701.757456063584, 9723.805523889483, 38651.22697546033, 38811.0, 38867.41698874491, 38956.0, 39042.609573904185, 2569.331973686836, 2844.132539575429, 3215.057234375374, 3435.6220815710253, 3512.841922113511, 27206.0, 27881.86059069712, 28143.43713125726, 28515.287117822012, 28559.57160642592, 2781.5966684830787, 2817.112609527992, 2823.026056010673, 2863.541833306661, 2949.410117976392, 500155.0, 506105.0, 506162.0, 506581.0, 506701.0, 52707.73646131745, 53932.92134157295, 55059.17411238835, 55076.72461637746, 65389.67305163444, 61048.084278735856, 61684.45788855225, 61703.38296617066, 61746.0, 61801.45496362537, 15892.52322430329, 16050.839491605167, 16080.758788618181, 16104.516864494084, 16124.677506449805, 11407.315561066363, 11521.596744113916, 11662.53349865996, 12266.81599776004, 12424.813627795591, 19491.026625831677, 20156.89921550383, 20167.29414470516, 20170.495737606383, 20179.091940862698, 7629.656665450068, 8876.644934202559, 9007.459552426744, 9026.729198124067, 9041.276697864156, 887.5074333744705, 966.4008314844841, 1009.6617633092849, 1078.487718333785, 1088.363307465126, 28509.857450712614, 28678.85284588593, 28704.856475717486, 28974.0, 29164.0, 1044.38903241603, 1073.7208325835338, 1082.155918383662, 1088.8584484017185, 1131.6152508147104, 13915.860841391457, 14042.227677477633, 14106.753812636125, 14126.717465650834, 14315.0, 646872.0, 654777.0, 655105.0, 655694.0, 659171.0, 54742.17886731702, 55153.72423137858, 55306.17040744392, 55336.16995744986, 55351.72324138354, 1136.1933027550367, 1243.9564615238423, 1363.454618152727, 1406.5428735660746, 1426.3866537389022, 27441.588376173975, 27998.0, 28143.43713125767, 29231.85384073066, 29762.255943601584, 46137.07725845531, 50951.23573146332, 51397.74301128471, 51452.742736286076, 51549.74225129, 462478.0, 529752.0, 537545.0, 538304.0, 538662.0, 39175.216495670495, 39242.2151556973, 40493.39259911163, 40506.594934050285, 40658.78023659295, 37592.87221383363, 42252.57747422486, 42272.788636056626, 43398.91502712331, 43439.0, 34938.82530587432, 37042.25915481729, 37621.05947351229, 37733.4339984895, 37987.81006095062, 36439.0, 36651.0, 36758.816205918796, 37838.62161378461, 37902.0524486879, 36428.63571364252, 36749.0, 37683.0, 37687.434688479145, 37694.246115076996, 21759.456013599785, 30389.310852188988, 31064.0, 31909.521357179197, 32076.5188522177, 24157.79350821874, 24389.756102438747, 24570.262892113264, 25131.0, 25228.873855630605], "unit": "score", "name": "ext.html", "value": 19617.667520252002}, {"lowerIsBetter": false, "replicates": [360.3999341097074, 365.61792926391917, 366.1870647163298, 367.47451144862833, 372.0735368931362, 15058.54824355271, 15515.534533963999, 18589.442316730503, 19107.713384299248, 19923.302684406066, 11498.19512634116, 11735.941320293387, 11740.530378784859, 11761.411929403517, 18901.43295701131, 3651.8904432867057, 5099.311592934962, 5284.101702710548, 5286.947130528684, 5293.04725149473, 4033.1328764315813, 4063.2279866825356, 4592.242280023809, 5868.471837534621, 5882.823515294526, 5815.62198457101, 5866.589338746268, 6091.664958427285, 6165.229346331708, 6331.081993110996, 5564.777408903639, 6309.526785491106, 6314.905276420857, 6324.525660575452, 6336.778212762554, 5492.588055895823, 5521.116621340566, 5527.419620939824, 5528.944710552923, 5536.529395001429, 12656.873431265754, 13264.204147751167, 13595.252261125634, 13603.931980340134, 13606.183628982293, 2117.2907076129513, 2172.435166856613, 2289.347535952262, 2547.4905018996274, 2737.3156710822295, 8666.22004019635, 9460.006699296544, 9510.524473776284, 9636.22910167185, 9905.702828915144, 1669.3406104588742, 1754.4473490850341, 1794.1298470241923, 1804.0709034847064, 1821.0257512231026, 93687.0, 97768.0, 99223.0, 100673.0, 100948.0, 11033.668989930315, 11044.171687123498, 11046.392448415414, 11104.833427498594, 11211.495482703298, 13259.801102983463, 13387.397567109503, 13432.328383580782, 13444.260565668787, 13487.0, 8414.49513029208, 8433.451825631315, 8450.0, 8508.532030738244, 8520.446170998865, 8589.012263589642, 8598.785030374165, 8604.010538787994, 8665.306775457948, 8701.651933922698, 3973.602639736061, 4168.499780026355, 4172.4784401949755, 4308.482982042175, 4424.579664931826, 1761.4803632928317, 1808.9638207235782, 1825.8265464780825, 1830.7162389829598, 1841.3095089341498, 863.2705363967438, 914.2229105260475, 986.3835103060587, 993.2054356514759, 1010.888802231754, 15146.621334466727, 17467.912660436872, 19893.403197904085, 19899.900500497693, 19926.70109948352, 774.2219069834892, 853.3770347646129, 934.2946075712794, 984.7045886234101, 993.9155171810332, 10588.311759735592, 10740.087092597218, 10768.515416806262, 10769.83845242322, 10815.35107893529, 681206.0, 713425.4328728323, 726101.0, 747213.2639336877, 750738.0, 76504.0, 94173.0, 97612.0, 105374.0, 106954.0, 1115.4924509348227, 1142.5258517715222, 1187.0681515010674, 1190.1490434339316, 1192.5170306026073, 17931.551711207325, 18234.088295585432, 18269.269229231213, 18346.990915499777, 18629.18101789157, 47769.0, 48770.0, 49021.0, 49291.85268136172, 49778.751106244235, 63269.0, 64718.38204044748, 64921.67539162274, 65066.37334066686, 65341.67329163324, 7228.855422891618, 7526.172121066787, 7542.208068152765, 7576.7348142816945, 7600.239976002576, 7413.554356900353, 7802.843943120993, 9395.953020234854, 11761.529538818351, 11878.584249551224, 10168.135708464863, 10171.847422288523, 10243.23175761806, 10478.214133939833, 10524.263301568817, 7345.669444874887, 7409.740659076906, 7444.240658467439, 7483.812904677427, 7638.388928885787, 6499.28507864144, 6942.166939967236, 7549.0, 7725.806854828675, 7762.301392874669, 10515.631952881613, 10750.784984300113, 10820.242583019113, 10829.620963266249, 10891.945540272249, 8960.507172105335, 10855.728606784893, 10906.509207085859, 11007.339559626447, 11135.99776020162], "unit": "score", "name": "jquery.html", "value": 8705.559589226175}, {"lowerIsBetter": false, "replicates": [1403.796449514821, 1533.5092770313497, 1560.4538411555952, 1795.7396177554256, 1950.278396993112, 7897.802554936122, 8090.595470226487, 8510.319174466036, 8617.612207450664, 8640.611172497236, 8470.449420787645, 8581.227689507943, 8655.480671159736, 8661.0, 8681.175288347613, 2151.8708877467325, 2212.8561643493204, 2462.704475462947, 2487.6268559716004, 2496.1388321029217, 2227.5520911407552, 2232.229880691159, 2237.2505210754334, 2239.317008312464, 2437.987810060947, 2426.5887071829743, 2456.91400800972, 2457.803375729937, 2462.741412151725, 2464.0143942422997, 2075.4915045813723, 2423.079229892647, 2444.1689825459252, 2460.2988148377626, 2468.740782217877, 2167.4581354661336, 2221.4113259986116, 2224.8442609017375, 2426.34488688055, 2478.6158145487298, 8540.14598540141, 8623.180797824196, 8628.611712472954, 8643.0, 8643.611037503328, 5220.8694782630355, 5348.251244825728, 5374.462553744634, 5379.596530260246, 5385.78456861725, 3520.295940811822, 3617.5478065241846, 3648.7263455240964, 3655.342038433081, 3670.3026424979435, 1035.6219979707353, 1051.5478344311944, 1051.9421431821247, 1081.3185496552858, 1081.783643271341, 11740.236884602558, 11798.646040618794, 11802.64592062231, 11819.704507387383, 11839.467223974942, 4769.286389952277, 4784.760761961888, 4837.685550439211, 4869.488703686133, 4909.582685471775, 10024.298299118991, 10045.69862904114, 10046.19630429564, 10049.497525123861, 10051.899481005243, 5389.595780316492, 5428.185772134211, 5435.266239057677, 5436.10304299794, 5438.129899216106, 4896.730679812573, 4928.556429921325, 4936.358273424432, 4938.0, 4958.975205124024, 3612.8012959287494, 3733.663970242691, 3751.0622344413896, 3765.644368027508, 3774.981125094357, 1159.1306520109918, 1160.7794519041356, 1167.9240849344765, 1168.1122347016328, 1170.5368289637952, 1334.0794851552398, 1345.4281930179634, 1377.8346598408255, 1380.9102408343426, 1384.6053874645677, 7988.480748751313, 8098.109207987117, 8112.594370281462, 8123.268905798506, 8209.0, 1200.5197920831738, 1201.6214892308894, 1203.6750077479032, 1215.10689643114, 1232.1990706041145, 5991.880162396815, 5993.700314984233, 6141.84645383869, 6272.560920735596, 6389.8722025560155, 10337.328073675188, 10568.682939511827, 10631.681049568526, 10717.142628589694, 10727.946360268148, 10649.84025239622, 10850.186236032328, 10879.401632910107, 10887.782244355069, 10928.890711092947, 8105.0, 8184.140665230184, 8292.792680182924, 8324.209200125979, 8348.707795227137, 8084.595770211584, 8142.267195952392, 8158.224968627971, 8160.347172226327, 8160.755177344689, 9373.765655858659, 9464.479453630116, 9608.75978100553, 9640.807183856143, 9789.85315220258, 7261.636918153966, 9879.753006174904, 9898.10917017472, 9987.850182247417, 10006.448355669549, 7018.649067546704, 7111.715531378687, 7120.1099862517185, 7125.643717814192, 7137.678804453916, 8145.307648849915, 8200.42597018203, 8253.83492330138, 8269.710560130367, 8296.294814940798, 7759.844803104019, 7800.336971357498, 7812.140664527011, 7938.64276107565, 7955.4828936118965, 7419.332260096401, 7572.432067594842, 7666.884996725165, 7672.309492145734, 7810.10183828867, 7777.261160189773, 7830.843383132192, 7878.0, 7889.960550197212, 7905.407094467823, 7064.540804847874, 7181.676824542804, 7182.281771822776, 7189.029481020205, 7198.316159964795, 7157.427405807627, 7230.023946767329, 7232.674529646284, 7249.166345870081, 7318.487705860539], "unit": "score", "name": "mootools.html", "value": 4921.821302132432}, {"lowerIsBetter": false, "replicates": [291.562656015976, 319.4712750398092, 320.365675961596, 333.8280785395521, 337.133566733495, 6427.807165785034, 6616.966915165423, 6647.302033286508, 6652.9002064968945, 6681.53229273951, 6447.323031081739, 6563.671816409184, 6571.934280657204, 6574.94800831867, 6582.045603387506, 4281.871543853682, 4634.1195172917205, 4638.211504044304, 4929.580985616227, 4946.752662366867, 4748.477667456577, 4792.281157826319, 4912.877178070559, 4934.680700070979, 4974.900501989976, 4911.533404326583, 4936.876578085541, 4947.9505204947845, 4950.762309422645, 4964.702117872921, 4935.925961110586, 4943.579795717368, 4949.901001979976, 4955.306257124005, 4960.131976904046, 4083.8774836754947, 4200.096979149467, 4201.222773786829, 4209.684273679486, 4225.556316586745, 5417.241586177938, 6136.6011209271255, 6359.491240700733, 6385.553011289212, 6391.360863913618, 5744.712764361807, 5750.913736293959, 5752.424757524214, 5760.53915686744, 5768.769249230026, 5461.890762184734, 6619.304972977864, 6687.030380594835, 6770.763023294161, 7012.894806577905, 4266.210751011042, 4572.359869618256, 4666.696664716783, 4684.227102528079, 4695.765211739399, 5995.850103747398, 7418.851622967564, 7451.739189128409, 7454.40364770817, 7465.402767778619, 4732.266498692708, 4755.0727608116085, 4756.429228492603, 4759.643026773006, 4780.904381912343, 4690.835820746258, 4832.202686556749, 4832.975835120872, 4837.250226214942, 4844.128056949712, 5801.216835727208, 5801.361850196475, 5804.9419505805245, 5818.505427038749, 5818.941810581925, 6262.12330273762, 6543.1821022372205, 7061.576305421691, 7071.82320441993, 7083.2916708329785, 1666.7499875018843, 1694.9576010753299, 1697.8981261124372, 1698.150924537731, 1698.6772513222447, 922.8338898998111, 1079.379356869803, 1115.1803424482998, 1126.752114534801, 1137.294877176156, 6435.131257280207, 6652.334766523309, 6655.600663960178, 6657.833554161088, 6663.666816659148, 7197.100362454693, 7312.853742925112, 7321.926780732231, 7414.295641914117, 7417.664820332284, 6700.195976482756, 6724.529282950147, 6741.258461569223, 6751.898721519181, 6752.662366881636, 3510.578215822596, 3654.853805847736, 3786.1291902862495, 3898.571157172709, 3948.881533553998, 7704.730334438268, 7713.498622589514, 7715.922840771633, 7725.884111738328, 7726.111497177896, 7624.313811756969, 7624.5425274482595, 7625.847483050308, 7628.0, 7631.3894888408795, 5407.432219616962, 7525.7958726604575, 7690.346320562703, 7700.345470634835, 7726.304632583095, 7381.298776616213, 7402.444816638881, 7405.925940740523, 7412.147603025505, 7422.0, 6241.812745617639, 7288.96355518219, 7291.526050806893, 7292.671829767779, 7293.0, 7187.02975098355, 7717.2282771722375, 7717.498362606637, 7726.1114971776715, 7747.1090824555895, 4821.855344339676, 4824.228123500223, 4824.565789079, 4840.1529732296, 4840.903181936271, 5864.589478736618, 7087.964560177373, 7325.963370183328, 7367.484276100836, 7374.188839227788, 7125.251848556034, 7134.108236470442, 7141.3572778448115, 7143.464240182111, 7149.892751608834, 7072.2220555737795, 7081.752138675121, 7083.610401427764, 7086.78739637791, 7087.3267039631155, 5619.522340601095, 6746.4940129489505, 6944.097267355413, 6947.478939079489, 6964.547304425196, 6885.586864788129, 7111.608861512666, 7136.215016348301, 7138.214796372291, 7163.31948464895, 5956.434138756811, 6639.933600663931, 6906.447484201151, 6915.6887940043825, 6926.965365173141], "unit": "score", "name": "prototype.html", "value": 5159.420088953293}, {"lowerIsBetter": false, "replicates": [655.2039272284176, 738.047918185541, 743.2901578992063, 746.8282295072133, 755.3617193471516, 14618.195999220039, 14715.558533243993, 14741.48404805832, 14839.258037098129, 14847.183404912725, 13604.0, 13756.724865502683, 13773.380197891094, 13797.51708690196, 13814.240216788072, 690.1649004704313, 696.5924933913667, 705.3052743048094, 851.0, 872.5244741615803, 840.0339609449121, 865.9004214515348, 871.5903525343078, 875.8117004843957, 876.1413814461831, 901.3600343755941, 911.1207684584375, 913.4793167894303, 914.1178762494192, 917.2524392620027, 727.9818004549876, 733.1129333506464, 733.339994005394, 733.7358550921664, 737.1301863800713, 664.2228592546732, 679.3987321220756, 680.6630717794674, 681.0057316318181, 681.2131987554383, 14605.561833145022, 14694.11835289886, 14697.0, 14705.779413308808, 14751.114933104049, 12312.753744925141, 12494.937525312314, 12564.623061308175, 12881.549145779853, 12917.547885824046, 9852.408855468695, 9945.15466185375, 9988.45063521506, 10183.38899666015, 10183.745406364826, 2972.5986991756054, 3000.7149320814488, 3490.842912068963, 3545.7340699447386, 3565.4295312750096, 77060.0, 77324.0, 77438.45123097507, 79999.800003, 80229.59885200595, 9174.403663761834, 9366.110219529133, 9476.95261523688, 9506.714798556055, 9833.60665573369, 20359.592808143756, 20637.69043464319, 20692.965351732353, 20727.896360518404, 20745.066472008493, 7629.847403052019, 7668.003159589218, 7692.153863075057, 7694.730684426018, 7735.0, 4131.690123240769, 4136.44158038667, 4141.047559061432, 4144.150449157915, 4165.645920096826, 3442.225499262646, 3479.6694314040633, 3485.4597537381746, 3494.3884820156372, 3494.825258737053, 621.3289647181034, 633.5628416392674, 633.56917296239, 650.9218893732782, 658.1016911915201, 558.600600570594, 599.6222379900722, 603.471962033221, 607.781198768443, 624.6881548747684, 8439.451435656785, 8523.914760852436, 8548.444351117158, 8711.303095752324, 8760.56197190138, 461.3448902558375, 566.1677334318545, 602.807101727443, 615.689077016104, 625.8185126313318, 3753.8031822035578, 3991.660708839723, 3994.840206391712, 4111.506619205715, 4140.730852494638, 66181.0, 88305.0, 88877.0, 89416.0, 89525.0, 74408.0, 74835.62582187162, 75581.0, 76160.61919690366, 76781.0, 66340.6682966582, 66949.09750358506, 68000.31999680039, 68011.65994169998, 68831.96752048723, 8122.161128376895, 8267.255946964802, 8522.616482258189, 8728.607212675572, 8728.912710873064, 47769.76115119402, 50791.49208507867, 51106.0, 51451.0, 52663.21005185002, 64585.51023163084, 65183.0, 65370.67314663396, 72087.0, 73548.0, 11164.0, 11533.82699259495, 11709.946104850264, 11720.961592805364, 12535.749285014432, 12026.75946481083, 12043.397830108635, 12068.818967715315, 12400.81398779037, 12642.747145056863, 11092.10847788904, 11256.493457794255, 11635.47640356169, 11638.70903227426, 11796.0, 11494.482748276514, 11619.269471674319, 11734.647960561197, 11874.406279685809, 11876.16866819349, 10928.836067459153, 11149.0, 11281.661550153509, 11435.371054592077, 11551.595694150665, 8973.82052358936, 9059.592318345558, 9178.036306187754, 9367.5784589695, 9378.577963991773, 7604.771856844303, 9536.618535258789, 9689.660861869801, 9808.950955245178, 9830.361026533252], "unit": "score", "name": "yui.html", "value": 6778.019567677382}], "name": "dromaeo_css", "value": 7417.92423085097}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [103.0, 109.0, 110.0, 110.0, 110.0, 111.0, 114.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [157.0, 121.0, 146.0, 144.0, 141.0, 129.0, 172.0, 147.0, 187.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [187.0, 188.0, 186.0, 184.0, 185.0, 185.0, 185.0, 186.0, 181.0, 173.0], "unit": "score", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [78.0, 76.0, 90.0, 69.0, 57.0, 75.0, 87.0, 112.0, 89.0, 46.0], "unit": "score", "name": "audio-fft", "value": 77.9}, {"lowerIsBetter": true, "replicates": [90.0, 97.0, 132.0, 79.0, 80.0, 80.0, 115.0, 76.0, 78.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 94.6}, {"lowerIsBetter": true, "replicates": [89.0, 98.0, 91.0, 91.0, 91.0, 92.0, 89.0, 140.0, 113.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 96.0, 95.0, 93.0, 94.0, 94.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.4}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 86.0, 86.0, 84.0, 87.0, 84.0, 87.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 54.0, 53.0, 55.0, 56.0, 65.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 71.0, 78.0, 70.0, 68.0, 68.0, 66.0, 79.0, 103.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.2}, {"lowerIsBetter": true, "replicates": [84.0, 109.0, 108.0, 108.0, 83.0, 82.0, 83.0, 83.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.5}, {"lowerIsBetter": true, "replicates": [124.0, 125.0, 122.0, 129.0, 122.0, 119.0, 121.0, 120.0, 125.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [140.0, 128.0, 139.0, 137.0, 138.0, 138.0, 139.0, 137.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 65.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1437.6}]} 02:19:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1437.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7417.92"}}} 02:19:57 INFO - Return code: 0 02:19:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:19:57 INFO - # TBPL SUCCESS # 02:19:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:19:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:19:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:19:57 INFO - 2016-02-04 02:19:57.396 screenresolution[3557:98874] starting screenresolution argv=screenresolution get 02:19:57 INFO - 2016-02-04 02:19:57.398 screenresolution[3557:98874] Display 0: 1600x1200x32@60 02:19:57 INFO - 2016-02-04 02:19:57.404 screenresolution[3558:98877] starting screenresolution argv=screenresolution list 02:19:57 INFO - Available Modes on Display 0 02:19:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:19:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:19:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:19:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:19:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:19:57 INFO - Intel Iris: 02:19:57 INFO - Chipset Model: Intel Iris 02:19:57 INFO - Type: GPU 02:19:57 INFO - Bus: Built-In 02:19:57 INFO - VRAM (Dynamic, Max): 1536 MB 02:19:57 INFO - Vendor: Intel (0x8086) 02:19:57 INFO - Device ID: 0x0a2e 02:19:57 INFO - Revision ID: 0x0009 02:19:57 INFO - Displays: 02:19:57 INFO - Display: 02:19:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:19:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:19:57 INFO - Display Serial Number: 1600x1200 60 02:19:57 INFO - Main Display: Yes 02:19:57 INFO - Mirror: Off 02:19:57 INFO - Online: Yes 02:19:57 INFO - Rotation: Supported 02:19:57 INFO - Return code: 0 02:19:57 INFO - Running post-action listener: _resource_record_post_action 02:19:57 INFO - Running post-run listener: _resource_record_post_run 02:19:58 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 0; Write bytes: 708021248; Read time: 0; Write time: 2024 02:19:58 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403732992; Write bytes: 405596160; Read time: 30424; Write time: 823 02:19:58 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 0; Write bytes: 300819456; Read time: 0; Write time: 1196 02:19:58 INFO - Running post-run listener: _upload_blobber_files 02:19:58 INFO - Blob upload gear active. 02:19:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:19:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:19:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:19:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:19:59 INFO - (blobuploader) - INFO - Open directory for files ... 02:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:01 INFO - (blobuploader) - INFO - Done attempting. 02:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:20:02 INFO - (blobuploader) - INFO - Done attempting. 02:20:02 INFO - (blobuploader) - INFO - Iteration through files over. 02:20:02 INFO - Return code: 0 02:20:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:20:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:20:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9c24ec25a784b1235b05202038e2b6692f6d65443b65f519ca598867fe8d7627975f1ba4562f5de88569e1217fe6e4ae08192a513996a88bbe544253a6b423f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61d29182ce0ed86d4bbfe4d8d9966ba796e53be2e412e2d539ee6b877bc50de9f4119cb5a5ad139cd9602a82f88326b772b7347ff6d295aef71d351d6ca8d23b"} 02:20:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:20:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:20:02 INFO - Contents: 02:20:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9c24ec25a784b1235b05202038e2b6692f6d65443b65f519ca598867fe8d7627975f1ba4562f5de88569e1217fe6e4ae08192a513996a88bbe544253a6b423f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61d29182ce0ed86d4bbfe4d8d9966ba796e53be2e412e2d539ee6b877bc50de9f4119cb5a5ad139cd9602a82f88326b772b7347ff6d295aef71d351d6ca8d23b"} 02:20:02 INFO - Running post-run listener: copy_logs_to_upload_dir 02:20:02 INFO - Copying logs to upload dir... 02:20:02 INFO - mkdir: /builds/slave/test/build/upload/logs 02:20:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.272573 ========= master_lag: 1.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-02-04 02:20:04.281800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 02:20:04.285205) ========= 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.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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/c9c24ec25a784b1235b05202038e2b6692f6d65443b65f519ca598867fe8d7627975f1ba4562f5de88569e1217fe6e4ae08192a513996a88bbe544253a6b423f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61d29182ce0ed86d4bbfe4d8d9966ba796e53be2e412e2d539ee6b877bc50de9f4119cb5a5ad139cd9602a82f88326b772b7347ff6d295aef71d351d6ca8d23b"} build_url:https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/HzQgDc9oTu6Aex54hs0QQQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9c24ec25a784b1235b05202038e2b6692f6d65443b65f519ca598867fe8d7627975f1ba4562f5de88569e1217fe6e4ae08192a513996a88bbe544253a6b423f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61d29182ce0ed86d4bbfe4d8d9966ba796e53be2e412e2d539ee6b877bc50de9f4119cb5a5ad139cd9602a82f88326b772b7347ff6d295aef71d351d6ca8d23b"}' ========= master_lag: 0.11 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-04 02:20:04.405033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:20:04.405357) ========= 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.7DQRTIsrgH/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.hv6g602r2d/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005349 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-04 02:20:04.499581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 02:20:04.499902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-04 02:20:04.503635) ========= ========= Total master_lag: 1.81 =========