builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0174 starttime: 1460057908.78 results: success (0) buildid: 20160407104248 builduid: f4ba15b2fbcf4988b3191883a0089476 revision: 16ad4d244d7d34af26301d63862b00a975eac294 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:28.779334) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:28.779799) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:28.780092) ========= 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.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005867 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:28.830482) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-07 12:38:28.833795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-04-07 12:38:29.856638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:29.856909) ========= 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.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005339 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:29.915518) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:29.918839) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:29.919299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:29.919573) ========= 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.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-07 12:38:29-- 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% 152M=0s 2016-04-07 12:38:30 (152 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181967 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:30.338374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:30.338642) ========= 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.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.020250 ========= master_lag: 0.81 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:31.167981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-07 12:38:31.168292) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 16ad4d244d7d34af26301d63862b00a975eac294 --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 16ad4d244d7d34af26301d63862b00a975eac294 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-07 12:38:31,282 truncating revision to first 12 chars 2016-04-07 12:38:31,282 Setting DEBUG logging. 2016-04-07 12:38:31,282 attempt 1/10 2016-04-07 12:38:31,282 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/16ad4d244d7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 12:38:31,892 unpacking tar archive at: fx-team-16ad4d244d7d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.852393 ========= master_lag: 6.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-07 12:38:38.301977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:38.302329) ========= echo 16ad4d244d7d34af26301d63862b00a975eac294 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'16ad4d244d7d34af26301d63862b00a975eac294'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 16ad4d244d7d34af26301d63862b00a975eac294 program finished with exit code 0 elapsedTime=0.005121 script_repo_revision: '16ad4d244d7d34af26301d63862b00a975eac294' ========= master_lag: 0.66 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:38.969067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:38.969492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 12:38:39.186796) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-07 12:38:39.187098) ========= /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.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:38:39 INFO - MultiFileLogger online at 20160407 12:38:39 in /builds/slave/test 12:38:39 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 12:38:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:38:39 INFO - {'append_to_log': False, 12:38:39 INFO - 'base_work_dir': '/builds/slave/test', 12:38:39 INFO - 'blob_upload_branch': 'Fx-Team', 12:38:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:38:39 INFO - 'branch': 'Fx-Team', 12:38:39 INFO - 'buildbot_json_path': 'buildprops.json', 12:38:39 INFO - 'config_files': ('talos/mac_config.py',), 12:38:39 INFO - 'default_actions': ('clobber', 12:38:39 INFO - 'read-buildbot-config', 12:38:39 INFO - 'download-and-extract', 12:38:39 INFO - 'populate-webroot', 12:38:39 INFO - 'create-virtualenv', 12:38:39 INFO - 'install', 12:38:39 INFO - 'run-tests'), 12:38:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:38:39 INFO - 'download_minidump_stackwalk': True, 12:38:39 INFO - 'download_symbols': 'ondemand', 12:38:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:38:39 INFO - 'tooltool.py': '/tools/tooltool.py', 12:38:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:38:39 INFO - '/tools/misc-python/virtualenv.py')}, 12:38:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:38:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:38:39 INFO - 'installer_path': 'installer.exe', 12:38:39 INFO - 'log_level': 'info', 12:38:39 INFO - 'log_name': 'talos', 12:38:39 INFO - 'log_to_console': True, 12:38:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:38:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:38:39 INFO - 'opt_config_files': (), 12:38:39 INFO - 'pip_index': False, 12:38:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:38:39 INFO - 'cmd': ('bash', 12:38:39 INFO - '-c', 12:38:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:38:39 INFO - 'enabled': True, 12:38:39 INFO - 'halt_on_failure': False, 12:38:39 INFO - 'name': 'check_screen_resolution'},), 12:38:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:38:39 INFO - 'cmd': ('bash', 12:38:39 INFO - '-c', 12:38:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:38:39 INFO - 'enabled': True, 12:38:39 INFO - 'halt_on_failure': False, 12:38:39 INFO - 'name': 'check_screen_resolution'},), 12:38:39 INFO - 'run_cmd_checks_enabled': True, 12:38:39 INFO - 'sps_profile': False, 12:38:39 INFO - 'sps_profile_interval': 0, 12:38:39 INFO - 'suite': 'dromaeojs-e10s', 12:38:39 INFO - 'system_bits': '32', 12:38:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:38:39 INFO - 'title': 't-yosemite-r7-0174', 12:38:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:38:39 INFO - 'use_talos_json': True, 12:38:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:38:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:38:39 INFO - 'work_dir': 'build'} 12:38:39 INFO - ##### 12:38:39 INFO - ##### Running clobber step. 12:38:39 INFO - ##### 12:38:39 INFO - Running pre-action listener: _resource_record_pre_action 12:38:39 INFO - Running main action method: clobber 12:38:39 INFO - rmtree: /builds/slave/test/build 12:38:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:38:40 INFO - Running post-action listener: _resource_record_post_action 12:38:40 INFO - ##### 12:38:40 INFO - ##### Running read-buildbot-config step. 12:38:40 INFO - ##### 12:38:40 INFO - Running pre-action listener: _resource_record_pre_action 12:38:40 INFO - Running main action method: read_buildbot_config 12:38:40 INFO - Using buildbot properties: 12:38:40 INFO - { 12:38:40 INFO - "project": "", 12:38:40 INFO - "product": "firefox", 12:38:40 INFO - "script_repo_revision": "production", 12:38:40 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:38:40 INFO - "repository": "", 12:38:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:38:40 INFO - "buildid": "20160407104248", 12:38:40 INFO - "pgo_build": "False", 12:38:40 INFO - "basedir": "/builds/slave/test", 12:38:40 INFO - "buildnumber": 667, 12:38:40 INFO - "slavename": "t-yosemite-r7-0174", 12:38:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:38:40 INFO - "platform": "yosemite_r7", 12:38:40 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:38:40 INFO - "branch": "fx-team", 12:38:40 INFO - "repo_path": "integration/fx-team", 12:38:40 INFO - "revision": "16ad4d244d7d34af26301d63862b00a975eac294", 12:38:40 INFO - "stage_platform": "macosx64", 12:38:40 INFO - "builduid": "f4ba15b2fbcf4988b3191883a0089476", 12:38:40 INFO - "slavebuilddir": "test" 12:38:40 INFO - } 12:38:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 12:38:40 INFO - Running post-action listener: _resource_record_post_action 12:38:40 INFO - ##### 12:38:40 INFO - ##### Running download-and-extract step. 12:38:40 INFO - ##### 12:38:40 INFO - Running pre-action listener: _resource_record_pre_action 12:38:40 INFO - Running main action method: download_and_extract 12:38:40 INFO - mkdir: /builds/slave/test/build/tests 12:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:40 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:38:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:38:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 12:38:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:41 INFO - Downloaded 1199 bytes. 12:38:41 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 12:38:41 INFO - Using the following test package requirements: 12:38:41 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:38:41 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:38:41 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 12:38:41 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:38:41 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 12:38:41 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:38:41 INFO - u'jsshell-mac.zip'], 12:38:41 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:38:41 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 12:38:41 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 12:38:41 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:38:41 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 12:38:41 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:38:41 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 12:38:41 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:38:41 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 12:38:41 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 12:38:41 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 12:38:41 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:38: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')]} 12:38:41 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:38:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:38:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:38:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:43 INFO - Downloaded 17971735 bytes. 12:38:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:38:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:38:46 INFO - Return code: 0 12:38:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:46 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 12:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:47 INFO - Downloaded 17971735 bytes. 12:38:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:38:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 12:38:51 INFO - Return code: 0 12:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:38:51 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:38:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:38:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 12:38:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:52 INFO - Downloaded 10847693 bytes. 12:38:52 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'] 12:38:52 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 12:38:52 INFO - Return code: 0 12:38: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')]} 12:38:52 INFO - https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:38:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:38:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:38:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 12:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J_1yZDRMQRuisxRmLoXPoA/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 12:38:55 INFO - Downloaded 108875126 bytes. 12:38:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:38:55 INFO - mkdir: /builds/slave/test/properties 12:38:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:38:55 INFO - Writing to file /builds/slave/test/properties/build_url 12:38:55 INFO - Contents: 12:38:55 INFO - build_url:https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 12:38:56 INFO - Running post-action listener: _resource_record_post_action 12:38:56 INFO - Running post-action listener: set_extra_try_arguments 12:38:56 INFO - ##### 12:38:56 INFO - ##### Running populate-webroot step. 12:38:56 INFO - ##### 12:38:56 INFO - Running pre-action listener: _resource_record_pre_action 12:38:56 INFO - Running main action method: populate_webroot 12:38:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:38:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:38:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:38:56 INFO - '--tppagecycles', 12:38:56 INFO - '7'], 12:38:56 INFO - 'tests': ['tsvgm']}}, 12:38:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:38:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:38:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:38:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:38:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:56 INFO - 'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:38:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:56 INFO - 'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['damp', 'tps']}, 12:38:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:56 INFO - 'tests': ['damp', 'tps']}, 12:38:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['dromaeo_dom']}, 12:38:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:38:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['a11yr', 12:38:56 INFO - 'ts_paint', 12:38:56 INFO - 'tpaint', 12:38:56 INFO - 'sessionrestore', 12:38:56 INFO - 'sessionrestore_no_auto_restore', 12:38:56 INFO - 'tabpaint']}, 12:38:56 INFO - 'other-e10s': {'tests': ['a11yr', 12:38:56 INFO - 'ts_paint', 12:38:56 INFO - 'tpaint', 12:38:56 INFO - 'sessionrestore', 12:38:56 INFO - 'sessionrestore_no_auto_restore', 12:38:56 INFO - 'tabpaint']}, 12:38:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:38:56 INFO - 'ts_paint', 12:38:56 INFO - 'tpaint', 12:38:56 INFO - 'sessionrestore', 12:38:56 INFO - 'sessionrestore_no_auto_restore', 12:38:56 INFO - 'tabpaint']}, 12:38:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:38:56 INFO - 'ts_paint', 12:38:56 INFO - 'tpaint', 12:38:56 INFO - 'sessionrestore', 12:38:56 INFO - 'sessionrestore_no_auto_restore', 12:38:56 INFO - 'tabpaint']}, 12:38:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['a11yr', 12:38:56 INFO - 'ts_paint', 12:38:56 INFO - 'tpaint', 12:38:56 INFO - 'sessionrestore', 12:38:56 INFO - 'sessionrestore_no_auto_restore', 12:38:56 INFO - 'tabpaint']}, 12:38:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['a11yr', 12:38:56 INFO - 'ts_paint', 12:38:56 INFO - 'tpaint', 12:38:56 INFO - 'sessionrestore', 12:38:56 INFO - 'sessionrestore_no_auto_restore', 12:38:56 INFO - 'tabpaint']}, 12:38:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['tsvgx', 12:38:56 INFO - 'tsvgr_opacity', 12:38:56 INFO - 'tart', 12:38:56 INFO - 'tscrollx', 12:38:56 INFO - 'cart']}, 12:38:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:38:56 INFO - 'tsvgr_opacity', 12:38:56 INFO - 'tart', 12:38:56 INFO - 'tscrollx', 12:38:56 INFO - 'cart']}, 12:38:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:56 INFO - 'talos_options': ['--disable-e10s'], 12:38:56 INFO - 'tests': ['tp5o']}, 12:38:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:56 INFO - 'tests': ['tp5o']}, 12:38:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:56 INFO - 'talos_options': ['--disable-e10s', 12:38:56 INFO - '--xperf_path', 12:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:56 INFO - 'tests': ['tp5n']}, 12:38:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:38:56 INFO - 'talos_options': ['--xperf_path', 12:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:38:56 INFO - 'tests': ['tp5n']}}, 12:38:56 INFO - 'talos.zip': {'path': '', 12:38:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:38:56 INFO - Running post-action listener: _resource_record_post_action 12:38:56 INFO - ##### 12:38:56 INFO - ##### Running create-virtualenv step. 12:38:56 INFO - ##### 12:38:56 INFO - Running pre-action listener: _resource_record_pre_action 12:38:56 INFO - Running main action method: create_virtualenv 12:38:56 INFO - Creating virtualenv /builds/slave/test/build/venv 12:38:56 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 12:38:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:38:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:38:56 INFO - Using real prefix '/tools/python27' 12:38:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:38:57 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:00 INFO - Installing pip.................done. 12:39:00 INFO - Return code: 0 12:39:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:39:00 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')]} 12:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:00 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')]} 12:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:00 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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:00 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 12:39:00 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 12:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:00 INFO - 'HOME': '/Users/cltbld', 12:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:00 INFO - 'LOGNAME': 'cltbld', 12:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:00 INFO - 'MOZ_NO_REMOTE': '1', 12:39:00 INFO - 'NO_EM_RESTART': '1', 12:39:00 INFO - 'PAGER': '/bin/cat', 12:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:00 INFO - 'PWD': '/builds/slave/test', 12:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:00 INFO - 'SHELL': '/bin/bash', 12:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:00 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:00 INFO - 'USER': 'cltbld', 12:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:00 INFO - 'XPC_FLAGS': '0x0', 12:39:00 INFO - 'XPC_SERVICE_NAME': '0', 12:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:00 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 12:39:00 INFO - Cleaning up... 12:39:00 INFO - Return code: 0 12:39:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:39:00 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')]} 12:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:00 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')]} 12:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:00 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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:00 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 12:39:00 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 12:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:00 INFO - 'HOME': '/Users/cltbld', 12:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:00 INFO - 'LOGNAME': 'cltbld', 12:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:00 INFO - 'MOZ_NO_REMOTE': '1', 12:39:00 INFO - 'NO_EM_RESTART': '1', 12:39:00 INFO - 'PAGER': '/bin/cat', 12:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:00 INFO - 'PWD': '/builds/slave/test', 12:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:00 INFO - 'SHELL': '/bin/bash', 12:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:00 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:00 INFO - 'USER': 'cltbld', 12:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:00 INFO - 'XPC_FLAGS': '0x0', 12:39:00 INFO - 'XPC_SERVICE_NAME': '0', 12:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:00 INFO - Downloading/unpacking psutil>=0.7.1 12:39:00 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 12:39:00 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 12:39:00 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 12:39:00 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 12:39:00 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 12:39:00 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 12:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:03 INFO - Installing collected packages: psutil 12:39:03 INFO - Running setup.py install for psutil 12:39:03 INFO - building 'psutil._psutil_osx' extension 12:39:03 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 12:39:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:39:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:39:04 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 12:39:04 INFO - building 'psutil._psutil_posix' extension 12:39:04 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 12:39:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:39:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:39:04 INFO - ^ 12:39:04 INFO - 1 warning generated. 12:39:04 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 12:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:04 INFO - Successfully installed psutil 12:39:04 INFO - Cleaning up... 12:39:04 INFO - Return code: 0 12:39:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:04 INFO - 'HOME': '/Users/cltbld', 12:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:04 INFO - 'LOGNAME': 'cltbld', 12:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:04 INFO - 'MOZ_NO_REMOTE': '1', 12:39:04 INFO - 'NO_EM_RESTART': '1', 12:39:04 INFO - 'PAGER': '/bin/cat', 12:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:04 INFO - 'PWD': '/builds/slave/test', 12:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:04 INFO - 'SHELL': '/bin/bash', 12:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:04 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:04 INFO - 'USER': 'cltbld', 12:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:04 INFO - 'XPC_FLAGS': '0x0', 12:39:04 INFO - 'XPC_SERVICE_NAME': '0', 12:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:39:07 INFO - Installing collected packages: mozsystemmonitor 12:39:07 INFO - Running setup.py install for mozsystemmonitor 12:39:07 INFO - Successfully installed mozsystemmonitor 12:39:07 INFO - Cleaning up... 12:39:07 INFO - Return code: 0 12:39:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:39:07 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')]} 12:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:07 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')]} 12:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:07 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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:07 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 12:39:07 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 12:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:07 INFO - 'HOME': '/Users/cltbld', 12:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:07 INFO - 'LOGNAME': 'cltbld', 12:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:07 INFO - 'MOZ_NO_REMOTE': '1', 12:39:07 INFO - 'NO_EM_RESTART': '1', 12:39:07 INFO - 'PAGER': '/bin/cat', 12:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:07 INFO - 'PWD': '/builds/slave/test', 12:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:07 INFO - 'SHELL': '/bin/bash', 12:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:07 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:07 INFO - 'USER': 'cltbld', 12:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:07 INFO - 'XPC_FLAGS': '0x0', 12:39:07 INFO - 'XPC_SERVICE_NAME': '0', 12:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:08 INFO - Downloading/unpacking blobuploader==1.2.4 12:39:08 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 12:39:08 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 12:39:08 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 12:39:08 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 12:39:08 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 12:39:08 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 12:39:10 INFO - Downloading blobuploader-1.2.4.tar.gz 12:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:39:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:39:10 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 12:39:10 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 12:39:10 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 12:39:10 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 12:39:10 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 12:39:10 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 12:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:39:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:11 INFO - Downloading docopt-0.6.1.tar.gz 12:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:39:11 INFO - Installing collected packages: blobuploader, requests, docopt 12:39:11 INFO - Running setup.py install for blobuploader 12:39:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:39:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:39:11 INFO - Running setup.py install for requests 12:39:12 INFO - Running setup.py install for docopt 12:39:12 INFO - Successfully installed blobuploader requests docopt 12:39:12 INFO - Cleaning up... 12:39:12 INFO - Return code: 0 12:39:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:12 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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:12 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 12:39:12 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 12:39:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:12 INFO - 'HOME': '/Users/cltbld', 12:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:12 INFO - 'LOGNAME': 'cltbld', 12:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:12 INFO - 'MOZ_NO_REMOTE': '1', 12:39:12 INFO - 'NO_EM_RESTART': '1', 12:39:12 INFO - 'PAGER': '/bin/cat', 12:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:12 INFO - 'PWD': '/builds/slave/test', 12:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:12 INFO - 'SHELL': '/bin/bash', 12:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:12 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:12 INFO - 'USER': 'cltbld', 12:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:12 INFO - 'XPC_FLAGS': '0x0', 12:39:12 INFO - 'XPC_SERVICE_NAME': '0', 12:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:39:12 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-TtmlUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:39:12 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-GVxD5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-mKe1VG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-9SDTwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-qFlC6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-NnuJa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Kv8R6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Ev85cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1QIOW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-fHdxkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-GXuQ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:13 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-CvZR0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gAn8k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-_LVwlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-n7ZSSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-0FOTOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-3qc3RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:39:14 INFO - Running setup.py install for manifestparser 12:39:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:39:14 INFO - Running setup.py install for mozcrash 12:39:14 INFO - Running setup.py install for mozdebug 12:39:14 INFO - Running setup.py install for mozdevice 12:39:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:39:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:39:15 INFO - Running setup.py install for mozfile 12:39:15 INFO - Running setup.py install for mozhttpd 12:39:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:39:15 INFO - Running setup.py install for mozinfo 12:39:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:39:15 INFO - Running setup.py install for mozInstall 12:39:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:39:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:39:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:39:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:39:15 INFO - Running setup.py install for mozleak 12:39:15 INFO - Running setup.py install for mozlog 12:39:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:39:16 INFO - Running setup.py install for moznetwork 12:39:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:39:16 INFO - Running setup.py install for mozprocess 12:39:16 INFO - Running setup.py install for mozprofile 12:39:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:39:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:39:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:39:16 INFO - Running setup.py install for mozrunner 12:39:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:39:16 INFO - Running setup.py install for mozscreenshot 12:39:16 INFO - Running setup.py install for moztest 12:39:17 INFO - Running setup.py install for mozversion 12:39:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:39:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:39:17 INFO - Cleaning up... 12:39:17 INFO - Return code: 0 12:39:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:17 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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:17 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 12:39:17 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 12:39:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:17 INFO - 'HOME': '/Users/cltbld', 12:39:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:17 INFO - 'LOGNAME': 'cltbld', 12:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:17 INFO - 'MOZ_NO_REMOTE': '1', 12:39:17 INFO - 'NO_EM_RESTART': '1', 12:39:17 INFO - 'PAGER': '/bin/cat', 12:39:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:17 INFO - 'PWD': '/builds/slave/test', 12:39:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:17 INFO - 'SHELL': '/bin/bash', 12:39:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:17 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:17 INFO - 'USER': 'cltbld', 12:39:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:17 INFO - 'XPC_FLAGS': '0x0', 12:39:17 INFO - 'XPC_SERVICE_NAME': '0', 12:39:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:39:17 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-mRYofy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:39:17 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)) 12:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:39:17 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-YLEAqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:39:17 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)) 12:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:39:17 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-FYQvvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:39:17 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)) 12:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:39:17 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1tYFIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:39:17 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)) 12:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:39:17 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-dSxjUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:39:17 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)) 12:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:39:17 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ZiAUC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-YFjvBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-_xWAoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-4kD4JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-oSpMrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-uRHq6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-S9kD9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-1LUO_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-yNi8NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:18 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)) 12:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:18 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-M4xmaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:19 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)) 12:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-f5dTsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:19 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)) 12:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:19 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-IolsUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:19 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)) 12:39:19 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)) 12:39:19 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)) 12:39:19 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)) 12:39:19 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)) 12:39:19 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)) 12:39:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:39:19 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 12:39:19 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 12:39:19 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 12:39:19 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 12:39:19 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 12:39:19 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 12:39:21 INFO - Downloading blessings-1.6.tar.gz 12:39:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:39:21 INFO - Installing collected packages: blessings 12:39:21 INFO - Running setup.py install for blessings 12:39:21 INFO - Successfully installed blessings 12:39:21 INFO - Cleaning up... 12:39:21 INFO - Return code: 0 12:39:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:22 INFO - Reading from file tmpfile_stdout 12:39:22 INFO - Current package versions: 12:39:22 INFO - blessings == 1.6 12:39:22 INFO - blobuploader == 1.2.4 12:39:22 INFO - docopt == 0.6.1 12:39:22 INFO - manifestparser == 1.1 12:39:22 INFO - mozInstall == 1.12 12:39:22 INFO - mozcrash == 0.17 12:39:22 INFO - mozdebug == 0.1 12:39:22 INFO - mozdevice == 0.48 12:39:22 INFO - mozfile == 1.2 12:39:22 INFO - mozhttpd == 0.7 12:39:22 INFO - mozinfo == 0.9 12:39:22 INFO - mozleak == 0.1 12:39:22 INFO - mozlog == 3.1 12:39:22 INFO - moznetwork == 0.27 12:39:22 INFO - mozprocess == 0.22 12:39:22 INFO - mozprofile == 0.28 12:39:22 INFO - mozrunner == 6.11 12:39:22 INFO - mozscreenshot == 0.1 12:39:22 INFO - mozsystemmonitor == 0.0 12:39:22 INFO - moztest == 0.7 12:39:22 INFO - mozversion == 1.4 12:39:22 INFO - psutil == 3.1.1 12:39:22 INFO - requests == 1.2.3 12:39:22 INFO - wsgiref == 0.1.2 12:39:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39:22 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')]} 12:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:22 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')]} 12:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:22 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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:22 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 12:39:22 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 12:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:22 INFO - 'HOME': '/Users/cltbld', 12:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:22 INFO - 'LOGNAME': 'cltbld', 12:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:22 INFO - 'MOZ_NO_REMOTE': '1', 12:39:22 INFO - 'NO_EM_RESTART': '1', 12:39:22 INFO - 'PAGER': '/bin/cat', 12:39:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:22 INFO - 'PWD': '/builds/slave/test', 12:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:22 INFO - 'SHELL': '/bin/bash', 12:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:22 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:22 INFO - 'USER': 'cltbld', 12:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:22 INFO - 'XPC_FLAGS': '0x0', 12:39:22 INFO - 'XPC_SERVICE_NAME': '0', 12:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 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)) 12:39:22 INFO - Cleaning up... 12:39:22 INFO - Return code: 0 12:39:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:39:22 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')]} 12:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:22 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')]} 12:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:22 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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:22 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 12:39:22 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 12:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:22 INFO - 'HOME': '/Users/cltbld', 12:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:22 INFO - 'LOGNAME': 'cltbld', 12:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:22 INFO - 'MOZ_NO_REMOTE': '1', 12:39:22 INFO - 'NO_EM_RESTART': '1', 12:39:22 INFO - 'PAGER': '/bin/cat', 12:39:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:22 INFO - 'PWD': '/builds/slave/test', 12:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:22 INFO - 'SHELL': '/bin/bash', 12:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:22 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:22 INFO - 'USER': 'cltbld', 12:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:22 INFO - 'XPC_FLAGS': '0x0', 12:39:22 INFO - 'XPC_SERVICE_NAME': '0', 12:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:22 INFO - Downloading/unpacking jsonschema 12:39:22 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 12:39:22 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 12:39:22 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 12:39:22 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 12:39:22 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 12:39:22 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 12:39:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:39:25 INFO - Downloading/unpacking functools32 (from jsonschema) 12:39:25 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 12:39:25 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 12:39:25 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 12:39:25 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 12:39:25 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 12:39:25 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 12:39:25 INFO - Downloading functools32-3.2.3-2.tar.gz 12:39:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:39:25 INFO - warning: no files found matching '*.txt' 12:39:25 INFO - no previously-included directories found matching 'build' 12:39:25 INFO - no previously-included directories found matching 'dist' 12:39:25 INFO - no previously-included directories found matching '.git*' 12:39:25 INFO - Installing collected packages: jsonschema, functools32 12:39:25 INFO - Running setup.py install for functools32 12:39:25 INFO - warning: no files found matching '*.txt' 12:39:25 INFO - no previously-included directories found matching 'build' 12:39:25 INFO - no previously-included directories found matching 'dist' 12:39:25 INFO - no previously-included directories found matching '.git*' 12:39:25 INFO - Successfully installed jsonschema functools32 12:39:25 INFO - Cleaning up... 12:39:25 INFO - Return code: 0 12:39:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:25 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 0x1030e4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1030f4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9328da40f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, '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.rbO860srag/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.sgncwXLSp6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 12:39:25 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 12:39:25 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 12:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:39:25 INFO - 'HOME': '/Users/cltbld', 12:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:39:25 INFO - 'LOGNAME': 'cltbld', 12:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:25 INFO - 'MOZ_NO_REMOTE': '1', 12:39:25 INFO - 'NO_EM_RESTART': '1', 12:39:25 INFO - 'PAGER': '/bin/cat', 12:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:25 INFO - 'PWD': '/builds/slave/test', 12:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:39:25 INFO - 'SHELL': '/bin/bash', 12:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:39:25 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:39:25 INFO - 'USER': 'cltbld', 12:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:25 INFO - 'XPC_FLAGS': '0x0', 12:39:25 INFO - 'XPC_SERVICE_NAME': '0', 12:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:26 INFO - Downloading/unpacking flake8 12:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:39:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:39:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:29 INFO - no previously-included directories found matching 'docs/_build' 12:39:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:39:29 INFO - Running setup.py install for pep8 12:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:39:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:39:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:39:29 INFO - no previously-included directories found matching 'docs/_build' 12:39:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:39:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:39:30 INFO - Cleaning up... 12:39:30 INFO - Return code: 0 12:39:30 INFO - Running post-action listener: _resource_record_post_action 12:39:30 INFO - Running post-action listener: _start_resource_monitoring 12:39:30 INFO - Starting resource monitoring. 12:39:30 INFO - ##### 12:39:30 INFO - ##### Running install step. 12:39:30 INFO - ##### 12:39:30 INFO - Running pre-action listener: _resource_record_pre_action 12:39:30 INFO - Running main action method: install 12:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:30 INFO - Reading from file tmpfile_stdout 12:39:30 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:39:30 INFO - Reading from file tmpfile_stdout 12:39:30 INFO - Output received: 12:39:30 INFO - Usage: mozinstall [options] installer 12:39:30 INFO - Options: 12:39:30 INFO - -h, --help show this help message and exit 12:39:30 INFO - -d DEST, --destination=DEST 12:39:30 INFO - Directory to install application into. [default: 12:39:30 INFO - "/builds/slave/test"] 12:39:30 INFO - --app=APP Application being installed. [default: firefox] 12:39:30 INFO - mkdir: /builds/slave/test/build/application 12:39:30 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'] 12:39:30 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 12:40:03 INFO - Reading from file tmpfile_stdout 12:40:03 INFO - Output received: 12:40:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:40:03 INFO - Running post-action listener: _resource_record_post_action 12:40:03 INFO - ##### 12:40:03 INFO - ##### Running run-tests step. 12:40:03 INFO - ##### 12:40:03 INFO - Running pre-action listener: _resource_record_pre_action 12:40:03 INFO - Running main action method: run_tests 12:40:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:40:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:40:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:40:04 INFO - 2016-04-07 12:40:04.004 screenresolution[1927:14039] starting screenresolution argv=screenresolution get 12:40:04 INFO - 2016-04-07 12:40:04.007 screenresolution[1927:14039] Display 0: 1600x1200x32@60 12:40:04 INFO - 2016-04-07 12:40:04.013 screenresolution[1928:14041] starting screenresolution argv=screenresolution list 12:40:04 INFO - Available Modes on Display 0 12:40:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:40:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:40:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:40:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:40:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:40:04 INFO - Intel Iris: 12:40:04 INFO - Chipset Model: Intel Iris 12:40:04 INFO - Type: GPU 12:40:04 INFO - Bus: Built-In 12:40:04 INFO - VRAM (Dynamic, Max): 1536 MB 12:40:04 INFO - Vendor: Intel (0x8086) 12:40:04 INFO - Device ID: 0x0a2e 12:40:04 INFO - Revision ID: 0x0009 12:40:04 INFO - Displays: 12:40:04 INFO - Display: 12:40:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:40:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:40:04 INFO - Display Serial Number: 1600x1200 60 12:40:04 INFO - Main Display: Yes 12:40:04 INFO - Mirror: Off 12:40:04 INFO - Online: Yes 12:40:04 INFO - Rotation: Supported 12:40:04 INFO - Return code: 0 12:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:40:04 INFO - Python 2.7.3 12:40:04 INFO - Return code: 0 12:40:04 INFO - grabbing minidump binary from tooltool 12:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:40:04 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 0x102f83e00>, '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 0x102decdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f7eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:40:04 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 12:40:04 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 12:40:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:40:04 INFO - Return code: 0 12:40:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:40:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:40:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:40:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:40:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:40:05 INFO - Return code: 0 12:40:05 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/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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 12:40:05 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/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --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 12:40:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rbO860srag/Render', 12:40:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:40:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:40:05 INFO - 'HOME': '/Users/cltbld', 12:40:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:40:05 INFO - 'LOGNAME': 'cltbld', 12:40:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:40:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:05 INFO - 'MOZ_NO_REMOTE': '1', 12:40:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:40:05 INFO - 'NO_EM_RESTART': '1', 12:40:05 INFO - 'PAGER': '/bin/cat', 12:40:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:05 INFO - 'PWD': '/builds/slave/test', 12:40:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:40:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:40:05 INFO - 'SHELL': '/bin/bash', 12:40:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sgncwXLSp6/Listeners', 12:40:05 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 12:40:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:40:05 INFO - 'USER': 'cltbld', 12:40:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:40:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:05 INFO - 'XPC_FLAGS': '0x0', 12:40:05 INFO - 'XPC_SERVICE_NAME': '0', 12:40:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:40:05 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/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--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 12:40:05 INFO - mozversion application_buildid: 20160407104248 12:40:05 INFO - mozversion application_changeset: 16ad4d244d7d34af26301d63862b00a975eac294 12:40:05 INFO - mozversion application_display_name: Nightly 12:40:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:40:05 INFO - mozversion application_name: Firefox 12:40:05 INFO - mozversion application_remotingname: firefox 12:40:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:40:05 INFO - mozversion application_vendor: Mozilla 12:40:05 INFO - mozversion application_version: 48.0a1 12:40:05 INFO - mozversion platform_buildid: 20160407104248 12:40:05 INFO - mozversion platform_changeset: 16ad4d244d7d34af26301d63862b00a975eac294 12:40:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:40:05 INFO - mozversion platform_version: 48.0a1 12:40:05 INFO - using testdate: 1460058005 12:40:05 INFO - actual date: 1460058005 12:40:05 INFO - starting webserver on 'localhost:49648' 12:40:05 INFO - SUITE-START | Running 2 tests 12:40:05 INFO - TEST-START | dromaeo_css 12:40:05 INFO - operating with platform_type : mac_ 12:40:05 INFO - Initialising browser for dromaeo_css test... 12:40:05 INFO - TEST-INFO | started process 1946 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpaJ9wNV/profile http://localhost:49648/getInfo.html) 12:40:08 INFO - PROCESS | 1946 | 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] 12:40:08 INFO - PROCESS | 1946 | __metrics Screen width/height:1600/1200 12:40:08 INFO - PROCESS | 1946 | colorDepth:24 12:40:08 INFO - PROCESS | 1946 | Browser inner width/height: 1024/689 12:40:08 INFO - PROCESS | 1946 | __metrics 12:40:08 ERROR - PROCESS | 1946 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 12:40:09 INFO - TEST-INFO | 1946: exit 0 12:40:09 INFO - Browser initialized. 12:40:09 INFO - Running cycle 1/1 for dromaeo_css test... 12:40:09 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpaJ9wNV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:21 INFO - PROCESS | 1949 | RSS: Main: 247377920 12:40:21 INFO - PROCESS | 1949 | 12:41:10 INFO - PROCESS | 1949 | 1460058070838 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] 12:43:22 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49648/tests/dromaeo/cssquery-ext.html) 12:43:23 INFO - PROCESS | 1949 | RSS: Main: 259608576 12:43:23 INFO - PROCESS | 1949 | 12:46:25 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-ext.html (next: http://localhost:49648/tests/dromaeo/cssquery-jquery.html) 12:46:26 INFO - PROCESS | 1949 | RSS: Main: 271228928 12:46:26 INFO - PROCESS | 1949 | 12:49:28 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49648/tests/dromaeo/cssquery-mootools.html) 12:49:28 INFO - PROCESS | 1949 | RSS: Main: 273326080 12:49:28 INFO - PROCESS | 1949 | 12:52:30 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49648/tests/dromaeo/cssquery-prototype.html) 12:52:30 INFO - PROCESS | 1949 | RSS: Main: 274956288 12:52:30 INFO - PROCESS | 1949 | 12:55:33 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49648/tests/dromaeo/cssquery-yui.html) 12:55:34 INFO - PROCESS | 1949 | RSS: Main: 277790720 12:55:34 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49648/tests/dromaeo/cssquery-yui.html (next: http://localhost:49648/tests/dromaeo/cssquery-dojo.html) 12:58:36 INFO - PROCESS | 1949 | RSS: Main: 278794240 12:58:36 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | __start_tp_report 12:58:36 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 12:58:36 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 12:58:36 INFO - PROCESS | 1949 | |i|pagename|runs| 12:58:36 INFO - PROCESS | 1949 | |0;dojo.html;2865.412590418963;3441.6386279440667;3447.7586568940173;3511.648835116487;3535.186907011387;4764.45208800988;5731.770729170833;5786.363500014995;5791.855203619901;5857.974854400484;5665.150227465882;5796.913046304308;5852.326982397026;5877.85305367365;5891.234139561861;5141.742912854361;5191.662541934781;5217.139172036609;5263.684178949256;5302.257683924254;5284.947150528503;5292.682439053669;5321.467853214667;5345.973270133644;5391.083515802323;5136;5143;5205.531502164786;5256.55319297862;5297.841064768044;5224.712640804754;5230.163173892197;5237.764300606482;5253.474652534755;5292.047431462335;5174.404943431478;5198.870028249286;5213.765380557884;5229.869253268661;5262.394824595182;4697.741624210667;5670.716464176775;5691.743871525791;5755.68343741094;5764.8847023059725;5456.208849716809;6197.411245931629;6216.409441103088;6224.595401298946;6266.185395898549;6246.250449946036;6246.500279977591;6250;6256.873762722708;6281.775053864499;5734.16854556087;5860.091685788667;5867.2959244890035;5931.762729490815;5959.761609535657;6293.937060629427;6311.589746666452;6313.779017734358;6332.778352757631;6340.4293613575;5205.47945205484;6063.484603808637;6214.2542894852;6247.718852651642;6263.874722505524;6175.62946223228;6209.316975132731;6252.062190671436;6264.561480696308;6265.530085243534;6074.119252708332;6153.384661533811;6179.134921111048;6230.408111229426;6242.719077641517;6138.723757430837;6212.47193988507;6229.127922090911;6230.56386052981;6240.719167637377;4261.808218630169;4780.521947805191;4971.105201063771;5014.949850501521;5053.242013697901;4416.646668266531;4441.244988351988;4460.620847228022;4491.30384790358;4497.437820272466;5723.456271654186;5814.040683287295;5819.127130930309;5861.794837180678;5864.882702345929;5207.270982062514;6194.225721784777;6217.409346112203;6228.937710622836;6233.875322493524;5785.710714464344;5850.831580200843;5869.442402971711;5901.321348044944;5918.911216331759;5388.838334849961;5465.398806131322;5468.316460442445;5479;5517.61376703635;6307.9369206308265;6381.3937675920715;6386.010168423994;6389.744410223539;6411.6794160290865;6236.282827474898;6242.719077641608;6244.344343843831;6255.218097737783;6257.624542527463;6183.319834818077;6317.241930968129;6360.363963603602;6376.840578985562;6392.073149393219;5031.371078615173;6043.456088952015;6236.875262494634;6273.153124328157;6275.5607107503865;6183;6214.130021797043;6215.192025036717;6235.189425374672;6244.188255526934;5867.325257595431;6051.818445446644;6096.375503402397;6144.494598823317;6233.438990490878;5338.3060202173465;6083.66539840313;6102.489251635809;6125.204929265209;6126.886289059745;5855.414458554111;5986.760529578943;6010.669413182142;6061.212042434456;6064.272287325549;6115.571909966259;6212.502999759918;6214.25428948529;6216.378362163748;6230.15892854477;5913.2608423947;6019.51843852482;6080.817575472743;6085.4523092921845;6132.478739307209 12:58:36 INFO - PROCESS | 1949 | |1;ext.html;436.27795997623946;468.7375069960822;573.6300086444244;601.1103566721255;609.2201981463725;36214.83529394121;36812.07969800756;36849;36891.26217475652;37005.074873128186;38418.039549011286;38824.805875970655;38844.41733373995;38942.83171504852;39113;9255.861162082558;9491.335606507548;9504.334696571243;9510.80978380432;9515.476648784314;9279.721608351727;9389.76525586859;9434.952825235865;9479.715608531755;9506.096920792514;8404.41169118162;9271;9489.098535639103;9519.381240219398;9549.85675214869;9398.530073496366;9399.671011514598;9431;9447.385919915252;9481.194098501635;9344.626214951393;9358.672446464341;9465;9482.38364506305;9500.619975200983;36954.26091478182;36964;37341;37498.625013749785;37680.43479347812;3121.1416860363584;3123.46901026826;3293.2590167212425;3354.815485148316;3451.4822776583715;27617.861910690317;28213;28416;28766.424671506662;28945.85527072372;2578.561644520436;2645.7486538778785;2746.945061098767;2801.29967508123;2865.1834227245135;393860;402724;404459;405821.9708901466;409752;44649.10701785946;63449.365506344344;63838;64045.679771601775;64051.679741600994;43551.782241089226;44299;44306;44427.11145777066;44648.107037859714;15314.846851531565;15516.534503964898;15575.76636350433;15600.609984750245;15609.21953902323;12355.25868447896;12445.875541244654;12484.063695222894;12507;12525.185862918881;14034.789478157836;14158.929205354114;14187.361568729431;14234.861211103087;14383.928080359532;6251.468625166912;6294.433500984934;6345.650989195638;6362.522810789209;6421.871562568723;922.4419226368085;1007.5818535307765;1069.2248120112856;1096.8848270931437;1097;28104.71895281021;28334.574981375295;28745.71254287472;28929.42141157165;28942.421151577273;963.4363897120123;1122.8820973797797;1154.9538018479334;1170.8185231289165;1210.9576164834189;14266.001379903308;14401;14642.560723178321;14680.04579702316;14727.55817325482;487683;519820;523977;525286;525768;55071.449285506635;55258;55259.44740552623;55564.16653750197;56031.159532607046;1428.5428662828003;1430.6637940084072;1487.174618086972;1493.529538195465;1494.6487575419767;28235.57646635261;28555.857220713762;28583.714162858938;28881.42237155203;28968.7103128966;47357;47398;47550.28674569954;47718.761406192745;47724.284135738686;489114;489296.10703892505;492302;492353;493023;32567;42541.8995798881;42663.146737065705;43166;44239;42122.157556849306;42384.7284581463;43492.56507434885;43531.56468435275;43690.56309436865;36345.09137271589;36452.90641280766;36900.70847520324;36937.81531092327;37009.81495092507;35757;35830.56677732861;36380.63619363772;36646.26707465889;36705;35315.11712207215;35794.92615221548;36036.45945310875;36201.818990904874;37558;25395;27350;32156.356872862878;32942.50586241256;33096;21210.787892120883;21310.254141104986;23425.648615271126;23780.88109559441;24615.13847015346 12:58:36 INFO - PROCESS | 1949 | |2;jquery.html;307.20280871139386;323.46628063694914;337.7957581222939;364.3841907176871;364.50427418710547;19082.522936926565;19873;19876.90061549692;20715.37853864383;20784.48038799031;11705.005074568651;11909.285442873434;12171.57399491018;12189.695257618563;12190.878091219107;4713.7643117844145;5123.923141152885;5269.104252277103;5314.883874386364;5363.839084827442;4659.976700116495;5669.886602267952;5685.829425117233;5704.515116215127;5717.171010203518;5408.675479471224;5655.349634792011;5807.593468457209;5818.5636077294375;5825.388334224909;5774.105013722879;5829.475347218749;5857.531397488212;5869.266341707286;5877.70611469427;5621.943780562183;5655.519280861132;5665.433456654343;5676.375598684142;5686.1755045518585;13054.934725326408;13381.66545836352;13420.328983550784;15920.56714895665;23846.165384211643;2169.349195241421;2178.237616834095;2207;2260.3783959411294;2632.9205025939464;9540.236781057498;9629;9822.116009559173;9949.30354875159;9996.90003099967;1733.098788629918;1746.8602511799027;1752.229019231534;1766.3199668127734;1795.1562765500194;99308.50345748298;100061;101671.99999999926;102366;102886;8762.518061506551;11159.995600395841;11208.047315978232;11218.495167717472;11285.153613479022;13531;13552.86447135516;13572.321383930765;13734.313284335944;13759.312034398241;8445.493270403795;8484.703035393732;8526.10475900034;8556.18716221958;8605.13948605147;8525.232729054414;8536.573171341408;8548.444351117158;8578.742637720878;8659.350548708871;4165.875023749292;4317.870463886088;4381.1237752449;4400.581944715247;4402.229609818269;1684.89890606564;1882.6328865871023;1926.7398901148447;1928.1419768203295;1929.5851391950516;854.1245223645813;947.9857802132835;970.5486948568808;986.3539381704994;1023.7952409518126;14708.779368309484;18411;19485.707714384294;20089.698654520194;20390.388288351078;765.3685709289858;912.397817440486;953.6233187890745;1011.0294117646994;1049;10602.522886470128;10743.194260430499;10760.784784304271;10785.975332343414;10929.945350273358;532905;559964;562475;562933;601031;56419.71790141105;104972.47513762383;111103;111690.44154779174;115610;859.4155973937658;963.5230560872413;987.5062468765617;999.5901680311038;1005.2360206243162;17818.910905445908;17850;17954.640907182045;18072.36746713859;18206.271749129886;47268.7636561815;48082.79793005203;48912;49008.2648760276;49865.75067124641;52551.73724131508;68666.82917365055;69333.65333173302;69665.65167174132;69789;6651.866962660816;7603.88594171099;7607.771766846782;7640.8471830564185;7783.805404864924;9107.408018478778;11953.342566158944;12104.092193085378;12211.877881221075;12458.190217635825;9263.073692630684;10169.084782369622;10259.538320775433;10410.011048950337;10600.946995264974;9750.75623109428;10149.898501014895;10218.540165692413;10273.84589231177;10401.219908507044;9088.681896133603;10479.161667066464;10779.353238805697;10810.29733067348;10886.455677216265;7459.515131516434;7574.204708505527;7594.924050759421;7632.656530456032;7932.960335198518;8884.955575222082;10611.31026483307;10626.256162068581;10795.29830561011;10928.617498387519 12:58:36 INFO - PROCESS | 1949 | |3;mootools.html;1456.9708605827884;1580.5969477783167;1830.7070868661008;1973.5559499112692;1987.5031242189452;7836.568988705619;8429.072801991791;8619.999999999993;8790.824183516334;8794.988576313717;8585.613647385868;8600.61297241624;8644.56777161141;8694.21752042316;8697.782555436117;2040.9081591328352;2454.1042519480393;2480.1691433369842;2480.466699659573;2492.6011838105906;2441.3286346254745;2453.116877923946;2458.729539750626;2476.9752302477013;2491.9626205606933;2445.8287919845616;2469.061756532515;2477.9008839646394;2494.9875250623722;2501.4746903150362;2442.023190723707;2443.9144629937955;2455.3493324269084;2455.729869714348;2465.642481840132;2426.46617744096;2426.623873299641;2435.452023294762;2471.542764588557;2471.9011239550396;8822.294216462667;8838.469691818511;8870.822583548294;8874.86687699685;8877.378583499158;5343.893122137574;5467.371252305996;5489.807856724996;5510.063289240798;5540.722963851791;3539.7876127432437;3627.8004709741217;3628.1836586767768;3649.160693040589;3701.167237371597;927.5315965437478;1041.2971244410069;1043.8121138195122;1050.9842352364722;1072.2012100984816;11611.593594224161;11718.06255499558;11720.296782193096;11729.944305012505;11749.353785541793;4492.9775351123035;4623.12160689468;4806.879828004258;4855.708657480563;4903.117438861039;9938.652147174815;9993.350432221881;9996.800063998679;9997.400155990665;10007.949960250153;5399.190121481731;5423.484768946943;5480.698561579152;5490.450954904558;5499.120140777456;4418.7127836690515;4841.467438581753;4916.237983112624;4930.852074437701;4946.901061978812;3819.121602031493;3914.119323152325;3926.1362500249897;3935.330993731073;3969.543502497192;1297.0920355750823;1303.6349822049842;1313.0939651640338;1318.5780550224029;1341.6042267531102;901.4726385064679;1104.7293413113678;1140.3841925360377;1385.8336999559915;1390.2353705461956;6769.763058292936;7999.200079991954;8124.025116985999;8130.837383252302;8131;510.4793111026732;523.0715480022914;525.0994544356447;527.9551238144801;531.5906751801092;6017.308009578867;6090.20827292458;6092.45167934888;6121.938780612226;6122.346966319158;10249.74375640615;10666.413347265974;10676.572937082585;10710.08964238033;10715.249932504807;8992.8651070234;9844.458554779412;10449.529771160316;10512.26414151002;10608.310459820086;6893.827654308682;8143.267105960492;8262.339012878956;8315.501069935703;8348.081711011784;7876;7909.406794490551;7918.81217817332;7926.841463170589;8010;9180.6786762463;9328.580213890527;9441.103095205945;9453.196478299422;9471.71584852428;9580.23358131334;9721.465319407218;9812.65655702047;10075.891651918137;10201.693949181536;6837.008633747979;7222.855542889218;7464;7598.506097103671;7682.654280557276;8191.79520511992;8257.710980115668;8259.587020648823;8290.751277461444;8291.212334828182;7201.675924583511;7331.4867959244475;7358.227386124594;7494.5503269803985;7503.399728021855;7147.428205743632;7166.390856777024;7187.604681742554;7207.9639601801655;7212.206657267591;6621.900671489835;7406.925930740624;7654.425918056057;7666.271704188093;7673.002509673706;6792.049113124068;6873.553219040747;6956.617386043817;6963.582185068912;6995.195552511526;7023.473239506955;7066.823329416806;7098.822529436598;7116.928830711627;7118.679659415235 12:58:36 INFO - PROCESS | 1949 | |4;prototype.html;326.595022172506;328.0797363395675;331.75615922297123;335.6090154969461;342.318785616623;6727.360900714437;6755.223149337821;6758.932410675891;6775;6800.693968771405;6626.900596491057;6633.834154146149;6642.833929151773;6651;6749.865002699943;3925.5878132796074;4670.859874203779;4756.5243475652505;4905.950940490603;4976.402831660197;4385.188740083095;4516.864494065167;4865.270209468573;4906.803727850882;4914.311996320518;4832.202686556714;4839.395075615548;4843.39457567804;4859.562639362457;4861.319415281863;4860.416749990006;4895.339129217546;4898.902021959577;4902.65681402302;4905.975470122645;4199.7690127043;4207.221663992172;4209.663226941837;4220.32474804033;4227.8308867645255;6113.938860611382;6332.1135041094285;6420.5505614607;6433.131527243856;6433.9678301608665;5682.829515114553;5714.571407144481;5727.140928860705;5745.540356771448;5772.422757724236;5731.799387021434;7090.184628767706;7127.857442851114;7141.178764442104;7172.9641351793425;4584.7478388688605;4596.4254468191475;4596.49438561758;4607.746573938432;4609.654275929285;7514;7571.545707257527;7571.583562904038;7595.4683172177965;7614.124375696755;4412.448443944507;4515.187266292099;4522.45730512334;4601.723896566216;4652.906941861143;4067.28822456069;4677.742724150205;4708.646851486153;4715.151272770934;4724.929126063112;4530.6602004849765;5571.8885622288135;5587.413321601254;5601.5238704710555;5607.635503692247;7101.857962840714;7125.82185445368;7126.465515086389;7130.714771409189;7133.108361454818;1540.7303721848632;1586.7461206207183;1621.1326940087233;1640.8195098539152;1644.350481559777;1021.8211812932856;1029.3052189771875;1033.813913495578;1045.7124290820086;1045.9372437653765;6604.603723776589;6618.30507796684;6630.138082049302;6645.169353830771;6648.8670226595195;7350.852982940311;7402.925970740332;7408.148062972719;7421.960925470438;7455.0681164854395;6628.337166283333;6633.535652504375;6635.469162466991;6642.435392991553;6681.465482761368;3903.9264202344584;3916.5104361954754;3925.9018524537114;3946.3685810270217;3959.049828041307;7057.858842823115;7643.159252482223;7735.110462296795;7745.380369570421;7768.378529717609;7640.847183056308;7652.961735191399;7665.156832748393;7666.693332266758;7762.573058481725;7839.490433121829;7848.21517848222;7848.332891704269;7860.84278314419;7891.842163156704;7194.244604316471;7505.624718764149;7518.398528117847;7526;7554.962225188839;7321.963390183015;7325.926740732524;7326.926730732837;7379.8155046124275;7393.963030184815;7794.415418843496;7823.335016523659;7828.843423131391;7832.686692532463;7868.72459463916;3855.4216867470104;4679.508651591534;4705.529447055404;4712.293156026486;4720.527947205389;7127.322904324081;7350.228226036189;7416.8887466686965;7434.405247580073;7436.814079648052;7088.255733147946;7173.42612590981;7175.174854891754;7189.820254493679;7194.856102878018;7121.540084282813;7187.28127187298;7191.4246860250005;7203.351698347174;7203.423726102004;6911.654417279216;6980.685869136003;7003.7548685795755;7030.683619237249;7031.753888613874;6919.550229235084;7116.573005619679;7151.4636402269;7240.96379518099;7259.709611615476;5889.0283103287475;7041.26066763003;7067;7069.787906362817;7103.786886393416 12:58:36 INFO - PROCESS | 1949 | |5;yui.html;589.7257775134561;688.8932215506595;689.5724650716553;736.7716008037512;750.6997201119551;14908.254587270634;15078.170700611461;15100.622484437881;15112.546623601296;17438;15492.535223943272;16076.115813630246;16084.1957902105;16111.597210069755;16134.75797863033;736.4292673178276;903.7198468474777;925.949072800999;928.3176865004217;928.5496534180917;906.2568693671192;923.2752289452781;923.4320892651039;924.177482040984;925.8287216864901;944.4569372610742;947.5546493148244;954.3271993244746;956.115593076405;957.1577012229228;933.6125507914207;941.2846236860001;945.935822200025;949.539473355422;950.7052813627763;682.7678589279669;688.277308825736;701.4388489208612;706.7985624097159;709.3934685843581;15480.845191548053;15617;15654.765178522332;15703.214839257991;15733.37066517338;12428.13003089784;12516.06129540279;12522.248665080124;12635.305058221795;12780.488780448772;9991.450470224136;10076.445795481246;10136.087752102347;10143.239257055677;10906.127509799197;3424.383610950028;3556.5732112146447;3563.7861728296384;3613.9819300903328;3645.1616128290375;67959.8836104753;83878.58060709719;84507.5774621123;84829.99999999939;85649;8075.192480751878;9127.406718563272;9290.070992900792;9369.203617692572;9508.524573771421;16994.235259413355;20895.477613059797;20967.895160524404;20983.685244721342;21015.579688406146;7130.429565634737;7402.629868506661;7414.258574142543;7458.5151965122095;7523.435742319348;3998.620131087542;4035.959640403617;4069.1454794492897;4100.979495102505;4106.1992911382595;3558.1638314995957;3559.056849934769;3577.266660334625;3583.480395342661;3590.6588874056924;652.5953908576713;661.0744957060058;666.3969107957209;667.8497338098986;675.8749631318221;538.1282322637353;562.935262444824;565.9122835960433;567.1889198446179;577.5177726598338;7970.362371010306;8099.757007289791;8193.631286592117;8253.793655158548;8404.327653787683;515.2811827500616;559.1333433178638;563.3999790223481;571.1318795430922;588.4880154265816;3757.793321367351;3759.605241449663;3769;3814.6757525610633;3844.6732027777393;92080.07919920849;92643;92995.07004929999;93861;94526.52736736272;77225.84161237587;78134.60932695415;78639.60680196677;79008.02479938048;79362.6031869837;69043.96434053393;69139.65430172917;70146.64926675436;70234.64882675554;70445;7665.195154508696;7696.576688282198;7893.1317555070045;7987.960060199662;8002.359811215205;36443.63556364508;40611.796941015105;49106;49327.260091097945;50819.491805081474;47226.76386618045;62029.759404812554;63256.68371658112;66112.6694366525;67987;9511.714648560554;9803.362781419184;9874;10004.29969902129;10119.89880101219;10705.617799439297;10827.24209305341;10991.395473249047;11253.943730281297;11339.603113890975;10226.6420675276;10271.7432064196;10318.43248621333;10386.688399348031;10588.10001149911;10027.049066210673;10266.794664106825;10460.738481538023;10674.412907289863;10791.676249712522;8300;10030.398176109165;10044.347117437343;10117.89882101199;10325.9483702581;6716.529842910949;8843.292536596928;8994.50530220818;9061;9247.352685311964;8682.479051256945;8810.383273170817;8871;8966.237869781142;8987.775305617412 12:58:36 INFO - PROCESS | 1949 | __end_tp_report 12:58:36 INFO - PROCESS | 1949 | __start_cc_report 12:58:36 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,383 12:58:36 INFO - PROCESS | 1949 | __end_cc_report 12:58:36 INFO - PROCESS | 1949 | __startTimestamp1460059116762__endTimestamp 12:58:36 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | ------- Summary: start ------- 12:58:36 INFO - PROCESS | 1949 | Number of tests: 6 12:58:36 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | [#0] dojo.html Cycles:165 Average:5742.13 Median:5959.76 stddev:658.32 (11.0%) stddev-sans-first:620.45 12:58:36 INFO - PROCESS | 1949 | Values: 2865.4 3441.6 3447.8 3511.6 3535.2 4764.5 5731.8 5786.4 5791.9 5858.0 5665.2 5796.9 5852.3 5877.9 5891.2 5141.7 5191.7 5217.1 5263.7 5302.3 5284.9 5292.7 5321.5 5346.0 5391.1 5136.0 5143.0 5205.5 5256.6 5297.8 5224.7 5230.2 5237.8 5253.5 5292.0 5174.4 5198.9 5213.8 5229.9 5262.4 4697.7 5670.7 5691.7 5755.7 5764.9 5456.2 6197.4 6216.4 6224.6 6266.2 6246.3 6246.5 6250.0 6256.9 6281.8 5734.2 5860.1 5867.3 5931.8 5959.8 6293.9 6311.6 6313.8 6332.8 6340.4 5205.5 6063.5 6214.3 6247.7 6263.9 6175.6 6209.3 6252.1 6264.6 6265.5 6074.1 6153.4 6179.1 6230.4 6242.7 6138.7 6212.5 6229.1 6230.6 6240.7 4261.8 4780.5 4971.1 5014.9 5053.2 4416.6 4441.2 4460.6 4491.3 4497.4 5723.5 5814.0 5819.1 5861.8 5864.9 5207.3 6194.2 6217.4 6228.9 6233.9 5785.7 5850.8 5869.4 5901.3 5918.9 5388.8 5465.4 5468.3 5479.0 5517.6 6307.9 6381.4 6386.0 6389.7 6411.7 6236.3 6242.7 6244.3 6255.2 6257.6 6183.3 6317.2 6360.4 6376.8 6392.1 5031.4 6043.5 6236.9 6273.2 6275.6 6183.0 6214.1 6215.2 6235.2 6244.2 5867.3 6051.8 6096.4 6144.5 6233.4 5338.3 6083.7 6102.5 6125.2 6126.9 5855.4 5986.8 6010.7 6061.2 6064.3 6115.6 6212.5 6214.3 6216.4 6230.2 5913.3 6019.5 6080.8 6085.5 6132.5 12:58:36 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | [#1] ext.html Cycles:180 Average:60648.03 Median:37419.81 stddev:125794.54 (336.2%) stddev-sans-first:126066.19 12:58:36 INFO - PROCESS | 1949 | Values: 436.3 468.7 573.6 601.1 609.2 36214.8 36812.1 36849.0 36891.3 37005.1 38418.0 38824.8 38844.4 38942.8 39113.0 9255.9 9491.3 9504.3 9510.8 9515.5 9279.7 9389.8 9435.0 9479.7 9506.1 8404.4 9271.0 9489.1 9519.4 9549.9 9398.5 9399.7 9431.0 9447.4 9481.2 9344.6 9358.7 9465.0 9482.4 9500.6 36954.3 36964.0 37341.0 37498.6 37680.4 3121.1 3123.5 3293.3 3354.8 3451.5 27617.9 28213.0 28416.0 28766.4 28945.9 2578.6 2645.7 2746.9 2801.3 2865.2 393860.0 402724.0 404459.0 405822.0 409752.0 44649.1 63449.4 63838.0 64045.7 64051.7 43551.8 44299.0 44306.0 44427.1 44648.1 15314.8 15516.5 15575.8 15600.6 15609.2 12355.3 12445.9 12484.1 12507.0 12525.2 14034.8 14158.9 14187.4 14234.9 14383.9 6251.5 6294.4 6345.7 6362.5 6421.9 922.4 1007.6 1069.2 1096.9 1097.0 28104.7 28334.6 28745.7 28929.4 28942.4 963.4 1122.9 1155.0 1170.8 1211.0 14266.0 14401.0 14642.6 14680.0 14727.6 487683.0 519820.0 523977.0 525286.0 525768.0 55071.4 55258.0 55259.4 55564.2 56031.2 1428.5 1430.7 1487.2 1493.5 1494.6 28235.6 28555.9 28583.7 28881.4 28968.7 47357.0 47398.0 47550.3 47718.8 47724.3 489114.0 489296.1 492302.0 492353.0 493023.0 32567.0 42541.9 42663.1 43166.0 44239.0 42122.2 42384.7 43492.6 43531.6 43690.6 36345.1 36452.9 36900.7 36937.8 37009.8 35757.0 35830.6 36380.6 36646.3 36705.0 35315.1 35794.9 36036.5 36201.8 37558.0 25395.0 27350.0 32156.4 32942.5 33096.0 21210.8 21310.3 23425.6 23780.9 24615.1 12:58:36 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | [#2] jquery.html Cycles:180 Average:31538.15 Median:2265.19 stddev:93521.62 (4128.6%) stddev-sans-first:93754.57 12:58:36 INFO - PROCESS | 1949 | Values: 307.2 323.5 337.8 364.4 364.5 19082.5 19873.0 19876.9 20715.4 20784.5 11705.0 11909.3 12171.6 12189.7 12190.9 4713.8 5123.9 5269.1 5314.9 5363.8 4660.0 5669.9 5685.8 5704.5 5717.2 5408.7 5655.3 5807.6 5818.6 5825.4 5774.1 5829.5 5857.5 5869.3 5877.7 5621.9 5655.5 5665.4 5676.4 5686.2 13054.9 13381.7 13420.3 15920.6 23846.2 2169.3 2178.2 2207.0 2260.4 2632.9 9540.2 9629.0 9822.1 9949.3 9996.9 1733.1 1746.9 1752.2 1766.3 1795.2 99308.5 100061.0 101672.0 102366.0 102886.0 8762.5 11160.0 11208.0 11218.5 11285.2 13531.0 13552.9 13572.3 13734.3 13759.3 8445.5 8484.7 8526.1 8556.2 8605.1 8525.2 8536.6 8548.4 8578.7 8659.4 4165.9 4317.9 4381.1 4400.6 4402.2 1684.9 1882.6 1926.7 1928.1 1929.6 854.1 948.0 970.5 986.4 1023.8 14708.8 18411.0 19485.7 20089.7 20390.4 765.4 912.4 953.6 1011.0 1049.0 10602.5 10743.2 10760.8 10786.0 10929.9 532905.0 559964.0 562475.0 562933.0 601031.0 56419.7 104972.5 111103.0 111690.4 115610.0 859.4 963.5 987.5 999.6 1005.2 17818.9 17850.0 17954.6 18072.4 18206.3 47268.8 48082.8 48912.0 49008.3 49865.8 52551.7 68666.8 69333.7 69665.7 69789.0 6651.9 7603.9 7607.8 7640.8 7783.8 9107.4 11953.3 12104.1 12211.9 12458.2 9263.1 10169.1 10259.5 10410.0 10600.9 9750.8 10149.9 10218.5 10273.8 10401.2 9088.7 10479.2 10779.4 10810.3 10886.5 7459.5 7574.2 7594.9 7632.7 7933.0 8885.0 10611.3 10626.3 10795.3 10928.6 12:58:36 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | [#3] mootools.html Cycles:180 Average:5975.54 Median:5494.79 stddev:3151.39 (57.4%) stddev-sans-first:3141.93 12:58:36 INFO - PROCESS | 1949 | Values: 1457.0 1580.6 1830.7 1973.6 1987.5 7836.6 8429.1 8620.0 8790.8 8795.0 8585.6 8600.6 8644.6 8694.2 8697.8 2040.9 2454.1 2480.2 2480.5 2492.6 2441.3 2453.1 2458.7 2477.0 2492.0 2445.8 2469.1 2477.9 2495.0 2501.5 2442.0 2443.9 2455.3 2455.7 2465.6 2426.5 2426.6 2435.5 2471.5 2471.9 8822.3 8838.5 8870.8 8874.9 8877.4 5343.9 5467.4 5489.8 5510.1 5540.7 3539.8 3627.8 3628.2 3649.2 3701.2 927.5 1041.3 1043.8 1051.0 1072.2 11611.6 11718.1 11720.3 11729.9 11749.4 4493.0 4623.1 4806.9 4855.7 4903.1 9938.7 9993.4 9996.8 9997.4 10007.9 5399.2 5423.5 5480.7 5490.5 5499.1 4418.7 4841.5 4916.2 4930.9 4946.9 3819.1 3914.1 3926.1 3935.3 3969.5 1297.1 1303.6 1313.1 1318.6 1341.6 901.5 1104.7 1140.4 1385.8 1390.2 6769.8 7999.2 8124.0 8130.8 8131.0 510.5 523.1 525.1 528.0 531.6 6017.3 6090.2 6092.5 6121.9 6122.3 10249.7 10666.4 10676.6 10710.1 10715.2 8992.9 9844.5 10449.5 10512.3 10608.3 6893.8 8143.3 8262.3 8315.5 8348.1 7876.0 7909.4 7918.8 7926.8 8010.0 9180.7 9328.6 9441.1 9453.2 9471.7 9580.2 9721.5 9812.7 10075.9 10201.7 6837.0 7222.9 7464.0 7598.5 7682.7 8191.8 8257.7 8259.6 8290.8 8291.2 7201.7 7331.5 7358.2 7494.6 7503.4 7147.4 7166.4 7187.6 7208.0 7212.2 6621.9 7406.9 7654.4 7666.3 7673.0 6792.0 6873.6 6956.6 6963.6 6995.2 7023.5 7066.8 7098.8 7116.9 7118.7 12:58:36 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | [#4] prototype.html Cycles:180 Average:5833.71 Median:6642.63 stddev:1909.92 (28.8%) stddev-sans-first:1870.01 12:58:36 INFO - PROCESS | 1949 | Values: 326.6 328.1 331.8 335.6 342.3 6727.4 6755.2 6758.9 6775.0 6800.7 6626.9 6633.8 6642.8 6651.0 6749.9 3925.6 4670.9 4756.5 4906.0 4976.4 4385.2 4516.9 4865.3 4906.8 4914.3 4832.2 4839.4 4843.4 4859.6 4861.3 4860.4 4895.3 4898.9 4902.7 4906.0 4199.8 4207.2 4209.7 4220.3 4227.8 6113.9 6332.1 6420.6 6433.1 6434.0 5682.8 5714.6 5727.1 5745.5 5772.4 5731.8 7090.2 7127.9 7141.2 7173.0 4584.7 4596.4 4596.5 4607.7 4609.7 7514.0 7571.5 7571.6 7595.5 7614.1 4412.4 4515.2 4522.5 4601.7 4652.9 4067.3 4677.7 4708.6 4715.2 4724.9 4530.7 5571.9 5587.4 5601.5 5607.6 7101.9 7125.8 7126.5 7130.7 7133.1 1540.7 1586.7 1621.1 1640.8 1644.4 1021.8 1029.3 1033.8 1045.7 1045.9 6604.6 6618.3 6630.1 6645.2 6648.9 7350.9 7402.9 7408.1 7422.0 7455.1 6628.3 6633.5 6635.5 6642.4 6681.5 3903.9 3916.5 3925.9 3946.4 3959.0 7057.9 7643.2 7735.1 7745.4 7768.4 7640.8 7653.0 7665.2 7666.7 7762.6 7839.5 7848.2 7848.3 7860.8 7891.8 7194.2 7505.6 7518.4 7526.0 7555.0 7322.0 7325.9 7326.9 7379.8 7394.0 7794.4 7823.3 7828.8 7832.7 7868.7 3855.4 4679.5 4705.5 4712.3 4720.5 7127.3 7350.2 7416.9 7434.4 7436.8 7088.3 7173.4 7175.2 7189.8 7194.9 7121.5 7187.3 7191.4 7203.4 7203.4 6911.7 6980.7 7003.8 7030.7 7031.8 6919.6 7116.6 7151.5 7241.0 7259.7 5889.0 7041.3 7067.0 7069.8 7103.8 12:58:36 INFO - PROCESS | 1949 | 12:58:36 INFO - PROCESS | 1949 | [#5] yui.html Cycles:180 Average:17856.52 Median:33386.87 stddev:25473.76 (76.3%) stddev-sans-first:25512.23 12:58:36 INFO - PROCESS | 1949 | Values: 589.7 688.9 689.6 736.8 750.7 14908.3 15078.2 15100.6 15112.5 17438.0 15492.5 16076.1 16084.2 16111.6 16134.8 736.4 903.7 925.9 928.3 928.5 906.3 923.3 923.4 924.2 925.8 944.5 947.6 954.3 956.1 957.2 933.6 941.3 945.9 949.5 950.7 682.8 688.3 701.4 706.8 709.4 15480.8 15617.0 15654.8 15703.2 15733.4 12428.1 12516.1 12522.2 12635.3 12780.5 9991.5 10076.4 10136.1 10143.2 10906.1 3424.4 3556.6 3563.8 3614.0 3645.2 67959.9 83878.6 84507.6 84830.0 85649.0 8075.2 9127.4 9290.1 9369.2 9508.5 16994.2 20895.5 20967.9 20983.7 21015.6 7130.4 7402.6 7414.3 7458.5 7523.4 3998.6 4036.0 4069.1 4101.0 4106.2 3558.2 3559.1 3577.3 3583.5 3590.7 652.6 661.1 666.4 667.8 675.9 538.1 562.9 565.9 567.2 577.5 7970.4 8099.8 8193.6 8253.8 8404.3 515.3 559.1 563.4 571.1 588.5 3757.8 3759.6 3769.0 3814.7 3844.7 92080.1 92643.0 92995.1 93861.0 94526.5 77225.8 78134.6 78639.6 79008.0 79362.6 69044.0 69139.7 70146.6 70234.6 70445.0 7665.2 7696.6 7893.1 7988.0 8002.4 36443.6 40611.8 49106.0 49327.3 50819.5 47226.8 62029.8 63256.7 66112.7 67987.0 9511.7 9803.4 9874.0 10004.3 10119.9 10705.6 10827.2 10991.4 11253.9 11339.6 10226.6 10271.7 10318.4 10386.7 10588.1 10027.0 10266.8 10460.7 10674.4 10791.7 8300.0 10030.4 10044.3 10117.9 10325.9 6716.5 8843.3 8994.5 9061.0 9247.4 8682.5 8810.4 8871.0 8966.2 8987.8 12:58:36 INFO - PROCESS | 1949 | -------- Summary: end -------- 12:58:36 INFO - PROCESS | 1949 | 12:58:37 INFO - TEST-INFO | 1949: exit 0 12:58:37 INFO - TEST-OK | dromaeo_css | took 1111536ms 12:58:37 INFO - TEST-START | kraken 12:58:37 INFO - operating with platform_type : mac_ 12:58:37 INFO - Initialising browser for kraken test... 12:58:37 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp9p4hUs/profile http://localhost:49648/getInfo.html) 12:58:39 INFO - PROCESS | 1953 | 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] 12:58:40 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 12:58:40 INFO - PROCESS | 1953 | colorDepth:24 12:58:40 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 12:58:40 INFO - PROCESS | 1953 | __metrics 12:58:40 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 12:58:40 INFO - TEST-INFO | 1953: exit 0 12:58:40 INFO - Browser initialized. 12:58:40 INFO - Running cycle 1/1 for kraken test... 12:58:40 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmp9p4hUs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:52 INFO - PROCESS | 1956 | RSS: Main: 247336960 12:58:52 INFO - PROCESS | 1956 | 12:58:55 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49648/tests/kraken/driver.html?testName=audio-beat-detection) 12:58:56 INFO - PROCESS | 1956 | RSS: Main: 259588096 12:58:56 INFO - PROCESS | 1956 | 12:58:58 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49648/tests/kraken/driver.html?testName=audio-dft) 12:58:59 INFO - PROCESS | 1956 | RSS: Main: 268406784 12:58:59 INFO - PROCESS | 1956 | 12:59:02 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49648/tests/kraken/driver.html?testName=audio-fft) 12:59:03 INFO - PROCESS | 1956 | RSS: Main: 271798272 12:59:03 INFO - PROCESS | 1956 | 12:59:05 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49648/tests/kraken/driver.html?testName=audio-oscillator) 12:59:05 INFO - PROCESS | 1956 | RSS: Main: 273088512 12:59:05 INFO - PROCESS | 1956 | 12:59:08 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:59:08 INFO - PROCESS | 1956 | RSS: Main: 274857984 12:59:08 INFO - PROCESS | 1956 | 12:59:11 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49648/tests/kraken/driver.html?testName=imaging-darkroom) 12:59:12 INFO - PROCESS | 1956 | RSS: Main: 274825216 12:59:12 INFO - PROCESS | 1956 | 12:59:15 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49648/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:15 INFO - PROCESS | 1956 | RSS: Main: 274595840 12:59:15 INFO - PROCESS | 1956 | 12:59:18 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49648/tests/kraken/driver.html?testName=json-parse-financial) 12:59:19 INFO - PROCESS | 1956 | RSS: Main: 274612224 12:59:19 INFO - PROCESS | 1956 | 12:59:20 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:21 INFO - PROCESS | 1956 | RSS: Main: 274366464 12:59:21 INFO - PROCESS | 1956 | 12:59:23 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:24 INFO - PROCESS | 1956 | RSS: Main: 274653184 12:59:24 INFO - PROCESS | 1956 | 12:59:26 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:59:26 INFO - PROCESS | 1956 | RSS: Main: 274710528 12:59:26 INFO - PROCESS | 1956 | 12:59:29 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:59:30 INFO - PROCESS | 1956 | RSS: Main: 274968576 12:59:30 INFO - PROCESS | 1956 | 12:59:32 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:59:33 INFO - PROCESS | 1956 | RSS: Main: 274784256 12:59:33 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49648/tests/kraken/driver.html?testName=ai-astar) 12:59:35 INFO - PROCESS | 1956 | RSS: Main: 276566016 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | __start_tp_report 12:59:35 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 12:59:35 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 12:59:35 INFO - PROCESS | 1956 | |i|pagename|runs| 12:59:35 INFO - PROCESS | 1956 | |0;ai-astar;116;110;117;115;115;129;114;115;116;115 12:59:35 INFO - PROCESS | 1956 | |1;audio-beat-detection;153;124;144;162;127;175;137;152;198;156 12:59:35 INFO - PROCESS | 1956 | |2;audio-dft;200;202;198;210;212;203;194;202;200;200 12:59:35 INFO - PROCESS | 1956 | |3;audio-fft;57;60;71;79;74;114;56;54;76;61 12:59:35 INFO - PROCESS | 1956 | |4;audio-oscillator;86;102;166;114;80;81;118;80;81;120 12:59:35 INFO - PROCESS | 1956 | |5;imaging-gaussian-blur;92;88;90;88;90;88;90;89;92;87 12:59:35 INFO - PROCESS | 1956 | |6;imaging-darkroom;96;141;149;97;118;113;97;98;105;97 12:59:35 INFO - PROCESS | 1956 | |7;imaging-desaturate;96;95;90;93;122;140;91;92;117;93 12:59:35 INFO - PROCESS | 1956 | |8;json-parse-financial;58;58;55;56;68;85;82;63;60;54 12:59:35 INFO - PROCESS | 1956 | |9;json-stringify-tinderbox;66;75;90;95;76;81;86;59;88;97 12:59:35 INFO - PROCESS | 1956 | |10;stanford-crypto-aes;86;85;85;84;91;89;84;87;88;91 12:59:35 INFO - PROCESS | 1956 | |11;stanford-crypto-ccm;126;136;137;135;138;125;111;128;151;142 12:59:35 INFO - PROCESS | 1956 | |12;stanford-crypto-pbkdf2;145;143;159;172;140;158;131;158;126;164 12:59:35 INFO - PROCESS | 1956 | |13;stanford-crypto-sha256-iterative;72;69;68;72;85;83;68;67;72;93 12:59:35 INFO - PROCESS | 1956 | __end_tp_report 12:59:35 INFO - PROCESS | 1956 | __start_cc_report 12:59:35 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,987 12:59:35 INFO - PROCESS | 1956 | __end_cc_report 12:59:35 INFO - PROCESS | 1956 | __startTimestamp1460059175404__endTimestamp 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | ------- Summary: start ------- 12:59:35 INFO - PROCESS | 1956 | Number of tests: 14 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#0] ai-astar Cycles:10 Average:116.20 Median:115.50 stddev:4.87 (4.2%) stddev-sans-first:5.17 12:59:35 INFO - PROCESS | 1956 | Values: 116.0 110.0 117.0 115.0 115.0 129.0 114.0 115.0 116.0 115.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:154.50 stddev:22.25 (14.4%) stddev-sans-first:23.59 12:59:35 INFO - PROCESS | 1956 | Values: 153.0 124.0 144.0 162.0 127.0 175.0 137.0 152.0 198.0 156.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#2] audio-dft Cycles:10 Average:202.10 Median:202.00 stddev:5.34 (2.6%) stddev-sans-first:5.61 12:59:35 INFO - PROCESS | 1956 | Values: 200.0 202.0 198.0 210.0 212.0 203.0 194.0 202.0 200.0 200.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#3] audio-fft Cycles:10 Average:70.20 Median:66.00 stddev:17.86 (27.1%) stddev-sans-first:18.30 12:59:35 INFO - PROCESS | 1956 | Values: 57.0 60.0 71.0 79.0 74.0 114.0 56.0 54.0 76.0 61.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:80.00 stddev:27.73 (34.7%) stddev-sans-first:28.74 12:59:35 INFO - PROCESS | 1956 | Values: 86.0 102.0 166.0 114.0 80.0 81.0 118.0 80.0 81.0 120.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:90.00 stddev:1.71 (1.9%) stddev-sans-first:1.54 12:59:35 INFO - PROCESS | 1956 | Values: 92.0 88.0 90.0 88.0 90.0 88.0 90.0 89.0 92.0 87.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#6] imaging-darkroom Cycles:10 Average:111.10 Median:96.50 stddev:19.48 (20.2%) stddev-sans-first:19.88 12:59:35 INFO - PROCESS | 1956 | Values: 96.0 141.0 149.0 97.0 118.0 113.0 97.0 98.0 105.0 97.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:92.50 stddev:17.23 (18.6%) stddev-sans-first:18.10 12:59:35 INFO - PROCESS | 1956 | Values: 96.0 95.0 90.0 93.0 122.0 140.0 91.0 92.0 117.0 93.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:61.50 stddev:11.13 (18.1%) stddev-sans-first:11.60 12:59:35 INFO - PROCESS | 1956 | Values: 58.0 58.0 55.0 56.0 68.0 85.0 82.0 63.0 60.0 54.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:81.30 Median:87.00 stddev:12.37 (14.2%) stddev-sans-first:11.81 12:59:35 INFO - PROCESS | 1956 | Values: 66.0 75.0 90.0 95.0 76.0 81.0 86.0 59.0 88.0 97.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.50 stddev:2.67 (3.0%) stddev-sans-first:2.80 12:59:35 INFO - PROCESS | 1956 | Values: 86.0 85.0 85.0 84.0 91.0 89.0 84.0 87.0 88.0 91.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:136.50 stddev:10.96 (8.0%) stddev-sans-first:11.34 12:59:35 INFO - PROCESS | 1956 | Values: 126.0 136.0 137.0 135.0 138.0 125.0 111.0 128.0 151.0 142.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:158.00 stddev:14.90 (9.4%) stddev-sans-first:15.71 12:59:35 INFO - PROCESS | 1956 | Values: 145.0 143.0 159.0 172.0 140.0 158.0 131.0 158.0 126.0 164.0 12:59:35 INFO - PROCESS | 1956 | 12:59:35 INFO - PROCESS | 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:72.00 stddev:8.90 (12.4%) stddev-sans-first:9.38 12:59:35 INFO - PROCESS | 1956 | Values: 72.0 69.0 68.0 72.0 85.0 83.0 68.0 67.0 72.0 93.0 12:59:35 INFO - PROCESS | 1956 | -------- Summary: end -------- 12:59:35 INFO - PROCESS | 1956 | 12:59:36 INFO - TEST-INFO | 1956: exit 0 12:59:36 INFO - TEST-OK | kraken | took 58868ms 12:59:36 INFO - SUITE-END | took 1170s 12:59:36 INFO - Completed test suite (00:19:30) 12:59:36 INFO - javascript benchmark 12:59:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2865.412590418963, 3441.6386279440667, 3447.7586568940173, 3511.648835116487, 3535.186907011387, 4764.45208800988, 5731.770729170833, 5786.363500014995, 5791.855203619901, 5857.974854400484, 5665.150227465882, 5796.913046304308, 5852.326982397026, 5877.85305367365, 5891.234139561861, 5141.742912854361, 5191.662541934781, 5217.139172036609, 5263.684178949256, 5302.257683924254, 5284.947150528503, 5292.682439053669, 5321.467853214667, 5345.973270133644, 5391.083515802323, 5136.0, 5143.0, 5205.531502164786, 5256.55319297862, 5297.841064768044, 5224.712640804754, 5230.163173892197, 5237.764300606482, 5253.474652534755, 5292.047431462335, 5174.404943431478, 5198.870028249286, 5213.765380557884, 5229.869253268661, 5262.394824595182, 4697.741624210667, 5670.716464176775, 5691.743871525791, 5755.68343741094, 5764.8847023059725, 5456.208849716809, 6197.411245931629, 6216.409441103088, 6224.595401298946, 6266.185395898549, 6246.250449946036, 6246.500279977591, 6250.0, 6256.873762722708, 6281.775053864499, 5734.16854556087, 5860.091685788667, 5867.2959244890035, 5931.762729490815, 5959.761609535657, 6293.937060629427, 6311.589746666452, 6313.779017734358, 6332.778352757631, 6340.4293613575, 5205.47945205484, 6063.484603808637, 6214.2542894852, 6247.718852651642, 6263.874722505524, 6175.62946223228, 6209.316975132731, 6252.062190671436, 6264.561480696308, 6265.530085243534, 6074.119252708332, 6153.384661533811, 6179.134921111048, 6230.408111229426, 6242.719077641517, 6138.723757430837, 6212.47193988507, 6229.127922090911, 6230.56386052981, 6240.719167637377, 4261.808218630169, 4780.521947805191, 4971.105201063771, 5014.949850501521, 5053.242013697901, 4416.646668266531, 4441.244988351988, 4460.620847228022, 4491.30384790358, 4497.437820272466, 5723.456271654186, 5814.040683287295, 5819.127130930309, 5861.794837180678, 5864.882702345929, 5207.270982062514, 6194.225721784777, 6217.409346112203, 6228.937710622836, 6233.875322493524, 5785.710714464344, 5850.831580200843, 5869.442402971711, 5901.321348044944, 5918.911216331759, 5388.838334849961, 5465.398806131322, 5468.316460442445, 5479.0, 5517.61376703635, 6307.9369206308265, 6381.3937675920715, 6386.010168423994, 6389.744410223539, 6411.6794160290865, 6236.282827474898, 6242.719077641608, 6244.344343843831, 6255.218097737783, 6257.624542527463, 6183.319834818077, 6317.241930968129, 6360.363963603602, 6376.840578985562, 6392.073149393219, 5031.371078615173, 6043.456088952015, 6236.875262494634, 6273.153124328157, 6275.5607107503865, 6183.0, 6214.130021797043, 6215.192025036717, 6235.189425374672, 6244.188255526934, 5867.325257595431, 6051.818445446644, 6096.375503402397, 6144.494598823317, 6233.438990490878, 5338.3060202173465, 6083.66539840313, 6102.489251635809, 6125.204929265209, 6126.886289059745, 5855.414458554111, 5986.760529578943, 6010.669413182142, 6061.212042434456, 6064.272287325549, 6115.571909966259, 6212.502999759918, 6214.25428948529, 6216.378362163748, 6230.15892854477, 5913.2608423947, 6019.51843852482, 6080.817575472743, 6085.4523092921845, 6132.478739307209], "value": 5701.32480207121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.27795997623946, 468.7375069960822, 573.6300086444244, 601.1103566721255, 609.2201981463725, 36214.83529394121, 36812.07969800756, 36849.0, 36891.26217475652, 37005.074873128186, 38418.039549011286, 38824.805875970655, 38844.41733373995, 38942.83171504852, 39113.0, 9255.861162082558, 9491.335606507548, 9504.334696571243, 9510.80978380432, 9515.476648784314, 9279.721608351727, 9389.76525586859, 9434.952825235865, 9479.715608531755, 9506.096920792514, 8404.41169118162, 9271.0, 9489.098535639103, 9519.381240219398, 9549.85675214869, 9398.530073496366, 9399.671011514598, 9431.0, 9447.385919915252, 9481.194098501635, 9344.626214951393, 9358.672446464341, 9465.0, 9482.38364506305, 9500.619975200983, 36954.26091478182, 36964.0, 37341.0, 37498.625013749785, 37680.43479347812, 3121.1416860363584, 3123.46901026826, 3293.2590167212425, 3354.815485148316, 3451.4822776583715, 27617.861910690317, 28213.0, 28416.0, 28766.424671506662, 28945.85527072372, 2578.561644520436, 2645.7486538778785, 2746.945061098767, 2801.29967508123, 2865.1834227245135, 393860.0, 402724.0, 404459.0, 405821.9708901466, 409752.0, 44649.10701785946, 63449.365506344344, 63838.0, 64045.679771601775, 64051.679741600994, 43551.782241089226, 44299.0, 44306.0, 44427.11145777066, 44648.107037859714, 15314.846851531565, 15516.534503964898, 15575.76636350433, 15600.609984750245, 15609.21953902323, 12355.25868447896, 12445.875541244654, 12484.063695222894, 12507.0, 12525.185862918881, 14034.789478157836, 14158.929205354114, 14187.361568729431, 14234.861211103087, 14383.928080359532, 6251.468625166912, 6294.433500984934, 6345.650989195638, 6362.522810789209, 6421.871562568723, 922.4419226368085, 1007.5818535307765, 1069.2248120112856, 1096.8848270931437, 1097.0, 28104.71895281021, 28334.574981375295, 28745.71254287472, 28929.42141157165, 28942.421151577273, 963.4363897120123, 1122.8820973797797, 1154.9538018479334, 1170.8185231289165, 1210.9576164834189, 14266.001379903308, 14401.0, 14642.560723178321, 14680.04579702316, 14727.55817325482, 487683.0, 519820.0, 523977.0, 525286.0, 525768.0, 55071.449285506635, 55258.0, 55259.44740552623, 55564.16653750197, 56031.159532607046, 1428.5428662828003, 1430.6637940084072, 1487.174618086972, 1493.529538195465, 1494.6487575419767, 28235.57646635261, 28555.857220713762, 28583.714162858938, 28881.42237155203, 28968.7103128966, 47357.0, 47398.0, 47550.28674569954, 47718.761406192745, 47724.284135738686, 489114.0, 489296.10703892505, 492302.0, 492353.0, 493023.0, 32567.0, 42541.8995798881, 42663.146737065705, 43166.0, 44239.0, 42122.157556849306, 42384.7284581463, 43492.56507434885, 43531.56468435275, 43690.56309436865, 36345.09137271589, 36452.90641280766, 36900.70847520324, 36937.81531092327, 37009.81495092507, 35757.0, 35830.56677732861, 36380.63619363772, 36646.26707465889, 36705.0, 35315.11712207215, 35794.92615221548, 36036.45945310875, 36201.818990904874, 37558.0, 25395.0, 27350.0, 32156.356872862878, 32942.50586241256, 33096.0, 21210.787892120883, 21310.254141104986, 23425.648615271126, 23780.88109559441, 24615.13847015346], "value": 18838.52040282408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.20280871139386, 323.46628063694914, 337.7957581222939, 364.3841907176871, 364.50427418710547, 19082.522936926565, 19873.0, 19876.90061549692, 20715.37853864383, 20784.48038799031, 11705.005074568651, 11909.285442873434, 12171.57399491018, 12189.695257618563, 12190.878091219107, 4713.7643117844145, 5123.923141152885, 5269.104252277103, 5314.883874386364, 5363.839084827442, 4659.976700116495, 5669.886602267952, 5685.829425117233, 5704.515116215127, 5717.171010203518, 5408.675479471224, 5655.349634792011, 5807.593468457209, 5818.5636077294375, 5825.388334224909, 5774.105013722879, 5829.475347218749, 5857.531397488212, 5869.266341707286, 5877.70611469427, 5621.943780562183, 5655.519280861132, 5665.433456654343, 5676.375598684142, 5686.1755045518585, 13054.934725326408, 13381.66545836352, 13420.328983550784, 15920.56714895665, 23846.165384211643, 2169.349195241421, 2178.237616834095, 2207.0, 2260.3783959411294, 2632.9205025939464, 9540.236781057498, 9629.0, 9822.116009559173, 9949.30354875159, 9996.90003099967, 1733.098788629918, 1746.8602511799027, 1752.229019231534, 1766.3199668127734, 1795.1562765500194, 99308.50345748298, 100061.0, 101671.99999999926, 102366.0, 102886.0, 8762.518061506551, 11159.995600395841, 11208.047315978232, 11218.495167717472, 11285.153613479022, 13531.0, 13552.86447135516, 13572.321383930765, 13734.313284335944, 13759.312034398241, 8445.493270403795, 8484.703035393732, 8526.10475900034, 8556.18716221958, 8605.13948605147, 8525.232729054414, 8536.573171341408, 8548.444351117158, 8578.742637720878, 8659.350548708871, 4165.875023749292, 4317.870463886088, 4381.1237752449, 4400.581944715247, 4402.229609818269, 1684.89890606564, 1882.6328865871023, 1926.7398901148447, 1928.1419768203295, 1929.5851391950516, 854.1245223645813, 947.9857802132835, 970.5486948568808, 986.3539381704994, 1023.7952409518126, 14708.779368309484, 18411.0, 19485.707714384294, 20089.698654520194, 20390.388288351078, 765.3685709289858, 912.397817440486, 953.6233187890745, 1011.0294117646994, 1049.0, 10602.522886470128, 10743.194260430499, 10760.784784304271, 10785.975332343414, 10929.945350273358, 532905.0, 559964.0, 562475.0, 562933.0, 601031.0, 56419.71790141105, 104972.47513762383, 111103.0, 111690.44154779174, 115610.0, 859.4155973937658, 963.5230560872413, 987.5062468765617, 999.5901680311038, 1005.2360206243162, 17818.910905445908, 17850.0, 17954.640907182045, 18072.36746713859, 18206.271749129886, 47268.7636561815, 48082.79793005203, 48912.0, 49008.2648760276, 49865.75067124641, 52551.73724131508, 68666.82917365055, 69333.65333173302, 69665.65167174132, 69789.0, 6651.866962660816, 7603.88594171099, 7607.771766846782, 7640.8471830564185, 7783.805404864924, 9107.408018478778, 11953.342566158944, 12104.092193085378, 12211.877881221075, 12458.190217635825, 9263.073692630684, 10169.084782369622, 10259.538320775433, 10410.011048950337, 10600.946995264974, 9750.75623109428, 10149.898501014895, 10218.540165692413, 10273.84589231177, 10401.219908507044, 9088.681896133603, 10479.161667066464, 10779.353238805697, 10810.29733067348, 10886.455677216265, 7459.515131516434, 7574.204708505527, 7594.924050759421, 7632.656530456032, 7932.960335198518, 8884.955575222082, 10611.31026483307, 10626.256162068581, 10795.29830561011, 10928.617498387519], "value": 8799.19289734199, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.9708605827884, 1580.5969477783167, 1830.7070868661008, 1973.5559499112692, 1987.5031242189452, 7836.568988705619, 8429.072801991791, 8619.999999999993, 8790.824183516334, 8794.988576313717, 8585.613647385868, 8600.61297241624, 8644.56777161141, 8694.21752042316, 8697.782555436117, 2040.9081591328352, 2454.1042519480393, 2480.1691433369842, 2480.466699659573, 2492.6011838105906, 2441.3286346254745, 2453.116877923946, 2458.729539750626, 2476.9752302477013, 2491.9626205606933, 2445.8287919845616, 2469.061756532515, 2477.9008839646394, 2494.9875250623722, 2501.4746903150362, 2442.023190723707, 2443.9144629937955, 2455.3493324269084, 2455.729869714348, 2465.642481840132, 2426.46617744096, 2426.623873299641, 2435.452023294762, 2471.542764588557, 2471.9011239550396, 8822.294216462667, 8838.469691818511, 8870.822583548294, 8874.86687699685, 8877.378583499158, 5343.893122137574, 5467.371252305996, 5489.807856724996, 5510.063289240798, 5540.722963851791, 3539.7876127432437, 3627.8004709741217, 3628.1836586767768, 3649.160693040589, 3701.167237371597, 927.5315965437478, 1041.2971244410069, 1043.8121138195122, 1050.9842352364722, 1072.2012100984816, 11611.593594224161, 11718.06255499558, 11720.296782193096, 11729.944305012505, 11749.353785541793, 4492.9775351123035, 4623.12160689468, 4806.879828004258, 4855.708657480563, 4903.117438861039, 9938.652147174815, 9993.350432221881, 9996.800063998679, 9997.400155990665, 10007.949960250153, 5399.190121481731, 5423.484768946943, 5480.698561579152, 5490.450954904558, 5499.120140777456, 4418.7127836690515, 4841.467438581753, 4916.237983112624, 4930.852074437701, 4946.901061978812, 3819.121602031493, 3914.119323152325, 3926.1362500249897, 3935.330993731073, 3969.543502497192, 1297.0920355750823, 1303.6349822049842, 1313.0939651640338, 1318.5780550224029, 1341.6042267531102, 901.4726385064679, 1104.7293413113678, 1140.3841925360377, 1385.8336999559915, 1390.2353705461956, 6769.763058292936, 7999.200079991954, 8124.025116985999, 8130.837383252302, 8131.0, 510.4793111026732, 523.0715480022914, 525.0994544356447, 527.9551238144801, 531.5906751801092, 6017.308009578867, 6090.20827292458, 6092.45167934888, 6121.938780612226, 6122.346966319158, 10249.74375640615, 10666.413347265974, 10676.572937082585, 10710.08964238033, 10715.249932504807, 8992.8651070234, 9844.458554779412, 10449.529771160316, 10512.26414151002, 10608.310459820086, 6893.827654308682, 8143.267105960492, 8262.339012878956, 8315.501069935703, 8348.081711011784, 7876.0, 7909.406794490551, 7918.81217817332, 7926.841463170589, 8010.0, 9180.6786762463, 9328.580213890527, 9441.103095205945, 9453.196478299422, 9471.71584852428, 9580.23358131334, 9721.465319407218, 9812.65655702047, 10075.891651918137, 10201.693949181536, 6837.008633747979, 7222.855542889218, 7464.0, 7598.506097103671, 7682.654280557276, 8191.79520511992, 8257.710980115668, 8259.587020648823, 8290.751277461444, 8291.212334828182, 7201.675924583511, 7331.4867959244475, 7358.227386124594, 7494.5503269803985, 7503.399728021855, 7147.428205743632, 7166.390856777024, 7187.604681742554, 7207.9639601801655, 7212.206657267591, 6621.900671489835, 7406.925930740624, 7654.425918056057, 7666.271704188093, 7673.002509673706, 6792.049113124068, 6873.553219040747, 6956.617386043817, 6963.582185068912, 6995.195552511526, 7023.473239506955, 7066.823329416806, 7098.822529436598, 7116.928830711627, 7118.679659415235], "value": 4799.6334237569135, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.595022172506, 328.0797363395675, 331.75615922297123, 335.6090154969461, 342.318785616623, 6727.360900714437, 6755.223149337821, 6758.932410675891, 6775.0, 6800.693968771405, 6626.900596491057, 6633.834154146149, 6642.833929151773, 6651.0, 6749.865002699943, 3925.5878132796074, 4670.859874203779, 4756.5243475652505, 4905.950940490603, 4976.402831660197, 4385.188740083095, 4516.864494065167, 4865.270209468573, 4906.803727850882, 4914.311996320518, 4832.202686556714, 4839.395075615548, 4843.39457567804, 4859.562639362457, 4861.319415281863, 4860.416749990006, 4895.339129217546, 4898.902021959577, 4902.65681402302, 4905.975470122645, 4199.7690127043, 4207.221663992172, 4209.663226941837, 4220.32474804033, 4227.8308867645255, 6113.938860611382, 6332.1135041094285, 6420.5505614607, 6433.131527243856, 6433.9678301608665, 5682.829515114553, 5714.571407144481, 5727.140928860705, 5745.540356771448, 5772.422757724236, 5731.799387021434, 7090.184628767706, 7127.857442851114, 7141.178764442104, 7172.9641351793425, 4584.7478388688605, 4596.4254468191475, 4596.49438561758, 4607.746573938432, 4609.654275929285, 7514.0, 7571.545707257527, 7571.583562904038, 7595.4683172177965, 7614.124375696755, 4412.448443944507, 4515.187266292099, 4522.45730512334, 4601.723896566216, 4652.906941861143, 4067.28822456069, 4677.742724150205, 4708.646851486153, 4715.151272770934, 4724.929126063112, 4530.6602004849765, 5571.8885622288135, 5587.413321601254, 5601.5238704710555, 5607.635503692247, 7101.857962840714, 7125.82185445368, 7126.465515086389, 7130.714771409189, 7133.108361454818, 1540.7303721848632, 1586.7461206207183, 1621.1326940087233, 1640.8195098539152, 1644.350481559777, 1021.8211812932856, 1029.3052189771875, 1033.813913495578, 1045.7124290820086, 1045.9372437653765, 6604.603723776589, 6618.30507796684, 6630.138082049302, 6645.169353830771, 6648.8670226595195, 7350.852982940311, 7402.925970740332, 7408.148062972719, 7421.960925470438, 7455.0681164854395, 6628.337166283333, 6633.535652504375, 6635.469162466991, 6642.435392991553, 6681.465482761368, 3903.9264202344584, 3916.5104361954754, 3925.9018524537114, 3946.3685810270217, 3959.049828041307, 7057.858842823115, 7643.159252482223, 7735.110462296795, 7745.380369570421, 7768.378529717609, 7640.847183056308, 7652.961735191399, 7665.156832748393, 7666.693332266758, 7762.573058481725, 7839.490433121829, 7848.21517848222, 7848.332891704269, 7860.84278314419, 7891.842163156704, 7194.244604316471, 7505.624718764149, 7518.398528117847, 7526.0, 7554.962225188839, 7321.963390183015, 7325.926740732524, 7326.926730732837, 7379.8155046124275, 7393.963030184815, 7794.415418843496, 7823.335016523659, 7828.843423131391, 7832.686692532463, 7868.72459463916, 3855.4216867470104, 4679.508651591534, 4705.529447055404, 4712.293156026486, 4720.527947205389, 7127.322904324081, 7350.228226036189, 7416.8887466686965, 7434.405247580073, 7436.814079648052, 7088.255733147946, 7173.42612590981, 7175.174854891754, 7189.820254493679, 7194.856102878018, 7121.540084282813, 7187.28127187298, 7191.4246860250005, 7203.351698347174, 7203.423726102004, 6911.654417279216, 6980.685869136003, 7003.7548685795755, 7030.683619237249, 7031.753888613874, 6919.550229235084, 7116.573005619679, 7151.4636402269, 7240.96379518099, 7259.709611615476, 5889.0283103287475, 7041.26066763003, 7067.0, 7069.787906362817, 7103.786886393416], "value": 5190.472153631578, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.7257775134561, 688.8932215506595, 689.5724650716553, 736.7716008037512, 750.6997201119551, 14908.254587270634, 15078.170700611461, 15100.622484437881, 15112.546623601296, 17438.0, 15492.535223943272, 16076.115813630246, 16084.1957902105, 16111.597210069755, 16134.75797863033, 736.4292673178276, 903.7198468474777, 925.949072800999, 928.3176865004217, 928.5496534180917, 906.2568693671192, 923.2752289452781, 923.4320892651039, 924.177482040984, 925.8287216864901, 944.4569372610742, 947.5546493148244, 954.3271993244746, 956.115593076405, 957.1577012229228, 933.6125507914207, 941.2846236860001, 945.935822200025, 949.539473355422, 950.7052813627763, 682.7678589279669, 688.277308825736, 701.4388489208612, 706.7985624097159, 709.3934685843581, 15480.845191548053, 15617.0, 15654.765178522332, 15703.214839257991, 15733.37066517338, 12428.13003089784, 12516.06129540279, 12522.248665080124, 12635.305058221795, 12780.488780448772, 9991.450470224136, 10076.445795481246, 10136.087752102347, 10143.239257055677, 10906.127509799197, 3424.383610950028, 3556.5732112146447, 3563.7861728296384, 3613.9819300903328, 3645.1616128290375, 67959.8836104753, 83878.58060709719, 84507.5774621123, 84829.99999999939, 85649.0, 8075.192480751878, 9127.406718563272, 9290.070992900792, 9369.203617692572, 9508.524573771421, 16994.235259413355, 20895.477613059797, 20967.895160524404, 20983.685244721342, 21015.579688406146, 7130.429565634737, 7402.629868506661, 7414.258574142543, 7458.5151965122095, 7523.435742319348, 3998.620131087542, 4035.959640403617, 4069.1454794492897, 4100.979495102505, 4106.1992911382595, 3558.1638314995957, 3559.056849934769, 3577.266660334625, 3583.480395342661, 3590.6588874056924, 652.5953908576713, 661.0744957060058, 666.3969107957209, 667.8497338098986, 675.8749631318221, 538.1282322637353, 562.935262444824, 565.9122835960433, 567.1889198446179, 577.5177726598338, 7970.362371010306, 8099.757007289791, 8193.631286592117, 8253.793655158548, 8404.327653787683, 515.2811827500616, 559.1333433178638, 563.3999790223481, 571.1318795430922, 588.4880154265816, 3757.793321367351, 3759.605241449663, 3769.0, 3814.6757525610633, 3844.6732027777393, 92080.07919920849, 92643.0, 92995.07004929999, 93861.0, 94526.52736736272, 77225.84161237587, 78134.60932695415, 78639.60680196677, 79008.02479938048, 79362.6031869837, 69043.96434053393, 69139.65430172917, 70146.64926675436, 70234.64882675554, 70445.0, 7665.195154508696, 7696.576688282198, 7893.1317555070045, 7987.960060199662, 8002.359811215205, 36443.63556364508, 40611.796941015105, 49106.0, 49327.260091097945, 50819.491805081474, 47226.76386618045, 62029.759404812554, 63256.68371658112, 66112.6694366525, 67987.0, 9511.714648560554, 9803.362781419184, 9874.0, 10004.29969902129, 10119.89880101219, 10705.617799439297, 10827.24209305341, 10991.395473249047, 11253.943730281297, 11339.603113890975, 10226.6420675276, 10271.7432064196, 10318.43248621333, 10386.688399348031, 10588.10001149911, 10027.049066210673, 10266.794664106825, 10460.738481538023, 10674.412907289863, 10791.676249712522, 8300.0, 10030.398176109165, 10044.347117437343, 10117.89882101199, 10325.9483702581, 6716.529842910949, 8843.292536596928, 8994.50530220818, 9061.0, 9247.352685311964, 8682.479051256945, 8810.383273170817, 8871.0, 8966.237869781142, 8987.775305617412], "value": 6728.466362558518, "unit": "score"}], "name": "dromaeo_css", "value": 7355.941131320532, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 117.0, 115.0, 115.0, 129.0, 114.0, 115.0, 116.0, 115.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 144.0, 162.0, 127.0, 175.0, 137.0, 152.0, 198.0, 156.0], "value": 152.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 202.0, 198.0, 210.0, 212.0, 203.0, 194.0, 202.0, 200.0, 200.0], "value": 202.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 71.0, 79.0, 74.0, 114.0, 56.0, 54.0, 76.0, 61.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 102.0, 166.0, 114.0, 80.0, 81.0, 118.0, 80.0, 81.0, 120.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 90.0, 88.0, 90.0, 88.0, 90.0, 89.0, 92.0, 87.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 141.0, 149.0, 97.0, 118.0, 113.0, 97.0, 98.0, 105.0, 97.0], "value": 111.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 90.0, 93.0, 122.0, 140.0, 91.0, 92.0, 117.0, 93.0], "value": 102.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 55.0, 56.0, 68.0, 85.0, 82.0, 63.0, 60.0, 54.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 90.0, 95.0, 76.0, 81.0, 86.0, 59.0, 88.0, 97.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 84.0, 91.0, 89.0, 84.0, 87.0, 88.0, 91.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 136.0, 137.0, 135.0, 138.0, 125.0, 111.0, 128.0, 151.0, 142.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 143.0, 159.0, 172.0, 140.0, 158.0, 131.0, 158.0, 126.0, 164.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 68.0, 72.0, 85.0, 83.0, 68.0, 67.0, 72.0, 93.0], "value": 74.9, "unit": "score"}], "name": "kraken", "value": 1537.1000000000001, "alertThreshold": 2.0}]} 12:59:36 INFO - Return code: 0 12:59:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:59:36 ERROR - # TBPL SUCCESS # 12:59:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:59:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:59:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:59:36 INFO - 2016-04-07 12:59:36.716 screenresolution[1961:16715] starting screenresolution argv=screenresolution get 12:59:36 INFO - 2016-04-07 12:59:36.718 screenresolution[1961:16715] Display 0: 1600x1200x32@60 12:59:36 INFO - 2016-04-07 12:59:36.724 screenresolution[1962:16718] starting screenresolution argv=screenresolution list 12:59:36 INFO - Available Modes on Display 0 12:59:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:59:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:59:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:59:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:59:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:59:36 INFO - Intel Iris: 12:59:36 INFO - Chipset Model: Intel Iris 12:59:36 INFO - Type: GPU 12:59:36 INFO - Bus: Built-In 12:59:36 INFO - VRAM (Dynamic, Max): 1536 MB 12:59:36 INFO - Vendor: Intel (0x8086) 12:59:36 INFO - Device ID: 0x0a2e 12:59:36 INFO - Revision ID: 0x0009 12:59:36 INFO - Displays: 12:59:36 INFO - Display: 12:59:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:59:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:59:36 INFO - Display Serial Number: 1600x1200 60 12:59:36 INFO - Main Display: Yes 12:59:36 INFO - Mirror: Off 12:59:36 INFO - Online: Yes 12:59:36 INFO - Rotation: Supported 12:59:36 INFO - Return code: 0 12:59:36 INFO - Running post-action listener: _resource_record_post_action 12:59:36 INFO - Running post-run listener: _resource_record_post_run 12:59:38 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 290816; Write bytes: 695725568; Read time: 3; Write time: 2029 12:59:38 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 375460352; Write bytes: 370402816; Read time: 28057; Write time: 705 12:59:38 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 290816; Write bytes: 300296192; Read time: 3; Write time: 1267 12:59:38 INFO - Running post-run listener: _upload_blobber_files 12:59:38 INFO - Blob upload gear active. 12:59:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:59:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:59:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:59:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:59:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:59:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:39 INFO - (blobuploader) - INFO - Done attempting. 12:59:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:59:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:59:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:40 INFO - (blobuploader) - INFO - Done attempting. 12:59:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:59:40 INFO - Return code: 0 12:59:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:59:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:59:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9bd051dcf506b320524108ee17f8fc0946ad311243724cbd17d5a5a6f3cf1cb7b17b09e6fed6a51ada75eb414b0bddaf8d71645e019b33fb3025b411d2227fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/943461abaab3553416470bbb5e06640affe1701601ecab928f397deeeafb20654b749385446dc5746ce0f47929b662e2cf7a3ef4c849792af49c7bbf87126dc0"} 12:59:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:59:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:59:40 INFO - Contents: 12:59:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d9bd051dcf506b320524108ee17f8fc0946ad311243724cbd17d5a5a6f3cf1cb7b17b09e6fed6a51ada75eb414b0bddaf8d71645e019b33fb3025b411d2227fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/943461abaab3553416470bbb5e06640affe1701601ecab928f397deeeafb20654b749385446dc5746ce0f47929b662e2cf7a3ef4c849792af49c7bbf87126dc0"} 12:59:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:59:40 INFO - Copying logs to upload dir... 12:59:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:59:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.113282 ========= master_lag: 1.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-04-07 12:59:41.711232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 12:59:41.719074) ========= 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.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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/d9bd051dcf506b320524108ee17f8fc0946ad311243724cbd17d5a5a6f3cf1cb7b17b09e6fed6a51ada75eb414b0bddaf8d71645e019b33fb3025b411d2227fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/943461abaab3553416470bbb5e06640affe1701601ecab928f397deeeafb20654b749385446dc5746ce0f47929b662e2cf7a3ef4c849792af49c7bbf87126dc0"} build_url:https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011008 build_url: 'https://queue.taskcluster.net/v1/task/J_1yZDRMQRuisxRmLoXPoA/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/d9bd051dcf506b320524108ee17f8fc0946ad311243724cbd17d5a5a6f3cf1cb7b17b09e6fed6a51ada75eb414b0bddaf8d71645e019b33fb3025b411d2227fa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/943461abaab3553416470bbb5e06640affe1701601ecab928f397deeeafb20654b749385446dc5746ce0f47929b662e2cf7a3ef4c849792af49c7bbf87126dc0"}' ========= master_lag: 0.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 12:59:42.020321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-04-07 12:59:42.020649) ========= 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.rbO860srag/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.sgncwXLSp6/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005288 ========= master_lag: 8.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-04-07 12:59:50.262618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 12:59:50.262935) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 12:59:50.794984) ========= ========= Total master_lag: 18.02 =========