builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0150 starttime: 1460133877.05 results: success (0) buildid: 20160408080755 builduid: 0443c99de66745f18538088dbd9a760d revision: 1e17a83bd0d7767cdf89eb11a78ef572d6c427bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.046202) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.046669) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.046959) ========= 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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005487 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.072861) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.073182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.096345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.096658) ========= 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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005818 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.146702) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.146969) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.147323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.147625) ========= 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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-08 09:44:37-- 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-04-08 09:44:37 (196 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122157 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.284869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.285205) ========= 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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.025548 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:37.334586) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 09:44:37.335005) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1e17a83bd0d7767cdf89eb11a78ef572d6c427bf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1e17a83bd0d7767cdf89eb11a78ef572d6c427bf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-08 09:44:37,375 truncating revision to first 12 chars 2016-04-08 09:44:37,375 Setting DEBUG logging. 2016-04-08 09:44:37,375 attempt 1/10 2016-04-08 09:44:37,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1e17a83bd0d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 09:44:38,317 unpacking tar archive at: fx-team-1e17a83bd0d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.186591 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-08 09:44:38.565343) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:38.565674) ========= echo 1e17a83bd0d7767cdf89eb11a78ef572d6c427bf in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1e17a83bd0d7767cdf89eb11a78ef572d6c427bf'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 1e17a83bd0d7767cdf89eb11a78ef572d6c427bf program finished with exit code 0 elapsedTime=0.005560 script_repo_revision: '1e17a83bd0d7767cdf89eb11a78ef572d6c427bf' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:38.617175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:38.617481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 09:44:38.777109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-08 09:44:38.777577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:44:38 INFO - MultiFileLogger online at 20160408 09:44:38 in /builds/slave/test 09:44:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:44:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:38 INFO - {'append_to_log': False, 09:44:38 INFO - 'base_work_dir': '/builds/slave/test', 09:44:38 INFO - 'blob_upload_branch': 'Fx-Team', 09:44:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:38 INFO - 'branch': 'Fx-Team', 09:44:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:38 INFO - 'config_files': ('talos/mac_config.py',), 09:44:38 INFO - 'default_actions': ('clobber', 09:44:38 INFO - 'read-buildbot-config', 09:44:38 INFO - 'download-and-extract', 09:44:38 INFO - 'populate-webroot', 09:44:38 INFO - 'create-virtualenv', 09:44:38 INFO - 'install', 09:44:38 INFO - 'run-tests'), 09:44:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:38 INFO - 'download_minidump_stackwalk': True, 09:44:38 INFO - 'download_symbols': 'ondemand', 09:44:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:38 INFO - 'installer_path': 'installer.exe', 09:44:38 INFO - 'log_level': 'info', 09:44:38 INFO - 'log_name': 'talos', 09:44:38 INFO - 'log_to_console': True, 09:44:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:44:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:44:38 INFO - 'opt_config_files': (), 09:44:38 INFO - 'pip_index': False, 09:44:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:38 INFO - 'cmd': ('bash', 09:44:38 INFO - '-c', 09:44:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:38 INFO - 'enabled': True, 09:44:38 INFO - 'halt_on_failure': False, 09:44:38 INFO - 'name': 'check_screen_resolution'},), 09:44:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:38 INFO - 'cmd': ('bash', 09:44:38 INFO - '-c', 09:44:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:38 INFO - 'enabled': True, 09:44:38 INFO - 'halt_on_failure': False, 09:44:38 INFO - 'name': 'check_screen_resolution'},), 09:44:38 INFO - 'run_cmd_checks_enabled': True, 09:44:38 INFO - 'sps_profile': False, 09:44:38 INFO - 'sps_profile_interval': 0, 09:44:38 INFO - 'suite': 'dromaeojs-e10s', 09:44:38 INFO - 'system_bits': '32', 09:44:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:38 INFO - 'title': 't-yosemite-r7-0150', 09:44:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:38 INFO - 'use_talos_json': True, 09:44:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:38 INFO - 'work_dir': 'build'} 09:44:38 INFO - ##### 09:44:38 INFO - ##### Running clobber step. 09:44:38 INFO - ##### 09:44:38 INFO - Running pre-action listener: _resource_record_pre_action 09:44:38 INFO - Running main action method: clobber 09:44:38 INFO - rmtree: /builds/slave/test/build 09:44:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:41 INFO - Running post-action listener: _resource_record_post_action 09:44:41 INFO - ##### 09:44:41 INFO - ##### Running read-buildbot-config step. 09:44:41 INFO - ##### 09:44:41 INFO - Running pre-action listener: _resource_record_pre_action 09:44:41 INFO - Running main action method: read_buildbot_config 09:44:41 INFO - Using buildbot properties: 09:44:41 INFO - { 09:44:41 INFO - "project": "", 09:44:41 INFO - "product": "firefox", 09:44:41 INFO - "script_repo_revision": "production", 09:44:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:44:41 INFO - "repository": "", 09:44:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:44:41 INFO - "buildid": "20160408080755", 09:44:41 INFO - "pgo_build": "False", 09:44:41 INFO - "basedir": "/builds/slave/test", 09:44:41 INFO - "buildnumber": 591, 09:44:41 INFO - "slavename": "t-yosemite-r7-0150", 09:44:41 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:44:41 INFO - "platform": "yosemite_r7", 09:44:41 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:44:41 INFO - "branch": "fx-team", 09:44:41 INFO - "repo_path": "integration/fx-team", 09:44:41 INFO - "revision": "1e17a83bd0d7767cdf89eb11a78ef572d6c427bf", 09:44:41 INFO - "stage_platform": "macosx64", 09:44:41 INFO - "builduid": "0443c99de66745f18538088dbd9a760d", 09:44:41 INFO - "slavebuilddir": "test" 09:44:41 INFO - } 09:44:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:44:41 INFO - Running post-action listener: _resource_record_post_action 09:44:41 INFO - ##### 09:44:41 INFO - ##### Running download-and-extract step. 09:44:41 INFO - ##### 09:44:41 INFO - Running pre-action listener: _resource_record_pre_action 09:44:41 INFO - Running main action method: download_and_extract 09:44:41 INFO - mkdir: /builds/slave/test/build/tests 09:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:41 INFO - https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:44:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:44:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:44:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:44:43 INFO - Downloaded 1199 bytes. 09:44:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:44:43 INFO - Using the following test package requirements: 09:44:43 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:44:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:44:43 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:44:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:44:43 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:44:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:44:43 INFO - u'jsshell-mac.zip'], 09:44:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:44:43 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:44:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:44:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:44:43 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:44:43 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:44:43 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:44:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:44:43 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:44:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:44:43 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:44:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:44:43 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')]} 09:44:43 INFO - https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:44:49 INFO - Downloaded 18014574 bytes. 09:44:49 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'] 09:44:49 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 09:44:52 INFO - Return code: 0 09:44:52 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 09:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:52 INFO - https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:44:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:44:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:44:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:44:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:44:58 INFO - Downloaded 18014574 bytes. 09:44:58 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'] 09:44:58 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 09:45:01 INFO - Return code: 0 09:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:01 INFO - https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:45:02 INFO - Downloaded 10847693 bytes. 09:45:02 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'] 09:45:02 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 09:45:03 INFO - Return code: 0 09:45:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:03 INFO - https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:45:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:45:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:45:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Djads4C1Roi23hkgLflOnw/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 09:45:07 INFO - Downloaded 108788039 bytes. 09:45:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:45:07 INFO - mkdir: /builds/slave/test/properties 09:45:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:07 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:07 INFO - Contents: 09:45:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:45:08 INFO - Running post-action listener: _resource_record_post_action 09:45:09 INFO - Running post-action listener: set_extra_try_arguments 09:45:09 INFO - ##### 09:45:09 INFO - ##### Running populate-webroot step. 09:45:09 INFO - ##### 09:45:09 INFO - Running pre-action listener: _resource_record_pre_action 09:45:09 INFO - Running main action method: populate_webroot 09:45:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:09 INFO - '--tppagecycles', 09:45:09 INFO - '7'], 09:45:09 INFO - 'tests': ['tsvgm']}}, 09:45:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:09 INFO - 'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:09 INFO - 'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['damp', 'tps']}, 09:45:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:09 INFO - 'tests': ['damp', 'tps']}, 09:45:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['dromaeo_dom']}, 09:45:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['a11yr', 09:45:09 INFO - 'ts_paint', 09:45:09 INFO - 'tpaint', 09:45:09 INFO - 'sessionrestore', 09:45:09 INFO - 'sessionrestore_no_auto_restore', 09:45:09 INFO - 'tabpaint']}, 09:45:09 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:09 INFO - 'ts_paint', 09:45:09 INFO - 'tpaint', 09:45:09 INFO - 'sessionrestore', 09:45:09 INFO - 'sessionrestore_no_auto_restore', 09:45:09 INFO - 'tabpaint']}, 09:45:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:09 INFO - 'ts_paint', 09:45:09 INFO - 'tpaint', 09:45:09 INFO - 'sessionrestore', 09:45:09 INFO - 'sessionrestore_no_auto_restore', 09:45:09 INFO - 'tabpaint']}, 09:45:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:09 INFO - 'ts_paint', 09:45:09 INFO - 'tpaint', 09:45:09 INFO - 'sessionrestore', 09:45:09 INFO - 'sessionrestore_no_auto_restore', 09:45:09 INFO - 'tabpaint']}, 09:45:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['a11yr', 09:45:09 INFO - 'ts_paint', 09:45:09 INFO - 'tpaint', 09:45:09 INFO - 'sessionrestore', 09:45:09 INFO - 'sessionrestore_no_auto_restore', 09:45:09 INFO - 'tabpaint']}, 09:45:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['a11yr', 09:45:09 INFO - 'ts_paint', 09:45:09 INFO - 'tpaint', 09:45:09 INFO - 'sessionrestore', 09:45:09 INFO - 'sessionrestore_no_auto_restore', 09:45:09 INFO - 'tabpaint']}, 09:45:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['tsvgx', 09:45:09 INFO - 'tsvgr_opacity', 09:45:09 INFO - 'tart', 09:45:09 INFO - 'tscrollx', 09:45:09 INFO - 'cart']}, 09:45:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:09 INFO - 'tsvgr_opacity', 09:45:09 INFO - 'tart', 09:45:09 INFO - 'tscrollx', 09:45:09 INFO - 'cart']}, 09:45:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:09 INFO - 'talos_options': ['--disable-e10s'], 09:45:09 INFO - 'tests': ['tp5o']}, 09:45:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:09 INFO - 'tests': ['tp5o']}, 09:45:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:09 INFO - 'talos_options': ['--disable-e10s', 09:45:09 INFO - '--xperf_path', 09:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:09 INFO - 'tests': ['tp5n']}, 09:45:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:09 INFO - 'talos_options': ['--xperf_path', 09:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:09 INFO - 'tests': ['tp5n']}}, 09:45:09 INFO - 'talos.zip': {'path': '', 09:45:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:09 INFO - Running post-action listener: _resource_record_post_action 09:45:09 INFO - ##### 09:45:09 INFO - ##### Running create-virtualenv step. 09:45:09 INFO - ##### 09:45:09 INFO - Running pre-action listener: _resource_record_pre_action 09:45:09 INFO - Running main action method: create_virtualenv 09:45:09 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:09 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 09:45:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:09 INFO - Using real prefix '/tools/python27' 09:45:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:12 INFO - Installing pip.................done. 09:45:12 INFO - Return code: 0 09:45:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:12 INFO - 'HOME': '/Users/cltbld', 09:45:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:12 INFO - 'LOGNAME': 'cltbld', 09:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:12 INFO - 'MOZ_NO_REMOTE': '1', 09:45:12 INFO - 'NO_EM_RESTART': '1', 09:45:12 INFO - 'PAGER': '/bin/cat', 09:45:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:12 INFO - 'PWD': '/builds/slave/test', 09:45:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:12 INFO - 'SHELL': '/bin/bash', 09:45:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:12 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:12 INFO - 'USER': 'cltbld', 09:45:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:12 INFO - 'XPC_FLAGS': '0x0', 09:45:12 INFO - 'XPC_SERVICE_NAME': '0', 09:45:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:13 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 09:45:13 INFO - Cleaning up... 09:45:13 INFO - Return code: 0 09:45:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 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 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:13 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 09:45:13 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 09:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:13 INFO - 'HOME': '/Users/cltbld', 09:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:13 INFO - 'LOGNAME': 'cltbld', 09:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:13 INFO - 'MOZ_NO_REMOTE': '1', 09:45:13 INFO - 'NO_EM_RESTART': '1', 09:45:13 INFO - 'PAGER': '/bin/cat', 09:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:13 INFO - 'PWD': '/builds/slave/test', 09:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:13 INFO - 'SHELL': '/bin/bash', 09:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:13 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:13 INFO - 'USER': 'cltbld', 09:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:13 INFO - 'XPC_FLAGS': '0x0', 09:45:13 INFO - 'XPC_SERVICE_NAME': '0', 09:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:13 INFO - Downloading/unpacking psutil>=0.7.1 09:45:13 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 09:45:13 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 09:45:13 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 09:45:13 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 09:45:13 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 09:45:13 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 09:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:16 INFO - Installing collected packages: psutil 09:45:16 INFO - Running setup.py install for psutil 09:45:16 INFO - building 'psutil._psutil_osx' extension 09:45:16 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 09:45:17 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 09:45:17 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 09:45:17 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 09:45:17 INFO - building 'psutil._psutil_posix' extension 09:45:17 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 09:45:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:45:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:45:17 INFO - ^ 09:45:17 INFO - 1 warning generated. 09:45:17 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 09:45:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:17 INFO - Successfully installed psutil 09:45:17 INFO - Cleaning up... 09:45:17 INFO - Return code: 0 09:45:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:17 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 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:17 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 09:45:17 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 09:45:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:17 INFO - 'HOME': '/Users/cltbld', 09:45:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:17 INFO - 'LOGNAME': 'cltbld', 09:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:17 INFO - 'MOZ_NO_REMOTE': '1', 09:45:17 INFO - 'NO_EM_RESTART': '1', 09:45:17 INFO - 'PAGER': '/bin/cat', 09:45:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:17 INFO - 'PWD': '/builds/slave/test', 09:45:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:17 INFO - 'SHELL': '/bin/bash', 09:45:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:17 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:17 INFO - 'USER': 'cltbld', 09:45:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:17 INFO - 'XPC_FLAGS': '0x0', 09:45:17 INFO - 'XPC_SERVICE_NAME': '0', 09:45:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:45:20 INFO - Installing collected packages: mozsystemmonitor 09:45:20 INFO - Running setup.py install for mozsystemmonitor 09:45:20 INFO - Successfully installed mozsystemmonitor 09:45:20 INFO - Cleaning up... 09:45:20 INFO - Return code: 0 09:45:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:20 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 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:20 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 09:45:20 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 09:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:20 INFO - 'HOME': '/Users/cltbld', 09:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:20 INFO - 'LOGNAME': 'cltbld', 09:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:20 INFO - 'MOZ_NO_REMOTE': '1', 09:45:20 INFO - 'NO_EM_RESTART': '1', 09:45:20 INFO - 'PAGER': '/bin/cat', 09:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:20 INFO - 'PWD': '/builds/slave/test', 09:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:20 INFO - 'SHELL': '/bin/bash', 09:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:20 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:20 INFO - 'USER': 'cltbld', 09:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:20 INFO - 'XPC_FLAGS': '0x0', 09:45:20 INFO - 'XPC_SERVICE_NAME': '0', 09:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:21 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:24 INFO - Downloading docopt-0.6.1.tar.gz 09:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:24 INFO - Running setup.py install for blobuploader 09:45:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:25 INFO - Running setup.py install for requests 09:45:25 INFO - Running setup.py install for docopt 09:45:25 INFO - Successfully installed blobuploader requests docopt 09:45:25 INFO - Cleaning up... 09:45:25 INFO - Return code: 0 09:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:25 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')]} 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 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')]} 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:25 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 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:25 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 09:45:25 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 09:45:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:25 INFO - 'HOME': '/Users/cltbld', 09:45:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:25 INFO - 'LOGNAME': 'cltbld', 09:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:25 INFO - 'MOZ_NO_REMOTE': '1', 09:45:25 INFO - 'NO_EM_RESTART': '1', 09:45:25 INFO - 'PAGER': '/bin/cat', 09:45:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:25 INFO - 'PWD': '/builds/slave/test', 09:45:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:25 INFO - 'SHELL': '/bin/bash', 09:45:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:25 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:25 INFO - 'USER': 'cltbld', 09:45:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:25 INFO - 'XPC_FLAGS': '0x0', 09:45:25 INFO - 'XPC_SERVICE_NAME': '0', 09:45:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-h1a4GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-pPV6RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-EKEaTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-apuuSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-awUxiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Xyc7aA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-asuSdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-C6WeMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:26 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-pqS4hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:27 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-3pljdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:27 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-PXLryZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:27 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-e35OUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:27 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-3FDT3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:27 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-0IP6vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:27 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-wSdSMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:27 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-tTqRR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:27 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-wOVPrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:27 INFO - Running setup.py install for manifestparser 09:45:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:27 INFO - Running setup.py install for mozcrash 09:45:28 INFO - Running setup.py install for mozdebug 09:45:28 INFO - Running setup.py install for mozdevice 09:45:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Running setup.py install for mozfile 09:45:28 INFO - Running setup.py install for mozhttpd 09:45:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Running setup.py install for mozinfo 09:45:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Running setup.py install for mozInstall 09:45:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:29 INFO - Running setup.py install for mozleak 09:45:29 INFO - Running setup.py install for mozlog 09:45:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:29 INFO - Running setup.py install for moznetwork 09:45:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:29 INFO - Running setup.py install for mozprocess 09:45:29 INFO - Running setup.py install for mozprofile 09:45:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:29 INFO - Running setup.py install for mozrunner 09:45:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:29 INFO - Running setup.py install for mozscreenshot 09:45:30 INFO - Running setup.py install for moztest 09:45:30 INFO - Running setup.py install for mozversion 09:45:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:30 INFO - Cleaning up... 09:45:30 INFO - Return code: 0 09:45:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:30 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 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:30 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 09:45:30 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 09:45:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:30 INFO - 'HOME': '/Users/cltbld', 09:45:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:30 INFO - 'LOGNAME': 'cltbld', 09:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:30 INFO - 'MOZ_NO_REMOTE': '1', 09:45:30 INFO - 'NO_EM_RESTART': '1', 09:45:30 INFO - 'PAGER': '/bin/cat', 09:45:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:30 INFO - 'PWD': '/builds/slave/test', 09:45:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:30 INFO - 'SHELL': '/bin/bash', 09:45:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:30 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:30 INFO - 'USER': 'cltbld', 09:45:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:30 INFO - 'XPC_FLAGS': '0x0', 09:45:30 INFO - 'XPC_SERVICE_NAME': '0', 09:45:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:30 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-redySY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:30 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)) 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:30 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-1YQ3kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:30 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)) 09:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:30 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-R6CuJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-SCGSNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-3XhB21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-xHM2hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-qM1DEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-0lVTft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-zLHC96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-6gT5KJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-eBAN_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-4UnV6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:31 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-tiTtKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:32 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-MnwOpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:32 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Zvsj4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:32 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-B6kgaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:32 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-yCWOU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 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)) 09:45:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:34 INFO - Downloading blessings-1.6.tar.gz 09:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:35 INFO - Installing collected packages: blessings 09:45:35 INFO - Running setup.py install for blessings 09:45:35 INFO - Successfully installed blessings 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:35 INFO - Reading from file tmpfile_stdout 09:45:35 INFO - Current package versions: 09:45:35 INFO - blessings == 1.6 09:45:35 INFO - blobuploader == 1.2.4 09:45:35 INFO - docopt == 0.6.1 09:45:35 INFO - manifestparser == 1.1 09:45:35 INFO - mozInstall == 1.12 09:45:35 INFO - mozcrash == 0.17 09:45:35 INFO - mozdebug == 0.1 09:45:35 INFO - mozdevice == 0.48 09:45:35 INFO - mozfile == 1.2 09:45:35 INFO - mozhttpd == 0.7 09:45:35 INFO - mozinfo == 0.9 09:45:35 INFO - mozleak == 0.1 09:45:35 INFO - mozlog == 3.1 09:45:35 INFO - moznetwork == 0.27 09:45:35 INFO - mozprocess == 0.22 09:45:35 INFO - mozprofile == 0.28 09:45:35 INFO - mozrunner == 6.11 09:45:35 INFO - mozscreenshot == 0.1 09:45:35 INFO - mozsystemmonitor == 0.0 09:45:35 INFO - moztest == 0.7 09:45:35 INFO - mozversion == 1.4 09:45:35 INFO - psutil == 3.1.1 09:45:35 INFO - requests == 1.2.3 09:45:35 INFO - wsgiref == 0.1.2 09:45:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:35 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')]} 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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')]} 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:35 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 09:45:35 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 09:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:35 INFO - 'HOME': '/Users/cltbld', 09:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:35 INFO - 'LOGNAME': 'cltbld', 09:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:35 INFO - 'MOZ_NO_REMOTE': '1', 09:45:35 INFO - 'NO_EM_RESTART': '1', 09:45:35 INFO - 'PAGER': '/bin/cat', 09:45:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:35 INFO - 'PWD': '/builds/slave/test', 09:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:35 INFO - 'SHELL': '/bin/bash', 09:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:35 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:35 INFO - 'USER': 'cltbld', 09:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:35 INFO - 'XPC_FLAGS': '0x0', 09:45:35 INFO - 'XPC_SERVICE_NAME': '0', 09:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:35 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')]} 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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')]} 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:35 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 09:45:35 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 09:45:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:35 INFO - 'HOME': '/Users/cltbld', 09:45:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:35 INFO - 'LOGNAME': 'cltbld', 09:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:35 INFO - 'MOZ_NO_REMOTE': '1', 09:45:35 INFO - 'NO_EM_RESTART': '1', 09:45:35 INFO - 'PAGER': '/bin/cat', 09:45:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:35 INFO - 'PWD': '/builds/slave/test', 09:45:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:35 INFO - 'SHELL': '/bin/bash', 09:45:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:35 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:35 INFO - 'USER': 'cltbld', 09:45:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:35 INFO - 'XPC_FLAGS': '0x0', 09:45:35 INFO - 'XPC_SERVICE_NAME': '0', 09:45:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:36 INFO - Downloading/unpacking jsonschema 09:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:38 INFO - Downloading/unpacking functools32 (from jsonschema) 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:38 INFO - warning: no files found matching '*.txt' 09:45:38 INFO - no previously-included directories found matching 'build' 09:45:38 INFO - no previously-included directories found matching 'dist' 09:45:38 INFO - no previously-included directories found matching '.git*' 09:45:38 INFO - Installing collected packages: jsonschema, functools32 09:45:39 INFO - Running setup.py install for functools32 09:45:39 INFO - warning: no files found matching '*.txt' 09:45:39 INFO - no previously-included directories found matching 'build' 09:45:39 INFO - no previously-included directories found matching 'dist' 09:45:39 INFO - no previously-included directories found matching '.git*' 09:45:39 INFO - Successfully installed jsonschema functools32 09:45:39 INFO - Cleaning up... 09:45:39 INFO - Return code: 0 09:45:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:45:39 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')]} 09:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:39 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')]} 09:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:39 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 0x10c443a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c453420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed285c8e20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, '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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:45:39 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 09:45:39 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 09:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:39 INFO - 'HOME': '/Users/cltbld', 09:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:39 INFO - 'LOGNAME': 'cltbld', 09:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:39 INFO - 'MOZ_NO_REMOTE': '1', 09:45:39 INFO - 'NO_EM_RESTART': '1', 09:45:39 INFO - 'PAGER': '/bin/cat', 09:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:39 INFO - 'PWD': '/builds/slave/test', 09:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:39 INFO - 'SHELL': '/bin/bash', 09:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:45:39 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:39 INFO - 'USER': 'cltbld', 09:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:39 INFO - 'XPC_FLAGS': '0x0', 09:45:39 INFO - 'XPC_SERVICE_NAME': '0', 09:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:39 INFO - Downloading/unpacking flake8 09:45:39 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 09:45:39 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 09:45:39 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 09:45:39 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 09:45:39 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 09:45:39 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 09:45:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:45:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:45:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:45:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:43 INFO - no previously-included directories found matching 'docs/_build' 09:45:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:45:43 INFO - Running setup.py install for pep8 09:45:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:43 INFO - no previously-included directories found matching 'docs/_build' 09:45:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:45:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:45:43 INFO - Cleaning up... 09:45:43 INFO - Return code: 0 09:45:43 INFO - Running post-action listener: _resource_record_post_action 09:45:43 INFO - Running post-action listener: _start_resource_monitoring 09:45:43 INFO - Starting resource monitoring. 09:45:43 INFO - ##### 09:45:43 INFO - ##### Running install step. 09:45:43 INFO - ##### 09:45:43 INFO - Running pre-action listener: _resource_record_pre_action 09:45:43 INFO - Running main action method: install 09:45:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:43 INFO - Reading from file tmpfile_stdout 09:45:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:43 INFO - Reading from file tmpfile_stdout 09:45:43 INFO - Output received: 09:45:43 INFO - Usage: mozinstall [options] installer 09:45:43 INFO - Options: 09:45:43 INFO - -h, --help show this help message and exit 09:45:43 INFO - -d DEST, --destination=DEST 09:45:43 INFO - Directory to install application into. [default: 09:45:43 INFO - "/builds/slave/test"] 09:45:43 INFO - --app=APP Application being installed. [default: firefox] 09:45:43 INFO - mkdir: /builds/slave/test/build/application 09:45:43 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'] 09:45:43 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 09:46:17 INFO - Reading from file tmpfile_stdout 09:46:17 INFO - Output received: 09:46:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:46:17 INFO - Running post-action listener: _resource_record_post_action 09:46:17 INFO - ##### 09:46:17 INFO - ##### Running run-tests step. 09:46:17 INFO - ##### 09:46:17 INFO - Running pre-action listener: _resource_record_pre_action 09:46:17 INFO - Running main action method: run_tests 09:46:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:17 INFO - 2016-04-08 09:46:17.115 screenresolution[1657:7976] starting screenresolution argv=screenresolution get 09:46:17 INFO - 2016-04-08 09:46:17.117 screenresolution[1657:7976] Display 0: 1600x1200x32@60 09:46:17 INFO - 2016-04-08 09:46:17.123 screenresolution[1658:7978] starting screenresolution argv=screenresolution list 09:46:17 INFO - Available Modes on Display 0 09:46:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:17 INFO - Intel Iris: 09:46:17 INFO - Chipset Model: Intel Iris 09:46:17 INFO - Type: GPU 09:46:17 INFO - Bus: Built-In 09:46:17 INFO - VRAM (Dynamic, Max): 1536 MB 09:46:17 INFO - Vendor: Intel (0x8086) 09:46:17 INFO - Device ID: 0x0a2e 09:46:17 INFO - Revision ID: 0x0009 09:46:17 INFO - Displays: 09:46:17 INFO - Display: 09:46:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:17 INFO - Display Serial Number: 1600x1200 60 09:46:17 INFO - Main Display: Yes 09:46:17 INFO - Mirror: Off 09:46:17 INFO - Online: Yes 09:46:17 INFO - Rotation: Supported 09:46:17 INFO - Return code: 0 09:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:17 INFO - Python 2.7.3 09:46:17 INFO - Return code: 0 09:46:17 INFO - grabbing minidump binary from tooltool 09:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:17 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 0x10c2e2e00>, '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 0x10c14bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c2ddb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:17 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 09:46:17 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 09:46:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:17 INFO - Return code: 0 09:46:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:46:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:46:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:46:18 INFO - Return code: 0 09:46:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 09:46:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --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 09:46:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A8VrNDtzOf/Render', 09:46:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:18 INFO - 'HOME': '/Users/cltbld', 09:46:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:18 INFO - 'LOGNAME': 'cltbld', 09:46:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:18 INFO - 'MOZ_NO_REMOTE': '1', 09:46:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:18 INFO - 'NO_EM_RESTART': '1', 09:46:18 INFO - 'PAGER': '/bin/cat', 09:46:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:18 INFO - 'PWD': '/builds/slave/test', 09:46:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:18 INFO - 'SHELL': '/bin/bash', 09:46:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wXLE5mv9vh/Listeners', 09:46:18 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:46:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:18 INFO - 'USER': 'cltbld', 09:46:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:18 INFO - 'XPC_FLAGS': '0x0', 09:46:18 INFO - 'XPC_SERVICE_NAME': '0', 09:46:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 09:46:18 INFO - mozversion application_buildid: 20160408080755 09:46:18 INFO - mozversion application_changeset: 1e17a83bd0d7767cdf89eb11a78ef572d6c427bf 09:46:18 INFO - mozversion application_display_name: Nightly 09:46:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:18 INFO - mozversion application_name: Firefox 09:46:18 INFO - mozversion application_remotingname: firefox 09:46:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:46:18 INFO - mozversion application_vendor: Mozilla 09:46:18 INFO - mozversion application_version: 48.0a1 09:46:18 INFO - mozversion platform_buildid: 20160408080755 09:46:18 INFO - mozversion platform_changeset: 1e17a83bd0d7767cdf89eb11a78ef572d6c427bf 09:46:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:46:18 INFO - mozversion platform_version: 48.0a1 09:46:18 INFO - using testdate: 1460133978 09:46:18 INFO - actual date: 1460133978 09:46:18 INFO - starting webserver on 'localhost:49275' 09:46:18 INFO - SUITE-START | Running 2 tests 09:46:18 INFO - TEST-START | dromaeo_css 09:46:18 INFO - operating with platform_type : mac_ 09:46:18 INFO - Initialising browser for dromaeo_css test... 09:46:18 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpBDl0ee/profile http://localhost:49275/getInfo.html) 09:46:21 INFO - PROCESS | 1676 | 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] 09:46:21 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 09:46:21 INFO - PROCESS | 1676 | colorDepth:24 09:46:21 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 09:46:21 INFO - PROCESS | 1676 | __metrics 09:46:22 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 09:46:22 INFO - TEST-INFO | 1676: exit 0 09:46:22 INFO - Browser initialized. 09:46:22 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:22 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpBDl0ee/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:34 INFO - PROCESS | 1680 | RSS: Main: 248172544 09:46:34 INFO - PROCESS | 1680 | 09:47:24 INFO - PROCESS | 1680 | 1460134044300 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] 09:49:35 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 09:49:36 INFO - PROCESS | 1680 | RSS: Main: 262258688 09:49:36 INFO - PROCESS | 1680 | 09:52:38 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 09:52:39 INFO - PROCESS | 1680 | RSS: Main: 273596416 09:52:39 INFO - PROCESS | 1680 | 09:55:41 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 09:55:41 INFO - PROCESS | 1680 | RSS: Main: 275886080 09:55:41 INFO - PROCESS | 1680 | 09:58:43 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 09:58:44 INFO - PROCESS | 1680 | RSS: Main: 277417984 09:58:44 INFO - PROCESS | 1680 | 10:01:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 10:01:47 INFO - PROCESS | 1680 | RSS: Main: 280272896 10:01:47 INFO - PROCESS | 1680 | 10:04:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 10:04:50 INFO - PROCESS | 1680 | RSS: Main: 281575424 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - PROCESS | 1680 | __start_tp_report 10:04:50 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 10:04:50 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 10:04:50 INFO - PROCESS | 1680 | |i|pagename|runs| 10:04:50 INFO - PROCESS | 1680 | |0;dojo.html;2809.9438011239777;2908.549174877893;3349.6650334966507;3486.511888335635;3486.651334866512;4798.4961579034225;5659.405762394951;5711.428857114297;5739.713014349287;5757.078867381219;5683.914741278884;5792.189093526909;5859.1797148399155;5862.794802181925;5912.763489460416;5162;5210.166373380251;5249.107651699221;5291.735413229323;5337.092694241969;5388.191771234307;5400.054990376669;5401.378841433227;5419.187121931703;5453.427390124039;5137.17805151174;5157.742112894341;5257.290265814105;5300.840974770763;5332.706701131437;5237.764300606444;5249.501297376782;5249.8425047248265;5254.106801843695;5266.236395722599;5200.479952004807;5201.505856943584;5216.765245563959;5236.1098613235845;5277.6305658603915;4806.7262175523165;5593.580481463907;5698.7435565399655;5730.598858079936;5751.338596061465;6170.8765824683705;6191.938080619227;6226.101039183048;6235;6286.937130628681;6232.1898153240245;6239.594426362272;6253.906191407133;6255.812325630239;6267.279262884781;5773.278340207474;5826.096954971986;5924.289085309747;5950.31571369298;5982.40175982407;6263.906041409383;6297.307296197415;6301.558890877686;6328.303886572473;6369.108324834527;6081.331053584102;6213.720382582795;6238.189035425366;6267.5299352548745;6270.7491700331475;5711.314642242957;5933.406659334119;6179.3820617937845;6264.21697287839;6306.590071645328;4986.80052797884;5199.818006369759;5278.868028299324;6153.953827849276;6239.688015599202;6111.777644471034;6197;6224;6268.435840774261;6285;4874.5856602188505;4895.167821470359;4961.231009193581;4972.701637901738;5009.373828271466;3826.8136877568045;4426.977865110718;4443.911121777546;4459.955400446019;4473.306637471197;5686.9715651421475;5811.283075386919;5862.296524417097;5862.384449632812;5897.0269905465975;6182.443580077815;6242.313345531988;6250.74997000124;6256.718447669866;6264.467520260829;5825.825225243249;5841.678707671034;5848.8537786554825;5892.941070589325;5908.350081491032;5317.787288508416;5434.70109143993;5446.264754258124;5449.3460784706085;5454.945450545444;6339.429451349401;6421.293657697743;6422.967885160638;6433.774817881352;6452.032195170668;6228.968855155696;6259.34276900937;6267.811965641038;6282.905756413566;6313.621182729051;6129.236538068469;6338.492920566436;6369.90445143314;6376.649284289409;6382.138411314413;5775.595708300379;5973.731182096729;6190.288116866618;6200.0699895016105;6241.563090583615;5527.336719593674;6205.44863784054;6243.250809902841;6258;6267.62394256346;6101.389861013863;6147.477464415575;6202.317745048132;6226.844328891814;6243;6125.877482450237;6130.306415576139;6151.0773383992755;6154.415330543591;6166.075088736726;4583.106294272585;5653.236813030353;5936.22829032223;6023.789167379121;6048.758049677964;4872;5437.238786569963;5612.466815652507;5942.910856337072;5967.9701601491715;5981.880362392815;6011.789587364421;6034.39656034393;6042.335343112342;6047.5464340173785 10:04:50 INFO - PROCESS | 1680 | |1;ext.html;477.6298368764207;530.4854291337404;543.6520626798848;544.9999999999999;585.6690969602172;35536;36356.63643363566;36384.81807590965;36399.09002274944;36458.27083458332;40025.79987100068;40549.59450405495;40771.18457630846;40947;40986.59013409865;9236.630534778618;9455.054494550524;9493.952530237373;9499.71500854972;9508;9350.672726454575;9387.389819661701;9402.5768840402;9406.43561386319;9454.29092818038;9408.341416100875;9443.102905223992;9476.715698529055;9508.429494230333;9521.619135234583;9451.432914025147;9532.571034303473;9536;9550.3792253504;9566.47384393858;9274.350795444321;9296.767580810467;9366.812663746756;9408.341416100875;9439.764005899839;37096.814515927246;37492.81253593715;37559.436608450895;37629.811850940845;37642.24715505702;2953.601263829377;3137.7892310046677;3202.96797032029;3207.951880721791;3222.4360736870954;27775.861120694266;28085.29786755327;28842.71157288421;28960;28974.130776076752;2750.9587356189672;2754.1049159023196;2819.4643017826547;2827.7313655202724;2846.6584009918943;459464;466193;467708;468525;470144.99999999657;34641.30717385638;35345.64654353475;35698;35703.4644480333;57283.427165728644;34174.63301467963;34186.65813341835;34440.31119377598;34460;34516.654833451845;14666.340014699364;14859;14894.627634309229;14904.70190596182;14930.10419374841;12429.875701243052;12517.061220408506;12521.186122901981;12611.495540178474;12673.556425525247;7862.2137786222065;7942.205779422012;8060.637271322805;8114.269715725495;8189.8771518427275;3392.423288041039;3408.642092580293;3453.2748122893972;3454.775439596418;3472.5138480612736;918.169057003413;992.0476342710934;1018.2770233134557;1032.8347464405658;1055.514463346869;28996;29193.7080629191;29486.852565737463;29591.556126657688;29611.111666650035;870.9433886797337;989.5250279865561;1068.1027936533349;1086.5327908999207;1124.7131981344705;12580.308083055337;13446.663833404244;14048.929755351157;14445.988780785245;14448.277586120652;590256;603426;611200.719982004;616907.9154604198;619348;51345.45963621097;51886;53382.39852804422;57846.13230801541;58005.419945800844;1225.7364666596725;1443.992780036093;1482.6071091160852;1493.4250313629113;1501.8498150185112;27206.047788327312;27335.86332068327;27817.72182278232;27919.860400697868;27953.860230698716;47004.529954701386;47100.7644961773;47348.7632561835;47491.05017899692;47775.5222447785;455068;538860;539012.609873912;541156;547194;25888.611670824575;26046.34884127912;26114;26524.734752652228;26542.203733888015;44278;44618.330725038504;45145.77427112844;45211.773941130086;45497.545024549334;36049.27901441904;36579.817100914326;36668.81665591762;37431;37621.435678464295;36369.27261454703;36557.634423656484;36655.633443665225;37045.44431833471;37288.44067339046;31640.525392118678;35974.640253598176;36525.63474365329;37491.62508374881;37619.81190094032;30397.544036839023;31065.37869242648;31878.64317717565;32897.34205315928;33216.00351989444;19325.138107798848;21857.234996775038;22334;24202;24260.63609045901 10:04:50 INFO - PROCESS | 1680 | |2;jquery.html;380.2565983502255;386.43580372655913;389.7135605330082;392.62504308385496;406.22208470778423;17850;18633;20378.898105509452;21315.467113322175;21369.465763355925;20001.899990500064;20731.689024664644;20792.68810967833;20820.895895520538;21145;4369.650427965755;4944.456109827916;5614.747336369863;5801.622894511865;5827.562932780059;4895.339129217564;5655;5662.858428539299;5671.177679236508;5760.855978600547;5078.568321692661;5830.44610761979;5896.96803059465;5930.080837470199;5999.100134979744;5223.843284701465;5695.40198279183;5785.3925337839555;5788;5893.852653683693;5702.059160238556;5709.74306156224;5807.767689292423;5821.330546987108;5836.212111364954;13356.998225133153;13567.389467473988;13987.720245595134;13988.790168147487;14010.579682609436;2024.2409096588779;2027.28031548801;2207.547452772178;2316.8841557922037;2398.9040438382444;7860.371170306362;9938.956409576962;9955.90044099557;10110.797784044278;10137.189024877993;1731.9393821216197;1758.78015248094;1773.5300145461463;1814.0838876367482;1841.5856432302758;79982.80025799618;102225;108978.45510772396;114345.99999999917;114917;11462.598809041643;11627.12796540263;11718.70703232409;11828.536093989946;12076;14923.104613723212;15036.248187590576;15041.47354842597;15178.620534486727;15218.847811521964;8709.303255739653;8779.561021948877;8799.516026618598;8807.119288071142;8833.734987950244;6981.930180698128;8494.320454363637;8515.531645759418;8647.135286471303;8734.519601421856;4627.537246275413;4681.7190968542;4693.9765301173275;4745.905081898342;4751.4535828379485;1729.5070904792074;1955.559999000242;2036.5926814637132;2046.3042565527792;2046.4065421028033;909.5270459361095;978.2467500025083;995.069609914732;1013.7465633591602;1100.3452945497415;19687;19731.309404170785;21370;21482.355529334145;21612.89193554022;920.8572671235969;964.9674847912806;974.3471873844542;978.3054031637618;1015.6496008876926;7592.658330375147;7893.842123157505;10110.515155294997;10287.74280642975;10547.419891906018;597841;634525;641686;643825;645727;99225;125387.74612253944;128271;128534;133558;953.7710949372239;984.1093810101869;1001.649422702063;1039.1738567838586;1068.529846867376;17967.640647187243;18357.81642183561;18493.16780744843;18571.907140464213;18588.837910565773;33335.83332083324;36302.636973629924;45563.772181138884;48371;49063.75468122637;70409;71282.28717712963;71595.28404716095;71610;73512.26487735267;7964.522128672298;8093.271605555528;8165.2243036911395;8366.372522060992;8561.22948934599;10527.157827373945;12125;12392.194507356993;12458.31479268649;12534;10670.83993740079;10703.357798532114;10991.06575941054;11115.277506962346;11214.327140371604;10374.636887708893;10408.583656653953;10711.678649640524;10885.564577416815;11109.222354435435;10935.781284374427;11035.613753518588;11068.612598559012;11303.830442543533;11525.596604118815;8149.959250203711;8316.584170791315;8318.958405207935;8328.625211865601;8486.957565212382;10123.443210623487;10832.945835270773;11130.387828669502;11176.217664763388;11302.943485282522 10:04:50 INFO - PROCESS | 1680 | |3;mootools.html;1544.6215677159098;1594.314444788741;1801.4775715042638;1846.8799528030677;1908.6659834528955;7741.961290193542;8265.50406975582;8329.458585191958;8585.613647385859;8621.008584012832;8263.752087437371;8294.83410331793;8349.749507514769;8350.83298334033;8384.329253659707;2371.229350461107;2375.26366826284;2390.5099454611764;2396.9280921572295;2402.231285988484;2347;2370.7316585626695;2386.7016622922133;2396.4488167721433;2404.9398765030837;2383.4041489627593;2395.7724016218517;2401.6157414813633;2415.5410472010262;2415.855048697075;2362.7873491385685;2377.476955069882;2388.940276493084;2391.940201494959;2396.293093537402;2340.5435939991708;2369.8387789982785;2381.8570885746913;2386.880655967195;2393.210240620591;7332.30343117403;8361.790955226108;8406.78983025423;8531.189536993976;8537.359698022674;5076.543111120017;5181.222816577506;5195.792168313263;5240.737963101829;5251.4485978972425;2815.802893797435;3517.7009954153928;3575.785452872836;3578.1054736315923;3641.708663306929;1008.7730260691359;1032.117539503721;1037.0718207204586;1041.833306670929;1045.968620941373;10721.785564288748;10723.46382680863;10819.13446924244;10825.566977320976;10834.15819310719;4357.4988876279;4438.533953934791;4533.979854532704;4534.387857639243;4535.569120933506;8738.69414570487;8768.079351667982;8777;8797.340199484936;8797.912020879709;5066.923996140061;5117.334746483008;5128.384593848762;5130.51260130287;5199.194124910569;3975.92048159041;4275.8075886585175;4777.450593181759;4793.760311984387;4804.495527969513;3642.21692336149;3673.559172899269;3712.4431335299923;3754.4931434256573;3807.3908174691915;1173.3370645585217;1174.3775798826637;1176.6764139861436;1183.44378142273;1189.881011898803;1339.4909934225127;1352.6956434802287;1383.004236949395;1384.9584512464642;1404.4101477379525;7797.688092476351;7942.483738556975;7983.2415920487465;8001.239882211181;8001.599920003977;504.46022755651103;511.2969666708276;518.7665550502289;520.5991386632272;523.4765234765234;6055.576109672369;6133.6319820810895;6276.058591211355;6288.52836037299;6372.107904893319;9779.51102444875;10214.95700859831;10217.386956782617;10217.74455638615;10306.48467576633;9892.851607225897;10013.449260290754;10122.240831937634;10196.439195844152;10300.793984120275;7909.604519773989;7956.5226086435;7962.08436029864;7974.880376794353;7986.281234688906;7633.488789685102;7645.464817462725;7698.153203147761;7736.071671399243;7745.651445684845;9136.634534618806;9404.905950940403;9495.19290860257;9601.279904007088;9649.517524123907;9243.21432678203;9444.102810233291;9497.382670126695;9507.952460237655;9586.520673966133;6663.13379260693;7070.222275549789;7088.468364872552;7262.092238470192;7296.452766042674;7981.161977992228;7986.401019923413;8030.397720170894;8035.517868927883;8053.073896501743;6995.405390541861;7103.964480177566;7130.322619351154;7240.167380751281;7281.817954551178;6644.83387915306;6705.027770973279;6726.39462448382;6759.831004224934;6828.931710682829;7525.849483010418;7542.2834830691;7577.052868391451;7608.087029556488;7610.124835643972;6843.794686159423;6869.210040845367;6877.793666190022;6919.792406227822;6938.757143499954;5587.860303492445;6460.160179176865;6945.722171113099;6974.128233970754;7047.823804404931 10:04:50 INFO - PROCESS | 1680 | |4;prototype.html;244.5573511943382;322.77567090871844;324.8651809499058;333.0757148911771;335.37452650806256;5522.779088836452;5539.639923404976;5707.9143812842785;6346.714397852091;6391.233052033751;4820;5465.672059676423;6250;6282.68586570672;6364.090772768174;3526.629703881094;3948.2893079245723;4109.589041095882;4646.558576935195;4646.907061858761;3510.385682505564;4157.688173386993;4615.515370886059;4678.415198100238;4695.413073365829;4113.280175969208;4505.77471126444;4618.884527886813;4693.530646935314;4701.378024581514;4229.534751177368;4368;4520.728756274634;4685.83599574015;4690.132325519789;3353.748468864845;3932.941005884914;3957.3668213086057;3970.2059588082498;3991.5808840071663;5996.220491336142;6031.788887388921;6040.848978775522;6044.607100538451;6051.671580630636;4455.688101832873;5247.134222853225;5427.432806304377;5428.75570599324;5436.320459942507;6549.6070235786;6659.93340066598;6666.933330666729;6682.599044057372;6684.364985326386;4411.338299255138;4413;4414.955850441486;4432.180046691373;4444.222261104326;5924.504542320009;6663.63350015749;6983.82540436488;7009.334113259232;7050.647467626598;4137.2552940470405;4448.688591798607;4482.932756008662;4488.12481566098;4515.729056256635;4345.956540434555;4547.136044151667;4554.863354099382;4578.427696537933;4584.3352713856975;4302.591253830881;5389.67661940277;5398.271233383522;5406.459354064562;5429.1856221566295;6261.5616906816085;6385.393387628168;6620.801375958729;6714.798556043326;6717.328267173243;1323.4904561743797;1478;1533.7009283189893;1582.0112429731419;1594.4658539389434;859.4529846276802;896.4800415758845;965.5799727118725;1015.5430056474615;1051.8272126578809;4826.469088400273;5159.458256883048;5365.490278423544;6118.296395914438;6168;6838.21360543534;6886.449084073262;6890.621015844176;6899.275576064541;6917.75787847433;5985.072313791369;6096.786612468631;6141.324454310023;6167.691615419211;6212.378762123752;3090.7063828936216;3587.121155316912;3623.0217841182734;3637.636236376341;3651.5253017107607;6737.079932219294;6815.863682726417;6881.311868813079;6998.125234345707;7119.644017799089;6147.415995480422;6691.631960242136;7046;7051.435885129177;7069;6622.966885165543;7089.255628159072;7097.615964886901;7099.467539934525;7133;6199.28708198563;6651.802675518453;6790.93209067903;6844.726210951506;6845.110135682329;6521.7065232065615;6741.831454213684;6750.232404714044;6767.323267673193;6873.5875847449315;7223.927760722536;7237.312455316736;7250.818729531593;7252.829622966709;7269.454790890599;3958.366661334173;4387.868363949086;4419;4432.268675668607;4450.443694538183;5837.241158649348;6466.579672321284;6858.6570671467225;6940;6987.231404545394;6262.279837818709;6642.4686025118845;6701.396874281338;6747;6766.830829229112;6241.438270555672;6629.867402652017;6671.066050752996;6720.294369091175;6724.697388617622;5196.427768254738;5745.770169193353;6417.294097649348;6497.480201583768;6527.249366322933;5517.668939863621;5661.320641523043;6737.69680364375;6751.535689473405;6758.918573028292;6293.748250069946;6535.509836762167;6553.672316384257;6578;6582.407583317525 10:04:50 INFO - PROCESS | 1680 | |5;yui.html;600.8708127752534;654.6268626882679;726.4043484342837;744.7132853851269;752.525908677533;14691.265436728161;15162.924185379085;15165;15170.848291517068;15175.54473365798;12376.257424554533;13719.519816806414;13798.965077619194;13953.790693139612;13971;691.4399336537396;882.466108004656;907.9001309855911;908.8182363527288;910.3718434280325;886.8359353519587;923.5751554285036;926.4811705444939;927.248928368024;927.9814403711922;927.9628814847398;950.2113246005833;958.2669258017622;964.1322809471496;965.6620182935986;911.0024523147143;929.8372784762673;953.5708930981051;954.8901876284177;955.6034245787989;679.1035832700837;681.1723755636875;689.3795583974413;699.8005568412977;708.8121647763347;14662.560123196321;14760.335784889598;14837.777433338508;14849.331780069922;14982.925085374503;12734.172278801849;12735.23588584688;12784.232946023269;12791.808122878165;12932.935335323356;8371.911651485329;9442.197413219885;9809;9853.605855765762;9897.406155630613;3315.7181639560667;3373;3392.9660703392897;3435.587729472479;3542.752007359486;63247.367526324146;82252.58873705653;84381;84636.57681711613;85643;7393.630318484054;8157.3474122071275;9098.590563424661;9494.28792840526;9530.475823829618;21531.56936861254;21701.348959530922;21724.348269551938;21827.01778419975;21840.672389914165;7415.925840741632;7572.167061623217;7634.809129771689;7686.769396918102;7808.2191780822595;3981.3828856527284;4013.9598604013586;4053.2906741320153;4061;4062.4921884764403;3370.443876760356;3437.3812713711773;3499.090236538518;3499.16020155166;3503.1242189452637;644.8935925572322;649.2825427902195;651.9959262735334;661.4873473058323;665.6139439125295;517.6350672775684;529.2352550564398;584.9356570777211;605.4088501214808;607.1590846677384;7720.652570634335;7908.130105688369;8023.277904988462;8040.758777236692;8240.793980150424;560.341598621618;590.5600327755849;597.5757212379173;601.380578004656;608.7869245763948;3508.6842184203542;3644.1800594865945;3787.299349620274;3814.675752561008;4064.776437295918;86161.56919215363;88688.11311886928;90073.54963225142;90242;91066.1786764261;66608;66850.66574667193;67467;67556;68901.31098688948;63375;66007;67294.66352668205;67955;68126.65936670384;7467.477276590586;7535.54786712799;7761.456698031309;7806.375489960676;7897.565633890191;42758;43829.56170438382;43853.56146438495;44640.55359446494;44820.55179448294;60461;61634;62261.75476490535;63829.68085159545;64344.03483947838;9700.805983880424;9778.266630002921;9781.608735650494;10006;10100.949495252476;10656.467176640981;10666.57333706674;10770.838437423601;10829.783404332027;11575.536978521102;8855.955720221358;9972.551235194289;9985.60057597688;10004.599816007278;10693.304935179189;8963.417377870417;10441.582336706446;10641.04230619248;10681.359118452918;10912.563497460013;7824.64789084504;9965;9978.700638980843;10028.799424011624;10349.689509314732;8450.577471126542;8574.442661227;8578.227959483676;8778.692745753868;8939.910600894167;7635.770926872203;8286.295664868312;8379.45533540318;8572.785680358042;8823.735287941372 10:04:50 INFO - PROCESS | 1680 | __end_tp_report 10:04:50 INFO - PROCESS | 1680 | __start_cc_report 10:04:50 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,395 10:04:50 INFO - PROCESS | 1680 | __end_cc_report 10:04:50 INFO - PROCESS | 1680 | __startTimestamp1460135090200__endTimestamp 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - PROCESS | 1680 | ------- Summary: start ------- 10:04:50 INFO - PROCESS | 1680 | Number of tests: 6 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - PROCESS | 1680 | [#0] dojo.html Cycles:165 Average:5714.56 Median:5912.76 stddev:680.88 (11.5%) stddev-sans-first:643.71 10:04:50 INFO - PROCESS | 1680 | Values: 2809.9 2908.5 3349.7 3486.5 3486.7 4798.5 5659.4 5711.4 5739.7 5757.1 5683.9 5792.2 5859.2 5862.8 5912.8 5162.0 5210.2 5249.1 5291.7 5337.1 5388.2 5400.1 5401.4 5419.2 5453.4 5137.2 5157.7 5257.3 5300.8 5332.7 5237.8 5249.5 5249.8 5254.1 5266.2 5200.5 5201.5 5216.8 5236.1 5277.6 4806.7 5593.6 5698.7 5730.6 5751.3 6170.9 6191.9 6226.1 6235.0 6286.9 6232.2 6239.6 6253.9 6255.8 6267.3 5773.3 5826.1 5924.3 5950.3 5982.4 6263.9 6297.3 6301.6 6328.3 6369.1 6081.3 6213.7 6238.2 6267.5 6270.7 5711.3 5933.4 6179.4 6264.2 6306.6 4986.8 5199.8 5278.9 6154.0 6239.7 6111.8 6197.0 6224.0 6268.4 6285.0 4874.6 4895.2 4961.2 4972.7 5009.4 3826.8 4427.0 4443.9 4460.0 4473.3 5687.0 5811.3 5862.3 5862.4 5897.0 6182.4 6242.3 6250.7 6256.7 6264.5 5825.8 5841.7 5848.9 5892.9 5908.4 5317.8 5434.7 5446.3 5449.3 5454.9 6339.4 6421.3 6423.0 6433.8 6452.0 6229.0 6259.3 6267.8 6282.9 6313.6 6129.2 6338.5 6369.9 6376.6 6382.1 5775.6 5973.7 6190.3 6200.1 6241.6 5527.3 6205.4 6243.3 6258.0 6267.6 6101.4 6147.5 6202.3 6226.8 6243.0 6125.9 6130.3 6151.1 6154.4 6166.1 4583.1 5653.2 5936.2 6023.8 6048.8 4872.0 5437.2 5612.5 5942.9 5968.0 5981.9 6011.8 6034.4 6042.3 6047.5 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - PROCESS | 1680 | [#1] ext.html Cycles:180 Average:64430.68 Median:36568.73 stddev:143618.57 (392.7%) stddev-sans-first:143941.19 10:04:50 INFO - PROCESS | 1680 | Values: 477.6 530.5 543.7 545.0 585.7 35536.0 36356.6 36384.8 36399.1 36458.3 40025.8 40549.6 40771.2 40947.0 40986.6 9236.6 9455.1 9494.0 9499.7 9508.0 9350.7 9387.4 9402.6 9406.4 9454.3 9408.3 9443.1 9476.7 9508.4 9521.6 9451.4 9532.6 9536.0 9550.4 9566.5 9274.4 9296.8 9366.8 9408.3 9439.8 37096.8 37492.8 37559.4 37629.8 37642.2 2953.6 3137.8 3203.0 3208.0 3222.4 27775.9 28085.3 28842.7 28960.0 28974.1 2751.0 2754.1 2819.5 2827.7 2846.7 459464.0 466193.0 467708.0 468525.0 470145.0 34641.3 35345.6 35698.0 35703.5 57283.4 34174.6 34186.7 34440.3 34460.0 34516.7 14666.3 14859.0 14894.6 14904.7 14930.1 12429.9 12517.1 12521.2 12611.5 12673.6 7862.2 7942.2 8060.6 8114.3 8189.9 3392.4 3408.6 3453.3 3454.8 3472.5 918.2 992.0 1018.3 1032.8 1055.5 28996.0 29193.7 29486.9 29591.6 29611.1 870.9 989.5 1068.1 1086.5 1124.7 12580.3 13446.7 14048.9 14446.0 14448.3 590256.0 603426.0 611200.7 616907.9 619348.0 51345.5 51886.0 53382.4 57846.1 58005.4 1225.7 1444.0 1482.6 1493.4 1501.8 27206.0 27335.9 27817.7 27919.9 27953.9 47004.5 47100.8 47348.8 47491.1 47775.5 455068.0 538860.0 539012.6 541156.0 547194.0 25888.6 26046.3 26114.0 26524.7 26542.2 44278.0 44618.3 45145.8 45211.8 45497.5 36049.3 36579.8 36668.8 37431.0 37621.4 36369.3 36557.6 36655.6 37045.4 37288.4 31640.5 35974.6 36525.6 37491.6 37619.8 30397.5 31065.4 31878.6 32897.3 33216.0 19325.1 21857.2 22334.0 24202.0 24260.6 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - PROCESS | 1680 | [#2] jquery.html Cycles:180 Average:34574.51 Median:11910.22 stddev:104950.36 (881.2%) stddev-sans-first:105213.36 10:04:50 INFO - PROCESS | 1680 | Values: 380.3 386.4 389.7 392.6 406.2 17850.0 18633.0 20378.9 21315.5 21369.5 20001.9 20731.7 20792.7 20820.9 21145.0 4369.7 4944.5 5614.7 5801.6 5827.6 4895.3 5655.0 5662.9 5671.2 5760.9 5078.6 5830.4 5897.0 5930.1 5999.1 5223.8 5695.4 5785.4 5788.0 5893.9 5702.1 5709.7 5807.8 5821.3 5836.2 13357.0 13567.4 13987.7 13988.8 14010.6 2024.2 2027.3 2207.5 2316.9 2398.9 7860.4 9939.0 9955.9 10110.8 10137.2 1731.9 1758.8 1773.5 1814.1 1841.6 79982.8 102225.0 108978.5 114346.0 114917.0 11462.6 11627.1 11718.7 11828.5 12076.0 14923.1 15036.2 15041.5 15178.6 15218.8 8709.3 8779.6 8799.5 8807.1 8833.7 6981.9 8494.3 8515.5 8647.1 8734.5 4627.5 4681.7 4694.0 4745.9 4751.5 1729.5 1955.6 2036.6 2046.3 2046.4 909.5 978.2 995.1 1013.7 1100.3 19687.0 19731.3 21370.0 21482.4 21612.9 920.9 965.0 974.3 978.3 1015.6 7592.7 7893.8 10110.5 10287.7 10547.4 597841.0 634525.0 641686.0 643825.0 645727.0 99225.0 125387.7 128271.0 128534.0 133558.0 953.8 984.1 1001.6 1039.2 1068.5 17967.6 18357.8 18493.2 18571.9 18588.8 33335.8 36302.6 45563.8 48371.0 49063.8 70409.0 71282.3 71595.3 71610.0 73512.3 7964.5 8093.3 8165.2 8366.4 8561.2 10527.2 12125.0 12392.2 12458.3 12534.0 10670.8 10703.4 10991.1 11115.3 11214.3 10374.6 10408.6 10711.7 10885.6 11109.2 10935.8 11035.6 11068.6 11303.8 11525.6 8150.0 8316.6 8319.0 8328.6 8487.0 10123.4 10832.9 11130.4 11176.2 11302.9 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - PROCESS | 1680 | [#3] mootools.html Cycles:180 Average:5769.34 Median:2882.11 stddev:3014.27 (104.6%) stddev-sans-first:3006.00 10:04:50 INFO - PROCESS | 1680 | Values: 1544.6 1594.3 1801.5 1846.9 1908.7 7742.0 8265.5 8329.5 8585.6 8621.0 8263.8 8294.8 8349.7 8350.8 8384.3 2371.2 2375.3 2390.5 2396.9 2402.2 2347.0 2370.7 2386.7 2396.4 2404.9 2383.4 2395.8 2401.6 2415.5 2415.9 2362.8 2377.5 2388.9 2391.9 2396.3 2340.5 2369.8 2381.9 2386.9 2393.2 7332.3 8361.8 8406.8 8531.2 8537.4 5076.5 5181.2 5195.8 5240.7 5251.4 2815.8 3517.7 3575.8 3578.1 3641.7 1008.8 1032.1 1037.1 1041.8 1046.0 10721.8 10723.5 10819.1 10825.6 10834.2 4357.5 4438.5 4534.0 4534.4 4535.6 8738.7 8768.1 8777.0 8797.3 8797.9 5066.9 5117.3 5128.4 5130.5 5199.2 3975.9 4275.8 4777.5 4793.8 4804.5 3642.2 3673.6 3712.4 3754.5 3807.4 1173.3 1174.4 1176.7 1183.4 1189.9 1339.5 1352.7 1383.0 1385.0 1404.4 7797.7 7942.5 7983.2 8001.2 8001.6 504.5 511.3 518.8 520.6 523.5 6055.6 6133.6 6276.1 6288.5 6372.1 9779.5 10215.0 10217.4 10217.7 10306.5 9892.9 10013.4 10122.2 10196.4 10300.8 7909.6 7956.5 7962.1 7974.9 7986.3 7633.5 7645.5 7698.2 7736.1 7745.7 9136.6 9404.9 9495.2 9601.3 9649.5 9243.2 9444.1 9497.4 9508.0 9586.5 6663.1 7070.2 7088.5 7262.1 7296.5 7981.2 7986.4 8030.4 8035.5 8053.1 6995.4 7104.0 7130.3 7240.2 7281.8 6644.8 6705.0 6726.4 6759.8 6828.9 7525.8 7542.3 7577.1 7608.1 7610.1 6843.8 6869.2 6877.8 6919.8 6938.8 5587.9 6460.2 6945.7 6974.1 7047.8 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - PROCESS | 1680 | [#4] prototype.html Cycles:180 Average:5334.25 Median:6048.14 stddev:1725.74 (28.5%) stddev-sans-first:1687.76 10:04:50 INFO - PROCESS | 1680 | Values: 244.6 322.8 324.9 333.1 335.4 5522.8 5539.6 5707.9 6346.7 6391.2 4820.0 5465.7 6250.0 6282.7 6364.1 3526.6 3948.3 4109.6 4646.6 4646.9 3510.4 4157.7 4615.5 4678.4 4695.4 4113.3 4505.8 4618.9 4693.5 4701.4 4229.5 4368.0 4520.7 4685.8 4690.1 3353.7 3932.9 3957.4 3970.2 3991.6 5996.2 6031.8 6040.8 6044.6 6051.7 4455.7 5247.1 5427.4 5428.8 5436.3 6549.6 6659.9 6666.9 6682.6 6684.4 4411.3 4413.0 4415.0 4432.2 4444.2 5924.5 6663.6 6983.8 7009.3 7050.6 4137.3 4448.7 4482.9 4488.1 4515.7 4346.0 4547.1 4554.9 4578.4 4584.3 4302.6 5389.7 5398.3 5406.5 5429.2 6261.6 6385.4 6620.8 6714.8 6717.3 1323.5 1478.0 1533.7 1582.0 1594.5 859.5 896.5 965.6 1015.5 1051.8 4826.5 5159.5 5365.5 6118.3 6168.0 6838.2 6886.4 6890.6 6899.3 6917.8 5985.1 6096.8 6141.3 6167.7 6212.4 3090.7 3587.1 3623.0 3637.6 3651.5 6737.1 6815.9 6881.3 6998.1 7119.6 6147.4 6691.6 7046.0 7051.4 7069.0 6623.0 7089.3 7097.6 7099.5 7133.0 6199.3 6651.8 6790.9 6844.7 6845.1 6521.7 6741.8 6750.2 6767.3 6873.6 7223.9 7237.3 7250.8 7252.8 7269.5 3958.4 4387.9 4419.0 4432.3 4450.4 5837.2 6466.6 6858.7 6940.0 6987.2 6262.3 6642.5 6701.4 6747.0 6766.8 6241.4 6629.9 6671.1 6720.3 6724.7 5196.4 5745.8 6417.3 6497.5 6527.2 5517.7 5661.3 6737.7 6751.5 6758.9 6293.7 6535.5 6553.7 6578.0 6582.4 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - PROCESS | 1680 | [#5] yui.html Cycles:180 Average:17179.67 Median:66729.33 stddev:24210.70 (36.3%) stddev-sans-first:24246.61 10:04:50 INFO - PROCESS | 1680 | Values: 600.9 654.6 726.4 744.7 752.5 14691.3 15162.9 15165.0 15170.8 15175.5 12376.3 13719.5 13799.0 13953.8 13971.0 691.4 882.5 907.9 908.8 910.4 886.8 923.6 926.5 927.2 928.0 928.0 950.2 958.3 964.1 965.7 911.0 929.8 953.6 954.9 955.6 679.1 681.2 689.4 699.8 708.8 14662.6 14760.3 14837.8 14849.3 14982.9 12734.2 12735.2 12784.2 12791.8 12932.9 8371.9 9442.2 9809.0 9853.6 9897.4 3315.7 3373.0 3393.0 3435.6 3542.8 63247.4 82252.6 84381.0 84636.6 85643.0 7393.6 8157.3 9098.6 9494.3 9530.5 21531.6 21701.3 21724.3 21827.0 21840.7 7415.9 7572.2 7634.8 7686.8 7808.2 3981.4 4014.0 4053.3 4061.0 4062.5 3370.4 3437.4 3499.1 3499.2 3503.1 644.9 649.3 652.0 661.5 665.6 517.6 529.2 584.9 605.4 607.2 7720.7 7908.1 8023.3 8040.8 8240.8 560.3 590.6 597.6 601.4 608.8 3508.7 3644.2 3787.3 3814.7 4064.8 86161.6 88688.1 90073.5 90242.0 91066.2 66608.0 66850.7 67467.0 67556.0 68901.3 63375.0 66007.0 67294.7 67955.0 68126.7 7467.5 7535.5 7761.5 7806.4 7897.6 42758.0 43829.6 43853.6 44640.6 44820.6 60461.0 61634.0 62261.8 63829.7 64344.0 9700.8 9778.3 9781.6 10006.0 10100.9 10656.5 10666.6 10770.8 10829.8 11575.5 8856.0 9972.6 9985.6 10004.6 10693.3 8963.4 10441.6 10641.0 10681.4 10912.6 7824.6 9965.0 9978.7 10028.8 10349.7 8450.6 8574.4 8578.2 8778.7 8939.9 7635.8 8286.3 8379.5 8572.8 8823.7 10:04:50 INFO - PROCESS | 1680 | -------- Summary: end -------- 10:04:50 INFO - PROCESS | 1680 | 10:04:50 INFO - TEST-INFO | 1680: exit 0 10:04:50 INFO - TEST-OK | dromaeo_css | took 1111865ms 10:04:50 INFO - TEST-START | kraken 10:04:50 INFO - operating with platform_type : mac_ 10:04:50 INFO - Initialising browser for kraken test... 10:04:50 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp9e6X_Z/profile http://localhost:49275/getInfo.html) 10:04:52 INFO - PROCESS | 1688 | 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] 10:04:53 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 10:04:53 INFO - PROCESS | 1688 | colorDepth:24 10:04:53 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 10:04:53 INFO - PROCESS | 1688 | __metrics 10:04:53 ERROR - PROCESS | 1688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 10:04:54 INFO - TEST-INFO | 1688: exit 0 10:04:54 INFO - Browser initialized. 10:04:54 INFO - Running cycle 1/1 for kraken test... 10:04:54 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp9e6X_Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:06 INFO - PROCESS | 1691 | RSS: Main: 248184832 10:05:06 INFO - PROCESS | 1691 | 10:05:09 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:09 INFO - PROCESS | 1691 | RSS: Main: 260141056 10:05:09 INFO - PROCESS | 1691 | 10:05:12 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 10:05:13 INFO - PROCESS | 1691 | RSS: Main: 269058048 10:05:13 INFO - PROCESS | 1691 | 10:05:16 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 10:05:17 INFO - PROCESS | 1691 | RSS: Main: 272109568 10:05:17 INFO - PROCESS | 1691 | 10:05:19 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 10:05:19 INFO - PROCESS | 1691 | RSS: Main: 272990208 10:05:19 INFO - PROCESS | 1691 | 10:05:21 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:22 INFO - PROCESS | 1691 | RSS: Main: 273473536 10:05:22 INFO - PROCESS | 1691 | 10:05:25 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:25 INFO - PROCESS | 1691 | RSS: Main: 275111936 10:05:25 INFO - PROCESS | 1691 | 10:05:28 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:29 INFO - PROCESS | 1691 | RSS: Main: 274878464 10:05:29 INFO - PROCESS | 1691 | 10:05:32 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 10:05:32 INFO - PROCESS | 1691 | RSS: Main: 274866176 10:05:32 INFO - PROCESS | 1691 | 10:05:34 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:35 INFO - PROCESS | 1691 | RSS: Main: 274788352 10:05:35 INFO - PROCESS | 1691 | 10:05:36 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:37 INFO - PROCESS | 1691 | RSS: Main: 275066880 10:05:37 INFO - PROCESS | 1691 | 10:05:39 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:40 INFO - PROCESS | 1691 | RSS: Main: 275197952 10:05:40 INFO - PROCESS | 1691 | 10:05:43 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:43 INFO - PROCESS | 1691 | RSS: Main: 275427328 10:05:43 INFO - PROCESS | 1691 | 10:05:46 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:47 INFO - PROCESS | 1691 | RSS: Main: 275202048 10:05:47 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 10:05:49 INFO - PROCESS | 1691 | RSS: Main: 276897792 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | __start_tp_report 10:05:49 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 10:05:49 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 10:05:49 INFO - PROCESS | 1691 | |i|pagename|runs| 10:05:49 INFO - PROCESS | 1691 | |0;ai-astar;117;105;118;117;128;112;123;165;170;101 10:05:49 INFO - PROCESS | 1691 | |1;audio-beat-detection;153;123;133;150;140;163;164;166;160;148 10:05:49 INFO - PROCESS | 1691 | |2;audio-dft;195;199;229;255;207;203;167;256;277;226 10:05:49 INFO - PROCESS | 1691 | |3;audio-fft;67;71;73;116;61;45;52;57;152;55 10:05:49 INFO - PROCESS | 1691 | |4;audio-oscillator;83;87;119;79;84;84;122;84;83;122 10:05:49 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;87;89;123;87;89;85;89;85;91;85 10:05:49 INFO - PROCESS | 1691 | |6;imaging-darkroom;151;121;94;95;94;94;95;94;95;94 10:05:49 INFO - PROCESS | 1691 | |7;imaging-desaturate;91;96;91;142;134;91;125;147;104;93 10:05:49 INFO - PROCESS | 1691 | |8;json-parse-financial;58;59;57;57;57;57;72;87;81;57 10:05:49 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;70;66;70;73;71;67;73;60;60;75 10:05:49 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;88;90;121;85;85;88;101;94;88;88 10:05:49 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;140;125;168;171;165;143;146;144;142;141 10:05:49 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;171;173;170;170;175;169;174;172;168;175 10:05:49 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;70;87;87;99;70;68;76;98;103;100 10:05:49 INFO - PROCESS | 1691 | __end_tp_report 10:05:49 INFO - PROCESS | 1691 | __start_cc_report 10:05:49 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,993 10:05:49 INFO - PROCESS | 1691 | __end_cc_report 10:05:49 INFO - PROCESS | 1691 | __startTimestamp1460135149484__endTimestamp 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | ------- Summary: start ------- 10:05:49 INFO - PROCESS | 1691 | Number of tests: 14 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:125.60 Median:120.50 stddev:23.47 (19.5%) stddev-sans-first:24.68 10:05:49 INFO - PROCESS | 1691 | Values: 117.0 105.0 118.0 117.0 128.0 112.0 123.0 165.0 170.0 101.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:156.50 stddev:14.34 (9.2%) stddev-sans-first:15.17 10:05:49 INFO - PROCESS | 1691 | Values: 153.0 123.0 133.0 150.0 140.0 163.0 164.0 166.0 160.0 148.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:221.40 Median:227.50 stddev:33.67 (14.8%) stddev-sans-first:34.33 10:05:49 INFO - PROCESS | 1691 | Values: 195.0 199.0 229.0 255.0 207.0 203.0 167.0 256.0 277.0 226.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:74.90 Median:59.00 stddev:33.40 (56.6%) stddev-sans-first:35.31 10:05:49 INFO - PROCESS | 1691 | Values: 67.0 71.0 73.0 116.0 61.0 45.0 52.0 57.0 152.0 55.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.50 stddev:18.27 (21.9%) stddev-sans-first:18.88 10:05:49 INFO - PROCESS | 1691 | Values: 83.0 87.0 119.0 79.0 84.0 84.0 122.0 84.0 83.0 122.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:88.00 stddev:11.43 (13.0%) stddev-sans-first:12.03 10:05:49 INFO - PROCESS | 1691 | Values: 87.0 89.0 123.0 87.0 89.0 85.0 89.0 85.0 91.0 85.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:102.70 Median:94.00 stddev:18.93 (20.1%) stddev-sans-first:8.89 10:05:49 INFO - PROCESS | 1691 | Values: 151.0 121.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 94.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:111.40 Median:91.00 stddev:23.04 (25.3%) stddev-sans-first:23.23 10:05:49 INFO - PROCESS | 1691 | Values: 91.0 96.0 91.0 142.0 134.0 91.0 125.0 147.0 104.0 93.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:58.50 stddev:11.49 (19.6%) stddev-sans-first:11.96 10:05:49 INFO - PROCESS | 1691 | Values: 58.0 59.0 57.0 57.0 57.0 57.0 72.0 87.0 81.0 57.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:70.50 stddev:5.23 (7.4%) stddev-sans-first:5.52 10:05:49 INFO - PROCESS | 1691 | Values: 70.0 66.0 70.0 73.0 71.0 67.0 73.0 60.0 60.0 75.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:88.00 stddev:10.98 (12.5%) stddev-sans-first:11.51 10:05:49 INFO - PROCESS | 1691 | Values: 88.0 90.0 121.0 85.0 85.0 88.0 101.0 94.0 88.0 88.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:148.50 Median:145.00 stddev:14.68 (10.1%) stddev-sans-first:15.24 10:05:49 INFO - PROCESS | 1691 | Values: 140.0 125.0 168.0 171.0 165.0 143.0 146.0 144.0 142.0 141.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.50 stddev:2.50 (1.4%) stddev-sans-first:2.64 10:05:49 INFO - PROCESS | 1691 | Values: 171.0 173.0 170.0 170.0 175.0 169.0 174.0 172.0 168.0 175.0 10:05:49 INFO - PROCESS | 1691 | 10:05:49 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.80 Median:81.50 stddev:13.89 (17.0%) stddev-sans-first:13.50 10:05:49 INFO - PROCESS | 1691 | Values: 70.0 87.0 87.0 99.0 70.0 68.0 76.0 98.0 103.0 100.0 10:05:49 INFO - PROCESS | 1691 | -------- Summary: end -------- 10:05:49 INFO - PROCESS | 1691 | 10:05:50 INFO - TEST-INFO | 1691: exit 0 10:05:50 INFO - TEST-OK | kraken | took 59546ms 10:05:50 INFO - SUITE-END | took 1171s 10:05:50 INFO - Completed test suite (00:19:31) 10:05:50 INFO - javascript benchmark 10:05:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2809.9438011239777, 2908.549174877893, 3349.6650334966507, 3486.511888335635, 3486.651334866512, 4798.4961579034225, 5659.405762394951, 5711.428857114297, 5739.713014349287, 5757.078867381219, 5683.914741278884, 5792.189093526909, 5859.1797148399155, 5862.794802181925, 5912.763489460416, 5162.0, 5210.166373380251, 5249.107651699221, 5291.735413229323, 5337.092694241969, 5388.191771234307, 5400.054990376669, 5401.378841433227, 5419.187121931703, 5453.427390124039, 5137.17805151174, 5157.742112894341, 5257.290265814105, 5300.840974770763, 5332.706701131437, 5237.764300606444, 5249.501297376782, 5249.8425047248265, 5254.106801843695, 5266.236395722599, 5200.479952004807, 5201.505856943584, 5216.765245563959, 5236.1098613235845, 5277.6305658603915, 4806.7262175523165, 5593.580481463907, 5698.7435565399655, 5730.598858079936, 5751.338596061465, 6170.8765824683705, 6191.938080619227, 6226.101039183048, 6235.0, 6286.937130628681, 6232.1898153240245, 6239.594426362272, 6253.906191407133, 6255.812325630239, 6267.279262884781, 5773.278340207474, 5826.096954971986, 5924.289085309747, 5950.31571369298, 5982.40175982407, 6263.906041409383, 6297.307296197415, 6301.558890877686, 6328.303886572473, 6369.108324834527, 6081.331053584102, 6213.720382582795, 6238.189035425366, 6267.5299352548745, 6270.7491700331475, 5711.314642242957, 5933.406659334119, 6179.3820617937845, 6264.21697287839, 6306.590071645328, 4986.80052797884, 5199.818006369759, 5278.868028299324, 6153.953827849276, 6239.688015599202, 6111.777644471034, 6197.0, 6224.0, 6268.435840774261, 6285.0, 4874.5856602188505, 4895.167821470359, 4961.231009193581, 4972.701637901738, 5009.373828271466, 3826.8136877568045, 4426.977865110718, 4443.911121777546, 4459.955400446019, 4473.306637471197, 5686.9715651421475, 5811.283075386919, 5862.296524417097, 5862.384449632812, 5897.0269905465975, 6182.443580077815, 6242.313345531988, 6250.74997000124, 6256.718447669866, 6264.467520260829, 5825.825225243249, 5841.678707671034, 5848.8537786554825, 5892.941070589325, 5908.350081491032, 5317.787288508416, 5434.70109143993, 5446.264754258124, 5449.3460784706085, 5454.945450545444, 6339.429451349401, 6421.293657697743, 6422.967885160638, 6433.774817881352, 6452.032195170668, 6228.968855155696, 6259.34276900937, 6267.811965641038, 6282.905756413566, 6313.621182729051, 6129.236538068469, 6338.492920566436, 6369.90445143314, 6376.649284289409, 6382.138411314413, 5775.595708300379, 5973.731182096729, 6190.288116866618, 6200.0699895016105, 6241.563090583615, 5527.336719593674, 6205.44863784054, 6243.250809902841, 6258.0, 6267.62394256346, 6101.389861013863, 6147.477464415575, 6202.317745048132, 6226.844328891814, 6243.0, 6125.877482450237, 6130.306415576139, 6151.0773383992755, 6154.415330543591, 6166.075088736726, 4583.106294272585, 5653.236813030353, 5936.22829032223, 6023.789167379121, 6048.758049677964, 4872.0, 5437.238786569963, 5612.466815652507, 5942.910856337072, 5967.9701601491715, 5981.880362392815, 6011.789587364421, 6034.39656034393, 6042.335343112342, 6047.5464340173785], "value": 5669.949500562915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.6298368764207, 530.4854291337404, 543.6520626798848, 544.9999999999999, 585.6690969602172, 35536.0, 36356.63643363566, 36384.81807590965, 36399.09002274944, 36458.27083458332, 40025.79987100068, 40549.59450405495, 40771.18457630846, 40947.0, 40986.59013409865, 9236.630534778618, 9455.054494550524, 9493.952530237373, 9499.71500854972, 9508.0, 9350.672726454575, 9387.389819661701, 9402.5768840402, 9406.43561386319, 9454.29092818038, 9408.341416100875, 9443.102905223992, 9476.715698529055, 9508.429494230333, 9521.619135234583, 9451.432914025147, 9532.571034303473, 9536.0, 9550.3792253504, 9566.47384393858, 9274.350795444321, 9296.767580810467, 9366.812663746756, 9408.341416100875, 9439.764005899839, 37096.814515927246, 37492.81253593715, 37559.436608450895, 37629.811850940845, 37642.24715505702, 2953.601263829377, 3137.7892310046677, 3202.96797032029, 3207.951880721791, 3222.4360736870954, 27775.861120694266, 28085.29786755327, 28842.71157288421, 28960.0, 28974.130776076752, 2750.9587356189672, 2754.1049159023196, 2819.4643017826547, 2827.7313655202724, 2846.6584009918943, 459464.0, 466193.0, 467708.0, 468525.0, 470144.99999999657, 34641.30717385638, 35345.64654353475, 35698.0, 35703.4644480333, 57283.427165728644, 34174.63301467963, 34186.65813341835, 34440.31119377598, 34460.0, 34516.654833451845, 14666.340014699364, 14859.0, 14894.627634309229, 14904.70190596182, 14930.10419374841, 12429.875701243052, 12517.061220408506, 12521.186122901981, 12611.495540178474, 12673.556425525247, 7862.2137786222065, 7942.205779422012, 8060.637271322805, 8114.269715725495, 8189.8771518427275, 3392.423288041039, 3408.642092580293, 3453.2748122893972, 3454.775439596418, 3472.5138480612736, 918.169057003413, 992.0476342710934, 1018.2770233134557, 1032.8347464405658, 1055.514463346869, 28996.0, 29193.7080629191, 29486.852565737463, 29591.556126657688, 29611.111666650035, 870.9433886797337, 989.5250279865561, 1068.1027936533349, 1086.5327908999207, 1124.7131981344705, 12580.308083055337, 13446.663833404244, 14048.929755351157, 14445.988780785245, 14448.277586120652, 590256.0, 603426.0, 611200.719982004, 616907.9154604198, 619348.0, 51345.45963621097, 51886.0, 53382.39852804422, 57846.13230801541, 58005.419945800844, 1225.7364666596725, 1443.992780036093, 1482.6071091160852, 1493.4250313629113, 1501.8498150185112, 27206.047788327312, 27335.86332068327, 27817.72182278232, 27919.860400697868, 27953.860230698716, 47004.529954701386, 47100.7644961773, 47348.7632561835, 47491.05017899692, 47775.5222447785, 455068.0, 538860.0, 539012.609873912, 541156.0, 547194.0, 25888.611670824575, 26046.34884127912, 26114.0, 26524.734752652228, 26542.203733888015, 44278.0, 44618.330725038504, 45145.77427112844, 45211.773941130086, 45497.545024549334, 36049.27901441904, 36579.817100914326, 36668.81665591762, 37431.0, 37621.435678464295, 36369.27261454703, 36557.634423656484, 36655.633443665225, 37045.44431833471, 37288.44067339046, 31640.525392118678, 35974.640253598176, 36525.63474365329, 37491.62508374881, 37619.81190094032, 30397.544036839023, 31065.37869242648, 31878.64317717565, 32897.34205315928, 33216.00351989444, 19325.138107798848, 21857.234996775038, 22334.0, 24202.0, 24260.63609045901], "value": 17792.898098220085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.2565983502255, 386.43580372655913, 389.7135605330082, 392.62504308385496, 406.22208470778423, 17850.0, 18633.0, 20378.898105509452, 21315.467113322175, 21369.465763355925, 20001.899990500064, 20731.689024664644, 20792.68810967833, 20820.895895520538, 21145.0, 4369.650427965755, 4944.456109827916, 5614.747336369863, 5801.622894511865, 5827.562932780059, 4895.339129217564, 5655.0, 5662.858428539299, 5671.177679236508, 5760.855978600547, 5078.568321692661, 5830.44610761979, 5896.96803059465, 5930.080837470199, 5999.100134979744, 5223.843284701465, 5695.40198279183, 5785.3925337839555, 5788.0, 5893.852653683693, 5702.059160238556, 5709.74306156224, 5807.767689292423, 5821.330546987108, 5836.212111364954, 13356.998225133153, 13567.389467473988, 13987.720245595134, 13988.790168147487, 14010.579682609436, 2024.2409096588779, 2027.28031548801, 2207.547452772178, 2316.8841557922037, 2398.9040438382444, 7860.371170306362, 9938.956409576962, 9955.90044099557, 10110.797784044278, 10137.189024877993, 1731.9393821216197, 1758.78015248094, 1773.5300145461463, 1814.0838876367482, 1841.5856432302758, 79982.80025799618, 102225.0, 108978.45510772396, 114345.99999999917, 114917.0, 11462.598809041643, 11627.12796540263, 11718.70703232409, 11828.536093989946, 12076.0, 14923.104613723212, 15036.248187590576, 15041.47354842597, 15178.620534486727, 15218.847811521964, 8709.303255739653, 8779.561021948877, 8799.516026618598, 8807.119288071142, 8833.734987950244, 6981.930180698128, 8494.320454363637, 8515.531645759418, 8647.135286471303, 8734.519601421856, 4627.537246275413, 4681.7190968542, 4693.9765301173275, 4745.905081898342, 4751.4535828379485, 1729.5070904792074, 1955.559999000242, 2036.5926814637132, 2046.3042565527792, 2046.4065421028033, 909.5270459361095, 978.2467500025083, 995.069609914732, 1013.7465633591602, 1100.3452945497415, 19687.0, 19731.309404170785, 21370.0, 21482.355529334145, 21612.89193554022, 920.8572671235969, 964.9674847912806, 974.3471873844542, 978.3054031637618, 1015.6496008876926, 7592.658330375147, 7893.842123157505, 10110.515155294997, 10287.74280642975, 10547.419891906018, 597841.0, 634525.0, 641686.0, 643825.0, 645727.0, 99225.0, 125387.74612253944, 128271.0, 128534.0, 133558.0, 953.7710949372239, 984.1093810101869, 1001.649422702063, 1039.1738567838586, 1068.529846867376, 17967.640647187243, 18357.81642183561, 18493.16780744843, 18571.907140464213, 18588.837910565773, 33335.83332083324, 36302.636973629924, 45563.772181138884, 48371.0, 49063.75468122637, 70409.0, 71282.28717712963, 71595.28404716095, 71610.0, 73512.26487735267, 7964.522128672298, 8093.271605555528, 8165.2243036911395, 8366.372522060992, 8561.22948934599, 10527.157827373945, 12125.0, 12392.194507356993, 12458.31479268649, 12534.0, 10670.83993740079, 10703.357798532114, 10991.06575941054, 11115.277506962346, 11214.327140371604, 10374.636887708893, 10408.583656653953, 10711.678649640524, 10885.564577416815, 11109.222354435435, 10935.781284374427, 11035.613753518588, 11068.612598559012, 11303.830442543533, 11525.596604118815, 8149.959250203711, 8316.584170791315, 8318.958405207935, 8328.625211865601, 8486.957565212382, 10123.443210623487, 10832.945835270773, 11130.387828669502, 11176.217664763388, 11302.943485282522], "value": 9228.718153236754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.6215677159098, 1594.314444788741, 1801.4775715042638, 1846.8799528030677, 1908.6659834528955, 7741.961290193542, 8265.50406975582, 8329.458585191958, 8585.613647385859, 8621.008584012832, 8263.752087437371, 8294.83410331793, 8349.749507514769, 8350.83298334033, 8384.329253659707, 2371.229350461107, 2375.26366826284, 2390.5099454611764, 2396.9280921572295, 2402.231285988484, 2347.0, 2370.7316585626695, 2386.7016622922133, 2396.4488167721433, 2404.9398765030837, 2383.4041489627593, 2395.7724016218517, 2401.6157414813633, 2415.5410472010262, 2415.855048697075, 2362.7873491385685, 2377.476955069882, 2388.940276493084, 2391.940201494959, 2396.293093537402, 2340.5435939991708, 2369.8387789982785, 2381.8570885746913, 2386.880655967195, 2393.210240620591, 7332.30343117403, 8361.790955226108, 8406.78983025423, 8531.189536993976, 8537.359698022674, 5076.543111120017, 5181.222816577506, 5195.792168313263, 5240.737963101829, 5251.4485978972425, 2815.802893797435, 3517.7009954153928, 3575.785452872836, 3578.1054736315923, 3641.708663306929, 1008.7730260691359, 1032.117539503721, 1037.0718207204586, 1041.833306670929, 1045.968620941373, 10721.785564288748, 10723.46382680863, 10819.13446924244, 10825.566977320976, 10834.15819310719, 4357.4988876279, 4438.533953934791, 4533.979854532704, 4534.387857639243, 4535.569120933506, 8738.69414570487, 8768.079351667982, 8777.0, 8797.340199484936, 8797.912020879709, 5066.923996140061, 5117.334746483008, 5128.384593848762, 5130.51260130287, 5199.194124910569, 3975.92048159041, 4275.8075886585175, 4777.450593181759, 4793.760311984387, 4804.495527969513, 3642.21692336149, 3673.559172899269, 3712.4431335299923, 3754.4931434256573, 3807.3908174691915, 1173.3370645585217, 1174.3775798826637, 1176.6764139861436, 1183.44378142273, 1189.881011898803, 1339.4909934225127, 1352.6956434802287, 1383.004236949395, 1384.9584512464642, 1404.4101477379525, 7797.688092476351, 7942.483738556975, 7983.2415920487465, 8001.239882211181, 8001.599920003977, 504.46022755651103, 511.2969666708276, 518.7665550502289, 520.5991386632272, 523.4765234765234, 6055.576109672369, 6133.6319820810895, 6276.058591211355, 6288.52836037299, 6372.107904893319, 9779.51102444875, 10214.95700859831, 10217.386956782617, 10217.74455638615, 10306.48467576633, 9892.851607225897, 10013.449260290754, 10122.240831937634, 10196.439195844152, 10300.793984120275, 7909.604519773989, 7956.5226086435, 7962.08436029864, 7974.880376794353, 7986.281234688906, 7633.488789685102, 7645.464817462725, 7698.153203147761, 7736.071671399243, 7745.651445684845, 9136.634534618806, 9404.905950940403, 9495.19290860257, 9601.279904007088, 9649.517524123907, 9243.21432678203, 9444.102810233291, 9497.382670126695, 9507.952460237655, 9586.520673966133, 6663.13379260693, 7070.222275549789, 7088.468364872552, 7262.092238470192, 7296.452766042674, 7981.161977992228, 7986.401019923413, 8030.397720170894, 8035.517868927883, 8053.073896501743, 6995.405390541861, 7103.964480177566, 7130.322619351154, 7240.167380751281, 7281.817954551178, 6644.83387915306, 6705.027770973279, 6726.39462448382, 6759.831004224934, 6828.931710682829, 7525.849483010418, 7542.2834830691, 7577.052868391451, 7608.087029556488, 7610.124835643972, 6843.794686159423, 6869.210040845367, 6877.793666190022, 6919.792406227822, 6938.757143499954, 5587.860303492445, 6460.160179176865, 6945.722171113099, 6974.128233970754, 7047.823804404931], "value": 4656.984607602344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [244.5573511943382, 322.77567090871844, 324.8651809499058, 333.0757148911771, 335.37452650806256, 5522.779088836452, 5539.639923404976, 5707.9143812842785, 6346.714397852091, 6391.233052033751, 4820.0, 5465.672059676423, 6250.0, 6282.68586570672, 6364.090772768174, 3526.629703881094, 3948.2893079245723, 4109.589041095882, 4646.558576935195, 4646.907061858761, 3510.385682505564, 4157.688173386993, 4615.515370886059, 4678.415198100238, 4695.413073365829, 4113.280175969208, 4505.77471126444, 4618.884527886813, 4693.530646935314, 4701.378024581514, 4229.534751177368, 4368.0, 4520.728756274634, 4685.83599574015, 4690.132325519789, 3353.748468864845, 3932.941005884914, 3957.3668213086057, 3970.2059588082498, 3991.5808840071663, 5996.220491336142, 6031.788887388921, 6040.848978775522, 6044.607100538451, 6051.671580630636, 4455.688101832873, 5247.134222853225, 5427.432806304377, 5428.75570599324, 5436.320459942507, 6549.6070235786, 6659.93340066598, 6666.933330666729, 6682.599044057372, 6684.364985326386, 4411.338299255138, 4413.0, 4414.955850441486, 4432.180046691373, 4444.222261104326, 5924.504542320009, 6663.63350015749, 6983.82540436488, 7009.334113259232, 7050.647467626598, 4137.2552940470405, 4448.688591798607, 4482.932756008662, 4488.12481566098, 4515.729056256635, 4345.956540434555, 4547.136044151667, 4554.863354099382, 4578.427696537933, 4584.3352713856975, 4302.591253830881, 5389.67661940277, 5398.271233383522, 5406.459354064562, 5429.1856221566295, 6261.5616906816085, 6385.393387628168, 6620.801375958729, 6714.798556043326, 6717.328267173243, 1323.4904561743797, 1478.0, 1533.7009283189893, 1582.0112429731419, 1594.4658539389434, 859.4529846276802, 896.4800415758845, 965.5799727118725, 1015.5430056474615, 1051.8272126578809, 4826.469088400273, 5159.458256883048, 5365.490278423544, 6118.296395914438, 6168.0, 6838.21360543534, 6886.449084073262, 6890.621015844176, 6899.275576064541, 6917.75787847433, 5985.072313791369, 6096.786612468631, 6141.324454310023, 6167.691615419211, 6212.378762123752, 3090.7063828936216, 3587.121155316912, 3623.0217841182734, 3637.636236376341, 3651.5253017107607, 6737.079932219294, 6815.863682726417, 6881.311868813079, 6998.125234345707, 7119.644017799089, 6147.415995480422, 6691.631960242136, 7046.0, 7051.435885129177, 7069.0, 6622.966885165543, 7089.255628159072, 7097.615964886901, 7099.467539934525, 7133.0, 6199.28708198563, 6651.802675518453, 6790.93209067903, 6844.726210951506, 6845.110135682329, 6521.7065232065615, 6741.831454213684, 6750.232404714044, 6767.323267673193, 6873.5875847449315, 7223.927760722536, 7237.312455316736, 7250.818729531593, 7252.829622966709, 7269.454790890599, 3958.366661334173, 4387.868363949086, 4419.0, 4432.268675668607, 4450.443694538183, 5837.241158649348, 6466.579672321284, 6858.6570671467225, 6940.0, 6987.231404545394, 6262.279837818709, 6642.4686025118845, 6701.396874281338, 6747.0, 6766.830829229112, 6241.438270555672, 6629.867402652017, 6671.066050752996, 6720.294369091175, 6724.697388617622, 5196.427768254738, 5745.770169193353, 6417.294097649348, 6497.480201583768, 6527.249366322933, 5517.668939863621, 5661.320641523043, 6737.69680364375, 6751.535689473405, 6758.918573028292, 6293.748250069946, 6535.509836762167, 6553.672316384257, 6578.0, 6582.407583317525], "value": 4762.339536209693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.8708127752534, 654.6268626882679, 726.4043484342837, 744.7132853851269, 752.525908677533, 14691.265436728161, 15162.924185379085, 15165.0, 15170.848291517068, 15175.54473365798, 12376.257424554533, 13719.519816806414, 13798.965077619194, 13953.790693139612, 13971.0, 691.4399336537396, 882.466108004656, 907.9001309855911, 908.8182363527288, 910.3718434280325, 886.8359353519587, 923.5751554285036, 926.4811705444939, 927.248928368024, 927.9814403711922, 927.9628814847398, 950.2113246005833, 958.2669258017622, 964.1322809471496, 965.6620182935986, 911.0024523147143, 929.8372784762673, 953.5708930981051, 954.8901876284177, 955.6034245787989, 679.1035832700837, 681.1723755636875, 689.3795583974413, 699.8005568412977, 708.8121647763347, 14662.560123196321, 14760.335784889598, 14837.777433338508, 14849.331780069922, 14982.925085374503, 12734.172278801849, 12735.23588584688, 12784.232946023269, 12791.808122878165, 12932.935335323356, 8371.911651485329, 9442.197413219885, 9809.0, 9853.605855765762, 9897.406155630613, 3315.7181639560667, 3373.0, 3392.9660703392897, 3435.587729472479, 3542.752007359486, 63247.367526324146, 82252.58873705653, 84381.0, 84636.57681711613, 85643.0, 7393.630318484054, 8157.3474122071275, 9098.590563424661, 9494.28792840526, 9530.475823829618, 21531.56936861254, 21701.348959530922, 21724.348269551938, 21827.01778419975, 21840.672389914165, 7415.925840741632, 7572.167061623217, 7634.809129771689, 7686.769396918102, 7808.2191780822595, 3981.3828856527284, 4013.9598604013586, 4053.2906741320153, 4061.0, 4062.4921884764403, 3370.443876760356, 3437.3812713711773, 3499.090236538518, 3499.16020155166, 3503.1242189452637, 644.8935925572322, 649.2825427902195, 651.9959262735334, 661.4873473058323, 665.6139439125295, 517.6350672775684, 529.2352550564398, 584.9356570777211, 605.4088501214808, 607.1590846677384, 7720.652570634335, 7908.130105688369, 8023.277904988462, 8040.758777236692, 8240.793980150424, 560.341598621618, 590.5600327755849, 597.5757212379173, 601.380578004656, 608.7869245763948, 3508.6842184203542, 3644.1800594865945, 3787.299349620274, 3814.675752561008, 4064.776437295918, 86161.56919215363, 88688.11311886928, 90073.54963225142, 90242.0, 91066.1786764261, 66608.0, 66850.66574667193, 67467.0, 67556.0, 68901.31098688948, 63375.0, 66007.0, 67294.66352668205, 67955.0, 68126.65936670384, 7467.477276590586, 7535.54786712799, 7761.456698031309, 7806.375489960676, 7897.565633890191, 42758.0, 43829.56170438382, 43853.56146438495, 44640.55359446494, 44820.55179448294, 60461.0, 61634.0, 62261.75476490535, 63829.68085159545, 64344.03483947838, 9700.805983880424, 9778.266630002921, 9781.608735650494, 10006.0, 10100.949495252476, 10656.467176640981, 10666.57333706674, 10770.838437423601, 10829.783404332027, 11575.536978521102, 8855.955720221358, 9972.551235194289, 9985.60057597688, 10004.599816007278, 10693.304935179189, 8963.417377870417, 10441.582336706446, 10641.04230619248, 10681.359118452918, 10912.563497460013, 7824.64789084504, 9965.0, 9978.700638980843, 10028.799424011624, 10349.689509314732, 8450.577471126542, 8574.442661227, 8578.227959483676, 8778.692745753868, 8939.910600894167, 7635.770926872203, 8286.295664868312, 8379.45533540318, 8572.785680358042, 8823.735287941372], "value": 6588.9005755921235, "unit": "score"}], "name": "dromaeo_css", "value": 7171.721384696459, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 105.0, 118.0, 117.0, 128.0, 112.0, 123.0, 165.0, 170.0, 101.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 133.0, 150.0, 140.0, 163.0, 164.0, 166.0, 160.0, 148.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 229.0, 255.0, 207.0, 203.0, 167.0, 256.0, 277.0, 226.0], "value": 221.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 73.0, 116.0, 61.0, 45.0, 52.0, 57.0, 152.0, 55.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 119.0, 79.0, 84.0, 84.0, 122.0, 84.0, 83.0, 122.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 123.0, 87.0, 89.0, 85.0, 89.0, 85.0, 91.0, 85.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 102.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 91.0, 142.0, 134.0, 91.0, 125.0, 147.0, 104.0, 93.0], "value": 111.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 57.0, 57.0, 57.0, 72.0, 87.0, 81.0, 57.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 70.0, 73.0, 71.0, 67.0, 73.0, 60.0, 60.0, 75.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 121.0, 85.0, 85.0, 88.0, 101.0, 94.0, 88.0, 88.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 125.0, 168.0, 171.0, 165.0, 143.0, 146.0, 144.0, 142.0, 141.0], "value": 148.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 170.0, 170.0, 175.0, 169.0, 174.0, 172.0, 168.0, 175.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 87.0, 87.0, 99.0, 70.0, 68.0, 76.0, 98.0, 103.0, 100.0], "value": 85.8, "unit": "score"}], "name": "kraken", "value": 1603.2, "alertThreshold": 2.0}]} 10:05:50 INFO - Return code: 0 10:05:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:05:50 ERROR - # TBPL SUCCESS # 10:05:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:05:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:05:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:05:50 INFO - 2016-04-08 10:05:50.746 screenresolution[1696:10798] starting screenresolution argv=screenresolution get 10:05:50 INFO - 2016-04-08 10:05:50.748 screenresolution[1696:10798] Display 0: 1600x1200x32@60 10:05:50 INFO - 2016-04-08 10:05:50.754 screenresolution[1697:10801] starting screenresolution argv=screenresolution list 10:05:50 INFO - Available Modes on Display 0 10:05:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:05:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:05:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:05:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:05:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:05:50 INFO - Intel Iris: 10:05:50 INFO - Chipset Model: Intel Iris 10:05:50 INFO - Type: GPU 10:05:50 INFO - Bus: Built-In 10:05:50 INFO - VRAM (Dynamic, Max): 1536 MB 10:05:50 INFO - Vendor: Intel (0x8086) 10:05:50 INFO - Device ID: 0x0a2e 10:05:50 INFO - Revision ID: 0x0009 10:05:50 INFO - Displays: 10:05:50 INFO - Display: 10:05:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:05:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:05:50 INFO - Display Serial Number: 1600x1200 60 10:05:50 INFO - Main Display: Yes 10:05:50 INFO - Mirror: Off 10:05:50 INFO - Online: Yes 10:05:50 INFO - Rotation: Supported 10:05:50 INFO - Return code: 0 10:05:50 INFO - Running post-action listener: _resource_record_post_action 10:05:50 INFO - Running post-run listener: _resource_record_post_run 10:05:52 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 32194048; Write bytes: 691214848; Read time: 322; Write time: 1893 10:05:52 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 381348352; Write bytes: 375539200; Read time: 28195; Write time: 756 10:05:52 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 30432768; Write bytes: 296104960; Read time: 304; Write time: 1100 10:05:52 INFO - Running post-run listener: _upload_blobber_files 10:05:52 INFO - Blob upload gear active. 10:05:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:52 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 10:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:05:52 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:05:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:05:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:53 INFO - (blobuploader) - INFO - Done attempting. 10:05:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:05:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:05:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:54 INFO - (blobuploader) - INFO - Done attempting. 10:05:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:54 INFO - Return code: 0 10:05:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/473ba36d6b1d2fdd8f4058d9a6ac698426fb54cc0baa9637cb84c6310c647dea1357240fa7af9a058e1b71aaebaed71dac9fa42981ed3e4ff6764122ebf1fee1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bd01e6a5f1a1edc95087bee167cb1284ed75d9454e7cabb01ada13acd0a6b8c2bd48c8216be41a85a0ce50cdb385141db17cc71f86ab72a33cfae25dc172112"} 10:05:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:54 INFO - Contents: 10:05:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/473ba36d6b1d2fdd8f4058d9a6ac698426fb54cc0baa9637cb84c6310c647dea1357240fa7af9a058e1b71aaebaed71dac9fa42981ed3e4ff6764122ebf1fee1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bd01e6a5f1a1edc95087bee167cb1284ed75d9454e7cabb01ada13acd0a6b8c2bd48c8216be41a85a0ce50cdb385141db17cc71f86ab72a33cfae25dc172112"} 10:05:54 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:54 INFO - Copying logs to upload dir... 10:05:54 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.499267 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-04-08 10:05:54.320197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 10:05:54.323811) ========= 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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/473ba36d6b1d2fdd8f4058d9a6ac698426fb54cc0baa9637cb84c6310c647dea1357240fa7af9a058e1b71aaebaed71dac9fa42981ed3e4ff6764122ebf1fee1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bd01e6a5f1a1edc95087bee167cb1284ed75d9454e7cabb01ada13acd0a6b8c2bd48c8216be41a85a0ce50cdb385141db17cc71f86ab72a33cfae25dc172112"} build_url:https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010992 build_url: 'https://queue.taskcluster.net/v1/task/Djads4C1Roi23hkgLflOnw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/473ba36d6b1d2fdd8f4058d9a6ac698426fb54cc0baa9637cb84c6310c647dea1357240fa7af9a058e1b71aaebaed71dac9fa42981ed3e4ff6764122ebf1fee1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bd01e6a5f1a1edc95087bee167cb1284ed75d9454e7cabb01ada13acd0a6b8c2bd48c8216be41a85a0ce50cdb385141db17cc71f86ab72a33cfae25dc172112"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 10:05:54.351910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:05:54.352273) ========= 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.A8VrNDtzOf/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.wXLE5mv9vh/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005055 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 10:05:54.401733) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 10:05:54.402097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 10:05:54.402596) ========= ========= Total master_lag: 0.30 =========