builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0142 starttime: 1459535977.15 results: success (0) buildid: 20160401093655 builduid: 21590504ad88410eb9bfcc03b62d18a7 revision: 320b39130851d20d0f4dd654e1b6f8f322c686fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.154811) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.155231) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.155520) ========= 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.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005588 basedir: '/builds/slave/test' ========= master_lag: 0.11 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.267400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.267714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.309038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.309367) ========= 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.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005414 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.358543) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.361866) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.362219) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.362492) ========= 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.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-04-01 11:39:37-- 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% 16.5M=0.001s 2016-04-01 11:39:37 (16.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.557295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.557632) ========= 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.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.035036 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:37.611938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 11:39:37.612305) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 320b39130851d20d0f4dd654e1b6f8f322c686fb --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 320b39130851d20d0f4dd654e1b6f8f322c686fb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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-04-01 11:39:37,691 truncating revision to first 12 chars 2016-04-01 11:39:37,691 Setting DEBUG logging. 2016-04-01 11:39:37,691 attempt 1/10 2016-04-01 11:39:37,691 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/320b39130851?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 11:39:38,858 unpacking tar archive at: fx-team-320b39130851/testing/mozharness/ program finished with exit code 0 elapsedTime=1.415223 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 11:39:39.045583) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:39.046192) ========= echo 320b39130851d20d0f4dd654e1b6f8f322c686fb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'320b39130851d20d0f4dd654e1b6f8f322c686fb'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 320b39130851d20d0f4dd654e1b6f8f322c686fb program finished with exit code 0 elapsedTime=0.005712 script_repo_revision: '320b39130851d20d0f4dd654e1b6f8f322c686fb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:39.097323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:39.098046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 11:39:39.113193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-01 11:39:39.113460) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:39:39 INFO - MultiFileLogger online at 20160401 11:39:39 in /builds/slave/test 11:39:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:39:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:39:39 INFO - {'append_to_log': False, 11:39:39 INFO - 'base_work_dir': '/builds/slave/test', 11:39:39 INFO - 'blob_upload_branch': 'Fx-Team', 11:39:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:39:39 INFO - 'branch': 'Fx-Team', 11:39:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:39:39 INFO - 'config_files': ('talos/mac_config.py',), 11:39:39 INFO - 'default_actions': ('clobber', 11:39:39 INFO - 'read-buildbot-config', 11:39:39 INFO - 'download-and-extract', 11:39:39 INFO - 'populate-webroot', 11:39:39 INFO - 'create-virtualenv', 11:39:39 INFO - 'install', 11:39:39 INFO - 'run-tests'), 11:39:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:39:39 INFO - 'download_minidump_stackwalk': True, 11:39:39 INFO - 'download_symbols': 'ondemand', 11:39:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:39:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:39:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:39:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:39:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:39:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:39:39 INFO - 'installer_path': 'installer.exe', 11:39:39 INFO - 'log_level': 'info', 11:39:39 INFO - 'log_name': 'talos', 11:39:39 INFO - 'log_to_console': True, 11:39:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:39:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:39:39 INFO - 'opt_config_files': (), 11:39:39 INFO - 'pip_index': False, 11:39:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:39:39 INFO - 'cmd': ('bash', 11:39:39 INFO - '-c', 11:39:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:39:39 INFO - 'enabled': True, 11:39:39 INFO - 'halt_on_failure': False, 11:39:39 INFO - 'name': 'check_screen_resolution'},), 11:39:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:39:39 INFO - 'cmd': ('bash', 11:39:39 INFO - '-c', 11:39:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:39:39 INFO - 'enabled': True, 11:39:39 INFO - 'halt_on_failure': False, 11:39:39 INFO - 'name': 'check_screen_resolution'},), 11:39:39 INFO - 'run_cmd_checks_enabled': True, 11:39:39 INFO - 'sps_profile': False, 11:39:39 INFO - 'sps_profile_interval': 0, 11:39:39 INFO - 'suite': 'dromaeojs', 11:39:39 INFO - 'system_bits': '32', 11:39:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:39:39 INFO - 'title': 't-yosemite-r7-0142', 11:39:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:39:39 INFO - 'use_talos_json': True, 11:39:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:39:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:39:39 INFO - 'work_dir': 'build'} 11:39:39 INFO - ##### 11:39:39 INFO - ##### Running clobber step. 11:39:39 INFO - ##### 11:39:39 INFO - Running pre-action listener: _resource_record_pre_action 11:39:39 INFO - Running main action method: clobber 11:39:39 INFO - rmtree: /builds/slave/test/build 11:39:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:39:40 INFO - Running post-action listener: _resource_record_post_action 11:39:40 INFO - ##### 11:39:40 INFO - ##### Running read-buildbot-config step. 11:39:40 INFO - ##### 11:39:40 INFO - Running pre-action listener: _resource_record_pre_action 11:39:40 INFO - Running main action method: read_buildbot_config 11:39:40 INFO - Using buildbot properties: 11:39:40 INFO - { 11:39:40 INFO - "project": "", 11:39:40 INFO - "product": "firefox", 11:39:40 INFO - "script_repo_revision": "production", 11:39:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:39:40 INFO - "repository": "", 11:39:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:39:40 INFO - "buildid": "20160401093655", 11:39:40 INFO - "pgo_build": "False", 11:39:40 INFO - "basedir": "/builds/slave/test", 11:39:40 INFO - "buildnumber": 596, 11:39:40 INFO - "slavename": "t-yosemite-r7-0142", 11:39:40 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:39:40 INFO - "platform": "yosemite_r7", 11:39:40 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:39:40 INFO - "branch": "fx-team", 11:39:40 INFO - "repo_path": "integration/fx-team", 11:39:40 INFO - "revision": "320b39130851d20d0f4dd654e1b6f8f322c686fb", 11:39:40 INFO - "stage_platform": "macosx64", 11:39:40 INFO - "builduid": "21590504ad88410eb9bfcc03b62d18a7", 11:39:40 INFO - "slavebuilddir": "test" 11:39:40 INFO - } 11:39:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:39:40 INFO - Running post-action listener: _resource_record_post_action 11:39:40 INFO - ##### 11:39:40 INFO - ##### Running download-and-extract step. 11:39:40 INFO - ##### 11:39:40 INFO - Running pre-action listener: _resource_record_pre_action 11:39:40 INFO - Running main action method: download_and_extract 11:39:40 INFO - mkdir: /builds/slave/test/build/tests 11:39: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')]} 11:39:40 INFO - https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:39:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:39:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:39:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:39:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 11:39:42 INFO - Downloaded 1199 bytes. 11:39:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:39:42 INFO - Using the following test package requirements: 11:39:42 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:39:42 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:39:42 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:39:42 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:39:42 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:39:42 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:39:42 INFO - u'jsshell-mac.zip'], 11:39:42 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:39:42 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:39:42 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:39:42 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:39:42 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:39:42 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:39:42 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:39:42 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:39:42 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:39:42 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:39:42 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:39:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:39:42 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')]} 11:39:42 INFO - https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:39:43 INFO - Downloaded 17956352 bytes. 11:39:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:39:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:39:46 INFO - Return code: 0 11:39:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:39:46 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')]} 11:39:46 INFO - https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:39:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:39:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:39:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:39:47 INFO - Downloaded 17956352 bytes. 11:39:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:39:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 11:39:51 INFO - Return code: 0 11:39:51 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')]} 11:39:51 INFO - https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:39:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:39:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:39:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:39:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:39:53 INFO - Downloaded 10847534 bytes. 11:39:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:39:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 11:39:53 INFO - Return code: 0 11:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:39:53 INFO - https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:39:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:39:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:39:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 11:39:56 INFO - Downloaded 111469440 bytes. 11:39:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:39:56 INFO - mkdir: /builds/slave/test/properties 11:39:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:56 INFO - Contents: 11:39:56 INFO - build_url:https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:39:57 INFO - Running post-action listener: _resource_record_post_action 11:39:57 INFO - Running post-action listener: set_extra_try_arguments 11:39:57 INFO - ##### 11:39:57 INFO - ##### Running populate-webroot step. 11:39:57 INFO - ##### 11:39:57 INFO - Running pre-action listener: _resource_record_pre_action 11:39:57 INFO - Running main action method: populate_webroot 11:39:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:39:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:39:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:39:57 INFO - '--tppagecycles', 11:39:57 INFO - '7'], 11:39:57 INFO - 'tests': ['tsvgm']}}, 11:39:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:39:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:39:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:39:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:39:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:57 INFO - 'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:57 INFO - 'tests': ['damp', 'tps']}, 11:39:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:57 INFO - 'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['damp', 'tps']}, 11:39:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:39:57 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['dromaeo_dom']}, 11:39:57 INFO - 'other': {'tests': ['a11yr', 11:39:57 INFO - 'ts_paint', 11:39:57 INFO - 'tpaint', 11:39:57 INFO - 'sessionrestore', 11:39:57 INFO - 'sessionrestore_no_auto_restore', 11:39:57 INFO - 'tabpaint']}, 11:39:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['a11yr', 11:39:57 INFO - 'ts_paint', 11:39:57 INFO - 'tpaint', 11:39:57 INFO - 'sessionrestore', 11:39:57 INFO - 'sessionrestore_no_auto_restore', 11:39:57 INFO - 'tabpaint']}, 11:39:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['a11yr', 11:39:57 INFO - 'ts_paint', 11:39:57 INFO - 'tpaint', 11:39:57 INFO - 'sessionrestore', 11:39:57 INFO - 'sessionrestore_no_auto_restore', 11:39:57 INFO - 'tabpaint']}, 11:39:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['a11yr', 11:39:57 INFO - 'ts_paint', 11:39:57 INFO - 'tpaint', 11:39:57 INFO - 'sessionrestore', 11:39:57 INFO - 'sessionrestore_no_auto_restore', 11:39:57 INFO - 'tabpaint']}, 11:39:57 INFO - 'other_l64': {'tests': ['a11yr', 11:39:57 INFO - 'ts_paint', 11:39:57 INFO - 'tpaint', 11:39:57 INFO - 'sessionrestore', 11:39:57 INFO - 'sessionrestore_no_auto_restore', 11:39:57 INFO - 'tabpaint']}, 11:39:57 INFO - 'other_nol64': {'tests': ['a11yr', 11:39:57 INFO - 'ts_paint', 11:39:57 INFO - 'tpaint', 11:39:57 INFO - 'sessionrestore', 11:39:57 INFO - 'sessionrestore_no_auto_restore', 11:39:57 INFO - 'tabpaint']}, 11:39:57 INFO - 'svgr': {'tests': ['tsvgx', 11:39:57 INFO - 'tsvgr_opacity', 11:39:57 INFO - 'tart', 11:39:57 INFO - 'tscrollx', 11:39:57 INFO - 'cart']}, 11:39:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['tsvgx', 11:39:57 INFO - 'tsvgr_opacity', 11:39:57 INFO - 'tart', 11:39:57 INFO - 'tscrollx', 11:39:57 INFO - 'cart']}, 11:39:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:57 INFO - 'tests': ['tp5o']}, 11:39:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:57 INFO - 'talos_options': ['--e10s'], 11:39:57 INFO - 'tests': ['tp5o']}, 11:39:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:57 INFO - 'talos_options': ['--xperf_path', 11:39:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:57 INFO - 'tests': ['tp5n']}, 11:39:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:57 INFO - 'talos_options': ['--e10s', 11:39:57 INFO - '--xperf_path', 11:39:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:57 INFO - 'tests': ['tp5n']}}, 11:39:57 INFO - 'talos.zip': {'path': '', 11:39:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:39:57 INFO - Running post-action listener: _resource_record_post_action 11:39:57 INFO - ##### 11:39:57 INFO - ##### Running create-virtualenv step. 11:39:57 INFO - ##### 11:39:57 INFO - Running pre-action listener: _resource_record_pre_action 11:39:57 INFO - Running main action method: create_virtualenv 11:39:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39:57 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 11:39:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:39:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:57 INFO - Using real prefix '/tools/python27' 11:39:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:40:01 INFO - Installing pip.................done. 11:40:01 INFO - Return code: 0 11:40:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:40:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:01 INFO - 'HOME': '/Users/cltbld', 11:40:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:01 INFO - 'LOGNAME': 'cltbld', 11:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:01 INFO - 'MOZ_NO_REMOTE': '1', 11:40:01 INFO - 'NO_EM_RESTART': '1', 11:40:01 INFO - 'PAGER': '/bin/cat', 11:40:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:01 INFO - 'PWD': '/builds/slave/test', 11:40:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:01 INFO - 'SHELL': '/bin/bash', 11:40:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:01 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:01 INFO - 'USER': 'cltbld', 11:40:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:01 INFO - 'XPC_FLAGS': '0x0', 11:40:01 INFO - 'XPC_SERVICE_NAME': '0', 11:40:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:01 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 11:40:01 INFO - Cleaning up... 11:40:01 INFO - Return code: 0 11:40:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:40:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:40:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:01 INFO - 'HOME': '/Users/cltbld', 11:40:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:01 INFO - 'LOGNAME': 'cltbld', 11:40:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:01 INFO - 'MOZ_NO_REMOTE': '1', 11:40:01 INFO - 'NO_EM_RESTART': '1', 11:40:01 INFO - 'PAGER': '/bin/cat', 11:40:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:01 INFO - 'PWD': '/builds/slave/test', 11:40:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:01 INFO - 'SHELL': '/bin/bash', 11:40:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:01 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:01 INFO - 'USER': 'cltbld', 11:40:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:01 INFO - 'XPC_FLAGS': '0x0', 11:40:01 INFO - 'XPC_SERVICE_NAME': '0', 11:40:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:01 INFO - Downloading/unpacking psutil>=0.7.1 11:40:01 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 11:40:01 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 11:40:01 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 11:40:01 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 11:40:01 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 11:40:01 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 11:40:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:40:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:04 INFO - Installing collected packages: psutil 11:40:04 INFO - Running setup.py install for psutil 11:40:04 INFO - building 'psutil._psutil_osx' extension 11:40:04 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 11:40:05 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 11:40:05 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 11:40:05 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 11:40:05 INFO - building 'psutil._psutil_posix' extension 11:40:05 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 11:40:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:40:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:40:05 INFO - ^ 11:40:05 INFO - 1 warning generated. 11:40:05 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 11:40:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:40:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:40:05 INFO - Successfully installed psutil 11:40:05 INFO - Cleaning up... 11:40:05 INFO - Return code: 0 11:40:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:40:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:05 INFO - 'HOME': '/Users/cltbld', 11:40:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:05 INFO - 'LOGNAME': 'cltbld', 11:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:05 INFO - 'MOZ_NO_REMOTE': '1', 11:40:05 INFO - 'NO_EM_RESTART': '1', 11:40:05 INFO - 'PAGER': '/bin/cat', 11:40:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:05 INFO - 'PWD': '/builds/slave/test', 11:40:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:05 INFO - 'SHELL': '/bin/bash', 11:40:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:05 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:05 INFO - 'USER': 'cltbld', 11:40:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:05 INFO - 'XPC_FLAGS': '0x0', 11:40:05 INFO - 'XPC_SERVICE_NAME': '0', 11:40:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:40:06 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 11:40:06 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 11:40:06 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 11:40:06 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 11:40:06 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 11:40:06 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 11:40:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:40:08 INFO - Installing collected packages: mozsystemmonitor 11:40:08 INFO - Running setup.py install for mozsystemmonitor 11:40:08 INFO - Successfully installed mozsystemmonitor 11:40:08 INFO - Cleaning up... 11:40:08 INFO - Return code: 0 11:40:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:40:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:08 INFO - 'HOME': '/Users/cltbld', 11:40:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:08 INFO - 'LOGNAME': 'cltbld', 11:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:08 INFO - 'MOZ_NO_REMOTE': '1', 11:40:08 INFO - 'NO_EM_RESTART': '1', 11:40:08 INFO - 'PAGER': '/bin/cat', 11:40:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:08 INFO - 'PWD': '/builds/slave/test', 11:40:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:08 INFO - 'SHELL': '/bin/bash', 11:40:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:08 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:08 INFO - 'USER': 'cltbld', 11:40:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:08 INFO - 'XPC_FLAGS': '0x0', 11:40:08 INFO - 'XPC_SERVICE_NAME': '0', 11:40:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:09 INFO - Downloading/unpacking blobuploader==1.2.4 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40:11 INFO - Downloading blobuploader-1.2.4.tar.gz 11:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:40:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:40:11 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 11:40:11 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 11:40:11 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 11:40:11 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 11:40:11 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 11:40:11 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 11:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:40:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40:12 INFO - Downloading docopt-0.6.1.tar.gz 11:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:40:12 INFO - Installing collected packages: blobuploader, requests, docopt 11:40:12 INFO - Running setup.py install for blobuploader 11:40:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:40:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:40:12 INFO - Running setup.py install for requests 11:40:13 INFO - Running setup.py install for docopt 11:40:13 INFO - Successfully installed blobuploader requests docopt 11:40:13 INFO - Cleaning up... 11:40:13 INFO - Return code: 0 11:40:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:13 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')]} 11:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:14 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')]} 11:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:14 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 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40:14 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 11:40:14 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 11:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:14 INFO - 'HOME': '/Users/cltbld', 11:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:14 INFO - 'LOGNAME': 'cltbld', 11:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:14 INFO - 'MOZ_NO_REMOTE': '1', 11:40:14 INFO - 'NO_EM_RESTART': '1', 11:40:14 INFO - 'PAGER': '/bin/cat', 11:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:14 INFO - 'PWD': '/builds/slave/test', 11:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:14 INFO - 'SHELL': '/bin/bash', 11:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:14 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:14 INFO - 'USER': 'cltbld', 11:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:14 INFO - 'XPC_FLAGS': '0x0', 11:40:14 INFO - 'XPC_SERVICE_NAME': '0', 11:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-6gcWTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-JLZwQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:14 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-XRABjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-YGqOwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-x2mIYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-GxCVqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Qk7gUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-jp4gpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-u_ST3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-1aU9cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-IDFgFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-IrRwPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:15 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-o5HczZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-luBd6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-3EeJr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-TQLDpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:16 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-kzvVFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:16 INFO - Running setup.py install for manifestparser 11:40:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:40:16 INFO - Running setup.py install for mozcrash 11:40:16 INFO - Running setup.py install for mozdebug 11:40:16 INFO - Running setup.py install for mozdevice 11:40:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Running setup.py install for mozfile 11:40:17 INFO - Running setup.py install for mozhttpd 11:40:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Running setup.py install for mozinfo 11:40:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Running setup.py install for mozInstall 11:40:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Running setup.py install for mozleak 11:40:17 INFO - Running setup.py install for mozlog 11:40:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:40:17 INFO - Running setup.py install for moznetwork 11:40:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:40:18 INFO - Running setup.py install for mozprocess 11:40:18 INFO - Running setup.py install for mozprofile 11:40:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:40:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:40:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:40:18 INFO - Running setup.py install for mozrunner 11:40:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:40:18 INFO - Running setup.py install for mozscreenshot 11:40:18 INFO - Running setup.py install for moztest 11:40:18 INFO - Running setup.py install for mozversion 11:40:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:40:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:40:19 INFO - Cleaning up... 11:40:19 INFO - Return code: 0 11:40:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:19 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 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40:19 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 11:40:19 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 11:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:19 INFO - 'HOME': '/Users/cltbld', 11:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:19 INFO - 'LOGNAME': 'cltbld', 11:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:19 INFO - 'MOZ_NO_REMOTE': '1', 11:40:19 INFO - 'NO_EM_RESTART': '1', 11:40:19 INFO - 'PAGER': '/bin/cat', 11:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:19 INFO - 'PWD': '/builds/slave/test', 11:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:19 INFO - 'SHELL': '/bin/bash', 11:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:19 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:19 INFO - 'USER': 'cltbld', 11:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:19 INFO - 'XPC_FLAGS': '0x0', 11:40:19 INFO - 'XPC_SERVICE_NAME': '0', 11:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:19 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-J77bQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:19 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)) 11:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:19 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Xknaxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:19 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-7i00iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:19 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)) 11:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:19 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-oZM9o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:19 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)) 11:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:19 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-pARVW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:19 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)) 11:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:19 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-EE8768-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:19 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)) 11:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:19 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-o_rlXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-EwXCtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-mgQZbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Juc4wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-GUZDeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-_QIm6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-TdyFZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-XtLq4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-acnaCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:20 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)) 11:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:20 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-BbLuSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:21 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)) 11:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:21 INFO - Running setup.py (path:/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/pip-Qz0lE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:21 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)) 11:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:40:21 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)) 11:40:21 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)) 11:40:21 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)) 11:40:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:40:21 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 11:40:21 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 11:40:21 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 11:40:21 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 11:40:21 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 11:40:21 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 11:40:23 INFO - Downloading blessings-1.6.tar.gz 11:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:40:23 INFO - Installing collected packages: blessings 11:40:23 INFO - Running setup.py install for blessings 11:40:23 INFO - Successfully installed blessings 11:40:23 INFO - Cleaning up... 11:40:23 INFO - Return code: 0 11:40:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:24 INFO - Reading from file tmpfile_stdout 11:40:24 INFO - Current package versions: 11:40:24 INFO - blessings == 1.6 11:40:24 INFO - blobuploader == 1.2.4 11:40:24 INFO - docopt == 0.6.1 11:40:24 INFO - manifestparser == 1.1 11:40:24 INFO - mozInstall == 1.12 11:40:24 INFO - mozcrash == 0.17 11:40:24 INFO - mozdebug == 0.1 11:40:24 INFO - mozdevice == 0.48 11:40:24 INFO - mozfile == 1.2 11:40:24 INFO - mozhttpd == 0.7 11:40:24 INFO - mozinfo == 0.9 11:40:24 INFO - mozleak == 0.1 11:40:24 INFO - mozlog == 3.1 11:40:24 INFO - moznetwork == 0.27 11:40:24 INFO - mozprocess == 0.22 11:40:24 INFO - mozprofile == 0.28 11:40:24 INFO - mozrunner == 6.11 11:40:24 INFO - mozscreenshot == 0.1 11:40:24 INFO - mozsystemmonitor == 0.0 11:40:24 INFO - moztest == 0.7 11:40:24 INFO - mozversion == 1.4 11:40:24 INFO - psutil == 3.1.1 11:40:24 INFO - requests == 1.2.3 11:40:24 INFO - wsgiref == 0.1.2 11:40:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:24 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 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40:24 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 11:40:24 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 11:40:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:24 INFO - 'HOME': '/Users/cltbld', 11:40:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:24 INFO - 'LOGNAME': 'cltbld', 11:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:24 INFO - 'MOZ_NO_REMOTE': '1', 11:40:24 INFO - 'NO_EM_RESTART': '1', 11:40:24 INFO - 'PAGER': '/bin/cat', 11:40:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:24 INFO - 'PWD': '/builds/slave/test', 11:40:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:24 INFO - 'SHELL': '/bin/bash', 11:40:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:24 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:24 INFO - 'USER': 'cltbld', 11:40:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:24 INFO - 'XPC_FLAGS': '0x0', 11:40:24 INFO - 'XPC_SERVICE_NAME': '0', 11:40:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 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)) 11:40:24 INFO - Cleaning up... 11:40:24 INFO - Return code: 0 11:40:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40:24 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 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40:24 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 11:40:24 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 11:40:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:24 INFO - 'HOME': '/Users/cltbld', 11:40:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:24 INFO - 'LOGNAME': 'cltbld', 11:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:24 INFO - 'MOZ_NO_REMOTE': '1', 11:40:24 INFO - 'NO_EM_RESTART': '1', 11:40:24 INFO - 'PAGER': '/bin/cat', 11:40:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:24 INFO - 'PWD': '/builds/slave/test', 11:40:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:24 INFO - 'SHELL': '/bin/bash', 11:40:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:24 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:24 INFO - 'USER': 'cltbld', 11:40:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:24 INFO - 'XPC_FLAGS': '0x0', 11:40:24 INFO - 'XPC_SERVICE_NAME': '0', 11:40:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:24 INFO - Downloading/unpacking jsonschema 11:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:40:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:40:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:40:27 INFO - Downloading/unpacking functools32 (from jsonschema) 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:40:27 INFO - warning: no files found matching '*.txt' 11:40:27 INFO - no previously-included directories found matching 'build' 11:40:27 INFO - no previously-included directories found matching 'dist' 11:40:27 INFO - no previously-included directories found matching '.git*' 11:40:27 INFO - Installing collected packages: jsonschema, functools32 11:40:27 INFO - Running setup.py install for functools32 11:40:27 INFO - warning: no files found matching '*.txt' 11:40:27 INFO - no previously-included directories found matching 'build' 11:40:27 INFO - no previously-included directories found matching 'dist' 11:40:27 INFO - no previously-included directories found matching '.git*' 11:40:27 INFO - Successfully installed jsonschema functools32 11:40:27 INFO - Cleaning up... 11:40:27 INFO - Return code: 0 11:40:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:40: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')]} 11:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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')]} 11:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf39a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf49420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2eb5d9c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, '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.r0Plnmb85F/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.DtMjpedIIX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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 11:40: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', 'flake8'] in /builds/slave/test/build 11:40: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 flake8 11:40:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:40:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:27 INFO - 'HOME': '/Users/cltbld', 11:40:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:27 INFO - 'LOGNAME': 'cltbld', 11:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:27 INFO - 'MOZ_NO_REMOTE': '1', 11:40:27 INFO - 'NO_EM_RESTART': '1', 11:40:27 INFO - 'PAGER': '/bin/cat', 11:40:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:27 INFO - 'PWD': '/builds/slave/test', 11:40:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:27 INFO - 'SHELL': '/bin/bash', 11:40:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:40:27 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:40:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:27 INFO - 'USER': 'cltbld', 11:40:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:27 INFO - 'XPC_FLAGS': '0x0', 11:40:27 INFO - 'XPC_SERVICE_NAME': '0', 11:40:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:28 INFO - Downloading/unpacking flake8 11:40:28 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 11:40:28 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 11:40:28 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 11:40:28 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 11:40:28 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 11:40:28 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 11:40:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:40:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:40:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 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 11:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:40:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:40:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:40:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:40:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:40:31 INFO - no previously-included directories found matching 'docs/_build' 11:40:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:40:32 INFO - Running setup.py install for pep8 11:40:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:40:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:40:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:40:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:40:32 INFO - no previously-included directories found matching 'docs/_build' 11:40:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:40:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:40:32 INFO - Cleaning up... 11:40:32 INFO - Return code: 0 11:40:32 INFO - Running post-action listener: _resource_record_post_action 11:40:32 INFO - Running post-action listener: _start_resource_monitoring 11:40:32 INFO - Starting resource monitoring. 11:40:32 INFO - ##### 11:40:32 INFO - ##### Running install step. 11:40:32 INFO - ##### 11:40:32 INFO - Running pre-action listener: _resource_record_pre_action 11:40:32 INFO - Running main action method: install 11:40:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:32 INFO - Reading from file tmpfile_stdout 11:40:32 INFO - Detecting whether we're running mozinstall >=1.0... 11:40:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:40:32 INFO - Reading from file tmpfile_stdout 11:40:32 INFO - Output received: 11:40:32 INFO - Usage: mozinstall [options] installer 11:40:32 INFO - Options: 11:40:32 INFO - -h, --help show this help message and exit 11:40:32 INFO - -d DEST, --destination=DEST 11:40:32 INFO - Directory to install application into. [default: 11:40:32 INFO - "/builds/slave/test"] 11:40:32 INFO - --app=APP Application being installed. [default: firefox] 11:40:32 INFO - mkdir: /builds/slave/test/build/application 11:40:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:41:06 INFO - Reading from file tmpfile_stdout 11:41:06 INFO - Output received: 11:41:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:41:06 INFO - Running post-action listener: _resource_record_post_action 11:41:06 INFO - ##### 11:41:06 INFO - ##### Running run-tests step. 11:41:06 INFO - ##### 11:41:06 INFO - Running pre-action listener: _resource_record_pre_action 11:41:06 INFO - Running main action method: run_tests 11:41:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:41:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:41:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:41:06 INFO - 2016-04-01 11:41:06.587 screenresolution[1645:7661] starting screenresolution argv=screenresolution get 11:41:06 INFO - 2016-04-01 11:41:06.590 screenresolution[1645:7661] Display 0: 1600x1200x32@60 11:41:06 INFO - 2016-04-01 11:41:06.596 screenresolution[1646:7663] starting screenresolution argv=screenresolution list 11:41:06 INFO - Available Modes on Display 0 11:41:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:41:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:41:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:41:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:41:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:41:06 INFO - Intel Iris: 11:41:06 INFO - Chipset Model: Intel Iris 11:41:06 INFO - Type: GPU 11:41:06 INFO - Bus: Built-In 11:41:06 INFO - VRAM (Dynamic, Max): 1536 MB 11:41:06 INFO - Vendor: Intel (0x8086) 11:41:06 INFO - Device ID: 0x0a2e 11:41:06 INFO - Revision ID: 0x0009 11:41:06 INFO - Displays: 11:41:06 INFO - Display: 11:41:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:41:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:41:06 INFO - Display Serial Number: 1600x1200 60 11:41:06 INFO - Main Display: Yes 11:41:06 INFO - Mirror: Off 11:41:06 INFO - Online: Yes 11:41:06 INFO - Rotation: Supported 11:41:06 INFO - Return code: 0 11:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:41:06 INFO - Python 2.7.3 11:41:06 INFO - Return code: 0 11:41:06 INFO - grabbing minidump binary from tooltool 11:41:06 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')]} 11:41:06 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 0x10bdd8e00>, '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 0x10bc01db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bdd3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:41:06 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 11:41:06 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 11:41:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:41:06 INFO - Return code: 0 11:41:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:41:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:41:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:41:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:41:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:41:08 INFO - Return code: 0 11:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0142 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.r0Plnmb85F/Render', 11:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:08 INFO - 'HOME': '/Users/cltbld', 11:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:08 INFO - 'LOGNAME': 'cltbld', 11:41:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:41:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:08 INFO - 'MOZ_NO_REMOTE': '1', 11:41:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:41:08 INFO - 'NO_EM_RESTART': '1', 11:41:08 INFO - 'PAGER': '/bin/cat', 11:41:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:08 INFO - 'PWD': '/builds/slave/test', 11:41:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:08 INFO - 'SHELL': '/bin/bash', 11:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DtMjpedIIX/Listeners', 11:41:08 INFO - 'TMPDIR': '/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/', 11:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:08 INFO - 'USER': 'cltbld', 11:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:08 INFO - 'XPC_FLAGS': '0x0', 11:41:08 INFO - 'XPC_SERVICE_NAME': '0', 11:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0142', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:41:08 INFO - mozversion application_buildid: 20160401093655 11:41:08 INFO - mozversion application_changeset: 320b39130851d20d0f4dd654e1b6f8f322c686fb 11:41:08 INFO - mozversion application_display_name: Nightly 11:41:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:41:08 INFO - mozversion application_name: Firefox 11:41:08 INFO - mozversion application_remotingname: firefox 11:41:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:41:08 INFO - mozversion application_vendor: Mozilla 11:41:08 INFO - mozversion application_version: 48.0a1 11:41:08 INFO - mozversion platform_buildid: 20160401093655 11:41:08 INFO - mozversion platform_changeset: 320b39130851d20d0f4dd654e1b6f8f322c686fb 11:41:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:41:08 INFO - mozversion platform_version: 48.0a1 11:41:08 INFO - using testdate: 1459536068 11:41:08 INFO - actual date: 1459536068 11:41:08 INFO - starting webserver on 'localhost:49270' 11:41:08 INFO - SUITE-START | Running 2 tests 11:41:08 INFO - TEST-START | dromaeo_css 11:41:08 INFO - operating with platform_type : mac_ 11:41:08 INFO - Initialising browser for dromaeo_css test... 11:41:08 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpxyTi1r/profile http://localhost:49270/getInfo.html) 11:41:10 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 11:41:10 INFO - PROCESS | 1664 | colorDepth:24 11:41:10 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 11:41:10 INFO - PROCESS | 1664 | __metrics 11:41:10 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:41:10 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:41:11 INFO - TEST-INFO | 1664: exit 0 11:41:11 INFO - Browser initialized. 11:41:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:41:11 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpxyTi1r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:23 INFO - PROCESS | 1666 | RSS: Main: 236707840 11:41:23 INFO - PROCESS | 1666 | 11:42:14 INFO - PROCESS | 1666 | 1459536134856 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] 11:44:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 11:44:26 INFO - PROCESS | 1666 | RSS: Main: 401313792 11:44:26 INFO - PROCESS | 1666 | 11:47:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 11:47:29 INFO - PROCESS | 1666 | RSS: Main: 365707264 11:47:29 INFO - PROCESS | 1666 | 11:50:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 11:50:32 INFO - PROCESS | 1666 | RSS: Main: 368062464 11:50:32 INFO - PROCESS | 1666 | 11:53:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 11:53:34 INFO - PROCESS | 1666 | RSS: Main: 324599808 11:53:34 INFO - PROCESS | 1666 | 11:56:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 11:56:38 INFO - PROCESS | 1666 | RSS: Main: 327446528 11:56:38 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 11:59:41 INFO - PROCESS | 1666 | RSS: Main: 376573952 11:59:41 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | __start_tp_report 11:59:41 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 11:59:41 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 11:59:41 INFO - PROCESS | 1666 | |i|pagename|runs| 11:59:41 INFO - PROCESS | 1666 | |0;dojo.html;3451.3614981228475;3499.4077694648936;3512.3853325668;3537.0803591066333;3570.268095040517;5727.57043221758;5765.971170144154;5788.218590490283;5802.187693722877;5821.592488525805;5731.083026715726;5755.568332375067;5772.826815195541;5778.162166485857;5789.39211382805;5173.301604283421;5194.896102077956;5234.555062819665;5257.921131183035;5302.522772950434;5294.364676238857;5298.6555873868265;5300.178472336775;5304.177852432879;5305.336832895888;5205.349331333583;5229.215617657363;5263.552598029172;5270.736463176826;5294.5764338853;5281.8943621127555;5287.841364759063;5298.894022119536;5321.680699158024;5323.121684922022;4176.206520761046;5114.84655460333;5123.308353372285;5194.194899790501;5225.190095535198;5638.520725738317;5679.119736440858;5725.055365864628;5734.053881109612;5754.280714910637;6210.813675589739;6219.129321894939;6239.188905442309;6242.282137554149;6249.375062493759;6132.936844521186;6196.7831125910825;6200.844978875519;6243.500519958392;6255.6872156392;5894.528437725057;5900.940990590125;5947.851303717398;5953.047512397996;5955.868385006878;6271.404216599416;6279.591826531352;6286.245650521967;6292.244930608356;6293.118963345135;5272.420033796279;5984.251968503937;6135.1408007826785;6202.4417802398;6214;5277.762500687479;6193.783217587363;6235.625862448268;6240.594361366497;6266.843328916813;6138.508919286446;6202.658853763086;6249.343818899041;6271.686415679198;6281.968590157111;6213.161223234805;6276.184096067482;6285.9057114143325;6292.370762923762;6315.494760419156;3779.6976241900584;4935.679180853233;4952.851414457572;4959.380077490314;4984.975075124674;4373.9343909840745;4439.578240067253;4442.378067070613;4447.888802779892;4459.0413061192;5717.113847353667;5785.942140578541;5794.710264486759;5842.182094506772;5845.620034697731;6236.18929539157;6244.687765611701;6245.281792593819;6245.344238854946;6250.0937364082865;5676.290463692038;5780.508656764222;5782.768689252467;5828.475437210672;5837.29952405714;5351.759170837322;5398.1093119634825;5407.324084489439;5440.619156659075;5444.8094316698725;6329.525285603506;6348.619082855043;6353.078803573549;6369.20384951881;6375.139356187041;6153.046277826944;6180.443760061616;6190.690465476799;6242.063690446469;6249.062640603764;6253.37466253371;6337.176167098432;6346.7461301549265;6350.079238510482;6356.872862542631;6182.103594978793;6238.563300569098;6255.218097737783;6258.968705156445;6268.1851359323;4818.71087734737;6248.937510625017;6252.906206406817;6254.21822272216;6277.403646653561;6101.398774955092;6150.50795936333;6183.907241391293;6226.470749986121;6226.688665566794;6180.907286390618;6204.038374052029;6214.875702486015;6228.501719862309;6229.501639868709;5906;5995.064523657047;6080.513558915364;6090.786822461193;6091.756329746938;6087.208662873798;6087.2999605044215;6098.420650038239;6106.786700156709;6111.166351794699;5939.227900373096;6095;6126;6129.080637904171;6132.63204207749 11:59:41 INFO - PROCESS | 1666 | |1;ext.html;502.14133831148735;546.4508169289863;574.7672192761933;626.1265534579262;642.9292777794443;30139.945101921436;30553.694463055363;30664.233394165156;38064.23871522568;38433.65482208123;41362.793186034025;41861.95345116374;41933.7903310483;41976.58023419765;42125;9503.619855205801;9731.270154738388;9735.561899714494;9749.658761943334;9751.414915105117;9540.99819518951;9692.27307951903;9708.41749495029;9713.562889669982;9742.561584728704;9717.368371055894;9730.65942692006;9733.756656083584;9792.461414622192;9813.558389872473;9724.367916085432;9772.31593788435;9797.510124493747;9801.264905132144;9826.852597211084;9574.569144388519;9718.902810971871;9732.513374331254;9751.17115045222;9770.609175633037;39801.60198398008;40134;40139.595114170865;40315;40431;3221.2591104045964;3275.6396796352383;3278.32794277175;3302.4220761366664;3378.7803792753393;27862.5820612691;27906.02328918478;28218.012369567172;28472.288192795346;29143.68853401602;2680.892764289426;2741.300968253083;2756.421151558175;2779.194033730216;2842.488352096622;496639.0336096629;498028;503890;504541.4772926149;505196;43491.91270218207;44263;44296;44425.00087496071;61075;44596;44626.55373446224;44661.33008004883;44802.77598612051;44854.77572612116;15300;15485.922570387302;15501.922490387477;15513.301901414463;15518.068915865084;12516;12561.995040396747;12589.622311330675;12623.990080793514;12762.80855787164;11901.642950711319;14327.78508322376;14345.426182952773;14410;14534.418623255162;5339.7063161526485;5397.379301380313;6208.348123446973;6244.656543890039;6300.456388184924;875.7722992021993;934.5700977550267;974.6442548469757;1004.829179039565;1076.381080878498;30196.54705179424;30695.079147625605;30968.916087936814;31015.53476697806;31316.84341578323;922.9630814767335;1003.0922015575916;1017.31839667423;1025.8615086963164;1036.32638784789;12412.81380779289;12791.808122878165;13721.313934303245;14010.089344192595;14058.929705351407;657709;662461;665761;666732;671120;54392.91214175694;55948.72025639846;56128.43871561314;56187.87624247492;56218.71890640521;1356.938937747784;1369.1237607930932;1451.6588601678598;1472.4919902633787;1494.588988028301;27670.44659106847;27735.445291094467;27856.303592410353;28393.574096388984;28461.288467788472;44991.77504112459;45537;45609.859753506425;45651.086978259584;45816.312755308034;350853;361734;361935;361943;363271;27433.31416714518;31167.844160779052;31275.84362078175;32021.67978320187;32179;40337.59662403456;41034;42218.94452638586;42273.577264228195;42385.57614423816;33806.64773409135;34538.481922770676;34898;35182;35274.47088293729;33989.150271243416;34208.65791342154;34240;34891.127721806144;34908.82545587256;33497.16257093592;34414.13964650904;34617.48073778845;34618.65381346255;34879;30684;30803;30857;30942.53586196254;31013;23022;23335.066597335917;23504.94227759721;23692.52614947726;23907.521849563258 11:59:41 INFO - PROCESS | 1666 | |2;jquery.html;348.36075800905337;363.9326724555957;370.93137769512634;374.34302798588476;378.5703226837542;19480.805191948075;20157.899210503947;20446.182152713893;20823.167073317087;20906.05922733477;16647.00117992921;19291.74603650762;19649.017549122556;20269.290574829884;20272;5210.114280572302;5315.548178404841;5401.783928642869;5402.459754024605;5416.702081385522;3901.55132159801;4076.32740597801;5338.893222135555;5697.743601537941;5974.79088231912;4841.661083724141;5933.554983376264;5945.583809133363;5946.702664866761;5950.970245148768;5683.232763576926;5903.645781253117;5954.077118046666;5956.315023772257;5971.671558064305;5565.860853478655;5636.070048442043;5659.8585035374035;5661;5662.773489060432;16489.91755041229;24048;24932.252032439057;24933.875330623414;24962.126325578698;2044.2231951858348;2075.2217918280644;2114.418534902914;2228.9412529048736;2555.501677172952;9684.75788105296;9884.35751676146;10132.94933525335;12671.98624110069;13827.930860345634;1675.9162041897857;1700;1739.9130043497773;1750.571110078039;1788.204249109134;93620.53189734076;95186.52406737921;95800;97341.51329243308;98612.50693746557;11004.669859904216;11080.224384293184;11138.827928553854;11139.275947063416;11232.831507527393;13668.179909205479;13712.040157188902;13726.107802992774;13753.38109785062;13764.793528097087;8443.324534037261;8470.331845468658;8486.872696909551;8509.404341696145;8548.333075050305;6962.825929351807;8571.828563428697;8597.4919013455;8708.477491350539;8727.519986400808;3649.361361761681;4355.477342718894;4375.256206444912;4420.889477763018;4450.287953927356;1723.2417736196035;1785.5893843863203;1802.5845367208003;1805.4312891439154;1903.0865184711415;831.5301854452215;911.4485736129678;916.4547094478908;934.6728644974205;1014.457265363042;18939.43181704551;18958.905205473886;20152.193912243638;20824.1670333185;20863.47841303949;904.2901322461968;939.8167357365248;952.1953948913157;955.6954756757116;997.2719914462338;8449.704260350858;8687.695930642523;10451.738706532245;10567.788644227227;10820.863809300068;510764;610833;615353;626587;627772;117698;121111;122245.14775310404;124738;126061;903.4534106865383;1008.1984822066474;1029.7013865978931;1059.401438187437;1063.4310643805527;14885.627859303604;18127.72808407901;18213.089345532935;18296.451106466826;18790.624187516445;48743.025139496305;50006.74983125451;50312.24531631955;51092.74453627708;52368;71942;74591.62704186444;75639.86540202012;77881.61059194668;78010;7479.1025076988935;7572.167061623327;7598.088229412506;7708.421868359784;7949.523028618301;10970.945145274223;11932.806719327999;12075.396230188631;12222.877771222174;12406.689832754253;10410.323328983592;10499.580016799242;10507.00183482568;10807.729806754895;10819.67540973772;7609.847803043797;10243.436610986468;10296.588136474456;10458.058774710313;10540;10499.790004200026;10673.786524269626;10689.967998883487;10695.572177112828;11032.834507482234;7510.324070833652;7593.810154745955;7629.2370762923265;7676.117246516499;7857.960710196412;8909.910900890907;10586.8941310589;10598.735031624272;10784.622538211124;10812.297200681931 11:59:41 INFO - PROCESS | 1666 | |3;mootools.html;1431.5061303850168;1567.1694002178845;1597.8402159784018;1870.943871683849;2010.7888671689482;7937.404694647903;8526.786830329245;8714.997775255848;8723.345749068814;8724.258438032775;8474.279686226662;8686.087960764124;8695.652173913037;8714.041455439896;8717.782055448617;2161.794629510194;2373;2441.40185654514;2448.179859746978;2469.3579669285937;1961.7351657526265;2452.2765784093735;2471.8269721119527;2473.6042233242683;2482.8758562071916;2396.0775101585928;2430.562498750224;2459.2376363327335;2460.188137914484;2463.74130716274;2400.975990240093;2435.4398488347692;2441.07239249086;2455.914043008504;2462.5198086373166;2402.303332033708;2458.0659349447096;2458.8524688518746;2460.3603063203695;2465.778079972793;8733.475991440533;8816.382853200279;8836.248918841906;8840.425372350777;8842.381033327669;5345.1447768356875;5557.277553918006;5562.749676264578;5563.693996830173;5573.944260557424;3579.266250418658;3673.393890008172;3697.2605478904056;3762.5673047599603;3763.1344790698295;1045.2735348932495;1050.732063323855;1057.7672911959357;1059.5761695321855;1081.9829360401197;11997.460114294878;12000.819987700192;12029.39853007355;12034.037277017906;12034.51861925522;4820.638452116105;4870.09903167915;4900.289458028566;4907.3620429343955;4937.851864444073;10014.449205293633;10137.493125343703;10138.949305253427;10151;10152.340097893613;5504.504594586507;5536.723163841792;5543.223948647193;5551.444855514416;5551.833444996657;4445.310976798602;4567.177907976529;4916.631252656065;4975.228839529878;5017.949820501748;3387.6781705737917;3827.3684842000757;3895.104126051024;3909.2963266612282;3938.2320447513034;1310.7444048410468;1314.6056183145017;1316.427354100969;1328.6811165320253;1339.136257114156;1109.7059279290995;1126.9943650281696;1128.3963079752293;1293.1142167615214;1384.121083112211;8220.095789463154;8239.134890836376;8273.048599411024;8304.667813287522;8329.625166867505;459.6185166311953;506.845412149298;523.6700878446554;526.2816255810867;528.9021531016774;6240.063990401476;6247.9062814057825;6303.432691057827;6303.558750887394;6311.274203466568;10630.043296103388;10833.620823271305;10982.341059536453;10986.505607247693;10987.890121098846;10479.840136342462;10545.578176872992;10767.946160269305;10823.512941917632;10852.294600850919;8216.671333146727;8336.499810011419;8395.160483951679;8395.24442800151;8398.160183981676;7711.228877112244;7835.138134805053;7887;7888.2506161914525;7901.288884000238;9320.72037838866;9585.281103917094;9626.47054412014;9763.316567840184;9768.609255629695;9720.562574684298;10002.099811017044;10070.748231294276;10080.54637541327;10087;6659.733610655519;6740.764073257413;7009.439244860297;7528.284812942762;7616.04799400075;8270.090290068209;8342.332613390792;8345.624446899783;8365.121662225622;8377.623006964823;7253.165885923187;7332.340089391981;7351.522151060164;7451.217622149813;7493.850122997401;7189.892151617834;7243.927560724325;7333.596652184181;7336.193018768038;7411.221821708643;6630.237522684953;7613.619319034137;7851.568163751049;7852.646630901738;7862.135165131716;7053.788386348418;7104;7120;7120.0387947626405;7120.928790712027;6909.205441374105;7154.570725756471;7173.5337203081635;7177.318154775288;7195.424366050808 11:59:41 INFO - PROCESS | 1666 | |4;prototype.html;323.47273943472146;329.2624521072798;332.21099887766553;335.1687814220734;340.14114361237887;6630.138082049339;6642.3025582313885;6688.5652432591905;6710.798676039714;6714.294999025099;5417.864553386167;5440.6735595864175;6702.664866756667;6713.563618364803;6721.19345678518;4719.079779442993;4819.6867203631655;4880.755962201893;4988.3515143031445;4988.725620090893;4973.651844370896;4983.800647974077;4986.551210391064;5017.523335283142;5018.02148581025;4968.726720030397;4972.477889821571;4974.825881094144;4978.128827455199;4982.825601103962;4661.86014419568;4775.259834725605;4905.975470122627;4906.165951788204;4919.901601967977;4182.226288136704;4186.016286172747;4195.91608167838;4204.285271503852;4225.78871056449;6473.579217350857;6481.28705842357;6502.642354670491;6513.12072870166;6516.77191298307;5861.882762344771;5863.70681465925;5870.11948207768;5872.500837428824;5885.529157667376;6822.931770682279;7163.0688010558815;7170.569765814068;7175.748848790319;7181.856362872765;4610.907781844345;4645.372874661911;4647.1402790483535;4649.953500464986;4653.464851542082;7449;7546.999999999945;7574.962125189339;7582.35549978247;7590.316871481538;4677.579017888406;4684.414448193976;4706.835260765857;4707.552782485658;4713.033828065307;4763;4763.333133361332;4765.285207218875;4766.642501812378;4797.112534181188;5550.972245138829;5751.281089863767;5753.424657534297;5775.653460792366;5778.191053252548;7173.6413179340825;7183.497155199086;7185.353318201387;7192.3886469649615;7215.927840721631;1621.8783591230706;1657.4613250693574;1657.917104144788;1658.8341165883314;1662.8503434690936;977.6675930183771;993.1806259835664;1024.3853687787416;1036.6786296248188;1063.8563544189872;6554.80335589933;6731.596104233761;6742.83142921421;6748.595084294958;6756.763513277012;7518.924810751932;7524.661390237453;7529.774106776806;7532.949155591994;7551.207123252089;6678.966605166943;6699.832504187434;6723.865522689519;6729.461643068543;6739.224989126215;3814.2180852925085;3968.3452230381663;3998.6001399859783;4008.719389642697;4022.1754540319166;6774.83062923421;7798.22017798227;7858.0963189232825;7882.881756773653;7919.366450683931;7749.108852481924;7765.844683106307;7790.571518566533;7793.025871766029;7793.415493837985;7792.8051798704355;7811.843763124706;7824.569648669378;7842.803929901798;7873.055233371918;7258.455615828729;7408.222136675787;7543.906133610486;7546.6981320748755;7582.924170758221;7355.338019578264;7400.888986665097;7407.703691852265;7409.184989651242;7413.777586672409;7823.569703666353;7855.096663883726;7855.37157027425;7881.054273487218;7889.053313602404;3879.6896248299504;4679.3448917150945;4687.804609824473;4690.953090469052;4704.176769065469;6054.515638748801;6121.663308518075;7349.265073492608;7465;7514.9624251878395;7176.282371762782;7221.097362829646;7226.783196504113;7234.96382518084;7263.927360726537;7216.458765592706;7222.0611320528;7234;7238.203797582157;7246.746363877239;7048.929510704827;7059.929400706133;7067.399271061811;7070.39901608369;7077.363037326665;6950.652467376712;7200.819979500345;7210.675519601526;7220.169680486812;7253.310935461122;6745.3591908768585;6936.4797640176175;6941.028256044259;6948.895766563607;6957.026016357815 11:59:41 INFO - PROCESS | 1666 | |5;yui.html;650.7104338569337;680.7549282258386;694.3620178041543;753.6796861333928;764.0411283838781;15030.549083527498;15175.620609484768;15390.923045384772;15395.923020384897;15406.614834629112;13257.005724570672;13622.45510179594;13750.656233594165;13775.311234438288;13794.44822207113;745.0909889934271;755.490044220152;903.6114470777563;931.4225180388169;932.1796818799447;916.4638686368482;937.8686983822271;937.9718608441758;938.6104766521885;940.6190492850372;974.142754376148;974.8342781727123;975.4244995452682;979.0503211884461;979.3242662562844;778.0779775965499;951.728757304165;965.5558443116175;967.1827305926516;972.0376826941277;665.544102289933;680.9114815074008;729.2780147653784;729.3217307903648;729.7409419655999;15205.619859503491;15320.616984575363;15324.080555166725;15328.310226039855;15343.923280383528;10687.893121068768;11730.237534560227;12468;12544.560940367044;12918.41867115982;9968.900310996869;10005.799884002352;10055;10369.637062702845;10655.632853473935;3549.4498352755363;3585.31878943;3610.3501369753435;3616;3636.2727454509204;74403.62798186029;74748.62625686891;74791;74845;75032.87450688244;9451;9491.857622135674;9584.616615335308;9595.90404095964;9913.851292230622;18584.628307433777;22230.221942232267;22308.330750077523;22360.776392236196;22680.886595566917;7642.08295004603;7663.042119735033;7674.616269186518;7848.686052557834;7908.762737117896;3314.2708604107056;4077.510698716173;4086.019355354753;4138.193052354762;4367.825286988548;3568.589612194579;3632.9818350908604;3638.399664055401;3638.8180590970346;3641.399169137063;630.574362305442;632.6646877155115;634.8190765631773;675.4157653629575;689.941354984832;546.4617351908367;547.9671219726749;590.285754237369;595.2262059322863;626.2485017978444;7319.597422141726;7394.926050739531;7740.187280335596;7741.419393545507;8078.919210807934;526.1660268474511;563.9915401268984;574.615007944678;585.2128886647453;592.62960649594;3659.194977105086;3694.152504751106;3726.9627303726616;3835.520559930009;3951.4665520154986;82806.3438731234;83557.16442835615;83763;84434.73347899786;96980;73764.89352659714;74359;80210.5989470049;81151.59424202841;81479;71358;72025.6398718003;72305.63847180836;73405;74035;7355.5586664800285;8162.6734930602115;8181.836363272821;8272.710455134042;8282.588296364162;42335.36496952487;50714.985700286525;51760.70598234924;51945.701357466365;52323.47676523338;68505.31494684989;72562.63718681372;72756;72965.63517182592;73815.63092184505;10392.896071039193;10709.250352475563;10809.945950270197;10835.945820270848;11626.446133833453;11875.228110172811;11977.221480603734;11982.940085299517;12240.387980600755;12272.280953591433;11223;11351.602693905674;11411;11724;11744.29534227949;11256.887431125911;11393.829092563785;11489.655310340702;11576.652700419001;11744.471498782746;10988.340699558052;11107.44462776874;11155.44222788841;11322.433878306216;11347.432628368713;9196.816063678556;9250.02874698147;9540.475273859727;9654.662086826927;9786.1192492676;9345.53272336394;9367;9423.293253005915;9474.763130921781;9600.231981441328 11:59:41 INFO - PROCESS | 1666 | __end_tp_report 11:59:41 INFO - PROCESS | 1666 | __start_cc_report 11:59:41 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1559 11:59:41 INFO - PROCESS | 1666 | __end_cc_report 11:59:41 INFO - PROCESS | 1666 | __startTimestamp1459537181725__endTimestamp 11:59:41 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | ------- Summary: start ------- 11:59:41 INFO - PROCESS | 1666 | Number of tests: 6 11:59:41 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5759.82 Median:6080.51 stddev:653.57 (10.7%) stddev-sans-first:629.98 11:59:41 INFO - PROCESS | 1666 | Values: 3451.4 3499.4 3512.4 3537.1 3570.3 5727.6 5766.0 5788.2 5802.2 5821.6 5731.1 5755.6 5772.8 5778.2 5789.4 5173.3 5194.9 5234.6 5257.9 5302.5 5294.4 5298.7 5300.2 5304.2 5305.3 5205.3 5229.2 5263.6 5270.7 5294.6 5281.9 5287.8 5298.9 5321.7 5323.1 4176.2 5114.8 5123.3 5194.2 5225.2 5638.5 5679.1 5725.1 5734.1 5754.3 6210.8 6219.1 6239.2 6242.3 6249.4 6132.9 6196.8 6200.8 6243.5 6255.7 5894.5 5900.9 5947.9 5953.0 5955.9 6271.4 6279.6 6286.2 6292.2 6293.1 5272.4 5984.3 6135.1 6202.4 6214.0 5277.8 6193.8 6235.6 6240.6 6266.8 6138.5 6202.7 6249.3 6271.7 6282.0 6213.2 6276.2 6285.9 6292.4 6315.5 3779.7 4935.7 4952.9 4959.4 4985.0 4373.9 4439.6 4442.4 4447.9 4459.0 5717.1 5785.9 5794.7 5842.2 5845.6 6236.2 6244.7 6245.3 6245.3 6250.1 5676.3 5780.5 5782.8 5828.5 5837.3 5351.8 5398.1 5407.3 5440.6 5444.8 6329.5 6348.6 6353.1 6369.2 6375.1 6153.0 6180.4 6190.7 6242.1 6249.1 6253.4 6337.2 6346.7 6350.1 6356.9 6182.1 6238.6 6255.2 6259.0 6268.2 4818.7 6248.9 6252.9 6254.2 6277.4 6101.4 6150.5 6183.9 6226.5 6226.7 6180.9 6204.0 6214.9 6228.5 6229.5 5906.0 5995.1 6080.5 6090.8 6091.8 6087.2 6087.3 6098.4 6106.8 6111.2 5939.2 6095.0 6126.0 6129.1 6132.6 11:59:41 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:63138.68 Median:361834.50 stddev:140357.65 (38.8%) stddev-sans-first:140672.60 11:59:41 INFO - PROCESS | 1666 | Values: 502.1 546.5 574.8 626.1 642.9 30139.9 30553.7 30664.2 38064.2 38433.7 41362.8 41862.0 41933.8 41976.6 42125.0 9503.6 9731.3 9735.6 9749.7 9751.4 9541.0 9692.3 9708.4 9713.6 9742.6 9717.4 9730.7 9733.8 9792.5 9813.6 9724.4 9772.3 9797.5 9801.3 9826.9 9574.6 9718.9 9732.5 9751.2 9770.6 39801.6 40134.0 40139.6 40315.0 40431.0 3221.3 3275.6 3278.3 3302.4 3378.8 27862.6 27906.0 28218.0 28472.3 29143.7 2680.9 2741.3 2756.4 2779.2 2842.5 496639.0 498028.0 503890.0 504541.5 505196.0 43491.9 44263.0 44296.0 44425.0 61075.0 44596.0 44626.6 44661.3 44802.8 44854.8 15300.0 15485.9 15501.9 15513.3 15518.1 12516.0 12562.0 12589.6 12624.0 12762.8 11901.6 14327.8 14345.4 14410.0 14534.4 5339.7 5397.4 6208.3 6244.7 6300.5 875.8 934.6 974.6 1004.8 1076.4 30196.5 30695.1 30968.9 31015.5 31316.8 923.0 1003.1 1017.3 1025.9 1036.3 12412.8 12791.8 13721.3 14010.1 14058.9 657709.0 662461.0 665761.0 666732.0 671120.0 54392.9 55948.7 56128.4 56187.9 56218.7 1356.9 1369.1 1451.7 1472.5 1494.6 27670.4 27735.4 27856.3 28393.6 28461.3 44991.8 45537.0 45609.9 45651.1 45816.3 350853.0 361734.0 361935.0 361943.0 363271.0 27433.3 31167.8 31275.8 32021.7 32179.0 40337.6 41034.0 42218.9 42273.6 42385.6 33806.6 34538.5 34898.0 35182.0 35274.5 33989.2 34208.7 34240.0 34891.1 34908.8 33497.2 34414.1 34617.5 34618.7 34879.0 30684.0 30803.0 30857.0 30942.5 31013.0 23022.0 23335.1 23504.9 23692.5 23907.5 11:59:41 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:33760.94 Median:2006.65 stddev:99571.57 (4962.1%) stddev-sans-first:99819.28 11:59:41 INFO - PROCESS | 1666 | Values: 348.4 363.9 370.9 374.3 378.6 19480.8 20157.9 20446.2 20823.2 20906.1 16647.0 19291.7 19649.0 20269.3 20272.0 5210.1 5315.5 5401.8 5402.5 5416.7 3901.6 4076.3 5338.9 5697.7 5974.8 4841.7 5933.6 5945.6 5946.7 5951.0 5683.2 5903.6 5954.1 5956.3 5971.7 5565.9 5636.1 5659.9 5661.0 5662.8 16489.9 24048.0 24932.3 24933.9 24962.1 2044.2 2075.2 2114.4 2228.9 2555.5 9684.8 9884.4 10132.9 12672.0 13827.9 1675.9 1700.0 1739.9 1750.6 1788.2 93620.5 95186.5 95800.0 97341.5 98612.5 11004.7 11080.2 11138.8 11139.3 11232.8 13668.2 13712.0 13726.1 13753.4 13764.8 8443.3 8470.3 8486.9 8509.4 8548.3 6962.8 8571.8 8597.5 8708.5 8727.5 3649.4 4355.5 4375.3 4420.9 4450.3 1723.2 1785.6 1802.6 1805.4 1903.1 831.5 911.4 916.5 934.7 1014.5 18939.4 18958.9 20152.2 20824.2 20863.5 904.3 939.8 952.2 955.7 997.3 8449.7 8687.7 10451.7 10567.8 10820.9 510764.0 610833.0 615353.0 626587.0 627772.0 117698.0 121111.0 122245.1 124738.0 126061.0 903.5 1008.2 1029.7 1059.4 1063.4 14885.6 18127.7 18213.1 18296.5 18790.6 48743.0 50006.7 50312.2 51092.7 52368.0 71942.0 74591.6 75639.9 77881.6 78010.0 7479.1 7572.2 7598.1 7708.4 7949.5 10970.9 11932.8 12075.4 12222.9 12406.7 10410.3 10499.6 10507.0 10807.7 10819.7 7609.8 10243.4 10296.6 10458.1 10540.0 10499.8 10673.8 10690.0 10695.6 11032.8 7510.3 7593.8 7629.2 7676.1 7858.0 8909.9 10586.9 10598.7 10784.6 10812.3 11:59:41 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6057.54 Median:515.26 stddev:3236.78 (628.2%) stddev-sans-first:3227.18 11:59:41 INFO - PROCESS | 1666 | Values: 1431.5 1567.2 1597.8 1870.9 2010.8 7937.4 8526.8 8715.0 8723.3 8724.3 8474.3 8686.1 8695.7 8714.0 8717.8 2161.8 2373.0 2441.4 2448.2 2469.4 1961.7 2452.3 2471.8 2473.6 2482.9 2396.1 2430.6 2459.2 2460.2 2463.7 2401.0 2435.4 2441.1 2455.9 2462.5 2402.3 2458.1 2458.9 2460.4 2465.8 8733.5 8816.4 8836.2 8840.4 8842.4 5345.1 5557.3 5562.7 5563.7 5573.9 3579.3 3673.4 3697.3 3762.6 3763.1 1045.3 1050.7 1057.8 1059.6 1082.0 11997.5 12000.8 12029.4 12034.0 12034.5 4820.6 4870.1 4900.3 4907.4 4937.9 10014.4 10137.5 10138.9 10151.0 10152.3 5504.5 5536.7 5543.2 5551.4 5551.8 4445.3 4567.2 4916.6 4975.2 5017.9 3387.7 3827.4 3895.1 3909.3 3938.2 1310.7 1314.6 1316.4 1328.7 1339.1 1109.7 1127.0 1128.4 1293.1 1384.1 8220.1 8239.1 8273.0 8304.7 8329.6 459.6 506.8 523.7 526.3 528.9 6240.1 6247.9 6303.4 6303.6 6311.3 10630.0 10833.6 10982.3 10986.5 10987.9 10479.8 10545.6 10767.9 10823.5 10852.3 8216.7 8336.5 8395.2 8395.2 8398.2 7711.2 7835.1 7887.0 7888.3 7901.3 9320.7 9585.3 9626.5 9763.3 9768.6 9720.6 10002.1 10070.7 10080.5 10087.0 6659.7 6740.8 7009.4 7528.3 7616.0 8270.1 8342.3 8345.6 8365.1 8377.6 7253.2 7332.3 7351.5 7451.2 7493.9 7189.9 7243.9 7333.6 7336.2 7411.2 6630.2 7613.6 7851.6 7852.6 7862.1 7053.8 7104.0 7120.0 7120.0 7120.9 6909.2 7154.6 7173.5 7177.3 7195.4 11:59:41 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5881.21 Median:6713.93 stddev:1898.40 (28.3%) stddev-sans-first:1857.33 11:59:41 INFO - PROCESS | 1666 | Values: 323.5 329.3 332.2 335.2 340.1 6630.1 6642.3 6688.6 6710.8 6714.3 5417.9 5440.7 6702.7 6713.6 6721.2 4719.1 4819.7 4880.8 4988.4 4988.7 4973.7 4983.8 4986.6 5017.5 5018.0 4968.7 4972.5 4974.8 4978.1 4982.8 4661.9 4775.3 4906.0 4906.2 4919.9 4182.2 4186.0 4195.9 4204.3 4225.8 6473.6 6481.3 6502.6 6513.1 6516.8 5861.9 5863.7 5870.1 5872.5 5885.5 6822.9 7163.1 7170.6 7175.7 7181.9 4610.9 4645.4 4647.1 4650.0 4653.5 7449.0 7547.0 7575.0 7582.4 7590.3 4677.6 4684.4 4706.8 4707.6 4713.0 4763.0 4763.3 4765.3 4766.6 4797.1 5551.0 5751.3 5753.4 5775.7 5778.2 7173.6 7183.5 7185.4 7192.4 7215.9 1621.9 1657.5 1657.9 1658.8 1662.9 977.7 993.2 1024.4 1036.7 1063.9 6554.8 6731.6 6742.8 6748.6 6756.8 7518.9 7524.7 7529.8 7532.9 7551.2 6679.0 6699.8 6723.9 6729.5 6739.2 3814.2 3968.3 3998.6 4008.7 4022.2 6774.8 7798.2 7858.1 7882.9 7919.4 7749.1 7765.8 7790.6 7793.0 7793.4 7792.8 7811.8 7824.6 7842.8 7873.1 7258.5 7408.2 7543.9 7546.7 7582.9 7355.3 7400.9 7407.7 7409.2 7413.8 7823.6 7855.1 7855.4 7881.1 7889.1 3879.7 4679.3 4687.8 4691.0 4704.2 6054.5 6121.7 7349.3 7465.0 7515.0 7176.3 7221.1 7226.8 7235.0 7263.9 7216.5 7222.1 7234.0 7238.2 7246.7 7048.9 7059.9 7067.4 7070.4 7077.4 6950.7 7200.8 7210.7 7220.2 7253.3 6745.4 6936.5 6941.0 6948.9 6957.0 11:59:41 INFO - PROCESS | 1666 | 11:59:41 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18138.07 Median:633.74 stddev:25275.74 (3988.3%) stddev-sans-first:25312.54 11:59:41 INFO - PROCESS | 1666 | Values: 650.7 680.8 694.4 753.7 764.0 15030.5 15175.6 15390.9 15395.9 15406.6 13257.0 13622.5 13750.7 13775.3 13794.4 745.1 755.5 903.6 931.4 932.2 916.5 937.9 938.0 938.6 940.6 974.1 974.8 975.4 979.1 979.3 778.1 951.7 965.6 967.2 972.0 665.5 680.9 729.3 729.3 729.7 15205.6 15320.6 15324.1 15328.3 15343.9 10687.9 11730.2 12468.0 12544.6 12918.4 9968.9 10005.8 10055.0 10369.6 10655.6 3549.4 3585.3 3610.4 3616.0 3636.3 74403.6 74748.6 74791.0 74845.0 75032.9 9451.0 9491.9 9584.6 9595.9 9913.9 18584.6 22230.2 22308.3 22360.8 22680.9 7642.1 7663.0 7674.6 7848.7 7908.8 3314.3 4077.5 4086.0 4138.2 4367.8 3568.6 3633.0 3638.4 3638.8 3641.4 630.6 632.7 634.8 675.4 689.9 546.5 548.0 590.3 595.2 626.2 7319.6 7394.9 7740.2 7741.4 8078.9 526.2 564.0 574.6 585.2 592.6 3659.2 3694.2 3727.0 3835.5 3951.5 82806.3 83557.2 83763.0 84434.7 96980.0 73764.9 74359.0 80210.6 81151.6 81479.0 71358.0 72025.6 72305.6 73405.0 74035.0 7355.6 8162.7 8181.8 8272.7 8282.6 42335.4 50715.0 51760.7 51945.7 52323.5 68505.3 72562.6 72756.0 72965.6 73815.6 10392.9 10709.3 10809.9 10835.9 11626.4 11875.2 11977.2 11982.9 12240.4 12272.3 11223.0 11351.6 11411.0 11724.0 11744.3 11256.9 11393.8 11489.7 11576.7 11744.5 10988.3 11107.4 11155.4 11322.4 11347.4 9196.8 9250.0 9540.5 9654.7 9786.1 9345.5 9367.0 9423.3 9474.8 9600.2 11:59:41 INFO - PROCESS | 1666 | -------- Summary: end -------- 11:59:41 INFO - PROCESS | 1666 | 11:59:42 INFO - TEST-INFO | 1666: exit 0 11:59:42 INFO - TEST-OK | dromaeo_css | took 1113909ms 11:59:42 INFO - TEST-START | kraken 11:59:42 INFO - operating with platform_type : mac_ 11:59:42 INFO - Initialising browser for kraken test... 11:59:42 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpzF47Oj/profile http://localhost:49270/getInfo.html) 11:59:44 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 11:59:44 INFO - PROCESS | 1673 | colorDepth:24 11:59:44 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 11:59:44 INFO - PROCESS | 1673 | __metrics 11:59:44 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:59:44 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:59:45 INFO - TEST-INFO | 1673: exit 0 11:59:45 INFO - Browser initialized. 11:59:45 INFO - Running cycle 1/1 for kraken test... 11:59:45 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/tmpzF47Oj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:57 INFO - PROCESS | 1675 | RSS: Main: 236638208 11:59:57 INFO - PROCESS | 1675 | 12:00:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 12:00:00 INFO - PROCESS | 1675 | RSS: Main: 282902528 12:00:00 INFO - PROCESS | 1675 | 12:00:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 12:00:03 INFO - PROCESS | 1675 | RSS: Main: 293752832 12:00:03 INFO - PROCESS | 1675 | 12:00:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 12:00:07 INFO - PROCESS | 1675 | RSS: Main: 279777280 12:00:07 INFO - PROCESS | 1675 | 12:00:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 12:00:10 INFO - PROCESS | 1675 | RSS: Main: 282099712 12:00:10 INFO - PROCESS | 1675 | 12:00:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:00:13 INFO - PROCESS | 1675 | RSS: Main: 284020736 12:00:13 INFO - PROCESS | 1675 | 12:00:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 12:00:16 INFO - PROCESS | 1675 | RSS: Main: 284065792 12:00:16 INFO - PROCESS | 1675 | 12:00:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 12:00:19 INFO - PROCESS | 1675 | RSS: Main: 283996160 12:00:19 INFO - PROCESS | 1675 | 12:00:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 12:00:23 INFO - PROCESS | 1675 | RSS: Main: 284356608 12:00:23 INFO - PROCESS | 1675 | 12:00:24 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:00:25 INFO - PROCESS | 1675 | RSS: Main: 316555264 12:00:25 INFO - PROCESS | 1675 | 12:00:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:00:27 INFO - PROCESS | 1675 | RSS: Main: 316182528 12:00:27 INFO - PROCESS | 1675 | 12:00:29 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:00:30 INFO - PROCESS | 1675 | RSS: Main: 323305472 12:00:30 INFO - PROCESS | 1675 | 12:00:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:00:33 INFO - PROCESS | 1675 | RSS: Main: 324968448 12:00:33 INFO - PROCESS | 1675 | 12:00:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:00:36 INFO - PROCESS | 1675 | RSS: Main: 325099520 12:00:36 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 12:00:38 INFO - PROCESS | 1675 | RSS: Main: 387612672 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | __start_tp_report 12:00:38 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 12:00:38 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 12:00:38 INFO - PROCESS | 1675 | |i|pagename|runs| 12:00:38 INFO - PROCESS | 1675 | |0;ai-astar;111;107;110;115;160;163;165;162;139;115 12:00:38 INFO - PROCESS | 1675 | |1;audio-beat-detection;154;121;145;159;118;139;141;130;196;105 12:00:38 INFO - PROCESS | 1675 | |2;audio-dft;186;185;187;189;184;181;182;187;185;184 12:00:38 INFO - PROCESS | 1675 | |3;audio-fft;81;71;77;126;56;57;58;57;116;55 12:00:38 INFO - PROCESS | 1675 | |4;audio-oscillator;90;93;126;73;76;83;117;80;77;118 12:00:38 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;87;84;87;84;89;128;86;85;133;122 12:00:38 INFO - PROCESS | 1675 | |6;imaging-darkroom;92;93;93;94;93;92;93;92;92;92 12:00:38 INFO - PROCESS | 1675 | |7;imaging-desaturate;86;87;101;124;87;86;86;82;84;87 12:00:38 INFO - PROCESS | 1675 | |8;json-parse-financial;53;55;54;52;52;51;54;63;53;51 12:00:38 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;62;73;72;69;67;66;67;67;66 12:00:38 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;85;84;77;83;83;83;83;82;83;84 12:00:38 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;126;134;122;126;121;123;119;121;122;120 12:00:38 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;138;128;139;140;140;130;140;138;139;142 12:00:38 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;68;87;93;94;87;66;67;67;66 12:00:38 INFO - PROCESS | 1675 | __end_tp_report 12:00:38 INFO - PROCESS | 1675 | __start_cc_report 12:00:38 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1268 12:00:38 INFO - PROCESS | 1675 | __end_cc_report 12:00:38 INFO - PROCESS | 1675 | __startTimestamp1459537238774__endTimestamp 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | ------- Summary: start ------- 12:00:38 INFO - PROCESS | 1675 | Number of tests: 14 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:134.70 Median:149.50 stddev:25.47 (17.0%) stddev-sans-first:25.53 12:00:38 INFO - PROCESS | 1675 | Values: 111.0 107.0 110.0 115.0 160.0 163.0 165.0 162.0 139.0 115.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:143.00 stddev:25.57 (17.9%) stddev-sans-first:26.67 12:00:38 INFO - PROCESS | 1675 | Values: 154.0 121.0 145.0 159.0 118.0 139.0 141.0 130.0 196.0 105.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:2.40 (1.3%) stddev-sans-first:2.52 12:00:38 INFO - PROCESS | 1675 | Values: 186.0 185.0 187.0 189.0 184.0 181.0 182.0 187.0 185.0 184.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:75.40 Median:57.50 stddev:25.89 (45.0%) stddev-sans-first:27.39 12:00:38 INFO - PROCESS | 1675 | Values: 81.0 71.0 77.0 126.0 56.0 57.0 58.0 57.0 116.0 55.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:78.50 stddev:19.75 (25.2%) stddev-sans-first:20.92 12:00:38 INFO - PROCESS | 1675 | Values: 90.0 93.0 126.0 73.0 76.0 83.0 117.0 80.0 77.0 118.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:85.50 stddev:20.35 (23.8%) stddev-sans-first:21.15 12:00:38 INFO - PROCESS | 1675 | Values: 87.0 84.0 87.0 84.0 89.0 128.0 86.0 85.0 133.0 122.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 12:00:38 INFO - PROCESS | 1675 | Values: 92.0 93.0 93.0 94.0 93.0 92.0 93.0 92.0 92.0 92.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:91.00 Median:86.00 stddev:12.66 (14.7%) stddev-sans-first:13.30 12:00:38 INFO - PROCESS | 1675 | Values: 86.0 87.0 101.0 124.0 87.0 86.0 86.0 82.0 84.0 87.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:3.49 (6.5%) stddev-sans-first:3.69 12:00:38 INFO - PROCESS | 1675 | Values: 53.0 55.0 54.0 52.0 52.0 51.0 54.0 63.0 53.0 51.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:3.46 (5.2%) stddev-sans-first:3.32 12:00:38 INFO - PROCESS | 1675 | Values: 63.0 62.0 73.0 72.0 69.0 67.0 66.0 67.0 67.0 66.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:2.16 (2.6%) stddev-sans-first:2.13 12:00:38 INFO - PROCESS | 1675 | Values: 85.0 84.0 77.0 83.0 83.0 83.0 83.0 82.0 83.0 84.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:122.50 stddev:4.38 (3.6%) stddev-sans-first:4.54 12:00:38 INFO - PROCESS | 1675 | Values: 126.0 134.0 122.0 126.0 121.0 123.0 119.0 121.0 122.0 120.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.40 Median:139.50 stddev:4.60 (3.3%) stddev-sans-first:4.87 12:00:38 INFO - PROCESS | 1675 | Values: 138.0 128.0 139.0 140.0 140.0 130.0 140.0 138.0 139.0 142.0 12:00:38 INFO - PROCESS | 1675 | 12:00:38 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:77.50 stddev:12.30 (15.9%) stddev-sans-first:12.59 12:00:38 INFO - PROCESS | 1675 | Values: 67.0 68.0 87.0 93.0 94.0 87.0 66.0 67.0 67.0 66.0 12:00:38 INFO - PROCESS | 1675 | -------- Summary: end -------- 12:00:38 INFO - PROCESS | 1675 | 12:00:39 INFO - TEST-INFO | 1675: exit 0 12:00:39 INFO - TEST-OK | kraken | took 57258ms 12:00:39 INFO - SUITE-END | took 1171s 12:00:39 INFO - Completed test suite (00:19:31) 12:00:39 INFO - javascript benchmark 12:00:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3451.3614981228475, 3499.4077694648936, 3512.3853325668, 3537.0803591066333, 3570.268095040517, 5727.57043221758, 5765.971170144154, 5788.218590490283, 5802.187693722877, 5821.592488525805, 5731.083026715726, 5755.568332375067, 5772.826815195541, 5778.162166485857, 5789.39211382805, 5173.301604283421, 5194.896102077956, 5234.555062819665, 5257.921131183035, 5302.522772950434, 5294.364676238857, 5298.6555873868265, 5300.178472336775, 5304.177852432879, 5305.336832895888, 5205.349331333583, 5229.215617657363, 5263.552598029172, 5270.736463176826, 5294.5764338853, 5281.8943621127555, 5287.841364759063, 5298.894022119536, 5321.680699158024, 5323.121684922022, 4176.206520761046, 5114.84655460333, 5123.308353372285, 5194.194899790501, 5225.190095535198, 5638.520725738317, 5679.119736440858, 5725.055365864628, 5734.053881109612, 5754.280714910637, 6210.813675589739, 6219.129321894939, 6239.188905442309, 6242.282137554149, 6249.375062493759, 6132.936844521186, 6196.7831125910825, 6200.844978875519, 6243.500519958392, 6255.6872156392, 5894.528437725057, 5900.940990590125, 5947.851303717398, 5953.047512397996, 5955.868385006878, 6271.404216599416, 6279.591826531352, 6286.245650521967, 6292.244930608356, 6293.118963345135, 5272.420033796279, 5984.251968503937, 6135.1408007826785, 6202.4417802398, 6214.0, 5277.762500687479, 6193.783217587363, 6235.625862448268, 6240.594361366497, 6266.843328916813, 6138.508919286446, 6202.658853763086, 6249.343818899041, 6271.686415679198, 6281.968590157111, 6213.161223234805, 6276.184096067482, 6285.9057114143325, 6292.370762923762, 6315.494760419156, 3779.6976241900584, 4935.679180853233, 4952.851414457572, 4959.380077490314, 4984.975075124674, 4373.9343909840745, 4439.578240067253, 4442.378067070613, 4447.888802779892, 4459.0413061192, 5717.113847353667, 5785.942140578541, 5794.710264486759, 5842.182094506772, 5845.620034697731, 6236.18929539157, 6244.687765611701, 6245.281792593819, 6245.344238854946, 6250.0937364082865, 5676.290463692038, 5780.508656764222, 5782.768689252467, 5828.475437210672, 5837.29952405714, 5351.759170837322, 5398.1093119634825, 5407.324084489439, 5440.619156659075, 5444.8094316698725, 6329.525285603506, 6348.619082855043, 6353.078803573549, 6369.20384951881, 6375.139356187041, 6153.046277826944, 6180.443760061616, 6190.690465476799, 6242.063690446469, 6249.062640603764, 6253.37466253371, 6337.176167098432, 6346.7461301549265, 6350.079238510482, 6356.872862542631, 6182.103594978793, 6238.563300569098, 6255.218097737783, 6258.968705156445, 6268.1851359323, 4818.71087734737, 6248.937510625017, 6252.906206406817, 6254.21822272216, 6277.403646653561, 6101.398774955092, 6150.50795936333, 6183.907241391293, 6226.470749986121, 6226.688665566794, 6180.907286390618, 6204.038374052029, 6214.875702486015, 6228.501719862309, 6229.501639868709, 5906.0, 5995.064523657047, 6080.513558915364, 6090.786822461193, 6091.756329746938, 6087.208662873798, 6087.2999605044215, 6098.420650038239, 6106.786700156709, 6111.166351794699, 5939.227900373096, 6095.0, 6126.0, 6129.080637904171, 6132.63204207749], "unit": "score", "name": "dojo.html", "value": 5719.748423184517}, {"lowerIsBetter": false, "replicates": [502.14133831148735, 546.4508169289863, 574.7672192761933, 626.1265534579262, 642.9292777794443, 30139.945101921436, 30553.694463055363, 30664.233394165156, 38064.23871522568, 38433.65482208123, 41362.793186034025, 41861.95345116374, 41933.7903310483, 41976.58023419765, 42125.0, 9503.619855205801, 9731.270154738388, 9735.561899714494, 9749.658761943334, 9751.414915105117, 9540.99819518951, 9692.27307951903, 9708.41749495029, 9713.562889669982, 9742.561584728704, 9717.368371055894, 9730.65942692006, 9733.756656083584, 9792.461414622192, 9813.558389872473, 9724.367916085432, 9772.31593788435, 9797.510124493747, 9801.264905132144, 9826.852597211084, 9574.569144388519, 9718.902810971871, 9732.513374331254, 9751.17115045222, 9770.609175633037, 39801.60198398008, 40134.0, 40139.595114170865, 40315.0, 40431.0, 3221.2591104045964, 3275.6396796352383, 3278.32794277175, 3302.4220761366664, 3378.7803792753393, 27862.5820612691, 27906.02328918478, 28218.012369567172, 28472.288192795346, 29143.68853401602, 2680.892764289426, 2741.300968253083, 2756.421151558175, 2779.194033730216, 2842.488352096622, 496639.0336096629, 498028.0, 503890.0, 504541.4772926149, 505196.0, 43491.91270218207, 44263.0, 44296.0, 44425.00087496071, 61075.0, 44596.0, 44626.55373446224, 44661.33008004883, 44802.77598612051, 44854.77572612116, 15300.0, 15485.922570387302, 15501.922490387477, 15513.301901414463, 15518.068915865084, 12516.0, 12561.995040396747, 12589.622311330675, 12623.990080793514, 12762.80855787164, 11901.642950711319, 14327.78508322376, 14345.426182952773, 14410.0, 14534.418623255162, 5339.7063161526485, 5397.379301380313, 6208.348123446973, 6244.656543890039, 6300.456388184924, 875.7722992021993, 934.5700977550267, 974.6442548469757, 1004.829179039565, 1076.381080878498, 30196.54705179424, 30695.079147625605, 30968.916087936814, 31015.53476697806, 31316.84341578323, 922.9630814767335, 1003.0922015575916, 1017.31839667423, 1025.8615086963164, 1036.32638784789, 12412.81380779289, 12791.808122878165, 13721.313934303245, 14010.089344192595, 14058.929705351407, 657709.0, 662461.0, 665761.0, 666732.0, 671120.0, 54392.91214175694, 55948.72025639846, 56128.43871561314, 56187.87624247492, 56218.71890640521, 1356.938937747784, 1369.1237607930932, 1451.6588601678598, 1472.4919902633787, 1494.588988028301, 27670.44659106847, 27735.445291094467, 27856.303592410353, 28393.574096388984, 28461.288467788472, 44991.77504112459, 45537.0, 45609.859753506425, 45651.086978259584, 45816.312755308034, 350853.0, 361734.0, 361935.0, 361943.0, 363271.0, 27433.31416714518, 31167.844160779052, 31275.84362078175, 32021.67978320187, 32179.0, 40337.59662403456, 41034.0, 42218.94452638586, 42273.577264228195, 42385.57614423816, 33806.64773409135, 34538.481922770676, 34898.0, 35182.0, 35274.47088293729, 33989.150271243416, 34208.65791342154, 34240.0, 34891.127721806144, 34908.82545587256, 33497.16257093592, 34414.13964650904, 34617.48073778845, 34618.65381346255, 34879.0, 30684.0, 30803.0, 30857.0, 30942.53586196254, 31013.0, 23022.0, 23335.066597335917, 23504.94227759721, 23692.52614947726, 23907.521849563258], "unit": "score", "name": "ext.html", "value": 18563.131844567415}, {"lowerIsBetter": false, "replicates": [348.36075800905337, 363.9326724555957, 370.93137769512634, 374.34302798588476, 378.5703226837542, 19480.805191948075, 20157.899210503947, 20446.182152713893, 20823.167073317087, 20906.05922733477, 16647.00117992921, 19291.74603650762, 19649.017549122556, 20269.290574829884, 20272.0, 5210.114280572302, 5315.548178404841, 5401.783928642869, 5402.459754024605, 5416.702081385522, 3901.55132159801, 4076.32740597801, 5338.893222135555, 5697.743601537941, 5974.79088231912, 4841.661083724141, 5933.554983376264, 5945.583809133363, 5946.702664866761, 5950.970245148768, 5683.232763576926, 5903.645781253117, 5954.077118046666, 5956.315023772257, 5971.671558064305, 5565.860853478655, 5636.070048442043, 5659.8585035374035, 5661.0, 5662.773489060432, 16489.91755041229, 24048.0, 24932.252032439057, 24933.875330623414, 24962.126325578698, 2044.2231951858348, 2075.2217918280644, 2114.418534902914, 2228.9412529048736, 2555.501677172952, 9684.75788105296, 9884.35751676146, 10132.94933525335, 12671.98624110069, 13827.930860345634, 1675.9162041897857, 1700.0, 1739.9130043497773, 1750.571110078039, 1788.204249109134, 93620.53189734076, 95186.52406737921, 95800.0, 97341.51329243308, 98612.50693746557, 11004.669859904216, 11080.224384293184, 11138.827928553854, 11139.275947063416, 11232.831507527393, 13668.179909205479, 13712.040157188902, 13726.107802992774, 13753.38109785062, 13764.793528097087, 8443.324534037261, 8470.331845468658, 8486.872696909551, 8509.404341696145, 8548.333075050305, 6962.825929351807, 8571.828563428697, 8597.4919013455, 8708.477491350539, 8727.519986400808, 3649.361361761681, 4355.477342718894, 4375.256206444912, 4420.889477763018, 4450.287953927356, 1723.2417736196035, 1785.5893843863203, 1802.5845367208003, 1805.4312891439154, 1903.0865184711415, 831.5301854452215, 911.4485736129678, 916.4547094478908, 934.6728644974205, 1014.457265363042, 18939.43181704551, 18958.905205473886, 20152.193912243638, 20824.1670333185, 20863.47841303949, 904.2901322461968, 939.8167357365248, 952.1953948913157, 955.6954756757116, 997.2719914462338, 8449.704260350858, 8687.695930642523, 10451.738706532245, 10567.788644227227, 10820.863809300068, 510764.0, 610833.0, 615353.0, 626587.0, 627772.0, 117698.0, 121111.0, 122245.14775310404, 124738.0, 126061.0, 903.4534106865383, 1008.1984822066474, 1029.7013865978931, 1059.401438187437, 1063.4310643805527, 14885.627859303604, 18127.72808407901, 18213.089345532935, 18296.451106466826, 18790.624187516445, 48743.025139496305, 50006.74983125451, 50312.24531631955, 51092.74453627708, 52368.0, 71942.0, 74591.62704186444, 75639.86540202012, 77881.61059194668, 78010.0, 7479.1025076988935, 7572.167061623327, 7598.088229412506, 7708.421868359784, 7949.523028618301, 10970.945145274223, 11932.806719327999, 12075.396230188631, 12222.877771222174, 12406.689832754253, 10410.323328983592, 10499.580016799242, 10507.00183482568, 10807.729806754895, 10819.67540973772, 7609.847803043797, 10243.436610986468, 10296.588136474456, 10458.058774710313, 10540.0, 10499.790004200026, 10673.786524269626, 10689.967998883487, 10695.572177112828, 11032.834507482234, 7510.324070833652, 7593.810154745955, 7629.2370762923265, 7676.117246516499, 7857.960710196412, 8909.910900890907, 10586.8941310589, 10598.735031624272, 10784.622538211124, 10812.297200681931], "unit": "score", "name": "jquery.html", "value": 9144.207696732215}, {"lowerIsBetter": false, "replicates": [1431.5061303850168, 1567.1694002178845, 1597.8402159784018, 1870.943871683849, 2010.7888671689482, 7937.404694647903, 8526.786830329245, 8714.997775255848, 8723.345749068814, 8724.258438032775, 8474.279686226662, 8686.087960764124, 8695.652173913037, 8714.041455439896, 8717.782055448617, 2161.794629510194, 2373.0, 2441.40185654514, 2448.179859746978, 2469.3579669285937, 1961.7351657526265, 2452.2765784093735, 2471.8269721119527, 2473.6042233242683, 2482.8758562071916, 2396.0775101585928, 2430.562498750224, 2459.2376363327335, 2460.188137914484, 2463.74130716274, 2400.975990240093, 2435.4398488347692, 2441.07239249086, 2455.914043008504, 2462.5198086373166, 2402.303332033708, 2458.0659349447096, 2458.8524688518746, 2460.3603063203695, 2465.778079972793, 8733.475991440533, 8816.382853200279, 8836.248918841906, 8840.425372350777, 8842.381033327669, 5345.1447768356875, 5557.277553918006, 5562.749676264578, 5563.693996830173, 5573.944260557424, 3579.266250418658, 3673.393890008172, 3697.2605478904056, 3762.5673047599603, 3763.1344790698295, 1045.2735348932495, 1050.732063323855, 1057.7672911959357, 1059.5761695321855, 1081.9829360401197, 11997.460114294878, 12000.819987700192, 12029.39853007355, 12034.037277017906, 12034.51861925522, 4820.638452116105, 4870.09903167915, 4900.289458028566, 4907.3620429343955, 4937.851864444073, 10014.449205293633, 10137.493125343703, 10138.949305253427, 10151.0, 10152.340097893613, 5504.504594586507, 5536.723163841792, 5543.223948647193, 5551.444855514416, 5551.833444996657, 4445.310976798602, 4567.177907976529, 4916.631252656065, 4975.228839529878, 5017.949820501748, 3387.6781705737917, 3827.3684842000757, 3895.104126051024, 3909.2963266612282, 3938.2320447513034, 1310.7444048410468, 1314.6056183145017, 1316.427354100969, 1328.6811165320253, 1339.136257114156, 1109.7059279290995, 1126.9943650281696, 1128.3963079752293, 1293.1142167615214, 1384.121083112211, 8220.095789463154, 8239.134890836376, 8273.048599411024, 8304.667813287522, 8329.625166867505, 459.6185166311953, 506.845412149298, 523.6700878446554, 526.2816255810867, 528.9021531016774, 6240.063990401476, 6247.9062814057825, 6303.432691057827, 6303.558750887394, 6311.274203466568, 10630.043296103388, 10833.620823271305, 10982.341059536453, 10986.505607247693, 10987.890121098846, 10479.840136342462, 10545.578176872992, 10767.946160269305, 10823.512941917632, 10852.294600850919, 8216.671333146727, 8336.499810011419, 8395.160483951679, 8395.24442800151, 8398.160183981676, 7711.228877112244, 7835.138134805053, 7887.0, 7888.2506161914525, 7901.288884000238, 9320.72037838866, 9585.281103917094, 9626.47054412014, 9763.316567840184, 9768.609255629695, 9720.562574684298, 10002.099811017044, 10070.748231294276, 10080.54637541327, 10087.0, 6659.733610655519, 6740.764073257413, 7009.439244860297, 7528.284812942762, 7616.04799400075, 8270.090290068209, 8342.332613390792, 8345.624446899783, 8365.121662225622, 8377.623006964823, 7253.165885923187, 7332.340089391981, 7351.522151060164, 7451.217622149813, 7493.850122997401, 7189.892151617834, 7243.927560724325, 7333.596652184181, 7336.193018768038, 7411.221821708643, 6630.237522684953, 7613.619319034137, 7851.568163751049, 7852.646630901738, 7862.135165131716, 7053.788386348418, 7104.0, 7120.0, 7120.0387947626405, 7120.928790712027, 6909.205441374105, 7154.570725756471, 7173.5337203081635, 7177.318154775288, 7195.424366050808], "unit": "score", "name": "mootools.html", "value": 4837.754663053199}, {"lowerIsBetter": false, "replicates": [323.47273943472146, 329.2624521072798, 332.21099887766553, 335.1687814220734, 340.14114361237887, 6630.138082049339, 6642.3025582313885, 6688.5652432591905, 6710.798676039714, 6714.294999025099, 5417.864553386167, 5440.6735595864175, 6702.664866756667, 6713.563618364803, 6721.19345678518, 4719.079779442993, 4819.6867203631655, 4880.755962201893, 4988.3515143031445, 4988.725620090893, 4973.651844370896, 4983.800647974077, 4986.551210391064, 5017.523335283142, 5018.02148581025, 4968.726720030397, 4972.477889821571, 4974.825881094144, 4978.128827455199, 4982.825601103962, 4661.86014419568, 4775.259834725605, 4905.975470122627, 4906.165951788204, 4919.901601967977, 4182.226288136704, 4186.016286172747, 4195.91608167838, 4204.285271503852, 4225.78871056449, 6473.579217350857, 6481.28705842357, 6502.642354670491, 6513.12072870166, 6516.77191298307, 5861.882762344771, 5863.70681465925, 5870.11948207768, 5872.500837428824, 5885.529157667376, 6822.931770682279, 7163.0688010558815, 7170.569765814068, 7175.748848790319, 7181.856362872765, 4610.907781844345, 4645.372874661911, 4647.1402790483535, 4649.953500464986, 4653.464851542082, 7449.0, 7546.999999999945, 7574.962125189339, 7582.35549978247, 7590.316871481538, 4677.579017888406, 4684.414448193976, 4706.835260765857, 4707.552782485658, 4713.033828065307, 4763.0, 4763.333133361332, 4765.285207218875, 4766.642501812378, 4797.112534181188, 5550.972245138829, 5751.281089863767, 5753.424657534297, 5775.653460792366, 5778.191053252548, 7173.6413179340825, 7183.497155199086, 7185.353318201387, 7192.3886469649615, 7215.927840721631, 1621.8783591230706, 1657.4613250693574, 1657.917104144788, 1658.8341165883314, 1662.8503434690936, 977.6675930183771, 993.1806259835664, 1024.3853687787416, 1036.6786296248188, 1063.8563544189872, 6554.80335589933, 6731.596104233761, 6742.83142921421, 6748.595084294958, 6756.763513277012, 7518.924810751932, 7524.661390237453, 7529.774106776806, 7532.949155591994, 7551.207123252089, 6678.966605166943, 6699.832504187434, 6723.865522689519, 6729.461643068543, 6739.224989126215, 3814.2180852925085, 3968.3452230381663, 3998.6001399859783, 4008.719389642697, 4022.1754540319166, 6774.83062923421, 7798.22017798227, 7858.0963189232825, 7882.881756773653, 7919.366450683931, 7749.108852481924, 7765.844683106307, 7790.571518566533, 7793.025871766029, 7793.415493837985, 7792.8051798704355, 7811.843763124706, 7824.569648669378, 7842.803929901798, 7873.055233371918, 7258.455615828729, 7408.222136675787, 7543.906133610486, 7546.6981320748755, 7582.924170758221, 7355.338019578264, 7400.888986665097, 7407.703691852265, 7409.184989651242, 7413.777586672409, 7823.569703666353, 7855.096663883726, 7855.37157027425, 7881.054273487218, 7889.053313602404, 3879.6896248299504, 4679.3448917150945, 4687.804609824473, 4690.953090469052, 4704.176769065469, 6054.515638748801, 6121.663308518075, 7349.265073492608, 7465.0, 7514.9624251878395, 7176.282371762782, 7221.097362829646, 7226.783196504113, 7234.96382518084, 7263.927360726537, 7216.458765592706, 7222.0611320528, 7234.0, 7238.203797582157, 7246.746363877239, 7048.929510704827, 7059.929400706133, 7067.399271061811, 7070.39901608369, 7077.363037326665, 6950.652467376712, 7200.819979500345, 7210.675519601526, 7220.169680486812, 7253.310935461122, 6745.3591908768585, 6936.4797640176175, 6941.028256044259, 6948.895766563607, 6957.026016357815], "unit": "score", "name": "prototype.html", "value": 5237.9679414698685}, {"lowerIsBetter": false, "replicates": [650.7104338569337, 680.7549282258386, 694.3620178041543, 753.6796861333928, 764.0411283838781, 15030.549083527498, 15175.620609484768, 15390.923045384772, 15395.923020384897, 15406.614834629112, 13257.005724570672, 13622.45510179594, 13750.656233594165, 13775.311234438288, 13794.44822207113, 745.0909889934271, 755.490044220152, 903.6114470777563, 931.4225180388169, 932.1796818799447, 916.4638686368482, 937.8686983822271, 937.9718608441758, 938.6104766521885, 940.6190492850372, 974.142754376148, 974.8342781727123, 975.4244995452682, 979.0503211884461, 979.3242662562844, 778.0779775965499, 951.728757304165, 965.5558443116175, 967.1827305926516, 972.0376826941277, 665.544102289933, 680.9114815074008, 729.2780147653784, 729.3217307903648, 729.7409419655999, 15205.619859503491, 15320.616984575363, 15324.080555166725, 15328.310226039855, 15343.923280383528, 10687.893121068768, 11730.237534560227, 12468.0, 12544.560940367044, 12918.41867115982, 9968.900310996869, 10005.799884002352, 10055.0, 10369.637062702845, 10655.632853473935, 3549.4498352755363, 3585.31878943, 3610.3501369753435, 3616.0, 3636.2727454509204, 74403.62798186029, 74748.62625686891, 74791.0, 74845.0, 75032.87450688244, 9451.0, 9491.857622135674, 9584.616615335308, 9595.90404095964, 9913.851292230622, 18584.628307433777, 22230.221942232267, 22308.330750077523, 22360.776392236196, 22680.886595566917, 7642.08295004603, 7663.042119735033, 7674.616269186518, 7848.686052557834, 7908.762737117896, 3314.2708604107056, 4077.510698716173, 4086.019355354753, 4138.193052354762, 4367.825286988548, 3568.589612194579, 3632.9818350908604, 3638.399664055401, 3638.8180590970346, 3641.399169137063, 630.574362305442, 632.6646877155115, 634.8190765631773, 675.4157653629575, 689.941354984832, 546.4617351908367, 547.9671219726749, 590.285754237369, 595.2262059322863, 626.2485017978444, 7319.597422141726, 7394.926050739531, 7740.187280335596, 7741.419393545507, 8078.919210807934, 526.1660268474511, 563.9915401268984, 574.615007944678, 585.2128886647453, 592.62960649594, 3659.194977105086, 3694.152504751106, 3726.9627303726616, 3835.520559930009, 3951.4665520154986, 82806.3438731234, 83557.16442835615, 83763.0, 84434.73347899786, 96980.0, 73764.89352659714, 74359.0, 80210.5989470049, 81151.59424202841, 81479.0, 71358.0, 72025.6398718003, 72305.63847180836, 73405.0, 74035.0, 7355.5586664800285, 8162.6734930602115, 8181.836363272821, 8272.710455134042, 8282.588296364162, 42335.36496952487, 50714.985700286525, 51760.70598234924, 51945.701357466365, 52323.47676523338, 68505.31494684989, 72562.63718681372, 72756.0, 72965.63517182592, 73815.63092184505, 10392.896071039193, 10709.250352475563, 10809.945950270197, 10835.945820270848, 11626.446133833453, 11875.228110172811, 11977.221480603734, 11982.940085299517, 12240.387980600755, 12272.280953591433, 11223.0, 11351.602693905674, 11411.0, 11724.0, 11744.29534227949, 11256.887431125911, 11393.829092563785, 11489.655310340702, 11576.652700419001, 11744.471498782746, 10988.340699558052, 11107.44462776874, 11155.44222788841, 11322.433878306216, 11347.432628368713, 9196.816063678556, 9250.02874698147, 9540.475273859727, 9654.662086826927, 9786.1192492676, 9345.53272336394, 9367.0, 9423.293253005915, 9474.763130921781, 9600.231981441328], "unit": "score", "name": "yui.html", "value": 6874.404253517246}], "name": "dromaeo_css", "value": 7436.604970590453}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 115.0, 160.0, 163.0, 165.0, 162.0, 139.0, 115.0], "unit": "score", "name": "ai-astar", "value": 134.7}, {"lowerIsBetter": true, "replicates": [154.0, 121.0, 145.0, 159.0, 118.0, 139.0, 141.0, 130.0, 196.0, 105.0], "unit": "score", "name": "audio-beat-detection", "value": 140.8}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 187.0, 189.0, 184.0, 181.0, 182.0, 187.0, 185.0, 184.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [81.0, 71.0, 77.0, 126.0, 56.0, 57.0, 58.0, 57.0, 116.0, 55.0], "unit": "score", "name": "audio-fft", "value": 75.4}, {"lowerIsBetter": true, "replicates": [90.0, 93.0, 126.0, 73.0, 76.0, 83.0, 117.0, 80.0, 77.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 93.3}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 84.0, 89.0, 128.0, 86.0, 85.0, 133.0, 122.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 94.0, 93.0, 92.0, 93.0, 92.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 101.0, 124.0, 87.0, 86.0, 86.0, 82.0, 84.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 91.0}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 54.0, 52.0, 52.0, 51.0, 54.0, 63.0, 53.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 53.8}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 73.0, 72.0, 69.0, 67.0, 66.0, 67.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 77.0, 83.0, 83.0, 83.0, 83.0, 82.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [126.0, 134.0, 122.0, 126.0, 121.0, 123.0, 119.0, 121.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [138.0, 128.0, 139.0, 140.0, 140.0, 130.0, 140.0, 138.0, 139.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 87.0, 93.0, 94.0, 87.0, 66.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.2}], "name": "kraken", "value": 1452.0000000000002}]} 12:00:40 INFO - Return code: 0 12:00:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:00:40 ERROR - # TBPL SUCCESS # 12:00:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:00:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:00:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:00:40 INFO - 2016-04-01 12:00:40.076 screenresolution[1680:9818] starting screenresolution argv=screenresolution get 12:00:40 INFO - 2016-04-01 12:00:40.079 screenresolution[1680:9818] Display 0: 1600x1200x32@60 12:00:40 INFO - 2016-04-01 12:00:40.085 screenresolution[1681:9820] starting screenresolution argv=screenresolution list 12:00:40 INFO - Available Modes on Display 0 12:00:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:00:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:00:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:00:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:00:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:00:40 INFO - Intel Iris: 12:00:40 INFO - Chipset Model: Intel Iris 12:00:40 INFO - Type: GPU 12:00:40 INFO - Bus: Built-In 12:00:40 INFO - VRAM (Dynamic, Max): 1536 MB 12:00:40 INFO - Vendor: Intel (0x8086) 12:00:40 INFO - Device ID: 0x0a2e 12:00:40 INFO - Revision ID: 0x0009 12:00:40 INFO - Displays: 12:00:40 INFO - Display: 12:00:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:00:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:00:40 INFO - Display Serial Number: 1600x1200 60 12:00:40 INFO - Main Display: Yes 12:00:40 INFO - Mirror: Off 12:00:40 INFO - Online: Yes 12:00:40 INFO - Rotation: Supported 12:00:40 INFO - Return code: 0 12:00:40 INFO - Running post-action listener: _resource_record_post_action 12:00:40 INFO - Running post-run listener: _resource_record_post_run 12:00:41 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 37324288; Write bytes: 705491968; Read time: 400; Write time: 2077 12:00:41 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403509760; Write bytes: 392164864; Read time: 30248; Write time: 737 12:00:41 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 30268928; Write bytes: 298083840; Read time: 303; Write time: 1289 12:00:41 INFO - Running post-run listener: _upload_blobber_files 12:00:41 INFO - Blob upload gear active. 12:00:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:41 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 12:00:41 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'] 12:00:41 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 12:00:41 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:00:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:00:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:42 INFO - (blobuploader) - INFO - Done attempting. 12:00:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:00:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:00:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:43 INFO - (blobuploader) - INFO - Done attempting. 12:00:43 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:43 INFO - Return code: 0 12:00:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb3e50389d2070f45439fbbbf3b2d8715e97b164147585cd49b00521427c0d55f0397213423f78ad8e8e4cc66e282a549ce119279ea70fd73603f69d79c15a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa92b558dc1ffdc868080fdeb254fae5b7a0dc1437e256d37ea72bff475e8ea807ecf5183bb5aac91a5f83c5c775c38afa54a9b6d5dd265e8691bcdeb3ceece6"} 12:00:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:43 INFO - Contents: 12:00:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb3e50389d2070f45439fbbbf3b2d8715e97b164147585cd49b00521427c0d55f0397213423f78ad8e8e4cc66e282a549ce119279ea70fd73603f69d79c15a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa92b558dc1ffdc868080fdeb254fae5b7a0dc1437e256d37ea72bff475e8ea807ecf5183bb5aac91a5f83c5c775c38afa54a9b6d5dd265e8691bcdeb3ceece6"} 12:00:43 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:43 INFO - Copying logs to upload dir... 12:00:43 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.792750 ========= master_lag: 2.91 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-01 12:00:46.815372) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 12:00:46.824161) ========= 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.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb3e50389d2070f45439fbbbf3b2d8715e97b164147585cd49b00521427c0d55f0397213423f78ad8e8e4cc66e282a549ce119279ea70fd73603f69d79c15a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa92b558dc1ffdc868080fdeb254fae5b7a0dc1437e256d37ea72bff475e8ea807ecf5183bb5aac91a5f83c5c775c38afa54a9b6d5dd265e8691bcdeb3ceece6"} build_url:https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/O4aXHC2VSqK4nVS3Qp9JTA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cb3e50389d2070f45439fbbbf3b2d8715e97b164147585cd49b00521427c0d55f0397213423f78ad8e8e4cc66e282a549ce119279ea70fd73603f69d79c15a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa92b558dc1ffdc868080fdeb254fae5b7a0dc1437e256d37ea72bff475e8ea807ecf5183bb5aac91a5f83c5c775c38afa54a9b6d5dd265e8691bcdeb3ceece6"}' ========= master_lag: 0.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 12:00:47.391593) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-01 12:00:47.391944) ========= 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.r0Plnmb85F/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.DtMjpedIIX/Listeners TMPDIR=/var/folders/cf/5zhxcwh11mq5cjjb5nhm70lm00000w/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.005135 ========= master_lag: 3.18 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-01 12:00:50.578893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 12:00:50.579198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 12:00:51.303334) ========= ========= Total master_lag: 6.90 =========