builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0111 starttime: 1459462019.42 results: success (0) buildid: 20160331130540 builduid: 9a7e5ca9b70c41938f47a417b33c9b56 revision: bccb11375f2af838cda714d42fd8cef78f5c7bf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 15:06:59.422641) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 15:06:59.423067) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-31 15:06:59.423361) ========= 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.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005563 basedir: '/builds/slave/test' ========= master_lag: 0.92 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.347016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.347287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.390782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.391085) ========= 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.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005538 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.439207) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.439465) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.439792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.440095) ========= 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.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-31 15:07:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 196M=0s 2016-03-31 15:07:00 (196 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131328 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:00.600392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-31 15:07:00.600683) ========= 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.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.020276 ========= master_lag: 3.64 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-31 15:07:04.262486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-31 15:07:04.265987) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bccb11375f2af838cda714d42fd8cef78f5c7bf1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bccb11375f2af838cda714d42fd8cef78f5c7bf1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-31 15:07:04,833 truncating revision to first 12 chars 2016-03-31 15:07:04,833 Setting DEBUG logging. 2016-03-31 15:07:04,833 attempt 1/10 2016-03-31 15:07:04,833 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bccb11375f2a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-31 15:07:05,879 unpacking tar archive at: mozilla-central-bccb11375f2a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.302449 ========= master_lag: 0.46 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-31 15:07:06.031282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:06.031580) ========= echo bccb11375f2af838cda714d42fd8cef78f5c7bf1 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bccb11375f2af838cda714d42fd8cef78f5c7bf1'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 bccb11375f2af838cda714d42fd8cef78f5c7bf1 program finished with exit code 0 elapsedTime=0.005239 script_repo_revision: 'bccb11375f2af838cda714d42fd8cef78f5c7bf1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:06.082352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:06.082638) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 15:07:06.096170) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-03-31 15:07:06.096437) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:07:06 INFO - MultiFileLogger online at 20160331 15:07:06 in /builds/slave/test 15:07:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:07:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:07:06 INFO - {'append_to_log': False, 15:07:06 INFO - 'base_work_dir': '/builds/slave/test', 15:07:06 INFO - 'blob_upload_branch': 'Firefox', 15:07:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:07:06 INFO - 'branch': 'Firefox', 15:07:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:07:06 INFO - 'config_files': ('talos/mac_config.py',), 15:07:06 INFO - 'default_actions': ('clobber', 15:07:06 INFO - 'read-buildbot-config', 15:07:06 INFO - 'download-and-extract', 15:07:06 INFO - 'populate-webroot', 15:07:06 INFO - 'create-virtualenv', 15:07:06 INFO - 'install', 15:07:06 INFO - 'run-tests'), 15:07:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:07:06 INFO - 'download_minidump_stackwalk': True, 15:07:06 INFO - 'download_symbols': 'ondemand', 15:07:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:07:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:07:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:07:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:07:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:07:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:07:06 INFO - 'installer_path': 'installer.exe', 15:07:06 INFO - 'log_level': 'info', 15:07:06 INFO - 'log_name': 'talos', 15:07:06 INFO - 'log_to_console': True, 15:07:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:07:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:07:06 INFO - 'opt_config_files': (), 15:07:06 INFO - 'pip_index': False, 15:07:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:07:06 INFO - 'cmd': ('bash', 15:07:06 INFO - '-c', 15:07:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:07:06 INFO - 'enabled': True, 15:07:06 INFO - 'halt_on_failure': False, 15:07:06 INFO - 'name': 'check_screen_resolution'},), 15:07:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:07:06 INFO - 'cmd': ('bash', 15:07:06 INFO - '-c', 15:07:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:07:06 INFO - 'enabled': True, 15:07:06 INFO - 'halt_on_failure': False, 15:07:06 INFO - 'name': 'check_screen_resolution'},), 15:07:06 INFO - 'run_cmd_checks_enabled': True, 15:07:06 INFO - 'sps_profile': False, 15:07:06 INFO - 'sps_profile_interval': 0, 15:07:06 INFO - 'suite': 'dromaeojs-e10s', 15:07:06 INFO - 'system_bits': '32', 15:07:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:07:06 INFO - 'title': 't-yosemite-r7-0111', 15:07:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:07:06 INFO - 'use_talos_json': True, 15:07:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:07:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:07:06 INFO - 'work_dir': 'build'} 15:07:06 INFO - ##### 15:07:06 INFO - ##### Running clobber step. 15:07:06 INFO - ##### 15:07:06 INFO - Running pre-action listener: _resource_record_pre_action 15:07:06 INFO - Running main action method: clobber 15:07:06 INFO - rmtree: /builds/slave/test/build 15:07:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:07:06 INFO - Running post-action listener: _resource_record_post_action 15:07:06 INFO - ##### 15:07:06 INFO - ##### Running read-buildbot-config step. 15:07:06 INFO - ##### 15:07:06 INFO - Running pre-action listener: _resource_record_pre_action 15:07:06 INFO - Running main action method: read_buildbot_config 15:07:06 INFO - Using buildbot properties: 15:07:06 INFO - { 15:07:06 INFO - "project": "", 15:07:06 INFO - "product": "firefox", 15:07:06 INFO - "script_repo_revision": "production", 15:07:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:07:06 INFO - "repository": "", 15:07:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:07:06 INFO - "buildid": "20160331130540", 15:07:06 INFO - "pgo_build": "False", 15:07:06 INFO - "basedir": "/builds/slave/test", 15:07:06 INFO - "buildnumber": 162, 15:07:06 INFO - "slavename": "t-yosemite-r7-0111", 15:07:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:07:06 INFO - "platform": "yosemite_r7", 15:07:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:07:06 INFO - "branch": "mozilla-central", 15:07:06 INFO - "repo_path": "mozilla-central", 15:07:06 INFO - "revision": "bccb11375f2af838cda714d42fd8cef78f5c7bf1", 15:07:06 INFO - "stage_platform": "macosx64", 15:07:06 INFO - "builduid": "9a7e5ca9b70c41938f47a417b33c9b56", 15:07:06 INFO - "slavebuilddir": "test" 15:07:06 INFO - } 15:07:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 15:07:06 INFO - Running post-action listener: _resource_record_post_action 15:07:06 INFO - ##### 15:07:06 INFO - ##### Running download-and-extract step. 15:07:06 INFO - ##### 15:07:06 INFO - Running pre-action listener: _resource_record_pre_action 15:07:06 INFO - Running main action method: download_and_extract 15:07:06 INFO - mkdir: /builds/slave/test/build/tests 15:07: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')]} 15:07:06 INFO - https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:07:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:07:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:07:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:07:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:07:09 INFO - Downloaded 1199 bytes. 15:07:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:07:09 INFO - Using the following test package requirements: 15:07:09 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:07:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:07:09 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 15:07:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:07:09 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 15:07:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:07:09 INFO - u'jsshell-mac.zip'], 15:07:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:07:09 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 15:07:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:07:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:07:09 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 15:07:09 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:07:09 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 15:07:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:07:09 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 15:07:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:07:09 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 15:07:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:07:09 INFO - https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:07:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:07:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:07:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:07:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:07:10 INFO - Downloaded 17955587 bytes. 15:07:10 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'] 15:07:10 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 15:07:13 INFO - Return code: 0 15:07:13 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 15:07: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')]} 15:07:13 INFO - https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:07:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:07:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:07:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:07:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:07:18 INFO - Downloaded 17955587 bytes. 15:07:18 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'] 15:07:18 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 15:07:21 INFO - Return code: 0 15:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:07:21 INFO - https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:07:22 INFO - Downloaded 10847534 bytes. 15:07:22 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'] 15:07:22 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 15:07:23 INFO - Return code: 0 15:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:07:23 INFO - https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 15:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/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 15:08:18 INFO - Downloaded 111442064 bytes. 15:08:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:08:18 INFO - mkdir: /builds/slave/test/properties 15:08:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:08:18 INFO - Writing to file /builds/slave/test/properties/build_url 15:08:18 INFO - Contents: 15:08:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:08:20 INFO - Running post-action listener: _resource_record_post_action 15:08:20 INFO - Running post-action listener: set_extra_try_arguments 15:08:20 INFO - ##### 15:08:20 INFO - ##### Running populate-webroot step. 15:08:20 INFO - ##### 15:08:20 INFO - Running pre-action listener: _resource_record_pre_action 15:08:20 INFO - Running main action method: populate_webroot 15:08:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:08:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:08:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:08:20 INFO - '--tppagecycles', 15:08:20 INFO - '7'], 15:08:20 INFO - 'tests': ['tsvgm']}}, 15:08:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:08:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:08:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:08:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:08:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:08:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:08:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:08:20 INFO - 'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:08:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:08:20 INFO - 'tests': ['damp', 'tps']}, 15:08:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:08:20 INFO - 'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['damp', 'tps']}, 15:08:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:08:20 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['dromaeo_dom']}, 15:08:20 INFO - 'other': {'tests': ['a11yr', 15:08:20 INFO - 'ts_paint', 15:08:20 INFO - 'tpaint', 15:08:20 INFO - 'sessionrestore', 15:08:20 INFO - 'sessionrestore_no_auto_restore', 15:08:20 INFO - 'tabpaint']}, 15:08:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['a11yr', 15:08:20 INFO - 'ts_paint', 15:08:20 INFO - 'tpaint', 15:08:20 INFO - 'sessionrestore', 15:08:20 INFO - 'sessionrestore_no_auto_restore', 15:08:20 INFO - 'tabpaint']}, 15:08:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['a11yr', 15:08:20 INFO - 'ts_paint', 15:08:20 INFO - 'tpaint', 15:08:20 INFO - 'sessionrestore', 15:08:20 INFO - 'sessionrestore_no_auto_restore', 15:08:20 INFO - 'tabpaint']}, 15:08:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['a11yr', 15:08:20 INFO - 'ts_paint', 15:08:20 INFO - 'tpaint', 15:08:20 INFO - 'sessionrestore', 15:08:20 INFO - 'sessionrestore_no_auto_restore', 15:08:20 INFO - 'tabpaint']}, 15:08:20 INFO - 'other_l64': {'tests': ['a11yr', 15:08:20 INFO - 'ts_paint', 15:08:20 INFO - 'tpaint', 15:08:20 INFO - 'sessionrestore', 15:08:20 INFO - 'sessionrestore_no_auto_restore', 15:08:20 INFO - 'tabpaint']}, 15:08:20 INFO - 'other_nol64': {'tests': ['a11yr', 15:08:20 INFO - 'ts_paint', 15:08:20 INFO - 'tpaint', 15:08:20 INFO - 'sessionrestore', 15:08:20 INFO - 'sessionrestore_no_auto_restore', 15:08:20 INFO - 'tabpaint']}, 15:08:20 INFO - 'svgr': {'tests': ['tsvgx', 15:08:20 INFO - 'tsvgr_opacity', 15:08:20 INFO - 'tart', 15:08:20 INFO - 'tscrollx', 15:08:20 INFO - 'cart']}, 15:08:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['tsvgx', 15:08:20 INFO - 'tsvgr_opacity', 15:08:20 INFO - 'tart', 15:08:20 INFO - 'tscrollx', 15:08:20 INFO - 'cart']}, 15:08:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:08:20 INFO - 'tests': ['tp5o']}, 15:08:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:08:20 INFO - 'talos_options': ['--e10s'], 15:08:20 INFO - 'tests': ['tp5o']}, 15:08:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:08:20 INFO - 'talos_options': ['--xperf_path', 15:08:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:08:20 INFO - 'tests': ['tp5n']}, 15:08:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:08:20 INFO - 'talos_options': ['--e10s', 15:08:20 INFO - '--xperf_path', 15:08:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:08:20 INFO - 'tests': ['tp5n']}}, 15:08:20 INFO - 'talos.zip': {'path': '', 15:08:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:08:20 INFO - Running post-action listener: _resource_record_post_action 15:08:20 INFO - ##### 15:08:20 INFO - ##### Running create-virtualenv step. 15:08:20 INFO - ##### 15:08:20 INFO - Running pre-action listener: _resource_record_pre_action 15:08:20 INFO - Running main action method: create_virtualenv 15:08:20 INFO - Creating virtualenv /builds/slave/test/build/venv 15:08:20 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 15:08:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:08:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:08:20 INFO - Using real prefix '/tools/python27' 15:08:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:08:20 INFO - Installing distribute.............................................................................................................................................................................................done. 15:08:23 INFO - Installing pip.................done. 15:08:23 INFO - Return code: 0 15:08:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:08:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:23 INFO - 'HOME': '/Users/cltbld', 15:08:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:23 INFO - 'LOGNAME': 'cltbld', 15:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:23 INFO - 'MOZ_NO_REMOTE': '1', 15:08:23 INFO - 'NO_EM_RESTART': '1', 15:08:23 INFO - 'PAGER': '/bin/cat', 15:08:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:23 INFO - 'PWD': '/builds/slave/test', 15:08:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:23 INFO - 'SHELL': '/bin/bash', 15:08:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:23 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:23 INFO - 'USER': 'cltbld', 15:08:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:23 INFO - 'XPC_FLAGS': '0x0', 15:08:23 INFO - 'XPC_SERVICE_NAME': '0', 15:08:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:23 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 15:08:23 INFO - Cleaning up... 15:08:24 INFO - Return code: 0 15:08:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08: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')]} 15:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08: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', '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 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:08: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 psutil>=0.7.1 15:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:24 INFO - 'HOME': '/Users/cltbld', 15:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:24 INFO - 'LOGNAME': 'cltbld', 15:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:24 INFO - 'MOZ_NO_REMOTE': '1', 15:08:24 INFO - 'NO_EM_RESTART': '1', 15:08:24 INFO - 'PAGER': '/bin/cat', 15:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:24 INFO - 'PWD': '/builds/slave/test', 15:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:24 INFO - 'SHELL': '/bin/bash', 15:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:24 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:24 INFO - 'USER': 'cltbld', 15:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:24 INFO - 'XPC_FLAGS': '0x0', 15:08:24 INFO - 'XPC_SERVICE_NAME': '0', 15:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:24 INFO - Downloading/unpacking psutil>=0.7.1 15:08: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 15:08: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 15:08: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 15:08: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 15:08: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 15:08: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 15:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:08:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:08:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:08:27 INFO - Installing collected packages: psutil 15:08:27 INFO - Running setup.py install for psutil 15:08:27 INFO - building 'psutil._psutil_osx' extension 15:08:27 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 15:08:27 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 15:08:28 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 15:08:28 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 15:08:28 INFO - building 'psutil._psutil_posix' extension 15:08:28 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 15:08:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:08:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:08:28 INFO - ^ 15:08:28 INFO - 1 warning generated. 15:08:28 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 15:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:08:28 INFO - Successfully installed psutil 15:08:28 INFO - Cleaning up... 15:08:28 INFO - Return code: 0 15:08:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:08:28 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')]} 15:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:28 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')]} 15:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:28 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 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08:28 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 15:08:28 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 15:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:28 INFO - 'HOME': '/Users/cltbld', 15:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:28 INFO - 'LOGNAME': 'cltbld', 15:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:28 INFO - 'MOZ_NO_REMOTE': '1', 15:08:28 INFO - 'NO_EM_RESTART': '1', 15:08:28 INFO - 'PAGER': '/bin/cat', 15:08:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:28 INFO - 'PWD': '/builds/slave/test', 15:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:28 INFO - 'SHELL': '/bin/bash', 15:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:28 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:28 INFO - 'USER': 'cltbld', 15:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:28 INFO - 'XPC_FLAGS': '0x0', 15:08:28 INFO - 'XPC_SERVICE_NAME': '0', 15:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:08: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 15:08: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 15:08: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 15:08: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 15:08: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 15:08: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 15:08:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:08:31 INFO - Installing collected packages: mozsystemmonitor 15:08:31 INFO - Running setup.py install for mozsystemmonitor 15:08:31 INFO - Successfully installed mozsystemmonitor 15:08:31 INFO - Cleaning up... 15:08:31 INFO - Return code: 0 15:08:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:31 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 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08:31 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 15:08:31 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 15:08:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:31 INFO - 'HOME': '/Users/cltbld', 15:08:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:31 INFO - 'LOGNAME': 'cltbld', 15:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:31 INFO - 'MOZ_NO_REMOTE': '1', 15:08:31 INFO - 'NO_EM_RESTART': '1', 15:08:31 INFO - 'PAGER': '/bin/cat', 15:08:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:31 INFO - 'PWD': '/builds/slave/test', 15:08:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:31 INFO - 'SHELL': '/bin/bash', 15:08:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:31 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:31 INFO - 'USER': 'cltbld', 15:08:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:31 INFO - 'XPC_FLAGS': '0x0', 15:08:31 INFO - 'XPC_SERVICE_NAME': '0', 15:08:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:31 INFO - Downloading/unpacking blobuploader==1.2.4 15:08: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 15:08: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 15:08: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 15:08: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 15:08: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 15:08: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 15:08:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:08:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:08:34 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 15:08:34 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 15:08:34 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 15:08:34 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 15:08:34 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 15:08:34 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 15:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:08:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:08:34 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 15:08:34 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 15:08:34 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 15:08:34 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 15:08:34 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 15:08:34 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 15:08:35 INFO - Downloading docopt-0.6.1.tar.gz 15:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:08:35 INFO - Installing collected packages: blobuploader, requests, docopt 15:08:35 INFO - Running setup.py install for blobuploader 15:08:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:08:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:08:35 INFO - Running setup.py install for requests 15:08:36 INFO - Running setup.py install for docopt 15:08:36 INFO - Successfully installed blobuploader requests docopt 15:08:36 INFO - Cleaning up... 15:08:36 INFO - Return code: 0 15:08:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:36 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 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08:36 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 15:08:36 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 15:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:36 INFO - 'HOME': '/Users/cltbld', 15:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:36 INFO - 'LOGNAME': 'cltbld', 15:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:36 INFO - 'MOZ_NO_REMOTE': '1', 15:08:36 INFO - 'NO_EM_RESTART': '1', 15:08:36 INFO - 'PAGER': '/bin/cat', 15:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:36 INFO - 'PWD': '/builds/slave/test', 15:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:36 INFO - 'SHELL': '/bin/bash', 15:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:36 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:36 INFO - 'USER': 'cltbld', 15:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:36 INFO - 'XPC_FLAGS': '0x0', 15:08:36 INFO - 'XPC_SERVICE_NAME': '0', 15:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:08:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-jhZFlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:08:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-JuzUan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:08:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-MLIATT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:08:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-VVIQ6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:08:36 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ruN5DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-jR6BLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Hvh0uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-sI06T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-rqhiU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-IeGeTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-WSVLb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-fTaVeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-bas5F9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-q61EMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:37 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-UjFP0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:08:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-3k98CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:08:38 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-9iP_MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:08:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:08:38 INFO - Running setup.py install for manifestparser 15:08:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:08:38 INFO - Running setup.py install for mozcrash 15:08:38 INFO - Running setup.py install for mozdebug 15:08:38 INFO - Running setup.py install for mozdevice 15:08:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:08:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:08:38 INFO - Running setup.py install for mozfile 15:08:39 INFO - Running setup.py install for mozhttpd 15:08:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:08:39 INFO - Running setup.py install for mozinfo 15:08:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:08:39 INFO - Running setup.py install for mozInstall 15:08:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:08:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:08:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:08:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:08:39 INFO - Running setup.py install for mozleak 15:08:39 INFO - Running setup.py install for mozlog 15:08:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:08:39 INFO - Running setup.py install for moznetwork 15:08:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:08:39 INFO - Running setup.py install for mozprocess 15:08:40 INFO - Running setup.py install for mozprofile 15:08:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:08:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:08:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:08:40 INFO - Running setup.py install for mozrunner 15:08:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:08:40 INFO - Running setup.py install for mozscreenshot 15:08:40 INFO - Running setup.py install for moztest 15:08:40 INFO - Running setup.py install for mozversion 15:08:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:08:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:08:40 INFO - Cleaning up... 15:08:40 INFO - Return code: 0 15:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08: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')]} 15:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:40 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 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08:40 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 15:08:40 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 15:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:40 INFO - 'HOME': '/Users/cltbld', 15:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:40 INFO - 'LOGNAME': 'cltbld', 15:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:40 INFO - 'MOZ_NO_REMOTE': '1', 15:08:40 INFO - 'NO_EM_RESTART': '1', 15:08:40 INFO - 'PAGER': '/bin/cat', 15:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:40 INFO - 'PWD': '/builds/slave/test', 15:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:40 INFO - 'SHELL': '/bin/bash', 15:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:40 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:40 INFO - 'USER': 'cltbld', 15:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:40 INFO - 'XPC_FLAGS': '0x0', 15:08:40 INFO - 'XPC_SERVICE_NAME': '0', 15:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-SXbkR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:08:41 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)) 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-pMOV3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:08:41 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)) 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-YM0cyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:08:41 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)) 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-RHUsG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:08:41 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)) 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-j2NymG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:08:41 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)) 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-TLOtDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:08:41 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)) 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-HayJpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:08:41 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)) 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-QAQ_zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:08:41 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)) 15:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:08:41 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-YxNTkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:08:42 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)) 15:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-KrOin3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:08:42 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)) 15:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-tHy0i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:08:42 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)) 15:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-Rt7MJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:08:42 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)) 15:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-0Tciem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:08:42 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)) 15:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-0eHjO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:08:42 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)) 15:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-XzuPBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:08:42 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)) 15:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-P0V_wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:08:42 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)) 15:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:08:42 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-9n2PfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:08:42 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)) 15:08:42 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)) 15:08:42 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)) 15:08:42 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)) 15:08:42 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)) 15:08:42 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)) 15:08:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:08:42 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 15:08:42 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 15:08:42 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 15:08:42 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 15:08:42 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 15:08:42 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 15:08:45 INFO - Downloading blessings-1.6.tar.gz 15:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:08:45 INFO - Installing collected packages: blessings 15:08:45 INFO - Running setup.py install for blessings 15:08:45 INFO - Successfully installed blessings 15:08:45 INFO - Cleaning up... 15:08:45 INFO - Return code: 0 15:08:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:08:45 INFO - Reading from file tmpfile_stdout 15:08:45 INFO - Current package versions: 15:08:45 INFO - blessings == 1.6 15:08:45 INFO - blobuploader == 1.2.4 15:08:45 INFO - docopt == 0.6.1 15:08:45 INFO - manifestparser == 1.1 15:08:45 INFO - mozInstall == 1.12 15:08:45 INFO - mozcrash == 0.17 15:08:45 INFO - mozdebug == 0.1 15:08:45 INFO - mozdevice == 0.48 15:08:45 INFO - mozfile == 1.2 15:08:45 INFO - mozhttpd == 0.7 15:08:45 INFO - mozinfo == 0.9 15:08:45 INFO - mozleak == 0.1 15:08:45 INFO - mozlog == 3.1 15:08:45 INFO - moznetwork == 0.27 15:08:45 INFO - mozprocess == 0.22 15:08:45 INFO - mozprofile == 0.28 15:08:45 INFO - mozrunner == 6.11 15:08:45 INFO - mozscreenshot == 0.1 15:08:45 INFO - mozsystemmonitor == 0.0 15:08:45 INFO - moztest == 0.7 15:08:45 INFO - mozversion == 1.4 15:08:45 INFO - psutil == 3.1.1 15:08:45 INFO - requests == 1.2.3 15:08:45 INFO - wsgiref == 0.1.2 15:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:45 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 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08:45 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 15:08:45 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 15:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:45 INFO - 'HOME': '/Users/cltbld', 15:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:45 INFO - 'LOGNAME': 'cltbld', 15:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:45 INFO - 'MOZ_NO_REMOTE': '1', 15:08:45 INFO - 'NO_EM_RESTART': '1', 15:08:45 INFO - 'PAGER': '/bin/cat', 15:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:45 INFO - 'PWD': '/builds/slave/test', 15:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:45 INFO - 'SHELL': '/bin/bash', 15:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:45 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:45 INFO - 'USER': 'cltbld', 15:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:45 INFO - 'XPC_FLAGS': '0x0', 15:08:45 INFO - 'XPC_SERVICE_NAME': '0', 15:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 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)) 15:08:46 INFO - Cleaning up... 15:08:46 INFO - Return code: 0 15:08:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:08: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')]} 15:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08: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')]} 15:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:46 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 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08:46 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 15:08:46 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 15:08:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:46 INFO - 'HOME': '/Users/cltbld', 15:08:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:46 INFO - 'LOGNAME': 'cltbld', 15:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:46 INFO - 'MOZ_NO_REMOTE': '1', 15:08:46 INFO - 'NO_EM_RESTART': '1', 15:08:46 INFO - 'PAGER': '/bin/cat', 15:08:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:46 INFO - 'PWD': '/builds/slave/test', 15:08:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:46 INFO - 'SHELL': '/bin/bash', 15:08:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:46 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:46 INFO - 'USER': 'cltbld', 15:08:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:46 INFO - 'XPC_FLAGS': '0x0', 15:08:46 INFO - 'XPC_SERVICE_NAME': '0', 15:08:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:46 INFO - Downloading/unpacking jsonschema 15:08:46 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 15:08:46 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 15:08:46 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 15:08:46 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 15:08:46 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 15:08:46 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 15:08:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:08:48 INFO - Downloading/unpacking functools32 (from jsonschema) 15:08:48 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 15:08:48 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 15:08:48 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 15:08:48 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 15:08:48 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 15:08:48 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 15:08:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:08:49 INFO - warning: no files found matching '*.txt' 15:08:49 INFO - no previously-included directories found matching 'build' 15:08:49 INFO - no previously-included directories found matching 'dist' 15:08:49 INFO - no previously-included directories found matching '.git*' 15:08:49 INFO - Installing collected packages: jsonschema, functools32 15:08:49 INFO - Running setup.py install for functools32 15:08:49 INFO - warning: no files found matching '*.txt' 15:08:49 INFO - no previously-included directories found matching 'build' 15:08:49 INFO - no previously-included directories found matching 'dist' 15:08:49 INFO - no previously-included directories found matching '.git*' 15:08:49 INFO - Successfully installed jsonschema functools32 15:08:49 INFO - Cleaning up... 15:08:49 INFO - Return code: 0 15:08:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:08:49 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 0x10e6c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e6d2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81e2598bd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, '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.X4w6kv60KI/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.t3qKoGuMqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 15:08:49 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 15:08:49 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 15:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:08:49 INFO - 'HOME': '/Users/cltbld', 15:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:08:49 INFO - 'LOGNAME': 'cltbld', 15:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:08:49 INFO - 'MOZ_NO_REMOTE': '1', 15:08:49 INFO - 'NO_EM_RESTART': '1', 15:08:49 INFO - 'PAGER': '/bin/cat', 15:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:08:49 INFO - 'PWD': '/builds/slave/test', 15:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:08:49 INFO - 'SHELL': '/bin/bash', 15:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:08:49 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:08:49 INFO - 'USER': 'cltbld', 15:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:08:49 INFO - 'XPC_FLAGS': '0x0', 15:08:49 INFO - 'XPC_SERVICE_NAME': '0', 15:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:08:49 INFO - Downloading/unpacking flake8 15:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:08:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:08:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:08:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:08:52 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 15:08:52 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 15:08:52 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 15:08:52 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 15:08:52 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 15:08:52 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 15:08:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:08:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:08:52 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 15:08:52 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 15:08:52 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 15:08:52 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 15:08:52 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 15:08:52 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 15:08:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:08:53 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 15:08:53 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 15:08:53 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 15:08:53 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 15:08:53 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 15:08:53 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 15:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:08:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:08:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:08:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:08:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:08:53 INFO - no previously-included directories found matching 'docs/_build' 15:08:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:08:53 INFO - Running setup.py install for pep8 15:08:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:08:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:08:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:08:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:08:53 INFO - no previously-included directories found matching 'docs/_build' 15:08:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:08:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:08:53 INFO - Cleaning up... 15:08:53 INFO - Return code: 0 15:08:53 INFO - Running post-action listener: _resource_record_post_action 15:08:53 INFO - Running post-action listener: _start_resource_monitoring 15:08:53 INFO - Starting resource monitoring. 15:08:53 INFO - ##### 15:08:53 INFO - ##### Running install step. 15:08:53 INFO - ##### 15:08:53 INFO - Running pre-action listener: _resource_record_pre_action 15:08:53 INFO - Running main action method: install 15:08:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:08:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:08:54 INFO - Reading from file tmpfile_stdout 15:08:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:08:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:08:54 INFO - Reading from file tmpfile_stdout 15:08:54 INFO - Output received: 15:08:54 INFO - Usage: mozinstall [options] installer 15:08:54 INFO - Options: 15:08:54 INFO - -h, --help show this help message and exit 15:08:54 INFO - -d DEST, --destination=DEST 15:08:54 INFO - Directory to install application into. [default: 15:08:54 INFO - "/builds/slave/test"] 15:08:54 INFO - --app=APP Application being installed. [default: firefox] 15:08:54 INFO - mkdir: /builds/slave/test/build/application 15:08:54 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'] 15:08:54 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 15:09:28 INFO - Reading from file tmpfile_stdout 15:09:28 INFO - Output received: 15:09:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:09:28 INFO - Running post-action listener: _resource_record_post_action 15:09:28 INFO - ##### 15:09:28 INFO - ##### Running run-tests step. 15:09:28 INFO - ##### 15:09:28 INFO - Running pre-action listener: _resource_record_pre_action 15:09:28 INFO - Running main action method: run_tests 15:09:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:09:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:09:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:09:28 INFO - 2016-03-31 15:09:28.573 screenresolution[6098:101515] starting screenresolution argv=screenresolution get 15:09:28 INFO - 2016-03-31 15:09:28.576 screenresolution[6098:101515] Display 0: 1600x1200x32@60 15:09:28 INFO - 2016-03-31 15:09:28.582 screenresolution[6099:101517] starting screenresolution argv=screenresolution list 15:09:28 INFO - Available Modes on Display 0 15:09:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:09:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:09:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:09:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:09:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:09:28 INFO - Intel Iris: 15:09:28 INFO - Chipset Model: Intel Iris 15:09:28 INFO - Type: GPU 15:09:28 INFO - Bus: Built-In 15:09:28 INFO - VRAM (Dynamic, Max): 1536 MB 15:09:28 INFO - Vendor: Intel (0x8086) 15:09:28 INFO - Device ID: 0x0a2e 15:09:28 INFO - Revision ID: 0x0009 15:09:28 INFO - Displays: 15:09:28 INFO - Display: 15:09:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:09:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:09:28 INFO - Display Serial Number: 1600x1200 60 15:09:28 INFO - Main Display: Yes 15:09:28 INFO - Mirror: Off 15:09:28 INFO - Online: Yes 15:09:28 INFO - Rotation: Supported 15:09:28 INFO - Return code: 0 15:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:09:28 INFO - Python 2.7.3 15:09:28 INFO - Return code: 0 15:09:28 INFO - grabbing minidump binary from tooltool 15:09:28 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')]} 15:09:28 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 0x10e561e00>, '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 0x10e3cadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:09:28 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 15:09:28 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 15:09:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:09:28 INFO - Return code: 0 15:09:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:09:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:09:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:09:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:09:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:09:30 INFO - Return code: 0 15:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X4w6kv60KI/Render', 15:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:09:30 INFO - 'HOME': '/Users/cltbld', 15:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:09:30 INFO - 'LOGNAME': 'cltbld', 15:09:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:09:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:09:30 INFO - 'MOZ_NO_REMOTE': '1', 15:09:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:09:30 INFO - 'NO_EM_RESTART': '1', 15:09:30 INFO - 'PAGER': '/bin/cat', 15:09:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:09:30 INFO - 'PWD': '/builds/slave/test', 15:09:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:09:30 INFO - 'SHELL': '/bin/bash', 15:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t3qKoGuMqD/Listeners', 15:09:30 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 15:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:09:30 INFO - 'USER': 'cltbld', 15:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:09:30 INFO - 'XPC_FLAGS': '0x0', 15:09:30 INFO - 'XPC_SERVICE_NAME': '0', 15:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:09:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:09:30 INFO - mozversion application_buildid: 20160331130540 15:09:30 INFO - mozversion application_changeset: bccb11375f2af838cda714d42fd8cef78f5c7bf1 15:09:30 INFO - mozversion application_display_name: Nightly 15:09:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:09:30 INFO - mozversion application_name: Firefox 15:09:30 INFO - mozversion application_remotingname: firefox 15:09:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:09:30 INFO - mozversion application_vendor: Mozilla 15:09:30 INFO - mozversion application_version: 48.0a1 15:09:30 INFO - mozversion platform_buildid: 20160331130540 15:09:30 INFO - mozversion platform_changeset: bccb11375f2af838cda714d42fd8cef78f5c7bf1 15:09:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:09:30 INFO - mozversion platform_version: 48.0a1 15:09:30 INFO - using testdate: 1459462170 15:09:30 INFO - actual date: 1459462170 15:09:30 INFO - starting webserver on 'localhost:56259' 15:09:30 INFO - SUITE-START | Running 2 tests 15:09:30 INFO - TEST-START | dromaeo_css 15:09:30 INFO - operating with platform_type : mac_ 15:09:30 INFO - Initialising browser for dromaeo_css test... 15:09:30 INFO - TEST-INFO | started process 6117 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpYn6KPt/profile http://localhost:56259/getInfo.html) 15:09:32 INFO - PROCESS | 6117 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:09:33 INFO - PROCESS | 6117 | __metrics Screen width/height:1600/1200 15:09:33 INFO - PROCESS | 6117 | colorDepth:24 15:09:33 INFO - PROCESS | 6117 | Browser inner width/height: 1024/689 15:09:33 INFO - PROCESS | 6117 | __metrics 15:09:33 ERROR - PROCESS | 6117 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 15:09:34 INFO - TEST-INFO | 6117: exit 0 15:09:34 INFO - Browser initialized. 15:09:34 INFO - Running cycle 1/1 for dromaeo_css test... 15:09:34 INFO - TEST-INFO | started process 6122 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpYn6KPt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:09:46 INFO - PROCESS | 6122 | RSS: Main: 254730240 15:09:46 INFO - PROCESS | 6122 | 15:10:35 INFO - PROCESS | 6122 | 1459462235968 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] 15:12:47 INFO - PROCESS | 6122 | Cycle 1(1): loaded http://localhost:56259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56259/tests/dromaeo/cssquery-ext.html) 15:12:48 INFO - PROCESS | 6122 | RSS: Main: 267165696 15:12:48 INFO - PROCESS | 6122 | 15:15:50 INFO - PROCESS | 6122 | Cycle 1(1): loaded http://localhost:56259/tests/dromaeo/cssquery-ext.html (next: http://localhost:56259/tests/dromaeo/cssquery-jquery.html) 15:15:51 INFO - PROCESS | 6122 | RSS: Main: 278917120 15:15:51 INFO - PROCESS | 6122 | 15:18:53 INFO - PROCESS | 6122 | Cycle 1(1): loaded http://localhost:56259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56259/tests/dromaeo/cssquery-mootools.html) 15:18:53 INFO - PROCESS | 6122 | RSS: Main: 280879104 15:18:53 INFO - PROCESS | 6122 | 15:21:55 INFO - PROCESS | 6122 | Cycle 1(1): loaded http://localhost:56259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56259/tests/dromaeo/cssquery-prototype.html) 15:21:56 INFO - PROCESS | 6122 | RSS: Main: 282386432 15:21:56 INFO - PROCESS | 6122 | 15:24:58 INFO - PROCESS | 6122 | Cycle 1(1): loaded http://localhost:56259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56259/tests/dromaeo/cssquery-yui.html) 15:24:59 INFO - PROCESS | 6122 | RSS: Main: 285274112 15:24:59 INFO - PROCESS | 6122 | 15:28:01 INFO - PROCESS | 6122 | Cycle 1(1): loaded http://localhost:56259/tests/dromaeo/cssquery-yui.html (next: http://localhost:56259/tests/dromaeo/cssquery-dojo.html) 15:28:02 INFO - PROCESS | 6122 | RSS: Main: 286212096 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - PROCESS | 6122 | __start_tp_report 15:28:02 INFO - PROCESS | 6122 | _x_x_mozilla_page_load 15:28:02 INFO - PROCESS | 6122 | _x_x_mozilla_page_load_details 15:28:02 INFO - PROCESS | 6122 | |i|pagename|runs| 15:28:02 INFO - PROCESS | 6122 | |0;dojo.html;3488.7034602058825;3508.5789705235375;3511.0871173494893;3525.68268855803;3566.090646885044;5842.737076831537;5904.0553511438175;5934.851628709284;5938.910916336258;5955.255593050869;5814.854628634286;5855.033919403304;5914.852128696774;5929.407059294069;6014.368491308415;5233.084210263199;5270.657407268515;5329.360476742796;5334.093204155303;5369.48989845964;422.0044903754084;5206.45332240115;5240.711760853152;5296.496832800878;5304.469553044703;5278.313819203518;5293.761780719877;5301.125314323132;5316.548093412064;5329.840104796843;4898.289747986558;5273.182656688219;5291.126964050927;5347.812826551052;5350.8127215547265;4713.316569097496;5159.871003224949;5247.737613119329;5302.257683924254;5313.654612450178;4792.400949881265;4832.9275060874115;5758.337791154029;5795.768169273224;5843.590948633555;6165.845853853644;6201.596896201732;6250.6874656267455;6254.249490061176;6275.246970363585;6230.781922632731;6245.906311405287;6277.309495955441;6290.937090629081;6308.842278943017;5939.910901336483;6042.9034200325295;6059.484943779784;6062.9090563641585;6083.8174854754425;6206.162168107338;6271.905921411182;6382.32985536512;6382.8723425531225;6384.201974753156;6176.629402235881;6256.217972753406;6256.812295631138;6259.4679452246155;6264.310925798159;6226.844328891723;6266.811995640138;6267.185265915493;6292.748290068346;6316.052592111128;6168.9691551541955;6173.382661733791;6198.6280823149855;6208.410201030895;6273.8745225095245;5505.788726480168;6197.4732147767045;6221.782237621752;6223.688815559204;6239.781607643801;4761.214399624093;4982.975085124551;5010.674306170087;5028.673136246132;5084.593232541388;4434.933475997863;4460;4492.213862574102;4535.750533720611;4543.931841022388;5825.271841019872;5941.376155503696;5987.13186587951;5994.1608174855555;5998.070299103646;6228.096925945712;6239.344868788802;6281.780137695158;6307.842303942438;6327.746890124436;5666.886662266732;5780.248567686174;5933.910991335133;5949.583529152917;5991.101334799728;5461.262729531462;5462.644928079662;5475.808346707846;5516.448355164532;5519.558435325164;6463.741450342028;6481.870362592722;6484.319146489551;6515.185601799775;6527.412532872159;6191.4118158774845;6216.937830621636;6250.9062364065485;6282.560220784684;6284.4344009039405;6480.384363485461;6505.251896032017;6507.7722279721875;6536.379043990813;6555.410013098844;6226.564140510302;6232.8130156095385;6242.157308763259;6250.249970003629;6252.781152659635;5489.655034516569;5820.417958204315;6139.829471381233;6223.253209614694;6332.366763323631;6108.297545782292;6167.907481387872;6173.506119510518;6182.165407669907;6220.564560480723;6108.251008765693;6197.752089916533;6224.657643829451;6240.5319601031015;6265.27949285838;6083.8174854754425;6103.389661033861;6147.723352449061;6165.537584681257;6169.321374648695;6159.4456498915315;6212.875742485216;6216;6222.906656400248;6259.1550140730415;5971.790987315423;6127.84680382994;6160.815175544741;6174.722137503733;6184.196054512884 15:28:02 INFO - PROCESS | 6122 | |1;ext.html;420.91160856220193;539.670800811505;555.1312196412616;587.0196771391775;617.5522746009144;32854.835725821365;38981.415278770844;39022.414663780066;39082.82751517452;39171;29136.708632913665;32033;37454.62545374545;40719.18561628766;41244.38133428001;8113.594320283992;9301.116393942582;9477.194438472738;9497.145256926875;9558.33091683579;9391.718248452524;9571.904280957171;9579.233661307078;9598.472084035375;9618.422894626345;9535.713928582154;9575.61697532098;9577.760555986086;9649.565769540352;9655.517224138765;8247.670093196295;9533.14201721845;9548;9555.331126821126;9608.759781005461;9439.575219115157;9440.527973601293;9560.521973901277;9576.61693532258;9579;39530.802345988086;39621;39831.60168398308;39949.40075898864;39987.20057597415;2825.491411545921;3103.20868178613;3131.8908318027143;3242.691944265291;3386.745994050456;27611.585826212624;27958.720412795814;27972.440551189065;28136.718632813616;28226.43547129046;2727.5499542575453;2740.780737540992;2762.2265765585666;2807.90172343969;2867.0968644877007;348841;350859.2457037724;353561.2321938374;353949;354877;50258;51397.972040558976;52294.21558676623;62833.37166628275;63604.68197659075;64472.355276447575;68538.65730671414;70294.64852675704;75488.62255688687;76393.47213055707;16830.410935617194;17140.40008599693;17146.91426542884;17253.827461725472;17415.129243537773;13043;13063.934680326538;13074.411651475706;13077.346132693518;13084.476620935246;21909.671354929687;22089.005994730276;22166.88916555407;22283.22008729719;22294.888525557268;8709.82254436391;8972.564389697616;8978.46129232235;8982.664507228037;8988;831.9533550824507;905.8414777413926;1009.7273736091214;1015.263933648114;1035.3115178406276;29674.40651186964;30091;30660.69339306623;30741.538876916864;30798.84600576983;1021.8402113601117;1096.7477480179602;1099.4722533184117;1153.4463457540428;1235.8208059831275;15209.847901520843;15280.235988200546;15298.617534561725;15463.845361546466;15716.528504144893;549913;554360;554364.7381157144;556640;556898;60376;61463.385366146664;62310.75378492405;62419.375806242264;62604;1442.5167568864338;1455.505128256398;1466.875315598186;1469.5224052183082;1469.955901322962;29331.266718332212;30106.69893301039;30114.84942575273;30147.455538120863;30183.245418864703;54327.72836135794;54726.726366369505;54808.985505797566;54879;55251;489109;491201;494133;497436;498618;33995.66004339925;34288.97133086011;34300.799472018356;34425.827870860485;34578.82710586431;52070.47929520656;52268;53059.6735081626;53376.199357008896;53795.65510862103;39212.60787392204;39292.80353598328;39397;39569.80215098906;39824.80087599543;40256.99357516086;40620;40655.39016914808;40679;41319.38020929629;35350.762723304564;39856.6050188242;40882.591174089066;41100.383494248206;41519;29988.700112999464;32060.6793932067;32111.839440802647;32184.517232241065;32268.515972259964;25598.360040998377;26042.86978565171;26168;26359;26729.732702672725 15:28:02 INFO - PROCESS | 6122 | |2;jquery.html;298.5894395206591;362.23929747530207;366.6333666333666;372.75584492157645;373.3895081541682;18544.443666690004;19543.804561954377;19956.501087472803;19982.300619478323;20010.399688009384;16550.50348489547;19413.61172776547;20008.399748007545;20654;20672.966351682393;5696.259486266779;5880.500157486619;5897.852553686149;5917.792877249297;5927.407259274081;5510.393856675762;5848.783169256892;5907.202527658754;5939.7921072762465;5970.761169553212;5725.227094342252;5798.420157984189;5830.096335068071;5837.211976383198;5853.473187413132;5720.399358067426;5753.309602847643;5793;5815.941840581603;5817.18559401682;4878.0975519529;4920.581750551208;4944.653874228806;5011.774470148815;5050.217216331474;19639;24027.27918162458;24063.518729625484;24391.390215244584;24466.266012019667;2238.0712004518105;2297.0122847175708;2339.5320935812906;2540.8094392920607;2596.039465397815;14363.994520383578;14414.351354189086;14674.55976320712;14848;14958.626034349229;1717.776689030418;1737.695903216932;1771.8405343519146;1793.7757780277466;1801.0634470075618;89937.55031224867;90037.64943525853;99274.5036274814;101492.9850701491;103120.48439757753;9027.774305642411;10679.51942162589;10692.679219623424;10771.89947960156;10914.399708015977;13483.123596966167;13529.526466573623;13536.59390218295;13536.932315338361;13564.253966031964;8331.916680833236;8406.075331713506;8497.192766687154;8545.359098067669;8588.828223435496;8627.22354988054;8690.826183476422;8711.303095752324;8765.167309105625;8821.514816685143;4325.675574331937;4359.12817436514;4375.934360984587;4382.758948257876;4413.3821265022925;1559.8067478379048;1830.6521760865394;1863.8136186381253;1874.8593855460895;1880.7743070831589;723.6960476599841;853.3727710133047;894.9015608283083;966.7728083900278;1019.7195771162841;16674.33302667904;18842.71735923962;18970;19905;20366.796332036785;961.9470929098967;977.2133432586694;1001.5993602559034;1002.4035698759227;1043.5773511727762;8175.83648327042;9666.323357365058;10210.795784084425;10522.579096836194;10585.100266477282;565725.1713741405;571710;587917;597855;612691;107585;112208.99999999837;118462;118994;119404;1032.514718082515;1039.2413538117216;1055.3087727538475;1061.7823346214007;1068.3589846092439;17383.130843458028;17764.822351776318;17782.288708452033;17910.462686119437;18253.726194106832;48407;50401.74799125981;51006.48993510166;51277.71805704887;51735.74132129315;67937;67999.64000719858;68110.29724256735;68962.96555551571;70267.64866175636;6949.783787837209;7459.589722565311;7824.882626760489;7861.449698521049;7965.761027169194;8734.388592798443;10630.893691062991;12263.509459621515;12531.686707832012;12703.618891433272;6179.752809887734;6886.793396198122;7512.436567257369;7524.849503009799;8293.792655183428;6311.27420346666;7520.721477348754;8115.188481151838;8348.415610907177;8578;6931.584104953719;8074.59627018635;8214.958925205336;8292.12932642064;8329.416940814084;11512.079033677453;11595.942020289845;11611.6516504505;11900.702482438008;11930.105242106703;11713.648590542298;11751.236169648946;11819.822702659296;11951;11998.64004079879 15:28:02 INFO - PROCESS | 6122 | |3;mootools.html;1457.9562613121607;1612.3631165689549;1825.9178336974835;1914.865959382843;1970.320239517366;8063.758087257392;8296.548104081792;8755.29957603391;9070.86393704095;9115.772105697353;7312.524685895413;8730.257928076122;8878.955605221965;8895.88801399825;8903.554822258877;2487.751224877507;2491.5390652729257;2499.9375015624664;2505.711843138035;2515.9119430819924;2451.914183003595;2479.603263477844;2505.649209110726;2515.4843257132334;2525.3434107132184;2209.7016902718087;2511.8869650865754;2521.5461216980934;2531.3291977625945;2540.3776074861685;2478.330850670318;2508.7114981777145;2525.734797846218;2526.633638122462;2531.139412599716;2428.441458464563;2433.9634905476432;2461.6676748638884;2466.48203877186;2539.174768200324;8977.6857809977;8978.640854365818;8990.190882820578;9034.503102329369;9039.593218305192;5549.528290095306;5551;5589.888202235932;5675.489205971482;5738.913916291259;3207.6471588125287;3634.618365071682;3704.1480459494196;3708.2583483303447;3757.5490941086973;922.4096578189964;1053.9262251642388;1061.2040969273046;1071.608862765093;1084.1218612923558;11982.520699172022;12260.632181034583;12262.386880655931;12265.877341226562;12319.199252048498;4276.850310239127;4898.118338699069;4938.333325001079;5016.021875734197;5032.572231360302;10175.28772985884;10230.6419275325;10293.330933489298;10299.639512617023;10306.948465257627;4803.3995750531185;5560.110382338888;5598.888022239533;5624.3813180550105;5649.604527683105;3875.903102422462;4563.201439748097;5030.84907452777;5034.496550345009;5067.670601410897;3939.5666476688116;3997.920561448451;4014.217227640582;4024.396340548941;4050.2911990401562;1337.5452346202144;1348.0630961481872;1348.4403972351365;1355.0785465883293;1361.2104979112091;1127.8872112788656;1334.9799753003713;1363.12078709232;1388.0977364712815;1390.2284232251197;8189.017317921887;8236.876446853303;8348.624311905978;8350.248477637042;8357;511.6597462687346;518.2252532463915;521.7260938007577;524.4152769661799;525.4377815737124;6050.273967123973;6056.273247210275;6164.660943648053;6233.875322493524;6292.590981586274;10362.689119326433;10553.050225479743;10609.893901061045;10621.628243011457;10633.202509811796;10390.688279351632;10491.318064325795;10516.526756295985;10578.894211057945;10639.095676867399;8267.793305167299;8410.32717382608;8440.15598440151;8468.28019618327;8520.403571750043;6701.832454188684;8004.51972881629;8132.471389359673;8159.755207343789;8258.380621453534;9389.624415023323;9462.290328225274;9561.521923903916;9635.855462168212;9637;9725.416475011521;9904.504774761377;9909.166804141258;9965.551550180115;9994.350367226107;6883.621400823003;7211.639418029183;7484.438667100098;7554.320111190019;7560.395168386626;8140.104588495379;8146.470479418819;8172.141925097779;8211.055728591049;8225.177482251727;7015.158181018106;7286.089238845145;7307.2327405621645;7337.853242935004;7526.09686837583;5925.881482370414;7290.817729556804;7339.045924029842;7360.411167106511;7443.627818609156;7709.4603377763015;7744.341730952932;7756.534607923542;7776.572288524186;7818.257265559762;6989.650517474208;7021.613811240227;7084.645767711697;7086.858262834818;7093.538919970186;7132.393746531396;7176.856462870818;7203.171635261802;7210.567365958059;7254.600996945219 15:28:02 INFO - PROCESS | 6122 | |4;prototype.html;327.7083395777758;328.85694722795586;333.30006985330823;338.4821223528002;339.7723525238089;6829.590224586522;6834.589924604521;6870.38166565009;6883.827904302395;6900.75847345343;6778.322167783219;6791.3887750102485;6804.353586409283;6809;6828.078209441724;4261.657577862963;4373.715708478954;4761.785719642625;4831.396075490564;4986.825461108862;4918.336024636682;4952.217201807346;4956.727379994099;4963.106640804654;4995.250712393134;3797.753146045512;4879.46325904152;4886.755662216893;4983.900321993558;4987.725675087869;4955.801767929296;4957.033378491195;4972.552470277675;4975.328330675385;4976.576990955773;3572.6427357264324;3858.4791053207737;4265.786710664454;4276.102018576103;4299.398084268205;6342.904856427157;6356;6505.60966342021;6530.249021362509;6549.083128362033;5249.580033597341;5260.947390526122;5883.970580147072;5923.703814809242;5947.464728174442;7289.489735718502;7293.234210407937;7306.598137102457;7323.084614423197;7325.267473252686;4136.296829538986;4354.368616550582;4828.879278018043;4845.2732090186755;4845.685030473008;7734.3039126478325;7746.186650401683;7755.418343624251;7766.728164514271;7774.65014074368;4707.741074240881;4895.192293271571;4916.0905232532095;4920.532549407801;4934.6545741798445;4982.10322142018;5013.89972200554;5018.197088465828;5021;5030.673006254582;5847.006008978484;5894.616849904743;5901.3508514063415;5909.940900591025;5911.231539899872;7354.852902941911;7356.632168391666;7361.411087113018;7374.00450939127;7384.96307518459;1730;1749.5101371615713;1752.9123543823014;1757.1302205408404;1760.9471715848545;1063.3247887591435;1119.4067144413473;1120.0703416164563;1127.8646562412398;1135.2677522997785;6726.7981960541265;6744.426723728538;6761.628110453972;6763.019362192553;6790.1296261131665;6799.5920244785475;6938.930610693828;7595.392368610498;7638.923610763822;7645.541267523855;6530.216374035146;6628.96685516579;6807.217170025411;6841.760538381132;6844;4033.193361327746;4056.817443215062;4062.857799977046;4063.532693740258;4064.309067458539;8002.999250187453;8004.399670024772;8032.638531266107;8049;8052.315553177928;7697.615119244016;7879.606019698992;7950.324222441157;7952.642131104114;7960.203979602109;6894.24163342032;7691.961540192263;7967.521948683097;8000.4399692021;8037.67849286022;6419.261784894797;6443.67781610927;7444.441666874898;7696.8460630788195;7704.807379815549;7373.373263272468;7575.053118360205;7577.583232922242;7589.962050189934;7606.923930760621;6657.73369065232;7642.235776422313;7972.362211022988;8032.236937490929;8034.437589368688;4912.287718280758;4916.06594746997;4948.208286674115;4949.208126699711;4963.627727920348;7660.616969151632;7676.53940763556;7684.6157692116285;7686.385089192963;7690.115636701851;5958.702064896825;7323.450741194325;7325.205324695484;7325.890111648223;7356.97002419651;6989.161300643956;7274.8908766369605;7278.818029549304;7310.378617817332;7315.670794814139;5333.333333333333;6269.811905642656;6390.456811171102;6677.666116694243;7216.7474138404905;7377.299156580117;7387.593682347308;7395.482316237812;7410.703571857065;7425.591592462466;5834.416558344132;7140.7857764267155;7180.676869540779;7201.531900426456;7222.169450513258 15:28:02 INFO - PROCESS | 6122 | |5;yui.html;736.4071922102709;746.2872956326709;764.7896828372197;764.9426293028023;802.7270727952495;16059.598510037255;17538.03540805255;17941.551461213476;17957.910210448947;17998.280068797234;16234.350625974976;16316.347346106171;16352.182390880438;16359;16406;744.2817680937894;763.1452772894366;924.2005665099691;944.3106532231475;946.2808265718035;897.3808072430035;902.6434558349448;903.408267584733;929.0802105915129;940.0740270833223;950.7813202963288;955.9187469065138;961.9470929098896;988.9851652225186;993.6323560282706;944.117250370902;969.2100937735722;982.3172894838019;986.0583143098396;987.6148302162198;707.9823004424879;712.618748969299;717.0212659719498;737.1080991999687;737.6090671943824;15407.460738874086;15480.303386347641;15654.217289135611;15679.216039198109;15697.529074127795;12390.56633017849;12441.066919980947;12455.564055258023;12674;12766.553170638983;9432.717018489457;10012;10043.497825108716;10094.242931780145;10789.946050269777;3576.0523461282783;3576.2311103112697;3646.4894914711963;3667;3685.005048636853;62447.063294050626;71910.64044679744;72402;75463.62268188679;76809.23190768076;9287.76780580491;9292.814143717223;9347.158755712018;9387.10822471864;9481.051894810602;20716;20813.479663008242;20832.47918802042;20953.580928381347;21537.461563460725;7542;7556.65995030225;7574.886376704354;7649;7750;4095.3037983542868;4123.299039163289;4129.91740165195;4144.7513149211145;4148.398482220061;3616.9095772605897;3628.8911332660064;3640.344737947195;3643.8360273787744;3648.325059863934;557.2950217974266;585.850608094933;588.632104934416;595.1994567306965;600.0938582740093;496.81866118866355;518.4815184815185;531.6920375875312;589.4459208344143;593.6230493636572;7932.16712245206;8241.175882411711;8338;8380.832383352421;8461.746147615582;563.5885803363567;567.29088639201;569.4305694305694;582.5543459253674;597.1520440973827;3796.7532110413285;3834.386498160337;3839.0594304395045;3922.431247469101;3993.1432874567327;90702;91200;93057.0694293062;93241;93506.59740103903;77515.83726244111;78179.82730259051;78762;79525.60237198777;80243.59878200572;68606;69547.65226173837;70337.64831175811;71193.57612847818;72035;6262.68686565679;6786.59280443175;7058.470614704021;7707.460477766503;7960.681572737258;42162;49313.50686493089;50033.749831250614;50289.74855125701;50314.74842625763;51668.22497662463;66861;67336.326636733;67663;68297.3170268291;9821.312508124649;9856.21150307988;10002.649907253211;10243.539040743035;10296.897031029894;9145.445274303518;10946.671599852018;11015.559377624806;11384.430778460877;11404.771904562029;10274.178065754571;10292.073713365533;10306.639267625596;10445.529951152064;10625.574977000833;9007.414518056305;9028.954855225944;9210.447373157633;9236.72289831306;9440.244780417688;10122;10211.285210035227;10217.948910255698;10225.335353202017;10599.576016959236;8573.74278771638;8796.252318552739;8824.647014119364;8848.07095254989;8978;8682.78293042679;8849.24781393563;8890.688825891062;8927.821443571222;9006.63973441055 15:28:02 INFO - PROCESS | 6122 | __end_tp_report 15:28:02 INFO - PROCESS | 6122 | __start_cc_report 15:28:02 INFO - PROCESS | 6122 | _x_x_mozilla_cycle_collect,387 15:28:02 INFO - PROCESS | 6122 | __end_cc_report 15:28:02 INFO - PROCESS | 6122 | __startTimestamp1459463282066__endTimestamp 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - PROCESS | 6122 | ------- Summary: start ------- 15:28:02 INFO - PROCESS | 6122 | Number of tests: 6 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - PROCESS | 6122 | [#0] dojo.html Cycles:165 Average:5790.49 Median:6108.30 stddev:770.20 (12.6%) stddev-sans-first:751.10 15:28:02 INFO - PROCESS | 6122 | Values: 3488.7 3508.6 3511.1 3525.7 3566.1 5842.7 5904.1 5934.9 5938.9 5955.3 5814.9 5855.0 5914.9 5929.4 6014.4 5233.1 5270.7 5329.4 5334.1 5369.5 422.0 5206.5 5240.7 5296.5 5304.5 5278.3 5293.8 5301.1 5316.5 5329.8 4898.3 5273.2 5291.1 5347.8 5350.8 4713.3 5159.9 5247.7 5302.3 5313.7 4792.4 4832.9 5758.3 5795.8 5843.6 6165.8 6201.6 6250.7 6254.2 6275.2 6230.8 6245.9 6277.3 6290.9 6308.8 5939.9 6042.9 6059.5 6062.9 6083.8 6206.2 6271.9 6382.3 6382.9 6384.2 6176.6 6256.2 6256.8 6259.5 6264.3 6226.8 6266.8 6267.2 6292.7 6316.1 6169.0 6173.4 6198.6 6208.4 6273.9 5505.8 6197.5 6221.8 6223.7 6239.8 4761.2 4983.0 5010.7 5028.7 5084.6 4434.9 4460.0 4492.2 4535.8 4543.9 5825.3 5941.4 5987.1 5994.2 5998.1 6228.1 6239.3 6281.8 6307.8 6327.7 5666.9 5780.2 5933.9 5949.6 5991.1 5461.3 5462.6 5475.8 5516.4 5519.6 6463.7 6481.9 6484.3 6515.2 6527.4 6191.4 6216.9 6250.9 6282.6 6284.4 6480.4 6505.3 6507.8 6536.4 6555.4 6226.6 6232.8 6242.2 6250.2 6252.8 5489.7 5820.4 6139.8 6223.3 6332.4 6108.3 6167.9 6173.5 6182.2 6220.6 6108.3 6197.8 6224.7 6240.5 6265.3 6083.8 6103.4 6147.7 6165.5 6169.3 6159.4 6212.9 6216.0 6222.9 6259.2 5971.8 6127.8 6160.8 6174.7 6184.2 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - PROCESS | 6122 | [#1] ext.html Cycles:180 Average:62379.88 Median:39550.30 stddev:126170.99 (319.0%) stddev-sans-first:126439.18 15:28:02 INFO - PROCESS | 6122 | Values: 420.9 539.7 555.1 587.0 617.6 32854.8 38981.4 39022.4 39082.8 39171.0 29136.7 32033.0 37454.6 40719.2 41244.4 8113.6 9301.1 9477.2 9497.1 9558.3 9391.7 9571.9 9579.2 9598.5 9618.4 9535.7 9575.6 9577.8 9649.6 9655.5 8247.7 9533.1 9548.0 9555.3 9608.8 9439.6 9440.5 9560.5 9576.6 9579.0 39530.8 39621.0 39831.6 39949.4 39987.2 2825.5 3103.2 3131.9 3242.7 3386.7 27611.6 27958.7 27972.4 28136.7 28226.4 2727.5 2740.8 2762.2 2807.9 2867.1 348841.0 350859.2 353561.2 353949.0 354877.0 50258.0 51398.0 52294.2 62833.4 63604.7 64472.4 68538.7 70294.6 75488.6 76393.5 16830.4 17140.4 17146.9 17253.8 17415.1 13043.0 13063.9 13074.4 13077.3 13084.5 21909.7 22089.0 22166.9 22283.2 22294.9 8709.8 8972.6 8978.5 8982.7 8988.0 832.0 905.8 1009.7 1015.3 1035.3 29674.4 30091.0 30660.7 30741.5 30798.8 1021.8 1096.7 1099.5 1153.4 1235.8 15209.8 15280.2 15298.6 15463.8 15716.5 549913.0 554360.0 554364.7 556640.0 556898.0 60376.0 61463.4 62310.8 62419.4 62604.0 1442.5 1455.5 1466.9 1469.5 1470.0 29331.3 30106.7 30114.8 30147.5 30183.2 54327.7 54726.7 54809.0 54879.0 55251.0 489109.0 491201.0 494133.0 497436.0 498618.0 33995.7 34289.0 34300.8 34425.8 34578.8 52070.5 52268.0 53059.7 53376.2 53795.7 39212.6 39292.8 39397.0 39569.8 39824.8 40257.0 40620.0 40655.4 40679.0 41319.4 35350.8 39856.6 40882.6 41100.4 41519.0 29988.7 32060.7 32111.8 32184.5 32268.5 25598.4 26042.9 26168.0 26359.0 26729.7 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - PROCESS | 6122 | [#2] jquery.html Cycles:180 Average:33076.05 Median:373.07 stddev:97348.15 (26093.6%) stddev-sans-first:97590.12 15:28:02 INFO - PROCESS | 6122 | Values: 298.6 362.2 366.6 372.8 373.4 18544.4 19543.8 19956.5 19982.3 20010.4 16550.5 19413.6 20008.4 20654.0 20673.0 5696.3 5880.5 5897.9 5917.8 5927.4 5510.4 5848.8 5907.2 5939.8 5970.8 5725.2 5798.4 5830.1 5837.2 5853.5 5720.4 5753.3 5793.0 5815.9 5817.2 4878.1 4920.6 4944.7 5011.8 5050.2 19639.0 24027.3 24063.5 24391.4 24466.3 2238.1 2297.0 2339.5 2540.8 2596.0 14364.0 14414.4 14674.6 14848.0 14958.6 1717.8 1737.7 1771.8 1793.8 1801.1 89937.6 90037.6 99274.5 101493.0 103120.5 9027.8 10679.5 10692.7 10771.9 10914.4 13483.1 13529.5 13536.6 13536.9 13564.3 8331.9 8406.1 8497.2 8545.4 8588.8 8627.2 8690.8 8711.3 8765.2 8821.5 4325.7 4359.1 4375.9 4382.8 4413.4 1559.8 1830.7 1863.8 1874.9 1880.8 723.7 853.4 894.9 966.8 1019.7 16674.3 18842.7 18970.0 19905.0 20366.8 961.9 977.2 1001.6 1002.4 1043.6 8175.8 9666.3 10210.8 10522.6 10585.1 565725.2 571710.0 587917.0 597855.0 612691.0 107585.0 112209.0 118462.0 118994.0 119404.0 1032.5 1039.2 1055.3 1061.8 1068.4 17383.1 17764.8 17782.3 17910.5 18253.7 48407.0 50401.7 51006.5 51277.7 51735.7 67937.0 67999.6 68110.3 68963.0 70267.6 6949.8 7459.6 7824.9 7861.4 7965.8 8734.4 10630.9 12263.5 12531.7 12703.6 6179.8 6886.8 7512.4 7524.8 8293.8 6311.3 7520.7 8115.2 8348.4 8578.0 6931.6 8074.6 8215.0 8292.1 8329.4 11512.1 11595.9 11611.7 11900.7 11930.1 11713.6 11751.2 11819.8 11951.0 11998.6 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - PROCESS | 6122 | [#3] mootools.html Cycles:180 Average:6068.81 Median:5550.26 stddev:3217.96 (58.0%) stddev-sans-first:3208.33 15:28:02 INFO - PROCESS | 6122 | Values: 1458.0 1612.4 1825.9 1914.9 1970.3 8063.8 8296.5 8755.3 9070.9 9115.8 7312.5 8730.3 8879.0 8895.9 8903.6 2487.8 2491.5 2499.9 2505.7 2515.9 2451.9 2479.6 2505.6 2515.5 2525.3 2209.7 2511.9 2521.5 2531.3 2540.4 2478.3 2508.7 2525.7 2526.6 2531.1 2428.4 2434.0 2461.7 2466.5 2539.2 8977.7 8978.6 8990.2 9034.5 9039.6 5549.5 5551.0 5589.9 5675.5 5738.9 3207.6 3634.6 3704.1 3708.3 3757.5 922.4 1053.9 1061.2 1071.6 1084.1 11982.5 12260.6 12262.4 12265.9 12319.2 4276.9 4898.1 4938.3 5016.0 5032.6 10175.3 10230.6 10293.3 10299.6 10306.9 4803.4 5560.1 5598.9 5624.4 5649.6 3875.9 4563.2 5030.8 5034.5 5067.7 3939.6 3997.9 4014.2 4024.4 4050.3 1337.5 1348.1 1348.4 1355.1 1361.2 1127.9 1335.0 1363.1 1388.1 1390.2 8189.0 8236.9 8348.6 8350.2 8357.0 511.7 518.2 521.7 524.4 525.4 6050.3 6056.3 6164.7 6233.9 6292.6 10362.7 10553.1 10609.9 10621.6 10633.2 10390.7 10491.3 10516.5 10578.9 10639.1 8267.8 8410.3 8440.2 8468.3 8520.4 6701.8 8004.5 8132.5 8159.8 8258.4 9389.6 9462.3 9561.5 9635.9 9637.0 9725.4 9904.5 9909.2 9965.6 9994.4 6883.6 7211.6 7484.4 7554.3 7560.4 8140.1 8146.5 8172.1 8211.1 8225.2 7015.2 7286.1 7307.2 7337.9 7526.1 5925.9 7290.8 7339.0 7360.4 7443.6 7709.5 7744.3 7756.5 7776.6 7818.3 6989.7 7021.6 7084.6 7086.9 7093.5 7132.4 7176.9 7203.2 7210.6 7254.6 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - PROCESS | 6122 | [#4] prototype.html Cycles:180 Average:5932.58 Median:6702.23 stddev:1918.36 (28.6%) stddev-sans-first:1877.05 15:28:02 INFO - PROCESS | 6122 | Values: 327.7 328.9 333.3 338.5 339.8 6829.6 6834.6 6870.4 6883.8 6900.8 6778.3 6791.4 6804.4 6809.0 6828.1 4261.7 4373.7 4761.8 4831.4 4986.8 4918.3 4952.2 4956.7 4963.1 4995.3 3797.8 4879.5 4886.8 4983.9 4987.7 4955.8 4957.0 4972.6 4975.3 4976.6 3572.6 3858.5 4265.8 4276.1 4299.4 6342.9 6356.0 6505.6 6530.2 6549.1 5249.6 5260.9 5884.0 5923.7 5947.5 7289.5 7293.2 7306.6 7323.1 7325.3 4136.3 4354.4 4828.9 4845.3 4845.7 7734.3 7746.2 7755.4 7766.7 7774.7 4707.7 4895.2 4916.1 4920.5 4934.7 4982.1 5013.9 5018.2 5021.0 5030.7 5847.0 5894.6 5901.4 5909.9 5911.2 7354.9 7356.6 7361.4 7374.0 7385.0 1730.0 1749.5 1752.9 1757.1 1760.9 1063.3 1119.4 1120.1 1127.9 1135.3 6726.8 6744.4 6761.6 6763.0 6790.1 6799.6 6938.9 7595.4 7638.9 7645.5 6530.2 6629.0 6807.2 6841.8 6844.0 4033.2 4056.8 4062.9 4063.5 4064.3 8003.0 8004.4 8032.6 8049.0 8052.3 7697.6 7879.6 7950.3 7952.6 7960.2 6894.2 7692.0 7967.5 8000.4 8037.7 6419.3 6443.7 7444.4 7696.8 7704.8 7373.4 7575.1 7577.6 7590.0 7606.9 6657.7 7642.2 7972.4 8032.2 8034.4 4912.3 4916.1 4948.2 4949.2 4963.6 7660.6 7676.5 7684.6 7686.4 7690.1 5958.7 7323.5 7325.2 7325.9 7357.0 6989.2 7274.9 7278.8 7310.4 7315.7 5333.3 6269.8 6390.5 6677.7 7216.7 7377.3 7387.6 7395.5 7410.7 7425.6 5834.4 7140.8 7180.7 7201.5 7222.2 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - PROCESS | 6122 | [#5] yui.html Cycles:180 Average:17835.19 Median:67499.66 stddev:25058.96 (37.1%) stddev-sans-first:25096.36 15:28:02 INFO - PROCESS | 6122 | Values: 736.4 746.3 764.8 764.9 802.7 16059.6 17538.0 17941.6 17957.9 17998.3 16234.4 16316.3 16352.2 16359.0 16406.0 744.3 763.1 924.2 944.3 946.3 897.4 902.6 903.4 929.1 940.1 950.8 955.9 961.9 989.0 993.6 944.1 969.2 982.3 986.1 987.6 708.0 712.6 717.0 737.1 737.6 15407.5 15480.3 15654.2 15679.2 15697.5 12390.6 12441.1 12455.6 12674.0 12766.6 9432.7 10012.0 10043.5 10094.2 10789.9 3576.1 3576.2 3646.5 3667.0 3685.0 62447.1 71910.6 72402.0 75463.6 76809.2 9287.8 9292.8 9347.2 9387.1 9481.1 20716.0 20813.5 20832.5 20953.6 21537.5 7542.0 7556.7 7574.9 7649.0 7750.0 4095.3 4123.3 4129.9 4144.8 4148.4 3616.9 3628.9 3640.3 3643.8 3648.3 557.3 585.9 588.6 595.2 600.1 496.8 518.5 531.7 589.4 593.6 7932.2 8241.2 8338.0 8380.8 8461.7 563.6 567.3 569.4 582.6 597.2 3796.8 3834.4 3839.1 3922.4 3993.1 90702.0 91200.0 93057.1 93241.0 93506.6 77515.8 78179.8 78762.0 79525.6 80243.6 68606.0 69547.7 70337.6 71193.6 72035.0 6262.7 6786.6 7058.5 7707.5 7960.7 42162.0 49313.5 50033.7 50289.7 50314.7 51668.2 66861.0 67336.3 67663.0 68297.3 9821.3 9856.2 10002.6 10243.5 10296.9 9145.4 10946.7 11015.6 11384.4 11404.8 10274.2 10292.1 10306.6 10445.5 10625.6 9007.4 9029.0 9210.4 9236.7 9440.2 10122.0 10211.3 10217.9 10225.3 10599.6 8573.7 8796.3 8824.6 8848.1 8978.0 8682.8 8849.2 8890.7 8927.8 9006.6 15:28:02 INFO - PROCESS | 6122 | -------- Summary: end -------- 15:28:02 INFO - PROCESS | 6122 | 15:28:02 INFO - TEST-INFO | 6122: exit 0 15:28:02 INFO - TEST-OK | dromaeo_css | took 1112238ms 15:28:02 INFO - TEST-START | kraken 15:28:02 INFO - operating with platform_type : mac_ 15:28:02 INFO - Initialising browser for kraken test... 15:28:02 INFO - TEST-INFO | started process 6128 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpV0Hlal/profile http://localhost:56259/getInfo.html) 15:28:04 INFO - PROCESS | 6128 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:28:05 INFO - PROCESS | 6128 | __metrics Screen width/height:1600/1200 15:28:05 INFO - PROCESS | 6128 | colorDepth:24 15:28:05 INFO - PROCESS | 6128 | Browser inner width/height: 1024/689 15:28:05 INFO - PROCESS | 6128 | __metrics 15:28:05 ERROR - PROCESS | 6128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 15:28:06 INFO - TEST-INFO | 6128: exit 0 15:28:06 INFO - Browser initialized. 15:28:06 INFO - Running cycle 1/1 for kraken test... 15:28:06 INFO - TEST-INFO | started process 6131 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpV0Hlal/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:18 INFO - PROCESS | 6131 | RSS: Main: 254607360 15:28:18 INFO - PROCESS | 6131 | 15:28:20 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56259/tests/kraken/driver.html?testName=audio-beat-detection) 15:28:21 INFO - PROCESS | 6131 | RSS: Main: 266563584 15:28:21 INFO - PROCESS | 6131 | 15:28:23 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56259/tests/kraken/driver.html?testName=audio-dft) 15:28:24 INFO - PROCESS | 6131 | RSS: Main: 275804160 15:28:24 INFO - PROCESS | 6131 | 15:28:27 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56259/tests/kraken/driver.html?testName=audio-fft) 15:28:28 INFO - PROCESS | 6131 | RSS: Main: 278806528 15:28:28 INFO - PROCESS | 6131 | 15:28:30 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56259/tests/kraken/driver.html?testName=audio-oscillator) 15:28:31 INFO - PROCESS | 6131 | RSS: Main: 280649728 15:28:31 INFO - PROCESS | 6131 | 15:28:33 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:28:33 INFO - PROCESS | 6131 | RSS: Main: 281403392 15:28:33 INFO - PROCESS | 6131 | 15:28:36 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56259/tests/kraken/driver.html?testName=imaging-darkroom) 15:28:37 INFO - PROCESS | 6131 | RSS: Main: 281698304 15:28:37 INFO - PROCESS | 6131 | 15:28:40 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56259/tests/kraken/driver.html?testName=imaging-desaturate) 15:28:40 INFO - PROCESS | 6131 | RSS: Main: 281444352 15:28:40 INFO - PROCESS | 6131 | 15:28:44 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56259/tests/kraken/driver.html?testName=json-parse-financial) 15:28:44 INFO - PROCESS | 6131 | RSS: Main: 281636864 15:28:44 INFO - PROCESS | 6131 | 15:28:46 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:28:46 INFO - PROCESS | 6131 | RSS: Main: 281387008 15:28:46 INFO - PROCESS | 6131 | 15:28:48 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56259/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:28:49 INFO - PROCESS | 6131 | RSS: Main: 281436160 15:28:49 INFO - PROCESS | 6131 | 15:28:51 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:28:52 INFO - PROCESS | 6131 | RSS: Main: 281821184 15:28:52 INFO - PROCESS | 6131 | 15:28:54 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:28:55 INFO - PROCESS | 6131 | RSS: Main: 282472448 15:28:55 INFO - PROCESS | 6131 | 15:28:57 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:28:58 INFO - PROCESS | 6131 | RSS: Main: 282329088 15:28:58 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | Cycle 1(1): loaded http://localhost:56259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56259/tests/kraken/driver.html?testName=ai-astar) 15:29:00 INFO - PROCESS | 6131 | RSS: Main: 283353088 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | __start_tp_report 15:29:00 INFO - PROCESS | 6131 | _x_x_mozilla_page_load 15:29:00 INFO - PROCESS | 6131 | _x_x_mozilla_page_load_details 15:29:00 INFO - PROCESS | 6131 | |i|pagename|runs| 15:29:00 INFO - PROCESS | 6131 | |0;ai-astar;112;108;114;114;115;128;114;115;116;114 15:29:00 INFO - PROCESS | 6131 | |1;audio-beat-detection;156;124;147;158;123;144;144;127;162;131 15:29:00 INFO - PROCESS | 6131 | |2;audio-dft;201;199;200;202;211;242;202;195;211;216 15:29:00 INFO - PROCESS | 6131 | |3;audio-fft;75;72;56;57;59;60;71;150;76;59 15:29:00 INFO - PROCESS | 6131 | |4;audio-oscillator;81;80;127;77;80;82;119;81;80;120 15:29:00 INFO - PROCESS | 6131 | |5;imaging-gaussian-blur;90;86;89;87;90;86;90;87;98;130 15:29:00 INFO - PROCESS | 6131 | |6;imaging-darkroom;94;130;119;96;144;99;124;150;149;96 15:29:00 INFO - PROCESS | 6131 | |7;imaging-desaturate;77;108;106;134;77;79;150;140;130;91 15:29:00 INFO - PROCESS | 6131 | |8;json-parse-financial;51;58;63;57;46;50;76;57;57;59 15:29:00 INFO - PROCESS | 6131 | |9;json-stringify-tinderbox;67;69;75;81;75;75;69;68;60;99 15:29:00 INFO - PROCESS | 6131 | |10;stanford-crypto-aes;84;85;83;85;86;87;82;106;73;96 15:29:00 INFO - PROCESS | 6131 | |11;stanford-crypto-ccm;121;120;125;122;127;133;120;131;138;134 15:29:00 INFO - PROCESS | 6131 | |12;stanford-crypto-pbkdf2;141;140;138;137;170;178;183;132;139;145 15:29:00 INFO - PROCESS | 6131 | |13;stanford-crypto-sha256-iterative;69;71;69;68;67;68;69;64;62;66 15:29:00 INFO - PROCESS | 6131 | __end_tp_report 15:29:00 INFO - PROCESS | 6131 | __start_cc_report 15:29:00 INFO - PROCESS | 6131 | _x_x_mozilla_cycle_collect,982 15:29:00 INFO - PROCESS | 6131 | __end_cc_report 15:29:00 INFO - PROCESS | 6131 | __startTimestamp1459463340446__endTimestamp 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | ------- Summary: start ------- 15:29:00 INFO - PROCESS | 6131 | Number of tests: 14 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.50 stddev:5.08 (4.4%) stddev-sans-first:5.27 15:29:00 INFO - PROCESS | 6131 | Values: 112.0 108.0 114.0 114.0 115.0 128.0 114.0 115.0 116.0 114.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:145.50 stddev:14.58 (10.0%) stddev-sans-first:14.51 15:29:00 INFO - PROCESS | 6131 | Values: 156.0 124.0 147.0 158.0 123.0 144.0 144.0 127.0 162.0 131.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#2] audio-dft Cycles:10 Average:207.90 Median:206.50 stddev:13.63 (6.6%) stddev-sans-first:14.23 15:29:00 INFO - PROCESS | 6131 | Values: 201.0 199.0 200.0 202.0 211.0 242.0 202.0 195.0 211.0 216.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#3] audio-fft Cycles:10 Average:73.50 Median:65.50 stddev:27.99 (42.7%) stddev-sans-first:29.68 15:29:00 INFO - PROCESS | 6131 | Values: 75.0 72.0 56.0 57.0 59.0 60.0 71.0 150.0 76.0 59.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:80.00 stddev:20.36 (25.5%) stddev-sans-first:21.15 15:29:00 INFO - PROCESS | 6131 | Values: 81.0 80.0 127.0 77.0 80.0 82.0 119.0 81.0 80.0 120.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:89.50 stddev:13.36 (14.9%) stddev-sans-first:14.12 15:29:00 INFO - PROCESS | 6131 | Values: 90.0 86.0 89.0 87.0 90.0 86.0 90.0 87.0 98.0 130.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#6] imaging-darkroom Cycles:10 Average:120.10 Median:122.00 stddev:22.86 (18.7%) stddev-sans-first:22.21 15:29:00 INFO - PROCESS | 6131 | Values: 94.0 130.0 119.0 96.0 144.0 99.0 124.0 150.0 149.0 96.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#7] imaging-desaturate Cycles:10 Average:109.20 Median:113.50 stddev:27.87 (24.6%) stddev-sans-first:27.01 15:29:00 INFO - PROCESS | 6131 | Values: 77.0 108.0 106.0 134.0 77.0 79.0 150.0 140.0 130.0 91.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:8.21 (14.3%) stddev-sans-first:8.37 15:29:00 INFO - PROCESS | 6131 | Values: 51.0 58.0 63.0 57.0 46.0 50.0 76.0 57.0 57.0 59.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:75.00 stddev:10.58 (14.1%) stddev-sans-first:10.93 15:29:00 INFO - PROCESS | 6131 | Values: 67.0 69.0 75.0 81.0 75.0 75.0 69.0 68.0 60.0 99.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.00 stddev:8.79 (10.3%) stddev-sans-first:9.27 15:29:00 INFO - PROCESS | 6131 | Values: 84.0 85.0 83.0 85.0 86.0 87.0 82.0 106.0 73.0 96.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:129.00 stddev:6.54 (5.1%) stddev-sans-first:6.55 15:29:00 INFO - PROCESS | 6131 | Values: 121.0 120.0 125.0 122.0 127.0 133.0 120.0 131.0 138.0 134.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:143.00 stddev:18.96 (13.3%) stddev-sans-first:19.81 15:29:00 INFO - PROCESS | 6131 | Values: 141.0 140.0 138.0 137.0 170.0 178.0 183.0 132.0 139.0 145.0 15:29:00 INFO - PROCESS | 6131 | 15:29:00 INFO - PROCESS | 6131 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.50 stddev:2.67 (3.9%) stddev-sans-first:2.76 15:29:00 INFO - PROCESS | 6131 | Values: 69.0 71.0 69.0 68.0 67.0 68.0 69.0 64.0 62.0 66.0 15:29:00 INFO - PROCESS | 6131 | -------- Summary: end -------- 15:29:00 INFO - PROCESS | 6131 | 15:29:01 INFO - TEST-INFO | 6131: exit 0 15:29:01 INFO - TEST-OK | kraken | took 58623ms 15:29:01 INFO - SUITE-END | took 1170s 15:29:01 INFO - Completed test suite (00:19:31) 15:29:01 INFO - javascript benchmark 15:29:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3488.7034602058825, 3508.5789705235375, 3511.0871173494893, 3525.68268855803, 3566.090646885044, 5842.737076831537, 5904.0553511438175, 5934.851628709284, 5938.910916336258, 5955.255593050869, 5814.854628634286, 5855.033919403304, 5914.852128696774, 5929.407059294069, 6014.368491308415, 5233.084210263199, 5270.657407268515, 5329.360476742796, 5334.093204155303, 5369.48989845964, 422.0044903754084, 5206.45332240115, 5240.711760853152, 5296.496832800878, 5304.469553044703, 5278.313819203518, 5293.761780719877, 5301.125314323132, 5316.548093412064, 5329.840104796843, 4898.289747986558, 5273.182656688219, 5291.126964050927, 5347.812826551052, 5350.8127215547265, 4713.316569097496, 5159.871003224949, 5247.737613119329, 5302.257683924254, 5313.654612450178, 4792.400949881265, 4832.9275060874115, 5758.337791154029, 5795.768169273224, 5843.590948633555, 6165.845853853644, 6201.596896201732, 6250.6874656267455, 6254.249490061176, 6275.246970363585, 6230.781922632731, 6245.906311405287, 6277.309495955441, 6290.937090629081, 6308.842278943017, 5939.910901336483, 6042.9034200325295, 6059.484943779784, 6062.9090563641585, 6083.8174854754425, 6206.162168107338, 6271.905921411182, 6382.32985536512, 6382.8723425531225, 6384.201974753156, 6176.629402235881, 6256.217972753406, 6256.812295631138, 6259.4679452246155, 6264.310925798159, 6226.844328891723, 6266.811995640138, 6267.185265915493, 6292.748290068346, 6316.052592111128, 6168.9691551541955, 6173.382661733791, 6198.6280823149855, 6208.410201030895, 6273.8745225095245, 5505.788726480168, 6197.4732147767045, 6221.782237621752, 6223.688815559204, 6239.781607643801, 4761.214399624093, 4982.975085124551, 5010.674306170087, 5028.673136246132, 5084.593232541388, 4434.933475997863, 4460.0, 4492.213862574102, 4535.750533720611, 4543.931841022388, 5825.271841019872, 5941.376155503696, 5987.13186587951, 5994.1608174855555, 5998.070299103646, 6228.096925945712, 6239.344868788802, 6281.780137695158, 6307.842303942438, 6327.746890124436, 5666.886662266732, 5780.248567686174, 5933.910991335133, 5949.583529152917, 5991.101334799728, 5461.262729531462, 5462.644928079662, 5475.808346707846, 5516.448355164532, 5519.558435325164, 6463.741450342028, 6481.870362592722, 6484.319146489551, 6515.185601799775, 6527.412532872159, 6191.4118158774845, 6216.937830621636, 6250.9062364065485, 6282.560220784684, 6284.4344009039405, 6480.384363485461, 6505.251896032017, 6507.7722279721875, 6536.379043990813, 6555.410013098844, 6226.564140510302, 6232.8130156095385, 6242.157308763259, 6250.249970003629, 6252.781152659635, 5489.655034516569, 5820.417958204315, 6139.829471381233, 6223.253209614694, 6332.366763323631, 6108.297545782292, 6167.907481387872, 6173.506119510518, 6182.165407669907, 6220.564560480723, 6108.251008765693, 6197.752089916533, 6224.657643829451, 6240.5319601031015, 6265.27949285838, 6083.8174854754425, 6103.389661033861, 6147.723352449061, 6165.537584681257, 6169.321374648695, 6159.4456498915315, 6212.875742485216, 6216.0, 6222.906656400248, 6259.1550140730415, 5971.790987315423, 6127.84680382994, 6160.815175544741, 6174.722137503733, 6184.196054512884], "unit": "score", "name": "dojo.html", "value": 5744.0940019636055}, {"lowerIsBetter": false, "replicates": [420.91160856220193, 539.670800811505, 555.1312196412616, 587.0196771391775, 617.5522746009144, 32854.835725821365, 38981.415278770844, 39022.414663780066, 39082.82751517452, 39171.0, 29136.708632913665, 32033.0, 37454.62545374545, 40719.18561628766, 41244.38133428001, 8113.594320283992, 9301.116393942582, 9477.194438472738, 9497.145256926875, 9558.33091683579, 9391.718248452524, 9571.904280957171, 9579.233661307078, 9598.472084035375, 9618.422894626345, 9535.713928582154, 9575.61697532098, 9577.760555986086, 9649.565769540352, 9655.517224138765, 8247.670093196295, 9533.14201721845, 9548.0, 9555.331126821126, 9608.759781005461, 9439.575219115157, 9440.527973601293, 9560.521973901277, 9576.61693532258, 9579.0, 39530.802345988086, 39621.0, 39831.60168398308, 39949.40075898864, 39987.20057597415, 2825.491411545921, 3103.20868178613, 3131.8908318027143, 3242.691944265291, 3386.745994050456, 27611.585826212624, 27958.720412795814, 27972.440551189065, 28136.718632813616, 28226.43547129046, 2727.5499542575453, 2740.780737540992, 2762.2265765585666, 2807.90172343969, 2867.0968644877007, 348841.0, 350859.2457037724, 353561.2321938374, 353949.0, 354877.0, 50258.0, 51397.972040558976, 52294.21558676623, 62833.37166628275, 63604.68197659075, 64472.355276447575, 68538.65730671414, 70294.64852675704, 75488.62255688687, 76393.47213055707, 16830.410935617194, 17140.40008599693, 17146.91426542884, 17253.827461725472, 17415.129243537773, 13043.0, 13063.934680326538, 13074.411651475706, 13077.346132693518, 13084.476620935246, 21909.671354929687, 22089.005994730276, 22166.88916555407, 22283.22008729719, 22294.888525557268, 8709.82254436391, 8972.564389697616, 8978.46129232235, 8982.664507228037, 8988.0, 831.9533550824507, 905.8414777413926, 1009.7273736091214, 1015.263933648114, 1035.3115178406276, 29674.40651186964, 30091.0, 30660.69339306623, 30741.538876916864, 30798.84600576983, 1021.8402113601117, 1096.7477480179602, 1099.4722533184117, 1153.4463457540428, 1235.8208059831275, 15209.847901520843, 15280.235988200546, 15298.617534561725, 15463.845361546466, 15716.528504144893, 549913.0, 554360.0, 554364.7381157144, 556640.0, 556898.0, 60376.0, 61463.385366146664, 62310.75378492405, 62419.375806242264, 62604.0, 1442.5167568864338, 1455.505128256398, 1466.875315598186, 1469.5224052183082, 1469.955901322962, 29331.266718332212, 30106.69893301039, 30114.84942575273, 30147.455538120863, 30183.245418864703, 54327.72836135794, 54726.726366369505, 54808.985505797566, 54879.0, 55251.0, 489109.0, 491201.0, 494133.0, 497436.0, 498618.0, 33995.66004339925, 34288.97133086011, 34300.799472018356, 34425.827870860485, 34578.82710586431, 52070.47929520656, 52268.0, 53059.6735081626, 53376.199357008896, 53795.65510862103, 39212.60787392204, 39292.80353598328, 39397.0, 39569.80215098906, 39824.80087599543, 40256.99357516086, 40620.0, 40655.39016914808, 40679.0, 41319.38020929629, 35350.762723304564, 39856.6050188242, 40882.591174089066, 41100.383494248206, 41519.0, 29988.700112999464, 32060.6793932067, 32111.839440802647, 32184.517232241065, 32268.515972259964, 25598.360040998377, 26042.86978565171, 26168.0, 26359.0, 26729.732702672725], "unit": "score", "name": "ext.html", "value": 19980.466280384935}, {"lowerIsBetter": false, "replicates": [298.5894395206591, 362.23929747530207, 366.6333666333666, 372.75584492157645, 373.3895081541682, 18544.443666690004, 19543.804561954377, 19956.501087472803, 19982.300619478323, 20010.399688009384, 16550.50348489547, 19413.61172776547, 20008.399748007545, 20654.0, 20672.966351682393, 5696.259486266779, 5880.500157486619, 5897.852553686149, 5917.792877249297, 5927.407259274081, 5510.393856675762, 5848.783169256892, 5907.202527658754, 5939.7921072762465, 5970.761169553212, 5725.227094342252, 5798.420157984189, 5830.096335068071, 5837.211976383198, 5853.473187413132, 5720.399358067426, 5753.309602847643, 5793.0, 5815.941840581603, 5817.18559401682, 4878.0975519529, 4920.581750551208, 4944.653874228806, 5011.774470148815, 5050.217216331474, 19639.0, 24027.27918162458, 24063.518729625484, 24391.390215244584, 24466.266012019667, 2238.0712004518105, 2297.0122847175708, 2339.5320935812906, 2540.8094392920607, 2596.039465397815, 14363.994520383578, 14414.351354189086, 14674.55976320712, 14848.0, 14958.626034349229, 1717.776689030418, 1737.695903216932, 1771.8405343519146, 1793.7757780277466, 1801.0634470075618, 89937.55031224867, 90037.64943525853, 99274.5036274814, 101492.9850701491, 103120.48439757753, 9027.774305642411, 10679.51942162589, 10692.679219623424, 10771.89947960156, 10914.399708015977, 13483.123596966167, 13529.526466573623, 13536.59390218295, 13536.932315338361, 13564.253966031964, 8331.916680833236, 8406.075331713506, 8497.192766687154, 8545.359098067669, 8588.828223435496, 8627.22354988054, 8690.826183476422, 8711.303095752324, 8765.167309105625, 8821.514816685143, 4325.675574331937, 4359.12817436514, 4375.934360984587, 4382.758948257876, 4413.3821265022925, 1559.8067478379048, 1830.6521760865394, 1863.8136186381253, 1874.8593855460895, 1880.7743070831589, 723.6960476599841, 853.3727710133047, 894.9015608283083, 966.7728083900278, 1019.7195771162841, 16674.33302667904, 18842.71735923962, 18970.0, 19905.0, 20366.796332036785, 961.9470929098967, 977.2133432586694, 1001.5993602559034, 1002.4035698759227, 1043.5773511727762, 8175.83648327042, 9666.323357365058, 10210.795784084425, 10522.579096836194, 10585.100266477282, 565725.1713741405, 571710.0, 587917.0, 597855.0, 612691.0, 107585.0, 112208.99999999837, 118462.0, 118994.0, 119404.0, 1032.514718082515, 1039.2413538117216, 1055.3087727538475, 1061.7823346214007, 1068.3589846092439, 17383.130843458028, 17764.822351776318, 17782.288708452033, 17910.462686119437, 18253.726194106832, 48407.0, 50401.74799125981, 51006.48993510166, 51277.71805704887, 51735.74132129315, 67937.0, 67999.64000719858, 68110.29724256735, 68962.96555551571, 70267.64866175636, 6949.783787837209, 7459.589722565311, 7824.882626760489, 7861.449698521049, 7965.761027169194, 8734.388592798443, 10630.893691062991, 12263.509459621515, 12531.686707832012, 12703.618891433272, 6179.752809887734, 6886.793396198122, 7512.436567257369, 7524.849503009799, 8293.792655183428, 6311.27420346666, 7520.721477348754, 8115.188481151838, 8348.415610907177, 8578.0, 6931.584104953719, 8074.59627018635, 8214.958925205336, 8292.12932642064, 8329.416940814084, 11512.079033677453, 11595.942020289845, 11611.6516504505, 11900.702482438008, 11930.105242106703, 11713.648590542298, 11751.236169648946, 11819.822702659296, 11951.0, 11998.64004079879], "unit": "score", "name": "jquery.html", "value": 9112.963737439457}, {"lowerIsBetter": false, "replicates": [1457.9562613121607, 1612.3631165689549, 1825.9178336974835, 1914.865959382843, 1970.320239517366, 8063.758087257392, 8296.548104081792, 8755.29957603391, 9070.86393704095, 9115.772105697353, 7312.524685895413, 8730.257928076122, 8878.955605221965, 8895.88801399825, 8903.554822258877, 2487.751224877507, 2491.5390652729257, 2499.9375015624664, 2505.711843138035, 2515.9119430819924, 2451.914183003595, 2479.603263477844, 2505.649209110726, 2515.4843257132334, 2525.3434107132184, 2209.7016902718087, 2511.8869650865754, 2521.5461216980934, 2531.3291977625945, 2540.3776074861685, 2478.330850670318, 2508.7114981777145, 2525.734797846218, 2526.633638122462, 2531.139412599716, 2428.441458464563, 2433.9634905476432, 2461.6676748638884, 2466.48203877186, 2539.174768200324, 8977.6857809977, 8978.640854365818, 8990.190882820578, 9034.503102329369, 9039.593218305192, 5549.528290095306, 5551.0, 5589.888202235932, 5675.489205971482, 5738.913916291259, 3207.6471588125287, 3634.618365071682, 3704.1480459494196, 3708.2583483303447, 3757.5490941086973, 922.4096578189964, 1053.9262251642388, 1061.2040969273046, 1071.608862765093, 1084.1218612923558, 11982.520699172022, 12260.632181034583, 12262.386880655931, 12265.877341226562, 12319.199252048498, 4276.850310239127, 4898.118338699069, 4938.333325001079, 5016.021875734197, 5032.572231360302, 10175.28772985884, 10230.6419275325, 10293.330933489298, 10299.639512617023, 10306.948465257627, 4803.3995750531185, 5560.110382338888, 5598.888022239533, 5624.3813180550105, 5649.604527683105, 3875.903102422462, 4563.201439748097, 5030.84907452777, 5034.496550345009, 5067.670601410897, 3939.5666476688116, 3997.920561448451, 4014.217227640582, 4024.396340548941, 4050.2911990401562, 1337.5452346202144, 1348.0630961481872, 1348.4403972351365, 1355.0785465883293, 1361.2104979112091, 1127.8872112788656, 1334.9799753003713, 1363.12078709232, 1388.0977364712815, 1390.2284232251197, 8189.017317921887, 8236.876446853303, 8348.624311905978, 8350.248477637042, 8357.0, 511.6597462687346, 518.2252532463915, 521.7260938007577, 524.4152769661799, 525.4377815737124, 6050.273967123973, 6056.273247210275, 6164.660943648053, 6233.875322493524, 6292.590981586274, 10362.689119326433, 10553.050225479743, 10609.893901061045, 10621.628243011457, 10633.202509811796, 10390.688279351632, 10491.318064325795, 10516.526756295985, 10578.894211057945, 10639.095676867399, 8267.793305167299, 8410.32717382608, 8440.15598440151, 8468.28019618327, 8520.403571750043, 6701.832454188684, 8004.51972881629, 8132.471389359673, 8159.755207343789, 8258.380621453534, 9389.624415023323, 9462.290328225274, 9561.521923903916, 9635.855462168212, 9637.0, 9725.416475011521, 9904.504774761377, 9909.166804141258, 9965.551550180115, 9994.350367226107, 6883.621400823003, 7211.639418029183, 7484.438667100098, 7554.320111190019, 7560.395168386626, 8140.104588495379, 8146.470479418819, 8172.141925097779, 8211.055728591049, 8225.177482251727, 7015.158181018106, 7286.089238845145, 7307.2327405621645, 7337.853242935004, 7526.09686837583, 5925.881482370414, 7290.817729556804, 7339.045924029842, 7360.411167106511, 7443.627818609156, 7709.4603377763015, 7744.341730952932, 7756.534607923542, 7776.572288524186, 7818.257265559762, 6989.650517474208, 7021.613811240227, 7084.645767711697, 7086.858262834818, 7093.538919970186, 7132.393746531396, 7176.856462870818, 7203.171635261802, 7210.567365958059, 7254.600996945219], "unit": "score", "name": "mootools.html", "value": 4875.72681899772}, {"lowerIsBetter": false, "replicates": [327.7083395777758, 328.85694722795586, 333.30006985330823, 338.4821223528002, 339.7723525238089, 6829.590224586522, 6834.589924604521, 6870.38166565009, 6883.827904302395, 6900.75847345343, 6778.322167783219, 6791.3887750102485, 6804.353586409283, 6809.0, 6828.078209441724, 4261.657577862963, 4373.715708478954, 4761.785719642625, 4831.396075490564, 4986.825461108862, 4918.336024636682, 4952.217201807346, 4956.727379994099, 4963.106640804654, 4995.250712393134, 3797.753146045512, 4879.46325904152, 4886.755662216893, 4983.900321993558, 4987.725675087869, 4955.801767929296, 4957.033378491195, 4972.552470277675, 4975.328330675385, 4976.576990955773, 3572.6427357264324, 3858.4791053207737, 4265.786710664454, 4276.102018576103, 4299.398084268205, 6342.904856427157, 6356.0, 6505.60966342021, 6530.249021362509, 6549.083128362033, 5249.580033597341, 5260.947390526122, 5883.970580147072, 5923.703814809242, 5947.464728174442, 7289.489735718502, 7293.234210407937, 7306.598137102457, 7323.084614423197, 7325.267473252686, 4136.296829538986, 4354.368616550582, 4828.879278018043, 4845.2732090186755, 4845.685030473008, 7734.3039126478325, 7746.186650401683, 7755.418343624251, 7766.728164514271, 7774.65014074368, 4707.741074240881, 4895.192293271571, 4916.0905232532095, 4920.532549407801, 4934.6545741798445, 4982.10322142018, 5013.89972200554, 5018.197088465828, 5021.0, 5030.673006254582, 5847.006008978484, 5894.616849904743, 5901.3508514063415, 5909.940900591025, 5911.231539899872, 7354.852902941911, 7356.632168391666, 7361.411087113018, 7374.00450939127, 7384.96307518459, 1730.0, 1749.5101371615713, 1752.9123543823014, 1757.1302205408404, 1760.9471715848545, 1063.3247887591435, 1119.4067144413473, 1120.0703416164563, 1127.8646562412398, 1135.2677522997785, 6726.7981960541265, 6744.426723728538, 6761.628110453972, 6763.019362192553, 6790.1296261131665, 6799.5920244785475, 6938.930610693828, 7595.392368610498, 7638.923610763822, 7645.541267523855, 6530.216374035146, 6628.96685516579, 6807.217170025411, 6841.760538381132, 6844.0, 4033.193361327746, 4056.817443215062, 4062.857799977046, 4063.532693740258, 4064.309067458539, 8002.999250187453, 8004.399670024772, 8032.638531266107, 8049.0, 8052.315553177928, 7697.615119244016, 7879.606019698992, 7950.324222441157, 7952.642131104114, 7960.203979602109, 6894.24163342032, 7691.961540192263, 7967.521948683097, 8000.4399692021, 8037.67849286022, 6419.261784894797, 6443.67781610927, 7444.441666874898, 7696.8460630788195, 7704.807379815549, 7373.373263272468, 7575.053118360205, 7577.583232922242, 7589.962050189934, 7606.923930760621, 6657.73369065232, 7642.235776422313, 7972.362211022988, 8032.236937490929, 8034.437589368688, 4912.287718280758, 4916.06594746997, 4948.208286674115, 4949.208126699711, 4963.627727920348, 7660.616969151632, 7676.53940763556, 7684.6157692116285, 7686.385089192963, 7690.115636701851, 5958.702064896825, 7323.450741194325, 7325.205324695484, 7325.890111648223, 7356.97002419651, 6989.161300643956, 7274.8908766369605, 7278.818029549304, 7310.378617817332, 7315.670794814139, 5333.333333333333, 6269.811905642656, 6390.456811171102, 6677.666116694243, 7216.7474138404905, 7377.299156580117, 7387.593682347308, 7395.482316237812, 7410.703571857065, 7425.591592462466, 5834.416558344132, 7140.7857764267155, 7180.676869540779, 7201.531900426456, 7222.169450513258], "unit": "score", "name": "prototype.html", "value": 5296.332142617567}, {"lowerIsBetter": false, "replicates": [736.4071922102709, 746.2872956326709, 764.7896828372197, 764.9426293028023, 802.7270727952495, 16059.598510037255, 17538.03540805255, 17941.551461213476, 17957.910210448947, 17998.280068797234, 16234.350625974976, 16316.347346106171, 16352.182390880438, 16359.0, 16406.0, 744.2817680937894, 763.1452772894366, 924.2005665099691, 944.3106532231475, 946.2808265718035, 897.3808072430035, 902.6434558349448, 903.408267584733, 929.0802105915129, 940.0740270833223, 950.7813202963288, 955.9187469065138, 961.9470929098896, 988.9851652225186, 993.6323560282706, 944.117250370902, 969.2100937735722, 982.3172894838019, 986.0583143098396, 987.6148302162198, 707.9823004424879, 712.618748969299, 717.0212659719498, 737.1080991999687, 737.6090671943824, 15407.460738874086, 15480.303386347641, 15654.217289135611, 15679.216039198109, 15697.529074127795, 12390.56633017849, 12441.066919980947, 12455.564055258023, 12674.0, 12766.553170638983, 9432.717018489457, 10012.0, 10043.497825108716, 10094.242931780145, 10789.946050269777, 3576.0523461282783, 3576.2311103112697, 3646.4894914711963, 3667.0, 3685.005048636853, 62447.063294050626, 71910.64044679744, 72402.0, 75463.62268188679, 76809.23190768076, 9287.76780580491, 9292.814143717223, 9347.158755712018, 9387.10822471864, 9481.051894810602, 20716.0, 20813.479663008242, 20832.47918802042, 20953.580928381347, 21537.461563460725, 7542.0, 7556.65995030225, 7574.886376704354, 7649.0, 7750.0, 4095.3037983542868, 4123.299039163289, 4129.91740165195, 4144.7513149211145, 4148.398482220061, 3616.9095772605897, 3628.8911332660064, 3640.344737947195, 3643.8360273787744, 3648.325059863934, 557.2950217974266, 585.850608094933, 588.632104934416, 595.1994567306965, 600.0938582740093, 496.81866118866355, 518.4815184815185, 531.6920375875312, 589.4459208344143, 593.6230493636572, 7932.16712245206, 8241.175882411711, 8338.0, 8380.832383352421, 8461.746147615582, 563.5885803363567, 567.29088639201, 569.4305694305694, 582.5543459253674, 597.1520440973827, 3796.7532110413285, 3834.386498160337, 3839.0594304395045, 3922.431247469101, 3993.1432874567327, 90702.0, 91200.0, 93057.0694293062, 93241.0, 93506.59740103903, 77515.83726244111, 78179.82730259051, 78762.0, 79525.60237198777, 80243.59878200572, 68606.0, 69547.65226173837, 70337.64831175811, 71193.57612847818, 72035.0, 6262.68686565679, 6786.59280443175, 7058.470614704021, 7707.460477766503, 7960.681572737258, 42162.0, 49313.50686493089, 50033.749831250614, 50289.74855125701, 50314.74842625763, 51668.22497662463, 66861.0, 67336.326636733, 67663.0, 68297.3170268291, 9821.312508124649, 9856.21150307988, 10002.649907253211, 10243.539040743035, 10296.897031029894, 9145.445274303518, 10946.671599852018, 11015.559377624806, 11384.430778460877, 11404.771904562029, 10274.178065754571, 10292.073713365533, 10306.639267625596, 10445.529951152064, 10625.574977000833, 9007.414518056305, 9028.954855225944, 9210.447373157633, 9236.72289831306, 9440.244780417688, 10122.0, 10211.285210035227, 10217.948910255698, 10225.335353202017, 10599.576016959236, 8573.74278771638, 8796.252318552739, 8824.647014119364, 8848.07095254989, 8978.0, 8682.78293042679, 8849.24781393563, 8890.688825891062, 8927.821443571222, 9006.63973441055], "unit": "score", "name": "yui.html", "value": 6762.469388128311}], "name": "dromaeo_css", "value": 7532.517910936489}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 114.0, 114.0, 115.0, 128.0, 114.0, 115.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 147.0, 158.0, 123.0, 144.0, 144.0, 127.0, 162.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 141.6}, {"lowerIsBetter": true, "replicates": [201.0, 199.0, 200.0, 202.0, 211.0, 242.0, 202.0, 195.0, 211.0, 216.0], "unit": "score", "name": "audio-dft", "value": 207.9}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 56.0, 57.0, 59.0, 60.0, 71.0, 150.0, 76.0, 59.0], "unit": "score", "name": "audio-fft", "value": 73.5}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 127.0, 77.0, 80.0, 82.0, 119.0, 81.0, 80.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [90.0, 86.0, 89.0, 87.0, 90.0, 86.0, 90.0, 87.0, 98.0, 130.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.3}, {"lowerIsBetter": true, "replicates": [94.0, 130.0, 119.0, 96.0, 144.0, 99.0, 124.0, 150.0, 149.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 120.1}, {"lowerIsBetter": true, "replicates": [77.0, 108.0, 106.0, 134.0, 77.0, 79.0, 150.0, 140.0, 130.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 109.2}, {"lowerIsBetter": true, "replicates": [51.0, 58.0, 63.0, 57.0, 46.0, 50.0, 76.0, 57.0, 57.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 75.0, 81.0, 75.0, 75.0, 69.0, 68.0, 60.0, 99.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.8}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 83.0, 85.0, 86.0, 87.0, 82.0, 106.0, 73.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 125.0, 122.0, 127.0, 133.0, 120.0, 131.0, 138.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [141.0, 140.0, 138.0, 137.0, 170.0, 178.0, 183.0, 132.0, 139.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.3}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 69.0, 68.0, 67.0, 68.0, 69.0, 64.0, 62.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1515.8999999999999}]} 15:29:01 INFO - Return code: 0 15:29:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:29:01 ERROR - # TBPL SUCCESS # 15:29:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:29:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:29:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:29:01 INFO - 2016-03-31 15:29:01.764 screenresolution[6136:104286] starting screenresolution argv=screenresolution get 15:29:01 INFO - 2016-03-31 15:29:01.766 screenresolution[6136:104286] Display 0: 1600x1200x32@60 15:29:01 INFO - 2016-03-31 15:29:01.772 screenresolution[6137:104289] starting screenresolution argv=screenresolution list 15:29:01 INFO - Available Modes on Display 0 15:29:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:29:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:29:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:29:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:29:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:29:02 INFO - Intel Iris: 15:29:02 INFO - Chipset Model: Intel Iris 15:29:02 INFO - Type: GPU 15:29:02 INFO - Bus: Built-In 15:29:02 INFO - VRAM (Dynamic, Max): 1536 MB 15:29:02 INFO - Vendor: Intel (0x8086) 15:29:02 INFO - Device ID: 0x0a2e 15:29:02 INFO - Revision ID: 0x0009 15:29:02 INFO - Displays: 15:29:02 INFO - Display: 15:29:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:29:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:29:02 INFO - Display Serial Number: 1600x1200 60 15:29:02 INFO - Main Display: Yes 15:29:02 INFO - Mirror: Off 15:29:02 INFO - Online: Yes 15:29:02 INFO - Rotation: Supported 15:29:02 INFO - Return code: 0 15:29:02 INFO - Running post-action listener: _resource_record_post_action 15:29:02 INFO - Running post-run listener: _resource_record_post_run 15:29:03 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 28675584; Write bytes: 706876928; Read time: 300; Write time: 2084 15:29:03 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391772672; Write bytes: 385955840; Read time: 29581; Write time: 685 15:29:03 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 28675584; Write bytes: 300569088; Read time: 300; Write time: 1349 15:29:03 INFO - Running post-run listener: _upload_blobber_files 15:29:03 INFO - Blob upload gear active. 15:29:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:29:03 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 15:29:03 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:29:03 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:29:03 INFO - (blobuploader) - INFO - Open directory for files ... 15:29:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:29:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:29:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:05 INFO - (blobuploader) - INFO - Done attempting. 15:29:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:29:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:29:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:29:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:29:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:29:07 INFO - (blobuploader) - INFO - Done attempting. 15:29:07 INFO - (blobuploader) - INFO - Iteration through files over. 15:29:07 INFO - Return code: 0 15:29:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:29:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:29:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52e2acf24766ac7467ffabbeff6cb10453422cc9bb8a912e114960c008f6f7a0232a8eb048258883800f8e2afd9c775b82861981c840cb1c4d5554e41c01d966", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dcd5d5cef05855b76619f746080e563d2a329c6b652a583bfdd0a10dac1bff45e4e8414255350069281e904908a9956beb3571bfaf403a288456110b5f16d6"} 15:29:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:29:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:29:07 INFO - Contents: 15:29:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52e2acf24766ac7467ffabbeff6cb10453422cc9bb8a912e114960c008f6f7a0232a8eb048258883800f8e2afd9c775b82861981c840cb1c4d5554e41c01d966", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dcd5d5cef05855b76619f746080e563d2a329c6b652a583bfdd0a10dac1bff45e4e8414255350069281e904908a9956beb3571bfaf403a288456110b5f16d6"} 15:29:07 INFO - Running post-run listener: copy_logs_to_upload_dir 15:29:07 INFO - Copying logs to upload dir... 15:29:07 INFO - mkdir: /builds/slave/test/build/upload/logs 15:29:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1321.180087 ========= master_lag: 1.48 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2016-03-31 15:29:08.756569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 15:29:08.761280) ========= 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.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52e2acf24766ac7467ffabbeff6cb10453422cc9bb8a912e114960c008f6f7a0232a8eb048258883800f8e2afd9c775b82861981c840cb1c4d5554e41c01d966", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dcd5d5cef05855b76619f746080e563d2a329c6b652a583bfdd0a10dac1bff45e4e8414255350069281e904908a9956beb3571bfaf403a288456110b5f16d6"} build_url:https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/Rcv4DxlNR5y4b_aLeJDcaQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52e2acf24766ac7467ffabbeff6cb10453422cc9bb8a912e114960c008f6f7a0232a8eb048258883800f8e2afd9c775b82861981c840cb1c4d5554e41c01d966", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36dcd5d5cef05855b76619f746080e563d2a329c6b652a583bfdd0a10dac1bff45e4e8414255350069281e904908a9956beb3571bfaf403a288456110b5f16d6"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 15:29:08.925114) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 22 secs) (at 2016-03-31 15:29:08.925429) ========= 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.X4w6kv60KI/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.t3qKoGuMqD/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005424 ========= master_lag: 22.42 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 22 secs) (at 2016-03-31 15:29:31.347439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 15:29:31.347718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 15:29:31.960093) ========= ========= Total master_lag: 29.19 =========