builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0098 starttime: 1456329987.71 results: success (0) buildid: 20160224063746 builduid: 8b84cac8a1f64565ad4a6049ddb54f02 revision: 9e99b8c9906ab9d0fd2145307c3a98a8a78e25da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.712230) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.712659) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.712959) ========= 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.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005683 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.769926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.770237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.840606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.840995) ========= 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.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005880 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.892519) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.893042) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:27.893639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-24 08:06:27.894126) ========= 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.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-24 08:06:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.4M=0.001s 2016-02-24 08:06:28 (11.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153541 ========= master_lag: 2.50 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-24 08:06:30.544615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:30.544974) ========= 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.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.026848 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:30.604055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 08:06:30.604354) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e99b8c9906ab9d0fd2145307c3a98a8a78e25da --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 9e99b8c9906ab9d0fd2145307c3a98a8a78e25da --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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-24 08:06:30,690 truncating revision to first 12 chars 2016-02-24 08:06:30,690 Setting DEBUG logging. 2016-02-24 08:06:30,690 attempt 1/10 2016-02-24 08:06:30,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e99b8c9906a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 08:06:31,401 unpacking tar archive at: fx-team-9e99b8c9906a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.955482 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 08:06:31.701581) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:31.701885) ========= echo 9e99b8c9906ab9d0fd2145307c3a98a8a78e25da in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9e99b8c9906ab9d0fd2145307c3a98a8a78e25da'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 9e99b8c9906ab9d0fd2145307c3a98a8a78e25da program finished with exit code 0 elapsedTime=0.005808 script_repo_revision: '9e99b8c9906ab9d0fd2145307c3a98a8a78e25da' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:31.788578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:31.788919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 08:06:31.872146) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-02-24 08:06:31.872602) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:06:32 INFO - MultiFileLogger online at 20160224 08:06:32 in /builds/slave/test 08:06:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:06:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:32 INFO - {'append_to_log': False, 08:06:32 INFO - 'base_work_dir': '/builds/slave/test', 08:06:32 INFO - 'blob_upload_branch': 'Fx-Team', 08:06:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:32 INFO - 'branch': 'Fx-Team', 08:06:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:32 INFO - 'config_files': ('talos/mac_config.py',), 08:06:32 INFO - 'default_actions': ('clobber', 08:06:32 INFO - 'read-buildbot-config', 08:06:32 INFO - 'download-and-extract', 08:06:32 INFO - 'populate-webroot', 08:06:32 INFO - 'create-virtualenv', 08:06:32 INFO - 'install', 08:06:32 INFO - 'run-tests'), 08:06:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:32 INFO - 'download_minidump_stackwalk': True, 08:06:32 INFO - 'download_symbols': 'ondemand', 08:06:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:32 INFO - 'installer_path': 'installer.exe', 08:06:32 INFO - 'log_level': 'info', 08:06:32 INFO - 'log_name': 'talos', 08:06:32 INFO - 'log_to_console': True, 08:06:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:06:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:06:32 INFO - 'opt_config_files': (), 08:06:32 INFO - 'pip_index': False, 08:06:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:06:32 INFO - 'cmd': ('bash', 08:06:32 INFO - '-c', 08:06:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:06:32 INFO - 'enabled': True, 08:06:32 INFO - 'halt_on_failure': False, 08:06:32 INFO - 'name': 'check_screen_resolution'},), 08:06:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:06:32 INFO - 'cmd': ('bash', 08:06:32 INFO - '-c', 08:06:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:06:32 INFO - 'enabled': True, 08:06:32 INFO - 'halt_on_failure': False, 08:06:32 INFO - 'name': 'check_screen_resolution'},), 08:06:32 INFO - 'run_cmd_checks_enabled': True, 08:06:32 INFO - 'sps_profile': False, 08:06:32 INFO - 'sps_profile_interval': 0, 08:06:32 INFO - 'suite': 'dromaeojs-e10s', 08:06:32 INFO - 'system_bits': '32', 08:06:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:32 INFO - 'title': 't-yosemite-r7-0098', 08:06:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:32 INFO - 'use_talos_json': True, 08:06:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:32 INFO - 'work_dir': 'build'} 08:06:32 INFO - ##### 08:06:32 INFO - ##### Running clobber step. 08:06:32 INFO - ##### 08:06:32 INFO - Running pre-action listener: _resource_record_pre_action 08:06:32 INFO - Running main action method: clobber 08:06:32 INFO - rmtree: /builds/slave/test/build 08:06:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:33 INFO - Running post-action listener: _resource_record_post_action 08:06:33 INFO - ##### 08:06:33 INFO - ##### Running read-buildbot-config step. 08:06:33 INFO - ##### 08:06:33 INFO - Running pre-action listener: _resource_record_pre_action 08:06:33 INFO - Running main action method: read_buildbot_config 08:06:33 INFO - Using buildbot properties: 08:06:33 INFO - { 08:06:33 INFO - "project": "", 08:06:33 INFO - "product": "firefox", 08:06:33 INFO - "script_repo_revision": "production", 08:06:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:06:33 INFO - "repository": "", 08:06:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:06:33 INFO - "buildid": "20160224063746", 08:06:33 INFO - "pgo_build": "False", 08:06:33 INFO - "basedir": "/builds/slave/test", 08:06:33 INFO - "buildnumber": 410, 08:06:33 INFO - "slavename": "t-yosemite-r7-0098", 08:06:33 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:06:33 INFO - "platform": "yosemite_r7", 08:06:33 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:06:33 INFO - "branch": "fx-team", 08:06:33 INFO - "repo_path": "integration/fx-team", 08:06:33 INFO - "revision": "9e99b8c9906ab9d0fd2145307c3a98a8a78e25da", 08:06:33 INFO - "stage_platform": "macosx64", 08:06:33 INFO - "builduid": "8b84cac8a1f64565ad4a6049ddb54f02", 08:06:33 INFO - "slavebuilddir": "test" 08:06:33 INFO - } 08:06:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:06:33 INFO - Running post-action listener: _resource_record_post_action 08:06:33 INFO - ##### 08:06:33 INFO - ##### Running download-and-extract step. 08:06:33 INFO - ##### 08:06:33 INFO - Running pre-action listener: _resource_record_pre_action 08:06:33 INFO - Running main action method: download_and_extract 08:06:33 INFO - mkdir: /builds/slave/test/build/tests 08:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:33 INFO - https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/test_packages.json 08:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/test_packages.json 08:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:06:40 INFO - Downloaded 1277 bytes. 08:06:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:06:40 INFO - Using the following test package requirements: 08:06:40 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:06:40 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:06:40 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:06:40 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:06:40 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:06:40 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:06:40 INFO - u'jsshell-mac.zip'], 08:06:40 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:06:40 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:06:40 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:06:40 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:06:40 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:06:40 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:06:40 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:06:40 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:06:40 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:06:40 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:06:40 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:06:40 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:06:40 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:40 INFO - https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/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 08:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/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 08:06:47 INFO - Downloaded 17827743 bytes. 08:06:47 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'] 08:06:47 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 08:06:50 INFO - Return code: 0 08:06:50 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 08:06:50 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')]} 08:06:50 INFO - https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:06:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:06:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:06:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/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 08:06:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/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 08:06:51 INFO - Downloaded 17827743 bytes. 08:06:51 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'] 08:06:51 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 08:06:55 INFO - Return code: 0 08:06:55 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')]} 08:06:55 INFO - https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:06:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:06:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:06:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/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 08:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/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 08:06:56 INFO - Downloaded 10707015 bytes. 08:06:56 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'] 08:06:56 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 08:06:57 INFO - Return code: 0 08:06:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:57 INFO - https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:06:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:06:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:06:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SbHI6XNbQ-aJvdhezRAmDw/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 08:06:59 INFO - Downloaded 111449596 bytes. 08:06:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:06:59 INFO - mkdir: /builds/slave/test/properties 08:06:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:59 INFO - Contents: 08:06:59 INFO - build_url:https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:07:00 INFO - Running post-action listener: _resource_record_post_action 08:07:00 INFO - Running post-action listener: set_extra_try_arguments 08:07:00 INFO - ##### 08:07:00 INFO - ##### Running populate-webroot step. 08:07:00 INFO - ##### 08:07:00 INFO - Running pre-action listener: _resource_record_pre_action 08:07:00 INFO - Running main action method: populate_webroot 08:07:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:07:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:07:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:07:00 INFO - '--tppagecycles', 08:07:00 INFO - '7'], 08:07:00 INFO - 'tests': ['tsvgm']}}, 08:07:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:07:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:07:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:07:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:07:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:00 INFO - 'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:07:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:00 INFO - 'tests': ['damp', 'tps']}, 08:07:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:00 INFO - 'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['damp', 'tps']}, 08:07:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:07:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:07:00 INFO - 'other': {'tests': ['a11yr', 08:07:00 INFO - 'ts_paint', 08:07:00 INFO - 'tpaint', 08:07:00 INFO - 'sessionrestore', 08:07:00 INFO - 'sessionrestore_no_auto_restore']}, 08:07:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['a11yr', 08:07:00 INFO - 'ts_paint', 08:07:00 INFO - 'tpaint', 08:07:00 INFO - 'sessionrestore', 08:07:00 INFO - 'sessionrestore_no_auto_restore']}, 08:07:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['a11yr', 08:07:00 INFO - 'ts_paint', 08:07:00 INFO - 'tpaint', 08:07:00 INFO - 'sessionrestore', 08:07:00 INFO - 'sessionrestore_no_auto_restore']}, 08:07:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['a11yr', 08:07:00 INFO - 'ts_paint', 08:07:00 INFO - 'tpaint', 08:07:00 INFO - 'sessionrestore', 08:07:00 INFO - 'sessionrestore_no_auto_restore']}, 08:07:00 INFO - 'other_l64': {'tests': ['a11yr', 08:07:00 INFO - 'ts_paint', 08:07:00 INFO - 'tpaint', 08:07:00 INFO - 'sessionrestore', 08:07:00 INFO - 'sessionrestore_no_auto_restore']}, 08:07:00 INFO - 'other_nol64': {'tests': ['a11yr', 08:07:00 INFO - 'ts_paint', 08:07:00 INFO - 'tpaint', 08:07:00 INFO - 'sessionrestore', 08:07:00 INFO - 'sessionrestore_no_auto_restore']}, 08:07:00 INFO - 'svgr': {'tests': ['tsvgx', 08:07:00 INFO - 'tsvgr_opacity', 08:07:00 INFO - 'tart', 08:07:00 INFO - 'tscrollx', 08:07:00 INFO - 'cart']}, 08:07:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['tsvgx', 08:07:00 INFO - 'tsvgr_opacity', 08:07:00 INFO - 'tart', 08:07:00 INFO - 'tscrollx', 08:07:00 INFO - 'cart']}, 08:07:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:00 INFO - 'tests': ['tp5o']}, 08:07:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:00 INFO - 'talos_options': ['--e10s'], 08:07:00 INFO - 'tests': ['tp5o']}, 08:07:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:00 INFO - 'talos_options': ['--xperf_path', 08:07:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:00 INFO - 'tests': ['tp5n']}, 08:07:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:07:00 INFO - 'talos_options': ['--e10s', 08:07:00 INFO - '--xperf_path', 08:07:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:07:00 INFO - 'tests': ['tp5n']}}, 08:07:00 INFO - 'talos.zip': {'path': '', 08:07:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:07:00 INFO - Running post-action listener: _resource_record_post_action 08:07:00 INFO - ##### 08:07:00 INFO - ##### Running create-virtualenv step. 08:07:00 INFO - ##### 08:07:00 INFO - Running pre-action listener: _resource_record_pre_action 08:07:00 INFO - Running main action method: create_virtualenv 08:07:00 INFO - Creating virtualenv /builds/slave/test/build/venv 08:07:00 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 08:07:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:07:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:07:01 INFO - Using real prefix '/tools/python27' 08:07:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:07:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:04 INFO - Installing pip.................done. 08:07:04 INFO - Return code: 0 08:07:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:04 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 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:04 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 08:07:04 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 08:07:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:04 INFO - 'HOME': '/Users/cltbld', 08:07:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:04 INFO - 'LOGNAME': 'cltbld', 08:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:04 INFO - 'MOZ_NO_REMOTE': '1', 08:07:04 INFO - 'NO_EM_RESTART': '1', 08:07:04 INFO - 'PAGER': '/bin/cat', 08:07:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:04 INFO - 'PWD': '/builds/slave/test', 08:07:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:04 INFO - 'SHELL': '/bin/bash', 08:07:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:04 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:04 INFO - 'USER': 'cltbld', 08:07:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:04 INFO - 'XPC_FLAGS': '0x0', 08:07:04 INFO - 'XPC_SERVICE_NAME': '0', 08:07:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:04 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 08:07:04 INFO - Cleaning up... 08:07:04 INFO - Return code: 0 08:07:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:04 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 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:04 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 08:07:04 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 08:07:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:04 INFO - 'HOME': '/Users/cltbld', 08:07:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:04 INFO - 'LOGNAME': 'cltbld', 08:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:04 INFO - 'MOZ_NO_REMOTE': '1', 08:07:04 INFO - 'NO_EM_RESTART': '1', 08:07:04 INFO - 'PAGER': '/bin/cat', 08:07:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:04 INFO - 'PWD': '/builds/slave/test', 08:07:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:04 INFO - 'SHELL': '/bin/bash', 08:07:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:04 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:04 INFO - 'USER': 'cltbld', 08:07:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:04 INFO - 'XPC_FLAGS': '0x0', 08:07:04 INFO - 'XPC_SERVICE_NAME': '0', 08:07:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:05 INFO - Downloading/unpacking psutil>=0.7.1 08:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:08 INFO - Installing collected packages: psutil 08:07:08 INFO - Running setup.py install for psutil 08:07:08 INFO - building 'psutil._psutil_osx' extension 08:07:08 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 08:07:09 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 08:07:09 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 08:07:09 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 08:07:09 INFO - building 'psutil._psutil_posix' extension 08:07:09 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 08:07:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:07:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:07:09 INFO - ^ 08:07:09 INFO - 1 warning generated. 08:07:09 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 08:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:09 INFO - Successfully installed psutil 08:07:09 INFO - Cleaning up... 08:07:09 INFO - Return code: 0 08:07:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:09 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 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:09 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 08:07:09 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 08:07:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:09 INFO - 'HOME': '/Users/cltbld', 08:07:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:09 INFO - 'LOGNAME': 'cltbld', 08:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:09 INFO - 'MOZ_NO_REMOTE': '1', 08:07:09 INFO - 'NO_EM_RESTART': '1', 08:07:09 INFO - 'PAGER': '/bin/cat', 08:07:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:09 INFO - 'PWD': '/builds/slave/test', 08:07:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:09 INFO - 'SHELL': '/bin/bash', 08:07:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:09 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:09 INFO - 'USER': 'cltbld', 08:07:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:09 INFO - 'XPC_FLAGS': '0x0', 08:07:09 INFO - 'XPC_SERVICE_NAME': '0', 08:07:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:07:12 INFO - Installing collected packages: mozsystemmonitor 08:07:12 INFO - Running setup.py install for mozsystemmonitor 08:07:12 INFO - Successfully installed mozsystemmonitor 08:07:12 INFO - Cleaning up... 08:07:12 INFO - Return code: 0 08:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:07:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:12 INFO - 'HOME': '/Users/cltbld', 08:07:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:12 INFO - 'LOGNAME': 'cltbld', 08:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:12 INFO - 'MOZ_NO_REMOTE': '1', 08:07:12 INFO - 'NO_EM_RESTART': '1', 08:07:12 INFO - 'PAGER': '/bin/cat', 08:07:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:12 INFO - 'PWD': '/builds/slave/test', 08:07:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:12 INFO - 'SHELL': '/bin/bash', 08:07:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:12 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:12 INFO - 'USER': 'cltbld', 08:07:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:12 INFO - 'XPC_FLAGS': '0x0', 08:07:12 INFO - 'XPC_SERVICE_NAME': '0', 08:07:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:12 INFO - Downloading/unpacking blobuploader==1.2.4 08:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:15 INFO - Downloading blobuploader-1.2.4.tar.gz 08:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:07:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:07:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:16 INFO - Downloading docopt-0.6.1.tar.gz 08:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:07:16 INFO - Installing collected packages: blobuploader, requests, docopt 08:07:16 INFO - Running setup.py install for blobuploader 08:07:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:07:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:07:16 INFO - Running setup.py install for requests 08:07:17 INFO - Running setup.py install for docopt 08:07:17 INFO - Successfully installed blobuploader requests docopt 08:07:17 INFO - Cleaning up... 08:07:17 INFO - Return code: 0 08:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:17 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 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:17 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 08:07:17 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 08:07:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:17 INFO - 'HOME': '/Users/cltbld', 08:07:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:17 INFO - 'LOGNAME': 'cltbld', 08:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:17 INFO - 'MOZ_NO_REMOTE': '1', 08:07:17 INFO - 'NO_EM_RESTART': '1', 08:07:17 INFO - 'PAGER': '/bin/cat', 08:07:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:17 INFO - 'PWD': '/builds/slave/test', 08:07:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:17 INFO - 'SHELL': '/bin/bash', 08:07:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:17 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:17 INFO - 'USER': 'cltbld', 08:07:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:17 INFO - 'XPC_FLAGS': '0x0', 08:07:17 INFO - 'XPC_SERVICE_NAME': '0', 08:07:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-nSTfyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-JmPJnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-SQi8H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-YGVmYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:17 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-66wqHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-hhg0Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-4s5LAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-msbXzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-qfx6Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-NEZO1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-JRjoX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-IilTY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-KMTDv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:18 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-ar5MkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:19 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-K5U2VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:19 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-98GSF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:19 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-7U6yLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:19 INFO - Running setup.py install for manifestparser 08:07:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:07:19 INFO - Running setup.py install for mozcrash 08:07:19 INFO - Running setup.py install for mozdebug 08:07:19 INFO - Running setup.py install for mozdevice 08:07:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:07:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:07:19 INFO - Running setup.py install for mozfile 08:07:20 INFO - Running setup.py install for mozhttpd 08:07:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:07:20 INFO - Running setup.py install for mozinfo 08:07:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:07:20 INFO - Running setup.py install for mozInstall 08:07:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:07:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:07:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:07:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:07:20 INFO - Running setup.py install for mozleak 08:07:20 INFO - Running setup.py install for mozlog 08:07:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:07:20 INFO - Running setup.py install for moznetwork 08:07:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:07:20 INFO - Running setup.py install for mozprocess 08:07:21 INFO - Running setup.py install for mozprofile 08:07:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Running setup.py install for mozrunner 08:07:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Running setup.py install for mozscreenshot 08:07:21 INFO - Running setup.py install for moztest 08:07:21 INFO - Running setup.py install for mozversion 08:07:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:07:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:07:21 INFO - Cleaning up... 08:07:21 INFO - Return code: 0 08:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:21 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 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:21 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 08:07:21 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 08:07:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:21 INFO - 'HOME': '/Users/cltbld', 08:07:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:21 INFO - 'LOGNAME': 'cltbld', 08:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:21 INFO - 'MOZ_NO_REMOTE': '1', 08:07:21 INFO - 'NO_EM_RESTART': '1', 08:07:21 INFO - 'PAGER': '/bin/cat', 08:07:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:21 INFO - 'PWD': '/builds/slave/test', 08:07:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:21 INFO - 'SHELL': '/bin/bash', 08:07:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:21 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:21 INFO - 'USER': 'cltbld', 08:07:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:21 INFO - 'XPC_FLAGS': '0x0', 08:07:21 INFO - 'XPC_SERVICE_NAME': '0', 08:07:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-NOYDdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:22 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)) 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-IYUIdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:22 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)) 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-ERz6W1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:22 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)) 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-ia1ua6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:22 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)) 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-nrGK7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:22 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)) 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-PEyZlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:22 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)) 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-q5mHD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:22 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)) 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-pMFNyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:22 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)) 08:07:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:22 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-w6oVcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:23 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-CInZ4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:23 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-gDz1yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:23 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-sIt5oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:23 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-XKg4jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:23 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-APjuJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:23 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-EOuCPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:23 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-wVjZT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:23 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)) 08:07:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:23 INFO - Running setup.py (path:/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/pip-Fqq3Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:23 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)) 08:07:23 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)) 08:07:23 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)) 08:07:23 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)) 08:07:23 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)) 08:07:23 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)) 08:07:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:07:23 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 08:07:23 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 08:07:23 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 08:07:23 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 08:07:23 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 08:07:23 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 08:07:26 INFO - Downloading blessings-1.6.tar.gz 08:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:07:26 INFO - Installing collected packages: blessings 08:07:26 INFO - Running setup.py install for blessings 08:07:26 INFO - Successfully installed blessings 08:07:26 INFO - Cleaning up... 08:07:26 INFO - Return code: 0 08:07:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:07:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:26 INFO - Reading from file tmpfile_stdout 08:07:26 INFO - Current package versions: 08:07:26 INFO - blessings == 1.6 08:07:26 INFO - blobuploader == 1.2.4 08:07:26 INFO - docopt == 0.6.1 08:07:26 INFO - manifestparser == 1.1 08:07:26 INFO - mozInstall == 1.12 08:07:26 INFO - mozcrash == 0.16 08:07:26 INFO - mozdebug == 0.1 08:07:26 INFO - mozdevice == 0.48 08:07:26 INFO - mozfile == 1.2 08:07:26 INFO - mozhttpd == 0.7 08:07:26 INFO - mozinfo == 0.9 08:07:26 INFO - mozleak == 0.1 08:07:26 INFO - mozlog == 3.1 08:07:26 INFO - moznetwork == 0.27 08:07:26 INFO - mozprocess == 0.22 08:07:26 INFO - mozprofile == 0.28 08:07:26 INFO - mozrunner == 6.11 08:07:26 INFO - mozscreenshot == 0.1 08:07:26 INFO - mozsystemmonitor == 0.0 08:07:26 INFO - moztest == 0.7 08:07:26 INFO - mozversion == 1.4 08:07:26 INFO - psutil == 3.1.1 08:07:26 INFO - requests == 1.2.3 08:07:26 INFO - wsgiref == 0.1.2 08:07:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:26 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 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:26 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 08:07:26 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 08:07:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:26 INFO - 'HOME': '/Users/cltbld', 08:07:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:26 INFO - 'LOGNAME': 'cltbld', 08:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:26 INFO - 'MOZ_NO_REMOTE': '1', 08:07:26 INFO - 'NO_EM_RESTART': '1', 08:07:26 INFO - 'PAGER': '/bin/cat', 08:07:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:26 INFO - 'PWD': '/builds/slave/test', 08:07:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:26 INFO - 'SHELL': '/bin/bash', 08:07:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:26 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:26 INFO - 'USER': 'cltbld', 08:07:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:26 INFO - 'XPC_FLAGS': '0x0', 08:07:26 INFO - 'XPC_SERVICE_NAME': '0', 08:07:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 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)) 08:07:27 INFO - Cleaning up... 08:07:27 INFO - Return code: 0 08:07:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:07:27 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')]} 08:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:27 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')]} 08:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:27 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 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:27 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 08:07:27 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 08:07:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:27 INFO - 'HOME': '/Users/cltbld', 08:07:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:27 INFO - 'LOGNAME': 'cltbld', 08:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:27 INFO - 'MOZ_NO_REMOTE': '1', 08:07:27 INFO - 'NO_EM_RESTART': '1', 08:07:27 INFO - 'PAGER': '/bin/cat', 08:07:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:27 INFO - 'PWD': '/builds/slave/test', 08:07:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:27 INFO - 'SHELL': '/bin/bash', 08:07:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:27 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:27 INFO - 'USER': 'cltbld', 08:07:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:27 INFO - 'XPC_FLAGS': '0x0', 08:07:27 INFO - 'XPC_SERVICE_NAME': '0', 08:07:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:27 INFO - Downloading/unpacking jsonschema 08:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:07:29 INFO - Downloading/unpacking functools32 (from jsonschema) 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07: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 08:07:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:07:30 INFO - warning: no files found matching '*.txt' 08:07:30 INFO - no previously-included directories found matching 'build' 08:07:30 INFO - no previously-included directories found matching 'dist' 08:07:30 INFO - no previously-included directories found matching '.git*' 08:07:30 INFO - Installing collected packages: jsonschema, functools32 08:07:30 INFO - Running setup.py install for functools32 08:07:30 INFO - warning: no files found matching '*.txt' 08:07:30 INFO - no previously-included directories found matching 'build' 08:07:30 INFO - no previously-included directories found matching 'dist' 08:07:30 INFO - no previously-included directories found matching '.git*' 08:07:30 INFO - Successfully installed jsonschema functools32 08:07:30 INFO - Cleaning up... 08:07:30 INFO - Return code: 0 08:07:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103c5aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c614c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5884d7140>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, '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.00be3Dkpde/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.xnulpItoBR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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 08:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:07:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:07:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:30 INFO - 'HOME': '/Users/cltbld', 08:07:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:30 INFO - 'LOGNAME': 'cltbld', 08:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:30 INFO - 'MOZ_NO_REMOTE': '1', 08:07:30 INFO - 'NO_EM_RESTART': '1', 08:07:30 INFO - 'PAGER': '/bin/cat', 08:07:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:30 INFO - 'PWD': '/builds/slave/test', 08:07:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:30 INFO - 'SHELL': '/bin/bash', 08:07:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:07:30 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:07:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:30 INFO - 'USER': 'cltbld', 08:07:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:30 INFO - 'XPC_FLAGS': '0x0', 08:07:30 INFO - 'XPC_SERVICE_NAME': '0', 08:07:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:30 INFO - Downloading/unpacking flake8 08:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:07:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:07:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:07:34 INFO - no previously-included directories found matching 'docs/_build' 08:07:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:07:34 INFO - Running setup.py install for pep8 08:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:07:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:07:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:07:34 INFO - no previously-included directories found matching 'docs/_build' 08:07:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:07:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:07:34 INFO - Cleaning up... 08:07:34 INFO - Return code: 0 08:07:34 INFO - Running post-action listener: _resource_record_post_action 08:07:34 INFO - Running post-action listener: _start_resource_monitoring 08:07:34 INFO - Starting resource monitoring. 08:07:34 INFO - ##### 08:07:34 INFO - ##### Running install step. 08:07:34 INFO - ##### 08:07:34 INFO - Running pre-action listener: _resource_record_pre_action 08:07:34 INFO - Running main action method: install 08:07:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:34 INFO - Reading from file tmpfile_stdout 08:07:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:07:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:07:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:07:35 INFO - Reading from file tmpfile_stdout 08:07:35 INFO - Output received: 08:07:35 INFO - Usage: mozinstall [options] installer 08:07:35 INFO - Options: 08:07:35 INFO - -h, --help show this help message and exit 08:07:35 INFO - -d DEST, --destination=DEST 08:07:35 INFO - Directory to install application into. [default: 08:07:35 INFO - "/builds/slave/test"] 08:07:35 INFO - --app=APP Application being installed. [default: firefox] 08:07:35 INFO - mkdir: /builds/slave/test/build/application 08:07:35 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'] 08:07:35 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 08:08:09 INFO - Reading from file tmpfile_stdout 08:08:09 INFO - Output received: 08:08:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:08:09 INFO - Running post-action listener: _resource_record_post_action 08:08:09 INFO - ##### 08:08:09 INFO - ##### Running run-tests step. 08:08:09 INFO - ##### 08:08:09 INFO - Running pre-action listener: _resource_record_pre_action 08:08:09 INFO - Running main action method: run_tests 08:08:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:08:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:08:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:08:09 INFO - 2016-02-24 08:08:09.411 screenresolution[1657:7814] starting screenresolution argv=screenresolution get 08:08:09 INFO - 2016-02-24 08:08:09.414 screenresolution[1657:7814] Display 0: 1600x1200x32@60 08:08:09 INFO - 2016-02-24 08:08:09.420 screenresolution[1658:7816] starting screenresolution argv=screenresolution list 08:08:09 INFO - Available Modes on Display 0 08:08:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:08:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:08:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:08:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:08:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:08:09 INFO - Intel Iris: 08:08:09 INFO - Chipset Model: Intel Iris 08:08:09 INFO - Type: GPU 08:08:09 INFO - Bus: Built-In 08:08:09 INFO - VRAM (Dynamic, Max): 1536 MB 08:08:09 INFO - Vendor: Intel (0x8086) 08:08:09 INFO - Device ID: 0x0a2e 08:08:09 INFO - Revision ID: 0x0009 08:08:09 INFO - Displays: 08:08:09 INFO - Display: 08:08:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:08:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:08:09 INFO - Display Serial Number: 1600x1200 60 08:08:09 INFO - Main Display: Yes 08:08:09 INFO - Mirror: Off 08:08:09 INFO - Online: Yes 08:08:09 INFO - Rotation: Supported 08:08:09 INFO - Return code: 0 08:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:09 INFO - Python 2.7.3 08:08:09 INFO - Return code: 0 08:08:09 INFO - grabbing minidump binary from tooltool 08:08: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')]} 08:08:09 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 0x103afed30>, '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 0x103922db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103af5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:09 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 08:08:09 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 08:08:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:09 INFO - Return code: 0 08:08:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:08:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:08:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:08:11 INFO - Return code: 0 08:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0098 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.00be3Dkpde/Render', 08:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:08:11 INFO - 'HOME': '/Users/cltbld', 08:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:08:11 INFO - 'LOGNAME': 'cltbld', 08:08:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:11 INFO - 'MOZ_NO_REMOTE': '1', 08:08:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:11 INFO - 'NO_EM_RESTART': '1', 08:08:11 INFO - 'PAGER': '/bin/cat', 08:08:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:11 INFO - 'PWD': '/builds/slave/test', 08:08:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:08:11 INFO - 'SHELL': '/bin/bash', 08:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xnulpItoBR/Listeners', 08:08:11 INFO - 'TMPDIR': '/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/', 08:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:08:11 INFO - 'USER': 'cltbld', 08:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:11 INFO - 'XPC_FLAGS': '0x0', 08:08:11 INFO - 'XPC_SERVICE_NAME': '0', 08:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:08:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0098', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:08:11 INFO - mozversion application_buildid: 20160224063746 08:08:11 INFO - mozversion application_changeset: 9e99b8c9906ab9d0fd2145307c3a98a8a78e25da 08:08:11 INFO - mozversion application_display_name: Nightly 08:08:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:11 INFO - mozversion application_name: Firefox 08:08:11 INFO - mozversion application_remotingname: firefox 08:08:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:08:11 INFO - mozversion application_vendor: Mozilla 08:08:11 INFO - mozversion application_version: 47.0a1 08:08:11 INFO - mozversion platform_buildid: 20160224063746 08:08:11 INFO - mozversion platform_changeset: 9e99b8c9906ab9d0fd2145307c3a98a8a78e25da 08:08:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:08:11 INFO - mozversion platform_version: 47.0a1 08:08:11 INFO - using testdate: 1456330091 08:08:11 INFO - actual date: 1456330091 08:08:11 INFO - starting webserver on 'localhost:49274' 08:08:11 INFO - SUITE-START | Running 2 tests 08:08:11 INFO - TEST-START | dromaeo_css 08:08:11 INFO - operating with platform_type : mac_ 08:08:11 INFO - Initialising browser for dromaeo_css test... 08:08:11 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpnYPanB/profile http://localhost:49274/getInfo.html) 08:08:14 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 08:08:14 INFO - PROCESS | 1676 | colorDepth:24 08:08:14 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 08:08:14 INFO - PROCESS | 1676 | __metrics 08:08:15 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:08:15 INFO - TEST-INFO | 1676: exit 0 08:08:15 INFO - Browser initialized. 08:08:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:15 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpnYPanB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:08:27 INFO - PROCESS | 1681 | RSS: Main: 256540672 08:08:27 INFO - PROCESS | 1681 | 08:09:17 INFO - PROCESS | 1681 | 1456330157348 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] 08:11:28 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 08:11:29 INFO - PROCESS | 1681 | RSS: Main: 269516800 08:11:29 INFO - PROCESS | 1681 | 08:14:31 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 08:14:31 INFO - PROCESS | 1681 | RSS: Main: 281489408 08:14:31 INFO - PROCESS | 1681 | 08:17:33 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 08:17:34 INFO - PROCESS | 1681 | RSS: Main: 282427392 08:17:34 INFO - PROCESS | 1681 | 08:20:35 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 08:20:36 INFO - PROCESS | 1681 | RSS: Main: 284098560 08:20:36 INFO - PROCESS | 1681 | 08:23:39 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 08:23:39 INFO - PROCESS | 1681 | RSS: Main: 286068736 08:23:39 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 08:26:42 INFO - PROCESS | 1681 | RSS: Main: 288366592 08:26:42 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | __start_tp_report 08:26:42 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 08:26:42 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 08:26:42 INFO - PROCESS | 1681 | |i|pagename|runs| 08:26:42 INFO - PROCESS | 1681 | |0;dojo.html;3387.3056023515182;3508.122969257684;3539.876104336349;3588.712902967763;3592.5688917329926;4653.976730116349;5698.51562617178;5751.913721294179;5755.971220143904;5775.624584402021;5611.859703507414;5658.122990936401;5743.368229494752;5783;5824.097264923933;5205.219217117435;5228.8692782680355;5261.421243663194;5262.263283140344;5292.126799078147;5268.8155914542995;5285.392179899322;5312.229726689628;5339.679619222839;5355.571554275649;5154.664946778447;5240.423553409122;5256.632035757499;5284.180951952453;5300.893982120375;5162.948370516285;5204.0372531081875;5208.166693329049;5212.713300768494;5245.737713114329;4977.975110124463;5143.022825663112;5144.819931302424;5180.766865491062;5180.792768289264;5479.671219726789;5569.248151499536;5607.411221821691;5634.408387119375;5644.548436125141;6139.2325959255095;6153.4154255345675;6220.253569571635;6240.31356550779;6289.968550157266;6099;6171.352008039136;6222.688865556749;6253.374662533755;6261.06084087386;5803.7968671096305;5803.941960580382;5807.854803629901;5822.592418530662;5842.298924129089;6145.692715364214;6200.100985357189;6234.532410069263;6292.653904035322;6407.839804004937;6117.3270940197435;6138.600990935575;6144;6157.384261573897;6165.815025549241;6137.438273608381;6234.501239900797;6237.313895471494;6269.373062693694;6281.842953926097;5436.401995780461;5788.768449261982;6030.005049166926;6247.9062814057825;6275.937240627627;6230.376962303824;6244.250689917239;6253.687315634291;6260.843478913063;6285.465735412449;4070.8575199867864;4072;4810.158222311082;4920.6801557898625;4958.404991400983;3716.9070773230346;4376.190404775127;4391.07787364657;4416.712913660602;4445.288753799441;5754;5783.450572195635;5796.510152599924;5808.82573522795;5818.5636077294375;5584.748686309126;6148.047052706837;6170.259568851767;6236.719347629368;6257.874842503215;5816.127580862904;5841.678707671119;5843.328017277982;5843.853903652358;5872.677002764804;4899.2896030075435;5325.3875804282225;5378;5444.265024221759;5445.319335083114;5624.887502249932;6181.567290289637;6337.112804207414;6337.144485494491;6393.232812062489;6133.64071396146;6184.381561843779;6197.101420294122;6207.34822843613;6210.161628180138;6214.2853571838;6217.502599791916;6262.53031022666;6348.396902294275;6352.555321127476;6119.602225855483;6125.448709616156;6138.294096178818;6168.9691551541955;6171.228596425447;6194.225721784777;6201.751929922752;6205.65868877198;6212.534059945432;6214.098955651315;6146.815595532141;6149.7847575334645;6155.569110162425;6160.969195153995;6171;6108.20593322883;6133.080037994337;6151;6155.261368635793;6163.075538669056;5433.728313584384;5936.643801371932;5943.940560594512;6073.514118870568;6097.939020609914;5286.682799032071;6001.939980600138;6025;6028.3971602839365;6035.728392222449;5817.767289308549;5860.15027820955;5864.44287792659;5883.941160588511;5908.291005079418 08:26:42 INFO - PROCESS | 1681 | |1;ext.html;440.6937178660832;495.30409774267156;561.3993027460617;565.6436445039625;594.4412252482663;37084.364454443195;37531.24937501255;37604.99999999996;37605.24789504215;37621.81189094054;38709.612903870955;39089.218215635745;39138.412923806165;39148.21703565927;39148.80425597868;9302.76743081425;9501.23990080792;9539.332246742732;9549.809003819919;9551.283653725963;9362.765930851716;9506.144446999768;9524.761880952963;9555.569999350046;9578.185854202366;9494.71515854522;9540.379875308117;9620.470874101922;9621.855672164924;9632.518374081303;9498;9507;9573.377730447568;9573.760655983586;9590.76023099421;9406.529673516297;9509.001554836712;9529.952350238205;9540.809183816285;9567.760805979837;31407.685923140933;38025.61974380248;38228.23543529142;38266.426003609966;38375;3175.0157451190207;3189.952150717741;3224.500202468621;3434.295969326282;3759.172981943968;22888.771112288832;28459.430811383656;28856;29021.41957160845;29299;2753.3942532642786;2814.985925070382;2855.0578309157927;2885.0190935082173;2957.822530648168;270127.29872701416;322946;326459;326791;326852;45224;45949.7702511492;63936.48349340831;63972;64802.67598662071;37134.88595342144;40040.39939400912;43984.3402348965;44370;44447.77776111163;15275.847241527443;15300.693986120437;15436.845631543765;15438;15476.76784848228;12282.570110046105;12437.440315185839;12488.50045998168;12545.247285162919;12554.681758415234;14078.366473508717;14164.00851940375;14543.78184327236;14653.633659158606;14678.192699401636;5552.91670624941;6345.650989195638;6390.968045159744;6455.61266324022;6476.35236476358;941.9623215071457;955.3980991975011;966.2704657983178;1055.2876808154465;1115.83820346051;28510.714892850807;30022.549661755093;30212.79148834022;30518.389632207676;30542.84728576343;843.2073850580557;981.9901800982042;1047.7328281288376;1125.4822781520593;1152.4929031226402;14268.215248161243;14590.41638334476;14725.926370368079;14727.484538041117;14995.775063374058;587168;590926;616968;629441;635778;58417.123743143886;58710;59021;59049.40950590439;59161.81676366449;1428.5285855667605;1451.622578129694;1454.2147240490017;1464.8974571780086;1477.711846190004;25303.493930120927;25589.488210236064;28256.85871570629;28799.28001799888;29021.56467653029;49141.75429122832;49799;49850;49908.75228119326;50241.748791255806;445195;452062;452888;453378;454150;32257.193570159994;32797.50803737898;33319.50020749642;33393.49909751307;33682.831585841916;43958.90102747329;44232.778836105615;44290;44797.32804007877;45663.54336456593;36506.634933650326;36820;37234.813825930694;37333.4399983995;37561.24877502489;36061.45907811332;37291;37885;38202.80898595489;39827.60172398355;37145.628543714214;37473.62526374702;37643.2471350566;38567.228655427294;38757;26349.49314460018;30006.399872002876;30685.235321737877;31503;31796.36407271795;24234.394140146636;24482.877585611957;24524.877375613007;25722.971081156546;26405.207843764718 08:26:42 INFO - PROCESS | 1681 | |2;jquery.html;289.7508142997023;315.54718978266186;344.8241595532192;358.3925246706833;364.7191662419935;15685.529434116967;16177.514674559767;19077.14152863121;19579.41261762146;19740.111694973726;11420;11839.763204735922;11865.406729663526;19357.709634355495;19647.5088122797;4417.712848664843;5341.412444631087;5354.384245811742;5409.161579955114;5420;5176.7336467722735;5951.196588460546;6021.036634138539;6025.397460253961;6040.909386359186;5943.702814859262;5968.88062238755;5971.343152253248;6188.628682279055;6488.870222595545;6455.031745238229;6502.674866256715;6521.282658907517;6522.967385163068;6563.212414510242;5574.693391863446;5685.090385538294;5711.257536520226;5716.42835716425;5739.4216590437545;12950.287734174617;12966.481340746359;13022.869771302356;13094.934525327408;14349;2001.7898120697262;2088.9268875589282;2278.840481166319;2646.206138158545;2791.734785195403;8109.4323397362205;9785.412875227508;10015.799684006352;10146;10205.081542661123;1474.6460849396067;1774.5652315182733;1780.3857669104138;1788.1059470264868;1822.4532640207885;111691;114010;114223.0292778785;115369;115715;9413.776209092912;11165.995060444598;11421.37182454973;11423.543058277743;11574.18980671345;12117.878821211674;12905.225686458842;13359.666008349868;13694.93152534231;13921.721565568834;8266.297364724065;8421.242088211968;8462.449940753831;8521.786955326166;8538.274246689101;8660.004099528634;8699.304055675531;8712.172343627346;8750.781230469289;8801.911980880237;4358.5205627380965;4452.421185245962;4476.171908196994;4490.618297444754;4496.662750293741;1634.8446897544713;1635.8445947634955;1827.10471868786;1885.4532185666278;1906.4757191772374;873.7902903303288;885.9158379953894;890.670451932776;938.6573900526258;989.4211886046743;16344.83655163457;19118.48426435492;20117.396478105682;20185.293514726913;20670.689939650918;934.7006364343655;962.2109869906749;964.8456247000587;971.3346357744967;1022.9641962531424;10364.689059328231;10751.354918704903;10929.289596176382;10944.835827462595;10966.725831854268;564007;628955;633666;641588;646703;115310.38758449735;116205;116283;118539.40730296294;118738.4063079679;1013.9695809125591;1023.948802559869;1024.2318261304172;1033.1115240892825;1034.1209971524145;17388.913055435147;17729.556761081076;17941.73087403664;18328.175232114852;18352.17415216345;37410.43884341683;39582.604173957894;47168.528314716415;48598.75700621474;48962.51037489722;52207;58293.83412331814;60515;65133.67433162804;74899;7936.960315198387;8087.959560202161;8122.187781221831;8223.629936652746;8377.204165604258;11767.52929882795;13452.596422107352;13552.93223533876;13665.18008919468;14045.016848820484;11103.833442498531;11308.151888608552;11610.477528511406;11634.243774154653;11763.764724705286;6133.693315334304;7580.4693671444675;11476.4261786912;11484.19610627248;12017.759644807229;11315.660530184108;11855.110866684861;11957.581484648343;11971.76056478883;12100.636980890587;8047;8198.303144232568;8199.71301004462;8275;8281.089080201053;8920.375573709778;11517.53929842797;11659.708507287047;11694.046812073806;11760.647180584596 08:26:42 INFO - PROCESS | 1681 | |3;mootools.html;1530.5790907500439;1547.8529539693725;1562.3828587707856;1931.7295578618987;1951.482857042883;7951.880721789178;8546.14538546145;8726;8910;9058;8652.91347086529;8680.652773889036;8766.6931657392;8794.03265640779;8805.295576353892;2439.951200975979;2469.074097213545;2469.6912885889265;2471.3080337505526;2483.081259933827;2418.286605451396;2454.8158888083376;2459.2376363327426;2460.3357093584723;2463.334899577113;2117.2272120676;2344.4373350395867;2416.8912398942;2435.866027368494;2450.620153876152;2385.33210701004;2400.7839294463497;2428.5264373447185;2441.389652586862;2448.8285819992607;2418.7460316666848;2430;2440.694913135858;2447.559439300925;2452.969752703869;8783.38516303859;8827.205551500396;8837.248833849131;8855.114488551159;8878;5479.04116779562;5538.806141785019;5576.275084239023;5581.8604534886545;5600.971995140039;3121;3653.6894363979095;3698.9260214795822;3711.2577484502935;3729.8881033569037;1046.4140081554278;1057.5399701129957;1087.6954452753241;1087.8096333141668;1094.4363652718855;12186.57346992851;12280.078994075391;12315.261084334968;12329.876701232963;12330.876691233063;4920.704757714477;4954.380702412199;5000.699958002531;5013.39839219296;5035.82374616894;10337.966203379752;10384.844227336596;10430.739231519272;10471.21465890046;10484.318519296374;5488.286522752097;5545.500904918576;5569.415211402826;5584.86037849057;5601.551875849922;5027.773750181251;5066.9746651266505;5073.061483625541;5078.5175408336145;5079.87300317495;3817.675497582681;3873.1091848874917;3950.9604903951167;3990.9002274942777;4012.3580227163516;1231.2673958994385;1324.9006324525699;1334.1328136711215;1341.9194848309132;1356.9796453053211;1112.5382966069153;1113.7828123515837;1137.4767606900753;1306.6014865466125;1401.1943132698739;8026.117127116013;8032.317253033558;8040.919590804017;8191.0580283267;8198.221168989056;1140.8459857919074;1142.114860982745;1144.5135817277624;1158.206628459508;1168;6208.50331973441;6222.377762223832;6274.372562743781;6277.560570760094;6322.873542529123;9453.43279403238;10407.843882341771;10777.946110269399;11054.889451105386;11107.888921110685;9605.423674579408;10501.737456563495;10665.253432259668;10785;10875.673729788119;8436.746897593082;8487.915120848713;8498.787530311669;8525.74422767318;8536.487810731376;8019.358451323997;8025.2777250047775;8031.959840200761;8078.394120440873;8097.8380432392205;9765.072318129767;9793.804123917624;9910.653127140515;9954.701358959242;10014.849777253492;9924.801503970024;10110.342827716175;10132.986701329808;10182.185425166117;10247.026532479402;7422.703091876265;7533.39732821362;7582.317591416799;7592.088949326117;7604.315611594983;8375.916240837514;8429.452085614415;8432.789180270542;8446.07093219733;8447.366447516339;6952.374286314256;7320.1215854097845;7478.1400138982535;7594.126675432396;7610.9238907610215;7292;7319.2314806944505;7370;7431.479796414199;7451.701931922662;7743.961280193563;7760.758278675611;7782.883256751266;7811.218878112143;7816.06207255133;6915.308469153246;7014.859702806018;7047.365737083687;7052.2242553318065;7104.254053324326;7143.321384468467;7199.856002879808;7261.636918153966;7293.635318234174;7299.52553084069 08:26:42 INFO - PROCESS | 1681 | |4;prototype.html;319.63880814679413;323.2274863077244;325.0411286704223;329.20496999745603;329.6999730245477;6636.867262654744;6745.966270168642;6838.281980392062;6850.383465488098;6867.141607299088;6755.797326080213;6847.178338599375;6861.313868613136;6862.8676268415775;6895.827604309895;4964.975175124128;5006.974965125188;5007.449180590151;5011.774470148852;5039.244113382985;4994.051130285234;5003.824866129687;5008.198688209887;5011.373578302712;5022.397312322508;4937.21004639256;4957.702537847723;4958.305837182797;4964.4787297333805;4970.850874473754;4113.8971525711795;4806.517717801566;4898.755062246873;4960.404751429834;4963.8262660806695;3452.7755695879937;3651.580068292154;4176.853810116631;4228.471441069866;4237.512686041114;6411.519136064814;6443.516736244754;6454.1609590752905;6463.192100987377;6476;4634.652401069933;4672.556107169813;4965.553100220961;5581.386047534808;5705.258316418881;5765.884682306372;7205;7230.927690723131;7231.783046508614;7261.927380726178;4573.5426457354;4615.469221039556;4622.491525932145;4625.242407885015;4630.58324750774;6265.7493700251935;7215.891761623579;7724.922750772476;7765.961170194113;7770.33952114071;4407.559244075567;4487.394201782783;4620.953790462119;4626.976865115653;4655.976720116378;4117.629413352753;4718.103560323528;4730.62155027597;4738.857834264978;4754.120487709784;5605.971970140124;5638.520725738276;5655.095184770499;5657.745401456944;5697.4302569742695;7263.527870688388;7292.708291668274;7293.452991025694;7297.628270812007;7312.780616581511;1640.6472608389254;1657.0471978612345;1658.8589969852455;1660.3192690996634;1661.0199982010672;872.2498651159997;978.1734434402919;1023.5701005577675;1052.179300145872;1071.791000754861;6685.966570167118;6696.59820410777;6730.528862979642;6761.560498567577;6797.145199016425;7518.699252029857;7519.511231769918;7523.8495230095095;7550.735724249625;7552.8489430212185;5476.58925580583;6721.563098398588;6741.7303307868115;6761.357671021246;6780.966095169492;3666.7799932004164;3962.286788378062;4001.5398229203433;4071.91856162881;4075.612816782401;7833.412494062854;7919.08930473003;7949.364050875916;7956.164602716747;7957.244061814118;7835.216478352119;7852.175521570267;7854.057513098464;7874.094479134973;7877.133515313311;7972.76422154567;7980.042394912648;8029.558374289353;8033.1163572007035;8108.797280067927;7410.62946852666;7673.923260767321;7690.653920573475;7718.807029824299;7722.845543089219;7460.77617671449;7487.962560187164;7507;7517.586532740752;7530.322270995636;7997.960265165491;8016.238457346542;8016.839663206587;8025.478343907861;8039.959800200962;4708.6468514860835;4728.929066063943;4732.171869922681;4744.074905393415;4748.905021899612;7308.342249197598;7616.867277162403;7626.389888808771;7640.656170472231;7657.745458180362;7288.194045292495;7371.041764570571;7372.59450730215;7377.077865266841;7406.888966655045;7326.267373262845;7339.486235963432;7340.302671246223;7349.669264882986;7359.521631093961;6854.6229957352825;7180.60506672138;7194.892076618959;7206.351428371472;7215.963920180366;5964.970175149097;6046.5767396281835;7348.338649521569;7385.7045718170675;7387;7194.6042967635185;7195.388391986739;7200.71197152108;7204.639768011473;7223.313785190398 08:26:42 INFO - PROCESS | 1681 | |5;yui.html;652.960822350659;704.2710794327871;710.1868360726968;716.1227496317013;757.9956557561226;13744.312784360767;14531.70936581269;14675.779863302045;14822.332995015224;16525.752113718303;12681.682957926056;15146.394144234246;15393.153376564313;15403.768943465857;15445.536633901002;844.4131328726522;871.4988881393224;871.5032431514039;873.1792115411524;874.396666300254;853.4665833853842;854.1927878155115;854.4659587757651;860.6686425726109;870.8867847179857;874.5627186406797;878.4026861734018;883.3419102768446;889.0442774017924;889.1730690457872;873.6942070275417;879.885614870066;885.5926273914007;889.4040992535017;891.7235656946367;649.7693318871827;653.5425202358321;656.5961933410965;658.5225711359226;660.6465540935576;14419.279036048261;14468;14517.78223326651;14555.345009474599;14798.778018329735;10591;12154.33151176685;12321.445534950948;12476.688082797911;12552.184108032949;9889.056157557168;10070;10120.696379108565;10407.167426605853;10770.461476926122;3393.9321213575836;3428.297199074209;3450.723942084627;3464.9307013859834;3538.3630946429635;77208;77870;77903.2209677896;77961.61019194925;78000.60999695022;9107.81784364309;9138.406003609743;9259.120383563552;9274.44353338802;9287.071292870658;20506.89746551258;20583.176672933216;20716.378508644764;20775.168993240404;20779;7227.7831665050135;7258.274172582699;7356.227596102439;7508.211637778064;7694.846103077907;4016.638502534786;4118.5057793065025;4139.710220284612;4142.212979533939;4263.488381394252;3506.7545271831236;3511.7892926423983;3539.0975301298004;3547.9888231853797;3550.6626870447267;559.6697948210575;577.3966205315455;580.9070548712185;653.7058323754329;692.2731132311154;567.1945836911596;584.1442287049493;629.8267976306461;630.0832289019465;633.5375176121457;7689.9615501922135;7943.324817390471;8151.796205094802;8495.787605309793;8668.523231222343;495.17306098815067;560.1905246918245;591.7248329849182;596.7105953612495;610.5085406247924;3989.9202015959518;4013.4983127109113;4176;4303.892402689895;4379.277419225792;88313.55843220743;89049;89574.55212724025;90312.5484372574;97168.14159292007;76377;77912;79952.60023699845;80205.59897200477;81494;66150.66924665442;66552.66894662079;66661.33362665003;66828.6658566704;66979.66510167516;7847.744360902228;8120.512769233865;8480.15198480147;8539.82920341602;8735.868961965449;35408.64591354054;37459.62540374562;39113.8044309788;48230;49017.754911225216;50504;53892.46107538875;54625.45374546362;56134;56536.586585335695;10775.353478791298;11264.605738799102;11566.537338506365;11580.131490138441;12131.878681213428;11915.761684766083;12059.81910271329;12103.213291136048;12461.813072803734;12519;10965.671029869116;11312.83030754523;11362.602308919479;11478.368689722145;11642.476088575864;11452.14108941816;11488.368139752394;11606.419679015846;11625.6512304631;11718.003969662674;9370.765730856783;10799.244052916221;11085.224034317844;11673.591424300108;12246.265224086583;8860.202581767415;8884;9075.682351117679;9376.203022743142;9504.904950950402;9324;9739.464329461947;9769.853452198366;9874.753131171778;10036.19710423179 08:26:42 INFO - PROCESS | 1681 | __end_tp_report 08:26:42 INFO - PROCESS | 1681 | __start_cc_report 08:26:42 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,340 08:26:42 INFO - PROCESS | 1681 | __end_cc_report 08:26:42 INFO - PROCESS | 1681 | __startTimestamp1456331202402__endTimestamp 08:26:42 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | ------- Summary: start ------- 08:26:42 INFO - PROCESS | 1681 | Number of tests: 6 08:26:42 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5707.64 Median:5864.44 stddev:651.69 (11.1%) stddev-sans-first:627.76 08:26:42 INFO - PROCESS | 1681 | Values: 3387.3 3508.1 3539.9 3588.7 3592.6 4654.0 5698.5 5751.9 5756.0 5775.6 5611.9 5658.1 5743.4 5783.0 5824.1 5205.2 5228.9 5261.4 5262.3 5292.1 5268.8 5285.4 5312.2 5339.7 5355.6 5154.7 5240.4 5256.6 5284.2 5300.9 5162.9 5204.0 5208.2 5212.7 5245.7 4978.0 5143.0 5144.8 5180.8 5180.8 5479.7 5569.2 5607.4 5634.4 5644.5 6139.2 6153.4 6220.3 6240.3 6290.0 6099.0 6171.4 6222.7 6253.4 6261.1 5803.8 5803.9 5807.9 5822.6 5842.3 6145.7 6200.1 6234.5 6292.7 6407.8 6117.3 6138.6 6144.0 6157.4 6165.8 6137.4 6234.5 6237.3 6269.4 6281.8 5436.4 5788.8 6030.0 6247.9 6275.9 6230.4 6244.3 6253.7 6260.8 6285.5 4070.9 4072.0 4810.2 4920.7 4958.4 3716.9 4376.2 4391.1 4416.7 4445.3 5754.0 5783.5 5796.5 5808.8 5818.6 5584.7 6148.0 6170.3 6236.7 6257.9 5816.1 5841.7 5843.3 5843.9 5872.7 4899.3 5325.4 5378.0 5444.3 5445.3 5624.9 6181.6 6337.1 6337.1 6393.2 6133.6 6184.4 6197.1 6207.3 6210.2 6214.3 6217.5 6262.5 6348.4 6352.6 6119.6 6125.4 6138.3 6169.0 6171.2 6194.2 6201.8 6205.7 6212.5 6214.1 6146.8 6149.8 6155.6 6161.0 6171.0 6108.2 6133.1 6151.0 6155.3 6163.1 5433.7 5936.6 5943.9 6073.5 6097.9 5286.7 6001.9 6025.0 6028.4 6035.7 5817.8 5860.2 5864.4 5883.9 5908.3 08:26:42 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:59745.70 Median:37632.53 stddev:127045.69 (337.6%) stddev-sans-first:127324.06 08:26:42 INFO - PROCESS | 1681 | Values: 440.7 495.3 561.4 565.6 594.4 37084.4 37531.2 37605.0 37605.2 37621.8 38709.6 39089.2 39138.4 39148.2 39148.8 9302.8 9501.2 9539.3 9549.8 9551.3 9362.8 9506.1 9524.8 9555.6 9578.2 9494.7 9540.4 9620.5 9621.9 9632.5 9498.0 9507.0 9573.4 9573.8 9590.8 9406.5 9509.0 9530.0 9540.8 9567.8 31407.7 38025.6 38228.2 38266.4 38375.0 3175.0 3190.0 3224.5 3434.3 3759.2 22888.8 28459.4 28856.0 29021.4 29299.0 2753.4 2815.0 2855.1 2885.0 2957.8 270127.3 322946.0 326459.0 326791.0 326852.0 45224.0 45949.8 63936.5 63972.0 64802.7 37134.9 40040.4 43984.3 44370.0 44447.8 15275.8 15300.7 15436.8 15438.0 15476.8 12282.6 12437.4 12488.5 12545.2 12554.7 14078.4 14164.0 14543.8 14653.6 14678.2 5552.9 6345.7 6391.0 6455.6 6476.4 942.0 955.4 966.3 1055.3 1115.8 28510.7 30022.5 30212.8 30518.4 30542.8 843.2 982.0 1047.7 1125.5 1152.5 14268.2 14590.4 14725.9 14727.5 14995.8 587168.0 590926.0 616968.0 629441.0 635778.0 58417.1 58710.0 59021.0 59049.4 59161.8 1428.5 1451.6 1454.2 1464.9 1477.7 25303.5 25589.5 28256.9 28799.3 29021.6 49141.8 49799.0 49850.0 49908.8 50241.7 445195.0 452062.0 452888.0 453378.0 454150.0 32257.2 32797.5 33319.5 33393.5 33682.8 43958.9 44232.8 44290.0 44797.3 45663.5 36506.6 36820.0 37234.8 37333.4 37561.2 36061.5 37291.0 37885.0 38202.8 39827.6 37145.6 37473.6 37643.2 38567.2 38757.0 26349.5 30006.4 30685.2 31503.0 31796.4 24234.4 24482.9 24524.9 25723.0 26405.2 08:26:42 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:33963.53 Median:11379.81 stddev:103466.84 (909.2%) stddev-sans-first:103726.19 08:26:42 INFO - PROCESS | 1681 | Values: 289.8 315.5 344.8 358.4 364.7 15685.5 16177.5 19077.1 19579.4 19740.1 11420.0 11839.8 11865.4 19357.7 19647.5 4417.7 5341.4 5354.4 5409.2 5420.0 5176.7 5951.2 6021.0 6025.4 6040.9 5943.7 5968.9 5971.3 6188.6 6488.9 6455.0 6502.7 6521.3 6523.0 6563.2 5574.7 5685.1 5711.3 5716.4 5739.4 12950.3 12966.5 13022.9 13094.9 14349.0 2001.8 2088.9 2278.8 2646.2 2791.7 8109.4 9785.4 10015.8 10146.0 10205.1 1474.6 1774.6 1780.4 1788.1 1822.5 111691.0 114010.0 114223.0 115369.0 115715.0 9413.8 11166.0 11421.4 11423.5 11574.2 12117.9 12905.2 13359.7 13694.9 13921.7 8266.3 8421.2 8462.4 8521.8 8538.3 8660.0 8699.3 8712.2 8750.8 8801.9 4358.5 4452.4 4476.2 4490.6 4496.7 1634.8 1635.8 1827.1 1885.5 1906.5 873.8 885.9 890.7 938.7 989.4 16344.8 19118.5 20117.4 20185.3 20670.7 934.7 962.2 964.8 971.3 1023.0 10364.7 10751.4 10929.3 10944.8 10966.7 564007.0 628955.0 633666.0 641588.0 646703.0 115310.4 116205.0 116283.0 118539.4 118738.4 1014.0 1023.9 1024.2 1033.1 1034.1 17388.9 17729.6 17941.7 18328.2 18352.2 37410.4 39582.6 47168.5 48598.8 48962.5 52207.0 58293.8 60515.0 65133.7 74899.0 7937.0 8088.0 8122.2 8223.6 8377.2 11767.5 13452.6 13552.9 13665.2 14045.0 11103.8 11308.2 11610.5 11634.2 11763.8 6133.7 7580.5 11476.4 11484.2 12017.8 11315.7 11855.1 11957.6 11971.8 12100.6 8047.0 8198.3 8199.7 8275.0 8281.1 8920.4 11517.5 11659.7 11694.0 11760.6 08:26:42 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:6137.23 Median:5075.79 stddev:3236.72 (63.8%) stddev-sans-first:3227.28 08:26:42 INFO - PROCESS | 1681 | Values: 1530.6 1547.9 1562.4 1931.7 1951.5 7951.9 8546.1 8726.0 8910.0 9058.0 8652.9 8680.7 8766.7 8794.0 8805.3 2440.0 2469.1 2469.7 2471.3 2483.1 2418.3 2454.8 2459.2 2460.3 2463.3 2117.2 2344.4 2416.9 2435.9 2450.6 2385.3 2400.8 2428.5 2441.4 2448.8 2418.7 2430.0 2440.7 2447.6 2453.0 8783.4 8827.2 8837.2 8855.1 8878.0 5479.0 5538.8 5576.3 5581.9 5601.0 3121.0 3653.7 3698.9 3711.3 3729.9 1046.4 1057.5 1087.7 1087.8 1094.4 12186.6 12280.1 12315.3 12329.9 12330.9 4920.7 4954.4 5000.7 5013.4 5035.8 10338.0 10384.8 10430.7 10471.2 10484.3 5488.3 5545.5 5569.4 5584.9 5601.6 5027.8 5067.0 5073.1 5078.5 5079.9 3817.7 3873.1 3951.0 3990.9 4012.4 1231.3 1324.9 1334.1 1341.9 1357.0 1112.5 1113.8 1137.5 1306.6 1401.2 8026.1 8032.3 8040.9 8191.1 8198.2 1140.8 1142.1 1144.5 1158.2 1168.0 6208.5 6222.4 6274.4 6277.6 6322.9 9453.4 10407.8 10777.9 11054.9 11107.9 9605.4 10501.7 10665.3 10785.0 10875.7 8436.7 8487.9 8498.8 8525.7 8536.5 8019.4 8025.3 8032.0 8078.4 8097.8 9765.1 9793.8 9910.7 9954.7 10014.8 9924.8 10110.3 10133.0 10182.2 10247.0 7422.7 7533.4 7582.3 7592.1 7604.3 8375.9 8429.5 8432.8 8446.1 8447.4 6952.4 7320.1 7478.1 7594.1 7610.9 7292.0 7319.2 7370.0 7431.5 7451.7 7744.0 7760.8 7782.9 7811.2 7816.1 6915.3 7014.9 7047.4 7052.2 7104.3 7143.3 7199.9 7261.6 7293.6 7299.5 08:26:42 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:5908.86 Median:6758.58 stddev:1963.85 (29.1%) stddev-sans-first:1924.03 08:26:42 INFO - PROCESS | 1681 | Values: 319.6 323.2 325.0 329.2 329.7 6636.9 6746.0 6838.3 6850.4 6867.1 6755.8 6847.2 6861.3 6862.9 6895.8 4965.0 5007.0 5007.4 5011.8 5039.2 4994.1 5003.8 5008.2 5011.4 5022.4 4937.2 4957.7 4958.3 4964.5 4970.9 4113.9 4806.5 4898.8 4960.4 4963.8 3452.8 3651.6 4176.9 4228.5 4237.5 6411.5 6443.5 6454.2 6463.2 6476.0 4634.7 4672.6 4965.6 5581.4 5705.3 5765.9 7205.0 7230.9 7231.8 7261.9 4573.5 4615.5 4622.5 4625.2 4630.6 6265.7 7215.9 7724.9 7766.0 7770.3 4407.6 4487.4 4621.0 4627.0 4656.0 4117.6 4718.1 4730.6 4738.9 4754.1 5606.0 5638.5 5655.1 5657.7 5697.4 7263.5 7292.7 7293.5 7297.6 7312.8 1640.6 1657.0 1658.9 1660.3 1661.0 872.2 978.2 1023.6 1052.2 1071.8 6686.0 6696.6 6730.5 6761.6 6797.1 7518.7 7519.5 7523.8 7550.7 7552.8 5476.6 6721.6 6741.7 6761.4 6781.0 3666.8 3962.3 4001.5 4071.9 4075.6 7833.4 7919.1 7949.4 7956.2 7957.2 7835.2 7852.2 7854.1 7874.1 7877.1 7972.8 7980.0 8029.6 8033.1 8108.8 7410.6 7673.9 7690.7 7718.8 7722.8 7460.8 7488.0 7507.0 7517.6 7530.3 7998.0 8016.2 8016.8 8025.5 8040.0 4708.6 4728.9 4732.2 4744.1 4748.9 7308.3 7616.9 7626.4 7640.7 7657.7 7288.2 7371.0 7372.6 7377.1 7406.9 7326.3 7339.5 7340.3 7349.7 7359.5 6854.6 7180.6 7194.9 7206.4 7216.0 5965.0 6046.6 7348.3 7385.7 7387.0 7194.6 7195.4 7200.7 7204.6 7223.3 08:26:42 INFO - PROCESS | 1681 | 08:26:42 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:17485.56 Median:587.93 stddev:24384.47 (4147.5%) stddev-sans-first:24420.12 08:26:42 INFO - PROCESS | 1681 | Values: 653.0 704.3 710.2 716.1 758.0 13744.3 14531.7 14675.8 14822.3 16525.8 12681.7 15146.4 15393.2 15403.8 15445.5 844.4 871.5 871.5 873.2 874.4 853.5 854.2 854.5 860.7 870.9 874.6 878.4 883.3 889.0 889.2 873.7 879.9 885.6 889.4 891.7 649.8 653.5 656.6 658.5 660.6 14419.3 14468.0 14517.8 14555.3 14798.8 10591.0 12154.3 12321.4 12476.7 12552.2 9889.1 10070.0 10120.7 10407.2 10770.5 3393.9 3428.3 3450.7 3464.9 3538.4 77208.0 77870.0 77903.2 77961.6 78000.6 9107.8 9138.4 9259.1 9274.4 9287.1 20506.9 20583.2 20716.4 20775.2 20779.0 7227.8 7258.3 7356.2 7508.2 7694.8 4016.6 4118.5 4139.7 4142.2 4263.5 3506.8 3511.8 3539.1 3548.0 3550.7 559.7 577.4 580.9 653.7 692.3 567.2 584.1 629.8 630.1 633.5 7690.0 7943.3 8151.8 8495.8 8668.5 495.2 560.2 591.7 596.7 610.5 3989.9 4013.5 4176.0 4303.9 4379.3 88313.6 89049.0 89574.6 90312.5 97168.1 76377.0 77912.0 79952.6 80205.6 81494.0 66150.7 66552.7 66661.3 66828.7 66979.7 7847.7 8120.5 8480.2 8539.8 8735.9 35408.6 37459.6 39113.8 48230.0 49017.8 50504.0 53892.5 54625.5 56134.0 56536.6 10775.4 11264.6 11566.5 11580.1 12131.9 11915.8 12059.8 12103.2 12461.8 12519.0 10965.7 11312.8 11362.6 11478.4 11642.5 11452.1 11488.4 11606.4 11625.7 11718.0 9370.8 10799.2 11085.2 11673.6 12246.3 8860.2 8884.0 9075.7 9376.2 9504.9 9324.0 9739.5 9769.9 9874.8 10036.2 08:26:42 INFO - PROCESS | 1681 | -------- Summary: end -------- 08:26:42 INFO - PROCESS | 1681 | 08:26:43 INFO - TEST-INFO | 1681: exit 0 08:26:43 INFO - TEST-OK | dromaeo_css | took 1111308ms 08:26:43 INFO - TEST-START | kraken 08:26:43 INFO - operating with platform_type : mac_ 08:26:43 INFO - Initialising browser for kraken test... 08:26:43 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpzdY_Kg/profile http://localhost:49274/getInfo.html) 08:26:45 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 08:26:45 INFO - PROCESS | 1688 | colorDepth:24 08:26:45 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 08:26:45 INFO - PROCESS | 1688 | __metrics 08:26:45 ERROR - PROCESS | 1688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:26:46 INFO - TEST-INFO | 1688: exit 0 08:26:46 INFO - Browser initialized. 08:26:46 INFO - Running cycle 1/1 for kraken test... 08:26:46 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/tmpzdY_Kg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:58 INFO - PROCESS | 1691 | RSS: Main: 255664128 08:26:58 INFO - PROCESS | 1691 | 08:27:01 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:01 INFO - PROCESS | 1691 | RSS: Main: 268922880 08:27:01 INFO - PROCESS | 1691 | 08:27:04 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 08:27:05 INFO - PROCESS | 1691 | RSS: Main: 278642688 08:27:05 INFO - PROCESS | 1691 | 08:27:08 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 08:27:09 INFO - PROCESS | 1691 | RSS: Main: 280940544 08:27:09 INFO - PROCESS | 1691 | 08:27:10 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 08:27:11 INFO - PROCESS | 1691 | RSS: Main: 282013696 08:27:11 INFO - PROCESS | 1691 | 08:27:13 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:27:14 INFO - PROCESS | 1691 | RSS: Main: 284229632 08:27:14 INFO - PROCESS | 1691 | 08:27:17 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 08:27:17 INFO - PROCESS | 1691 | RSS: Main: 283820032 08:27:17 INFO - PROCESS | 1691 | 08:27:21 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 08:27:21 INFO - PROCESS | 1691 | RSS: Main: 284725248 08:27:21 INFO - PROCESS | 1691 | 08:27:24 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 08:27:24 INFO - PROCESS | 1691 | RSS: Main: 283639808 08:27:24 INFO - PROCESS | 1691 | 08:27:26 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:27:27 INFO - PROCESS | 1691 | RSS: Main: 284327936 08:27:27 INFO - PROCESS | 1691 | 08:27:28 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:27:29 INFO - PROCESS | 1691 | RSS: Main: 284467200 08:27:29 INFO - PROCESS | 1691 | 08:27:31 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:27:32 INFO - PROCESS | 1691 | RSS: Main: 284319744 08:27:32 INFO - PROCESS | 1691 | 08:27:35 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:27:35 INFO - PROCESS | 1691 | RSS: Main: 284332032 08:27:35 INFO - PROCESS | 1691 | 08:27:38 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:27:38 INFO - PROCESS | 1691 | RSS: Main: 284696576 08:27:38 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 08:27:40 INFO - PROCESS | 1691 | RSS: Main: 285171712 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | __start_tp_report 08:27:40 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 08:27:40 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 08:27:40 INFO - PROCESS | 1691 | |i|pagename|runs| 08:27:40 INFO - PROCESS | 1691 | |0;ai-astar;113;112;115;101;170;174;134;121;113;113 08:27:40 INFO - PROCESS | 1691 | |1;audio-beat-detection;162;127;145;151;125;139;163;152;159;148 08:27:40 INFO - PROCESS | 1691 | |2;audio-dft;213;196;197;217;218;194;196;195;202;202 08:27:40 INFO - PROCESS | 1691 | |3;audio-fft;75;69;72;110;58;58;59;62;122;58 08:27:40 INFO - PROCESS | 1691 | |4;audio-oscillator;84;83;130;80;79;81;121;70;87;147 08:27:40 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;122;95;88;94;88;94;108;138;86;137 08:27:40 INFO - PROCESS | 1691 | |6;imaging-darkroom;142;120;126;100;149;151;103;148;150;108 08:27:40 INFO - PROCESS | 1691 | |7;imaging-desaturate;93;93;92;92;92;93;91;94;92;94 08:27:40 INFO - PROCESS | 1691 | |8;json-parse-financial;55;57;56;57;56;55;56;75;73;83 08:27:40 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;63;66;83;90;106;71;67;64;66;67 08:27:40 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;99;112;78;108;108;110;111;95;87;88 08:27:40 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;129;130;139;119;126;134;123;129;131;132 08:27:40 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;167;162;140;139;137;131;138;141;143;143 08:27:40 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;69;69;71;66;69;67;68;65;70;76 08:27:40 INFO - PROCESS | 1691 | __end_tp_report 08:27:40 INFO - PROCESS | 1691 | __start_cc_report 08:27:40 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,881 08:27:40 INFO - PROCESS | 1691 | __end_cc_report 08:27:40 INFO - PROCESS | 1691 | __startTimestamp1456331260696__endTimestamp 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | ------- Summary: start ------- 08:27:40 INFO - PROCESS | 1691 | Number of tests: 14 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:126.60 Median:118.00 stddev:25.33 (21.5%) stddev-sans-first:26.38 08:27:40 INFO - PROCESS | 1691 | Values: 113.0 112.0 115.0 101.0 170.0 174.0 134.0 121.0 113.0 113.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:151.50 stddev:13.41 (8.9%) stddev-sans-first:13.10 08:27:40 INFO - PROCESS | 1691 | Values: 162.0 127.0 145.0 151.0 125.0 139.0 163.0 152.0 159.0 148.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:203.00 Median:202.00 stddev:9.44 (4.7%) stddev-sans-first:9.29 08:27:40 INFO - PROCESS | 1691 | Values: 213.0 196.0 197.0 217.0 218.0 194.0 196.0 195.0 202.0 202.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:74.30 Median:60.50 stddev:23.01 (38.0%) stddev-sans-first:24.41 08:27:40 INFO - PROCESS | 1691 | Values: 75.0 69.0 72.0 110.0 58.0 58.0 59.0 62.0 122.0 58.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:80.50 stddev:26.29 (32.7%) stddev-sans-first:27.51 08:27:40 INFO - PROCESS | 1691 | Values: 84.0 83.0 130.0 80.0 79.0 81.0 121.0 70.0 87.0 147.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:105.00 Median:88.00 stddev:20.25 (23.0%) stddev-sans-first:20.53 08:27:40 INFO - PROCESS | 1691 | Values: 122.0 95.0 88.0 94.0 88.0 94.0 108.0 138.0 86.0 137.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:129.70 Median:145.00 stddev:20.81 (14.4%) stddev-sans-first:21.59 08:27:40 INFO - PROCESS | 1691 | Values: 142.0 120.0 126.0 100.0 149.0 151.0 103.0 148.0 150.0 108.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:93.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 08:27:40 INFO - PROCESS | 1691 | Values: 93.0 93.0 92.0 92.0 92.0 93.0 91.0 94.0 92.0 94.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:57.00 stddev:10.47 (18.4%) stddev-sans-first:10.76 08:27:40 INFO - PROCESS | 1691 | Values: 55.0 57.0 56.0 57.0 56.0 55.0 56.0 75.0 73.0 83.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:74.30 Median:67.00 stddev:14.21 (21.2%) stddev-sans-first:14.47 08:27:40 INFO - PROCESS | 1691 | Values: 63.0 66.0 83.0 90.0 106.0 71.0 67.0 64.0 66.0 67.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:99.60 Median:82.50 stddev:12.08 (14.6%) stddev-sans-first:12.82 08:27:40 INFO - PROCESS | 1691 | Values: 99.0 112.0 78.0 108.0 108.0 110.0 111.0 95.0 87.0 88.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:130.50 stddev:5.61 (4.3%) stddev-sans-first:5.95 08:27:40 INFO - PROCESS | 1691 | Values: 129.0 130.0 139.0 119.0 126.0 134.0 123.0 129.0 131.0 132.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:142.00 stddev:11.35 (8.0%) stddev-sans-first:8.49 08:27:40 INFO - PROCESS | 1691 | Values: 167.0 162.0 140.0 139.0 137.0 131.0 138.0 141.0 143.0 143.0 08:27:40 INFO - PROCESS | 1691 | 08:27:40 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:3.06 (4.4%) stddev-sans-first:3.24 08:27:40 INFO - PROCESS | 1691 | Values: 69.0 69.0 71.0 66.0 69.0 67.0 68.0 65.0 70.0 76.0 08:27:40 INFO - PROCESS | 1691 | -------- Summary: end -------- 08:27:40 INFO - PROCESS | 1691 | 08:27:41 INFO - TEST-INFO | 1691: exit 0 08:27:41 INFO - TEST-OK | kraken | took 58423ms 08:27:41 INFO - SUITE-END | took 1169s 08:27:41 INFO - Completed test suite (00:19:30) 08:27:41 INFO - Working with test: dromaeo_css 08:27:41 INFO - Generating results file: dromaeo_css 08:27:41 INFO - Working with test: kraken 08:27:41 INFO - Generating results file: kraken 08:27:41 INFO - javascript benchmark 08:27:41 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:27:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 08:27:41 INFO - process_Request line: dromaeo_css 7443.64 graph.html#tests=[[72,64,61]] 08:27:41 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:27:41 INFO - process_Request line: kraken 1553.00 graph.html#tests=[[232,64,61]] 08:27:41 INFO - RETURN: dromaeo_css: 7443.64 08:27:41 INFO - RETURN: kraken: 1553.00 08:27:41 INFO - javascript benchmark 08:27:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3387.3056023515182, 3508.122969257684, 3539.876104336349, 3588.712902967763, 3592.5688917329926, 4653.976730116349, 5698.51562617178, 5751.913721294179, 5755.971220143904, 5775.624584402021, 5611.859703507414, 5658.122990936401, 5743.368229494752, 5783.0, 5824.097264923933, 5205.219217117435, 5228.8692782680355, 5261.421243663194, 5262.263283140344, 5292.126799078147, 5268.8155914542995, 5285.392179899322, 5312.229726689628, 5339.679619222839, 5355.571554275649, 5154.664946778447, 5240.423553409122, 5256.632035757499, 5284.180951952453, 5300.893982120375, 5162.948370516285, 5204.0372531081875, 5208.166693329049, 5212.713300768494, 5245.737713114329, 4977.975110124463, 5143.022825663112, 5144.819931302424, 5180.766865491062, 5180.792768289264, 5479.671219726789, 5569.248151499536, 5607.411221821691, 5634.408387119375, 5644.548436125141, 6139.2325959255095, 6153.4154255345675, 6220.253569571635, 6240.31356550779, 6289.968550157266, 6099.0, 6171.352008039136, 6222.688865556749, 6253.374662533755, 6261.06084087386, 5803.7968671096305, 5803.941960580382, 5807.854803629901, 5822.592418530662, 5842.298924129089, 6145.692715364214, 6200.100985357189, 6234.532410069263, 6292.653904035322, 6407.839804004937, 6117.3270940197435, 6138.600990935575, 6144.0, 6157.384261573897, 6165.815025549241, 6137.438273608381, 6234.501239900797, 6237.313895471494, 6269.373062693694, 6281.842953926097, 5436.401995780461, 5788.768449261982, 6030.005049166926, 6247.9062814057825, 6275.937240627627, 6230.376962303824, 6244.250689917239, 6253.687315634291, 6260.843478913063, 6285.465735412449, 4070.8575199867864, 4072.0, 4810.158222311082, 4920.6801557898625, 4958.404991400983, 3716.9070773230346, 4376.190404775127, 4391.07787364657, 4416.712913660602, 4445.288753799441, 5754.0, 5783.450572195635, 5796.510152599924, 5808.82573522795, 5818.5636077294375, 5584.748686309126, 6148.047052706837, 6170.259568851767, 6236.719347629368, 6257.874842503215, 5816.127580862904, 5841.678707671119, 5843.328017277982, 5843.853903652358, 5872.677002764804, 4899.2896030075435, 5325.3875804282225, 5378.0, 5444.265024221759, 5445.319335083114, 5624.887502249932, 6181.567290289637, 6337.112804207414, 6337.144485494491, 6393.232812062489, 6133.64071396146, 6184.381561843779, 6197.101420294122, 6207.34822843613, 6210.161628180138, 6214.2853571838, 6217.502599791916, 6262.53031022666, 6348.396902294275, 6352.555321127476, 6119.602225855483, 6125.448709616156, 6138.294096178818, 6168.9691551541955, 6171.228596425447, 6194.225721784777, 6201.751929922752, 6205.65868877198, 6212.534059945432, 6214.098955651315, 6146.815595532141, 6149.7847575334645, 6155.569110162425, 6160.969195153995, 6171.0, 6108.20593322883, 6133.080037994337, 6151.0, 6155.261368635793, 6163.075538669056, 5433.728313584384, 5936.643801371932, 5943.940560594512, 6073.514118870568, 6097.939020609914, 5286.682799032071, 6001.939980600138, 6025.0, 6028.3971602839365, 6035.728392222449, 5817.767289308549, 5860.15027820955, 5864.44287792659, 5883.941160588511, 5908.291005079418], "unit": "score", "name": "dojo.html", "value": 5667.243899382545}, {"lowerIsBetter": false, "replicates": [440.6937178660832, 495.30409774267156, 561.3993027460617, 565.6436445039625, 594.4412252482663, 37084.364454443195, 37531.24937501255, 37604.99999999996, 37605.24789504215, 37621.81189094054, 38709.612903870955, 39089.218215635745, 39138.412923806165, 39148.21703565927, 39148.80425597868, 9302.76743081425, 9501.23990080792, 9539.332246742732, 9549.809003819919, 9551.283653725963, 9362.765930851716, 9506.144446999768, 9524.761880952963, 9555.569999350046, 9578.185854202366, 9494.71515854522, 9540.379875308117, 9620.470874101922, 9621.855672164924, 9632.518374081303, 9498.0, 9507.0, 9573.377730447568, 9573.760655983586, 9590.76023099421, 9406.529673516297, 9509.001554836712, 9529.952350238205, 9540.809183816285, 9567.760805979837, 31407.685923140933, 38025.61974380248, 38228.23543529142, 38266.426003609966, 38375.0, 3175.0157451190207, 3189.952150717741, 3224.500202468621, 3434.295969326282, 3759.172981943968, 22888.771112288832, 28459.430811383656, 28856.0, 29021.41957160845, 29299.0, 2753.3942532642786, 2814.985925070382, 2855.0578309157927, 2885.0190935082173, 2957.822530648168, 270127.29872701416, 322946.0, 326459.0, 326791.0, 326852.0, 45224.0, 45949.7702511492, 63936.48349340831, 63972.0, 64802.67598662071, 37134.88595342144, 40040.39939400912, 43984.3402348965, 44370.0, 44447.77776111163, 15275.847241527443, 15300.693986120437, 15436.845631543765, 15438.0, 15476.76784848228, 12282.570110046105, 12437.440315185839, 12488.50045998168, 12545.247285162919, 12554.681758415234, 14078.366473508717, 14164.00851940375, 14543.78184327236, 14653.633659158606, 14678.192699401636, 5552.91670624941, 6345.650989195638, 6390.968045159744, 6455.61266324022, 6476.35236476358, 941.9623215071457, 955.3980991975011, 966.2704657983178, 1055.2876808154465, 1115.83820346051, 28510.714892850807, 30022.549661755093, 30212.79148834022, 30518.389632207676, 30542.84728576343, 843.2073850580557, 981.9901800982042, 1047.7328281288376, 1125.4822781520593, 1152.4929031226402, 14268.215248161243, 14590.41638334476, 14725.926370368079, 14727.484538041117, 14995.775063374058, 587168.0, 590926.0, 616968.0, 629441.0, 635778.0, 58417.123743143886, 58710.0, 59021.0, 59049.40950590439, 59161.81676366449, 1428.5285855667605, 1451.622578129694, 1454.2147240490017, 1464.8974571780086, 1477.711846190004, 25303.493930120927, 25589.488210236064, 28256.85871570629, 28799.28001799888, 29021.56467653029, 49141.75429122832, 49799.0, 49850.0, 49908.75228119326, 50241.748791255806, 445195.0, 452062.0, 452888.0, 453378.0, 454150.0, 32257.193570159994, 32797.50803737898, 33319.50020749642, 33393.49909751307, 33682.831585841916, 43958.90102747329, 44232.778836105615, 44290.0, 44797.32804007877, 45663.54336456593, 36506.634933650326, 36820.0, 37234.813825930694, 37333.4399983995, 37561.24877502489, 36061.45907811332, 37291.0, 37885.0, 38202.80898595489, 39827.60172398355, 37145.628543714214, 37473.62526374702, 37643.2471350566, 38567.228655427294, 38757.0, 26349.49314460018, 30006.399872002876, 30685.235321737877, 31503.0, 31796.36407271795, 24234.394140146636, 24482.877585611957, 24524.877375613007, 25722.971081156546, 26405.207843764718], "unit": "score", "name": "ext.html", "value": 18753.44523275709}, {"lowerIsBetter": false, "replicates": [289.7508142997023, 315.54718978266186, 344.8241595532192, 358.3925246706833, 364.7191662419935, 15685.529434116967, 16177.514674559767, 19077.14152863121, 19579.41261762146, 19740.111694973726, 11420.0, 11839.763204735922, 11865.406729663526, 19357.709634355495, 19647.5088122797, 4417.712848664843, 5341.412444631087, 5354.384245811742, 5409.161579955114, 5420.0, 5176.7336467722735, 5951.196588460546, 6021.036634138539, 6025.397460253961, 6040.909386359186, 5943.702814859262, 5968.88062238755, 5971.343152253248, 6188.628682279055, 6488.870222595545, 6455.031745238229, 6502.674866256715, 6521.282658907517, 6522.967385163068, 6563.212414510242, 5574.693391863446, 5685.090385538294, 5711.257536520226, 5716.42835716425, 5739.4216590437545, 12950.287734174617, 12966.481340746359, 13022.869771302356, 13094.934525327408, 14349.0, 2001.7898120697262, 2088.9268875589282, 2278.840481166319, 2646.206138158545, 2791.734785195403, 8109.4323397362205, 9785.412875227508, 10015.799684006352, 10146.0, 10205.081542661123, 1474.6460849396067, 1774.5652315182733, 1780.3857669104138, 1788.1059470264868, 1822.4532640207885, 111691.0, 114010.0, 114223.0292778785, 115369.0, 115715.0, 9413.776209092912, 11165.995060444598, 11421.37182454973, 11423.543058277743, 11574.18980671345, 12117.878821211674, 12905.225686458842, 13359.666008349868, 13694.93152534231, 13921.721565568834, 8266.297364724065, 8421.242088211968, 8462.449940753831, 8521.786955326166, 8538.274246689101, 8660.004099528634, 8699.304055675531, 8712.172343627346, 8750.781230469289, 8801.911980880237, 4358.5205627380965, 4452.421185245962, 4476.171908196994, 4490.618297444754, 4496.662750293741, 1634.8446897544713, 1635.8445947634955, 1827.10471868786, 1885.4532185666278, 1906.4757191772374, 873.7902903303288, 885.9158379953894, 890.670451932776, 938.6573900526258, 989.4211886046743, 16344.83655163457, 19118.48426435492, 20117.396478105682, 20185.293514726913, 20670.689939650918, 934.7006364343655, 962.2109869906749, 964.8456247000587, 971.3346357744967, 1022.9641962531424, 10364.689059328231, 10751.354918704903, 10929.289596176382, 10944.835827462595, 10966.725831854268, 564007.0, 628955.0, 633666.0, 641588.0, 646703.0, 115310.38758449735, 116205.0, 116283.0, 118539.40730296294, 118738.4063079679, 1013.9695809125591, 1023.948802559869, 1024.2318261304172, 1033.1115240892825, 1034.1209971524145, 17388.913055435147, 17729.556761081076, 17941.73087403664, 18328.175232114852, 18352.17415216345, 37410.43884341683, 39582.604173957894, 47168.528314716415, 48598.75700621474, 48962.51037489722, 52207.0, 58293.83412331814, 60515.0, 65133.67433162804, 74899.0, 7936.960315198387, 8087.959560202161, 8122.187781221831, 8223.629936652746, 8377.204165604258, 11767.52929882795, 13452.596422107352, 13552.93223533876, 13665.18008919468, 14045.016848820484, 11103.833442498531, 11308.151888608552, 11610.477528511406, 11634.243774154653, 11763.764724705286, 6133.693315334304, 7580.4693671444675, 11476.4261786912, 11484.19610627248, 12017.759644807229, 11315.660530184108, 11855.110866684861, 11957.581484648343, 11971.76056478883, 12100.636980890587, 8047.0, 8198.303144232568, 8199.71301004462, 8275.0, 8281.089080201053, 8920.375573709778, 11517.53929842797, 11659.708507287047, 11694.046812073806, 11760.647180584596], "unit": "score", "name": "jquery.html", "value": 9054.844356328784}, {"lowerIsBetter": false, "replicates": [1530.5790907500439, 1547.8529539693725, 1562.3828587707856, 1931.7295578618987, 1951.482857042883, 7951.880721789178, 8546.14538546145, 8726.0, 8910.0, 9058.0, 8652.91347086529, 8680.652773889036, 8766.6931657392, 8794.03265640779, 8805.295576353892, 2439.951200975979, 2469.074097213545, 2469.6912885889265, 2471.3080337505526, 2483.081259933827, 2418.286605451396, 2454.8158888083376, 2459.2376363327426, 2460.3357093584723, 2463.334899577113, 2117.2272120676, 2344.4373350395867, 2416.8912398942, 2435.866027368494, 2450.620153876152, 2385.33210701004, 2400.7839294463497, 2428.5264373447185, 2441.389652586862, 2448.8285819992607, 2418.7460316666848, 2430.0, 2440.694913135858, 2447.559439300925, 2452.969752703869, 8783.38516303859, 8827.205551500396, 8837.248833849131, 8855.114488551159, 8878.0, 5479.04116779562, 5538.806141785019, 5576.275084239023, 5581.8604534886545, 5600.971995140039, 3121.0, 3653.6894363979095, 3698.9260214795822, 3711.2577484502935, 3729.8881033569037, 1046.4140081554278, 1057.5399701129957, 1087.6954452753241, 1087.8096333141668, 1094.4363652718855, 12186.57346992851, 12280.078994075391, 12315.261084334968, 12329.876701232963, 12330.876691233063, 4920.704757714477, 4954.380702412199, 5000.699958002531, 5013.39839219296, 5035.82374616894, 10337.966203379752, 10384.844227336596, 10430.739231519272, 10471.21465890046, 10484.318519296374, 5488.286522752097, 5545.500904918576, 5569.415211402826, 5584.86037849057, 5601.551875849922, 5027.773750181251, 5066.9746651266505, 5073.061483625541, 5078.5175408336145, 5079.87300317495, 3817.675497582681, 3873.1091848874917, 3950.9604903951167, 3990.9002274942777, 4012.3580227163516, 1231.2673958994385, 1324.9006324525699, 1334.1328136711215, 1341.9194848309132, 1356.9796453053211, 1112.5382966069153, 1113.7828123515837, 1137.4767606900753, 1306.6014865466125, 1401.1943132698739, 8026.117127116013, 8032.317253033558, 8040.919590804017, 8191.0580283267, 8198.221168989056, 1140.8459857919074, 1142.114860982745, 1144.5135817277624, 1158.206628459508, 1168.0, 6208.50331973441, 6222.377762223832, 6274.372562743781, 6277.560570760094, 6322.873542529123, 9453.43279403238, 10407.843882341771, 10777.946110269399, 11054.889451105386, 11107.888921110685, 9605.423674579408, 10501.737456563495, 10665.253432259668, 10785.0, 10875.673729788119, 8436.746897593082, 8487.915120848713, 8498.787530311669, 8525.74422767318, 8536.487810731376, 8019.358451323997, 8025.2777250047775, 8031.959840200761, 8078.394120440873, 8097.8380432392205, 9765.072318129767, 9793.804123917624, 9910.653127140515, 9954.701358959242, 10014.849777253492, 9924.801503970024, 10110.342827716175, 10132.986701329808, 10182.185425166117, 10247.026532479402, 7422.703091876265, 7533.39732821362, 7582.317591416799, 7592.088949326117, 7604.315611594983, 8375.916240837514, 8429.452085614415, 8432.789180270542, 8446.07093219733, 8447.366447516339, 6952.374286314256, 7320.1215854097845, 7478.1400138982535, 7594.126675432396, 7610.9238907610215, 7292.0, 7319.2314806944505, 7370.0, 7431.479796414199, 7451.701931922662, 7743.961280193563, 7760.758278675611, 7782.883256751266, 7811.218878112143, 7816.06207255133, 6915.308469153246, 7014.859702806018, 7047.365737083687, 7052.2242553318065, 7104.254053324326, 7143.321384468467, 7199.856002879808, 7261.636918153966, 7293.635318234174, 7299.52553084069], "unit": "score", "name": "mootools.html", "value": 4995.071150101368}, {"lowerIsBetter": false, "replicates": [319.63880814679413, 323.2274863077244, 325.0411286704223, 329.20496999745603, 329.6999730245477, 6636.867262654744, 6745.966270168642, 6838.281980392062, 6850.383465488098, 6867.141607299088, 6755.797326080213, 6847.178338599375, 6861.313868613136, 6862.8676268415775, 6895.827604309895, 4964.975175124128, 5006.974965125188, 5007.449180590151, 5011.774470148852, 5039.244113382985, 4994.051130285234, 5003.824866129687, 5008.198688209887, 5011.373578302712, 5022.397312322508, 4937.21004639256, 4957.702537847723, 4958.305837182797, 4964.4787297333805, 4970.850874473754, 4113.8971525711795, 4806.517717801566, 4898.755062246873, 4960.404751429834, 4963.8262660806695, 3452.7755695879937, 3651.580068292154, 4176.853810116631, 4228.471441069866, 4237.512686041114, 6411.519136064814, 6443.516736244754, 6454.1609590752905, 6463.192100987377, 6476.0, 4634.652401069933, 4672.556107169813, 4965.553100220961, 5581.386047534808, 5705.258316418881, 5765.884682306372, 7205.0, 7230.927690723131, 7231.783046508614, 7261.927380726178, 4573.5426457354, 4615.469221039556, 4622.491525932145, 4625.242407885015, 4630.58324750774, 6265.7493700251935, 7215.891761623579, 7724.922750772476, 7765.961170194113, 7770.33952114071, 4407.559244075567, 4487.394201782783, 4620.953790462119, 4626.976865115653, 4655.976720116378, 4117.629413352753, 4718.103560323528, 4730.62155027597, 4738.857834264978, 4754.120487709784, 5605.971970140124, 5638.520725738276, 5655.095184770499, 5657.745401456944, 5697.4302569742695, 7263.527870688388, 7292.708291668274, 7293.452991025694, 7297.628270812007, 7312.780616581511, 1640.6472608389254, 1657.0471978612345, 1658.8589969852455, 1660.3192690996634, 1661.0199982010672, 872.2498651159997, 978.1734434402919, 1023.5701005577675, 1052.179300145872, 1071.791000754861, 6685.966570167118, 6696.59820410777, 6730.528862979642, 6761.560498567577, 6797.145199016425, 7518.699252029857, 7519.511231769918, 7523.8495230095095, 7550.735724249625, 7552.8489430212185, 5476.58925580583, 6721.563098398588, 6741.7303307868115, 6761.357671021246, 6780.966095169492, 3666.7799932004164, 3962.286788378062, 4001.5398229203433, 4071.91856162881, 4075.612816782401, 7833.412494062854, 7919.08930473003, 7949.364050875916, 7956.164602716747, 7957.244061814118, 7835.216478352119, 7852.175521570267, 7854.057513098464, 7874.094479134973, 7877.133515313311, 7972.76422154567, 7980.042394912648, 8029.558374289353, 8033.1163572007035, 8108.797280067927, 7410.62946852666, 7673.923260767321, 7690.653920573475, 7718.807029824299, 7722.845543089219, 7460.77617671449, 7487.962560187164, 7507.0, 7517.586532740752, 7530.322270995636, 7997.960265165491, 8016.238457346542, 8016.839663206587, 8025.478343907861, 8039.959800200962, 4708.6468514860835, 4728.929066063943, 4732.171869922681, 4744.074905393415, 4748.905021899612, 7308.342249197598, 7616.867277162403, 7626.389888808771, 7640.656170472231, 7657.745458180362, 7288.194045292495, 7371.041764570571, 7372.59450730215, 7377.077865266841, 7406.888966655045, 7326.267373262845, 7339.486235963432, 7340.302671246223, 7349.669264882986, 7359.521631093961, 6854.6229957352825, 7180.60506672138, 7194.892076618959, 7206.351428371472, 7215.963920180366, 5964.970175149097, 6046.5767396281835, 7348.338649521569, 7385.7045718170675, 7387.0, 7194.6042967635185, 7195.388391986739, 7200.71197152108, 7204.639768011473, 7223.313785190398], "unit": "score", "name": "prototype.html", "value": 5242.366148878841}, {"lowerIsBetter": false, "replicates": [652.960822350659, 704.2710794327871, 710.1868360726968, 716.1227496317013, 757.9956557561226, 13744.312784360767, 14531.70936581269, 14675.779863302045, 14822.332995015224, 16525.752113718303, 12681.682957926056, 15146.394144234246, 15393.153376564313, 15403.768943465857, 15445.536633901002, 844.4131328726522, 871.4988881393224, 871.5032431514039, 873.1792115411524, 874.396666300254, 853.4665833853842, 854.1927878155115, 854.4659587757651, 860.6686425726109, 870.8867847179857, 874.5627186406797, 878.4026861734018, 883.3419102768446, 889.0442774017924, 889.1730690457872, 873.6942070275417, 879.885614870066, 885.5926273914007, 889.4040992535017, 891.7235656946367, 649.7693318871827, 653.5425202358321, 656.5961933410965, 658.5225711359226, 660.6465540935576, 14419.279036048261, 14468.0, 14517.78223326651, 14555.345009474599, 14798.778018329735, 10591.0, 12154.33151176685, 12321.445534950948, 12476.688082797911, 12552.184108032949, 9889.056157557168, 10070.0, 10120.696379108565, 10407.167426605853, 10770.461476926122, 3393.9321213575836, 3428.297199074209, 3450.723942084627, 3464.9307013859834, 3538.3630946429635, 77208.0, 77870.0, 77903.2209677896, 77961.61019194925, 78000.60999695022, 9107.81784364309, 9138.406003609743, 9259.120383563552, 9274.44353338802, 9287.071292870658, 20506.89746551258, 20583.176672933216, 20716.378508644764, 20775.168993240404, 20779.0, 7227.7831665050135, 7258.274172582699, 7356.227596102439, 7508.211637778064, 7694.846103077907, 4016.638502534786, 4118.5057793065025, 4139.710220284612, 4142.212979533939, 4263.488381394252, 3506.7545271831236, 3511.7892926423983, 3539.0975301298004, 3547.9888231853797, 3550.6626870447267, 559.6697948210575, 577.3966205315455, 580.9070548712185, 653.7058323754329, 692.2731132311154, 567.1945836911596, 584.1442287049493, 629.8267976306461, 630.0832289019465, 633.5375176121457, 7689.9615501922135, 7943.324817390471, 8151.796205094802, 8495.787605309793, 8668.523231222343, 495.17306098815067, 560.1905246918245, 591.7248329849182, 596.7105953612495, 610.5085406247924, 3989.9202015959518, 4013.4983127109113, 4176.0, 4303.892402689895, 4379.277419225792, 88313.55843220743, 89049.0, 89574.55212724025, 90312.5484372574, 97168.14159292007, 76377.0, 77912.0, 79952.60023699845, 80205.59897200477, 81494.0, 66150.66924665442, 66552.66894662079, 66661.33362665003, 66828.6658566704, 66979.66510167516, 7847.744360902228, 8120.512769233865, 8480.15198480147, 8539.82920341602, 8735.868961965449, 35408.64591354054, 37459.62540374562, 39113.8044309788, 48230.0, 49017.754911225216, 50504.0, 53892.46107538875, 54625.45374546362, 56134.0, 56536.586585335695, 10775.353478791298, 11264.605738799102, 11566.537338506365, 11580.131490138441, 12131.878681213428, 11915.761684766083, 12059.81910271329, 12103.213291136048, 12461.813072803734, 12519.0, 10965.671029869116, 11312.83030754523, 11362.602308919479, 11478.368689722145, 11642.476088575864, 11452.14108941816, 11488.368139752394, 11606.419679015846, 11625.6512304631, 11718.003969662674, 9370.765730856783, 10799.244052916221, 11085.224034317844, 11673.591424300108, 12246.265224086583, 8860.202581767415, 8884.0, 9075.682351117679, 9376.203022743142, 9504.904950950402, 9324.0, 9739.464329461947, 9769.853452198366, 9874.753131171778, 10036.19710423179], "unit": "score", "name": "yui.html", "value": 6749.5890799888475}], "name": "dromaeo_css", "value": 7443.639901020705}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 115.0, 101.0, 170.0, 174.0, 134.0, 121.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 126.6}, {"lowerIsBetter": true, "replicates": [162.0, 127.0, 145.0, 151.0, 125.0, 139.0, 163.0, 152.0, 159.0, 148.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [213.0, 196.0, 197.0, 217.0, 218.0, 194.0, 196.0, 195.0, 202.0, 202.0], "unit": "score", "name": "audio-dft", "value": 203.0}, {"lowerIsBetter": true, "replicates": [75.0, 69.0, 72.0, 110.0, 58.0, 58.0, 59.0, 62.0, 122.0, 58.0], "unit": "score", "name": "audio-fft", "value": 74.3}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 130.0, 80.0, 79.0, 81.0, 121.0, 70.0, 87.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 96.2}, {"lowerIsBetter": true, "replicates": [122.0, 95.0, 88.0, 94.0, 88.0, 94.0, 108.0, 138.0, 86.0, 137.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 105.0}, {"lowerIsBetter": true, "replicates": [142.0, 120.0, 126.0, 100.0, 149.0, 151.0, 103.0, 148.0, 150.0, 108.0], "unit": "score", "name": "imaging-darkroom", "value": 129.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 92.0, 92.0, 92.0, 93.0, 91.0, 94.0, 92.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 92.6}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 56.0, 57.0, 56.0, 55.0, 56.0, 75.0, 73.0, 83.0], "unit": "score", "name": "json-parse-financial", "value": 62.3}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 83.0, 90.0, 106.0, 71.0, 67.0, 64.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 74.3}, {"lowerIsBetter": true, "replicates": [99.0, 112.0, 78.0, 108.0, 108.0, 110.0, 111.0, 95.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 99.6}, {"lowerIsBetter": true, "replicates": [129.0, 130.0, 139.0, 119.0, 126.0, 134.0, 123.0, 129.0, 131.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.2}, {"lowerIsBetter": true, "replicates": [167.0, 162.0, 140.0, 139.0, 137.0, 131.0, 138.0, 141.0, 143.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 66.0, 69.0, 67.0, 68.0, 65.0, 70.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1553.0}]} 08:27:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1553.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7443.64"}}} 08:27:42 INFO - Return code: 0 08:27:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:27:42 ERROR - # TBPL SUCCESS # 08:27:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:27:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:27:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:27:42 INFO - 2016-02-24 08:27:42.074 screenresolution[1696:10399] starting screenresolution argv=screenresolution get 08:27:42 INFO - 2016-02-24 08:27:42.077 screenresolution[1696:10399] Display 0: 1600x1200x32@60 08:27:42 INFO - 2016-02-24 08:27:42.083 screenresolution[1697:10402] starting screenresolution argv=screenresolution list 08:27:42 INFO - Available Modes on Display 0 08:27:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:27:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:27:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:27:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:27:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:27:42 INFO - Intel Iris: 08:27:42 INFO - Chipset Model: Intel Iris 08:27:42 INFO - Type: GPU 08:27:42 INFO - Bus: Built-In 08:27:42 INFO - VRAM (Dynamic, Max): 1536 MB 08:27:42 INFO - Vendor: Intel (0x8086) 08:27:42 INFO - Device ID: 0x0a2e 08:27:42 INFO - Revision ID: 0x0009 08:27:42 INFO - Displays: 08:27:42 INFO - Display: 08:27:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:27:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:27:42 INFO - Display Serial Number: 1600x1200 60 08:27:42 INFO - Main Display: Yes 08:27:42 INFO - Mirror: Off 08:27:42 INFO - Online: Yes 08:27:42 INFO - Rotation: Supported 08:27:42 INFO - Return code: 0 08:27:42 INFO - Running post-action listener: _resource_record_post_action 08:27:42 INFO - Running post-run listener: _resource_record_post_run 08:27:43 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 33992192; Write bytes: 712086016; Read time: 352; Write time: 1999 08:27:43 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389126656; Write bytes: 382776832; Read time: 30054; Write time: 687 08:27:43 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 33062400; Write bytes: 306002944; Read time: 338; Write time: 1261 08:27:43 INFO - Running post-run listener: _upload_blobber_files 08:27:43 INFO - Blob upload gear active. 08:27:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:27:43 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 08:27:43 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'] 08:27:43 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 08:27:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:27:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:27:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:27:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:44 INFO - (blobuploader) - INFO - Done attempting. 08:27:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:27:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:27:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:45 INFO - (blobuploader) - INFO - Done attempting. 08:27:45 INFO - (blobuploader) - INFO - Iteration through files over. 08:27:45 INFO - Return code: 0 08:27:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:27:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:27:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e809e9334a0c7d0387b49430e997ca1751c7a333e726efcc712d6f7c083670a77f447c54f004331d1b00f409fc5b2d41efb80728b40dcb2bfcd7b5bbcb03aa2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0d8af276d4d8a803e291d2fafbc68e547648c72b30e5afd62c9eb59cee050481c0fab17158c91cc9f5418b6f069b5a2709eb3edb33bbf41671a96488b836b8e"} 08:27:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:27:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:27:45 INFO - Contents: 08:27:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e809e9334a0c7d0387b49430e997ca1751c7a333e726efcc712d6f7c083670a77f447c54f004331d1b00f409fc5b2d41efb80728b40dcb2bfcd7b5bbcb03aa2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0d8af276d4d8a803e291d2fafbc68e547648c72b30e5afd62c9eb59cee050481c0fab17158c91cc9f5418b6f069b5a2709eb3edb33bbf41671a96488b836b8e"} 08:27:45 INFO - Running post-run listener: copy_logs_to_upload_dir 08:27:45 INFO - Copying logs to upload dir... 08:27:45 INFO - mkdir: /builds/slave/test/build/upload/logs 08:27:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.971586 ========= master_lag: 2.72 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-02-24 08:27:48.567484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 08:27:48.571216) ========= 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.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e809e9334a0c7d0387b49430e997ca1751c7a333e726efcc712d6f7c083670a77f447c54f004331d1b00f409fc5b2d41efb80728b40dcb2bfcd7b5bbcb03aa2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0d8af276d4d8a803e291d2fafbc68e547648c72b30e5afd62c9eb59cee050481c0fab17158c91cc9f5418b6f069b5a2709eb3edb33bbf41671a96488b836b8e"} build_url:https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011460 build_url: 'https://queue.taskcluster.net/v1/task/SbHI6XNbQ-aJvdhezRAmDw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e809e9334a0c7d0387b49430e997ca1751c7a333e726efcc712d6f7c083670a77f447c54f004331d1b00f409fc5b2d41efb80728b40dcb2bfcd7b5bbcb03aa2a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0d8af276d4d8a803e291d2fafbc68e547648c72b30e5afd62c9eb59cee050481c0fab17158c91cc9f5418b6f069b5a2709eb3edb33bbf41671a96488b836b8e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 08:27:48.609758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 08:27:48.610089) ========= 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.00be3Dkpde/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.xnulpItoBR/Listeners TMPDIR=/var/folders/3x/thk4_hjj2mv64h_wz8cbb_1h00000w/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.005162 ========= master_lag: 1.83 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 08:27:50.443083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 08:27:50.443358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 08:27:50.449581) ========= ========= Total master_lag: 7.43 =========