builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0087 starttime: 1460550148.96 results: success (0) buildid: 20160413030239 builduid: fedd703e3d7d4222be6170a0a46df84f revision: 564b225d553547fe4aa9a1039278f695c9507db9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:28.962128) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:28.962643) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:28.962985) ========= 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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005428 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:28.987285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:28.987610) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.006889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.007271) ========= 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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005179 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.056076) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.056390) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.056762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.057053) ========= 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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-13 05:22:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.36M=0.001s 2016-04-13 05:22:29 (8.36 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.174874) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.175398) ========= 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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.026178 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.224816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:29.225211) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 564b225d553547fe4aa9a1039278f695c9507db9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 564b225d553547fe4aa9a1039278f695c9507db9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-13 05:22:29,308 truncating revision to first 12 chars 2016-04-13 05:22:29,308 Setting DEBUG logging. 2016-04-13 05:22:29,308 attempt 1/10 2016-04-13 05:22:29,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/564b225d5535?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 05:22:29,960 unpacking tar archive at: mozilla-central-564b225d5535/testing/mozharness/ program finished with exit code 0 elapsedTime=0.897741 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:30.139672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:30.140038) ========= echo 564b225d553547fe4aa9a1039278f695c9507db9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'564b225d553547fe4aa9a1039278f695c9507db9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 564b225d553547fe4aa9a1039278f695c9507db9 program finished with exit code 0 elapsedTime=0.005123 script_repo_revision: '564b225d553547fe4aa9a1039278f695c9507db9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:30.190339) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:30.190819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 05:22:30.204888) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-13 05:22:30.205314) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:22:30 INFO - MultiFileLogger online at 20160413 05:22:30 in /builds/slave/test 05:22:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:22:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:22:30 INFO - {'append_to_log': False, 05:22:30 INFO - 'base_work_dir': '/builds/slave/test', 05:22:30 INFO - 'blob_upload_branch': 'Firefox', 05:22:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:22:30 INFO - 'branch': 'Firefox', 05:22:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:22:30 INFO - 'config_files': ('talos/mac_config.py',), 05:22:30 INFO - 'default_actions': ('clobber', 05:22:30 INFO - 'read-buildbot-config', 05:22:30 INFO - 'download-and-extract', 05:22:30 INFO - 'populate-webroot', 05:22:30 INFO - 'create-virtualenv', 05:22:30 INFO - 'install', 05:22:30 INFO - 'run-tests'), 05:22:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:22:30 INFO - 'download_minidump_stackwalk': True, 05:22:30 INFO - 'download_symbols': 'ondemand', 05:22:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:22:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:22:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:22:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:22:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:22:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:22:30 INFO - 'installer_path': 'installer.exe', 05:22:30 INFO - 'log_level': 'info', 05:22:30 INFO - 'log_name': 'talos', 05:22:30 INFO - 'log_to_console': True, 05:22:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:22:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:22:30 INFO - 'opt_config_files': (), 05:22:30 INFO - 'pip_index': False, 05:22:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:22:30 INFO - 'cmd': ('bash', 05:22:30 INFO - '-c', 05:22:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:22:30 INFO - 'enabled': True, 05:22:30 INFO - 'halt_on_failure': False, 05:22:30 INFO - 'name': 'check_screen_resolution'},), 05:22:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:22:30 INFO - 'cmd': ('bash', 05:22:30 INFO - '-c', 05:22:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:22:30 INFO - 'enabled': True, 05:22:30 INFO - 'halt_on_failure': False, 05:22:30 INFO - 'name': 'check_screen_resolution'},), 05:22:30 INFO - 'run_cmd_checks_enabled': True, 05:22:30 INFO - 'sps_profile': False, 05:22:30 INFO - 'sps_profile_interval': 0, 05:22:30 INFO - 'suite': 'dromaeojs', 05:22:30 INFO - 'system_bits': '32', 05:22:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:22:30 INFO - 'title': 't-yosemite-r7-0087', 05:22:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:22:30 INFO - 'use_talos_json': True, 05:22:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:22:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:22:30 INFO - 'work_dir': 'build'} 05:22:30 INFO - ##### 05:22:30 INFO - ##### Running clobber step. 05:22:30 INFO - ##### 05:22:30 INFO - Running pre-action listener: _resource_record_pre_action 05:22:30 INFO - Running main action method: clobber 05:22:30 INFO - rmtree: /builds/slave/test/build 05:22:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:22:32 INFO - Running post-action listener: _resource_record_post_action 05:22:32 INFO - ##### 05:22:32 INFO - ##### Running read-buildbot-config step. 05:22:32 INFO - ##### 05:22:32 INFO - Running pre-action listener: _resource_record_pre_action 05:22:32 INFO - Running main action method: read_buildbot_config 05:22:32 INFO - Using buildbot properties: 05:22:32 INFO - { 05:22:32 INFO - "project": "", 05:22:32 INFO - "product": "firefox", 05:22:32 INFO - "script_repo_revision": "production", 05:22:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:22:32 INFO - "repository": "", 05:22:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:22:32 INFO - "buildid": "20160413030239", 05:22:32 INFO - "stage_platform": "macosx64", 05:22:32 INFO - "basedir": "/builds/slave/test", 05:22:32 INFO - "nightly_build": "True", 05:22:32 INFO - "buildnumber": 214, 05:22:32 INFO - "slavename": "t-yosemite-r7-0087", 05:22:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:22:32 INFO - "platform": "yosemite_r7", 05:22:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:22:32 INFO - "branch": "mozilla-central", 05:22:32 INFO - "repo_path": "mozilla-central", 05:22:32 INFO - "revision": "564b225d553547fe4aa9a1039278f695c9507db9", 05:22:32 INFO - "pgo_build": "False", 05:22:32 INFO - "builduid": "fedd703e3d7d4222be6170a0a46df84f", 05:22:32 INFO - "slavebuilddir": "test" 05:22:32 INFO - } 05:22:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:22:32 INFO - Running post-action listener: _resource_record_post_action 05:22:32 INFO - ##### 05:22:32 INFO - ##### Running download-and-extract step. 05:22:32 INFO - ##### 05:22:32 INFO - Running pre-action listener: _resource_record_pre_action 05:22:32 INFO - Running main action method: download_and_extract 05:22:32 INFO - mkdir: /builds/slave/test/build/tests 05:22:32 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')]} 05:22:32 INFO - https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:22:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:22:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:22:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:33 INFO - Downloaded 1199 bytes. 05:22:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:22:33 INFO - Using the following test package requirements: 05:22:33 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:22:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:22:33 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:22:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:22:33 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:22:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:22:33 INFO - u'jsshell-mac.zip'], 05:22:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:22:33 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:22:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:22:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:22:33 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:22:33 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:22:33 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:22:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:22:33 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:22:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:22:33 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:22:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:22:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:33 INFO - https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:22:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:22:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:22:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:34 INFO - Downloaded 18027463 bytes. 05:22:34 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'] 05:22:34 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 05:22:37 INFO - Return code: 0 05:22:37 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 05:22:37 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')]} 05:22:37 INFO - https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:22:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:22:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:22:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:38 INFO - Downloaded 18027463 bytes. 05:22:38 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'] 05:22:38 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 05:22:42 INFO - Return code: 0 05:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:42 INFO - https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:43 INFO - Downloaded 10841076 bytes. 05:22:43 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'] 05:22:43 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 05:22:43 INFO - Return code: 0 05:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:43 INFO - https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N2VuAvshTDibQRWULlf--g/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 05:22:46 INFO - Downloaded 109449401 bytes. 05:22:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:22:46 INFO - mkdir: /builds/slave/test/properties 05:22:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:22:46 INFO - Writing to file /builds/slave/test/properties/build_url 05:22:46 INFO - Contents: 05:22:46 INFO - build_url:https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:22:47 INFO - Running post-action listener: _resource_record_post_action 05:22:47 INFO - Running post-action listener: set_extra_try_arguments 05:22:47 INFO - ##### 05:22:47 INFO - ##### Running populate-webroot step. 05:22:47 INFO - ##### 05:22:47 INFO - Running pre-action listener: _resource_record_pre_action 05:22:47 INFO - Running main action method: populate_webroot 05:22:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:22:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:22:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:22:47 INFO - '--tppagecycles', 05:22:47 INFO - '7'], 05:22:47 INFO - 'tests': ['tsvgm']}}, 05:22:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:22:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:22:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:22:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:22:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:47 INFO - 'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:22:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:47 INFO - 'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['damp', 'tps']}, 05:22:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:47 INFO - 'tests': ['damp', 'tps']}, 05:22:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['dromaeo_dom']}, 05:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:22:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['a11yr', 05:22:47 INFO - 'ts_paint', 05:22:47 INFO - 'tpaint', 05:22:47 INFO - 'sessionrestore', 05:22:47 INFO - 'sessionrestore_no_auto_restore', 05:22:47 INFO - 'tabpaint']}, 05:22:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:22:47 INFO - 'ts_paint', 05:22:47 INFO - 'tpaint', 05:22:47 INFO - 'sessionrestore', 05:22:47 INFO - 'sessionrestore_no_auto_restore', 05:22:47 INFO - 'tabpaint']}, 05:22:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:22:47 INFO - 'ts_paint', 05:22:47 INFO - 'tpaint', 05:22:47 INFO - 'sessionrestore', 05:22:47 INFO - 'sessionrestore_no_auto_restore', 05:22:47 INFO - 'tabpaint']}, 05:22:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:22:47 INFO - 'ts_paint', 05:22:47 INFO - 'tpaint', 05:22:47 INFO - 'sessionrestore', 05:22:47 INFO - 'sessionrestore_no_auto_restore', 05:22:47 INFO - 'tabpaint']}, 05:22:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['a11yr', 05:22:47 INFO - 'ts_paint', 05:22:47 INFO - 'tpaint', 05:22:47 INFO - 'sessionrestore', 05:22:47 INFO - 'sessionrestore_no_auto_restore', 05:22:47 INFO - 'tabpaint']}, 05:22:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['a11yr', 05:22:47 INFO - 'ts_paint', 05:22:47 INFO - 'tpaint', 05:22:47 INFO - 'sessionrestore', 05:22:47 INFO - 'sessionrestore_no_auto_restore', 05:22:47 INFO - 'tabpaint']}, 05:22:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['tsvgx', 05:22:47 INFO - 'tsvgr_opacity', 05:22:47 INFO - 'tart', 05:22:47 INFO - 'tscrollx', 05:22:47 INFO - 'cart']}, 05:22:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:22:47 INFO - 'tsvgr_opacity', 05:22:47 INFO - 'tart', 05:22:47 INFO - 'tscrollx', 05:22:47 INFO - 'cart']}, 05:22:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:47 INFO - 'talos_options': ['--disable-e10s'], 05:22:47 INFO - 'tests': ['tp5o']}, 05:22:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:47 INFO - 'tests': ['tp5o']}, 05:22:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:47 INFO - 'talos_options': ['--disable-e10s', 05:22:47 INFO - '--xperf_path', 05:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:47 INFO - 'tests': ['tp5n']}, 05:22:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:22:47 INFO - 'talos_options': ['--xperf_path', 05:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:22:47 INFO - 'tests': ['tp5n']}}, 05:22:47 INFO - 'talos.zip': {'path': '', 05:22:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:22:47 INFO - Running post-action listener: _resource_record_post_action 05:22:47 INFO - ##### 05:22:47 INFO - ##### Running create-virtualenv step. 05:22:47 INFO - ##### 05:22:47 INFO - Running pre-action listener: _resource_record_pre_action 05:22:47 INFO - Running main action method: create_virtualenv 05:22:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:22:47 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 05:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:22:47 INFO - Using real prefix '/tools/python27' 05:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:22:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:22:51 INFO - Installing pip.................done. 05:22:51 INFO - Return code: 0 05:22:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:22: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')]} 05:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:51 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 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:22:51 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 05:22:51 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 05:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:51 INFO - 'HOME': '/Users/cltbld', 05:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:51 INFO - 'LOGNAME': 'cltbld', 05:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:51 INFO - 'MOZ_NO_REMOTE': '1', 05:22:51 INFO - 'NO_EM_RESTART': '1', 05:22:51 INFO - 'PAGER': '/bin/cat', 05:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:51 INFO - 'PWD': '/builds/slave/test', 05:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:51 INFO - 'SHELL': '/bin/bash', 05:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:22:51 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:51 INFO - 'USER': 'cltbld', 05:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:51 INFO - 'XPC_FLAGS': '0x0', 05:22:51 INFO - 'XPC_SERVICE_NAME': '0', 05:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:51 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 05:22:51 INFO - Cleaning up... 05:22:51 INFO - Return code: 0 05:22:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:22: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')]} 05:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:51 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 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:22:51 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 05:22:51 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 05:22:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:22:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:51 INFO - 'HOME': '/Users/cltbld', 05:22:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:51 INFO - 'LOGNAME': 'cltbld', 05:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:51 INFO - 'MOZ_NO_REMOTE': '1', 05:22:51 INFO - 'NO_EM_RESTART': '1', 05:22:51 INFO - 'PAGER': '/bin/cat', 05:22:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:51 INFO - 'PWD': '/builds/slave/test', 05:22:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:51 INFO - 'SHELL': '/bin/bash', 05:22:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:22:51 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:22:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:51 INFO - 'USER': 'cltbld', 05:22:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:51 INFO - 'XPC_FLAGS': '0x0', 05:22:51 INFO - 'XPC_SERVICE_NAME': '0', 05:22:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:51 INFO - Downloading/unpacking psutil>=0.7.1 05:22:51 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 05:22:51 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 05:22:51 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 05:22:51 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 05:22:51 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 05:22:51 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 05:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:22:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:54 INFO - Installing collected packages: psutil 05:22:54 INFO - Running setup.py install for psutil 05:22:54 INFO - building 'psutil._psutil_osx' extension 05:22:54 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 05:22:55 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 05:22:55 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 05:22:55 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 05:22:55 INFO - building 'psutil._psutil_posix' extension 05:22:55 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 05:22:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:22:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:22:55 INFO - ^ 05:22:55 INFO - 1 warning generated. 05:22:55 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 05:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:22:55 INFO - Successfully installed psutil 05:22:55 INFO - Cleaning up... 05:22:56 INFO - Return code: 0 05:22:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:22:56 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')]} 05:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:56 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')]} 05:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:56 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 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:22:56 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 05:22:56 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 05:22:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:22:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:56 INFO - 'HOME': '/Users/cltbld', 05:22:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:56 INFO - 'LOGNAME': 'cltbld', 05:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:56 INFO - 'MOZ_NO_REMOTE': '1', 05:22:56 INFO - 'NO_EM_RESTART': '1', 05:22:56 INFO - 'PAGER': '/bin/cat', 05:22:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:56 INFO - 'PWD': '/builds/slave/test', 05:22:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:56 INFO - 'SHELL': '/bin/bash', 05:22:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:22:56 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:22:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:56 INFO - 'USER': 'cltbld', 05:22:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:56 INFO - 'XPC_FLAGS': '0x0', 05:22:56 INFO - 'XPC_SERVICE_NAME': '0', 05:22:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:22:56 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 05:22:56 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 05:22:56 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 05:22:56 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 05:22:56 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 05:22:56 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 05:22:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:22:58 INFO - Installing collected packages: mozsystemmonitor 05:22:58 INFO - Running setup.py install for mozsystemmonitor 05:22:58 INFO - Successfully installed mozsystemmonitor 05:22:58 INFO - Cleaning up... 05:22:59 INFO - Return code: 0 05:22:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:22:59 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')]} 05:22:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:59 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')]} 05:22:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:59 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 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:22:59 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 05:22:59 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 05:22:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:22:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:22:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:22:59 INFO - 'HOME': '/Users/cltbld', 05:22:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:22:59 INFO - 'LOGNAME': 'cltbld', 05:22:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:59 INFO - 'MOZ_NO_REMOTE': '1', 05:22:59 INFO - 'NO_EM_RESTART': '1', 05:22:59 INFO - 'PAGER': '/bin/cat', 05:22:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:22:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:59 INFO - 'PWD': '/builds/slave/test', 05:22:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:22:59 INFO - 'SHELL': '/bin/bash', 05:22:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:22:59 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:22:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:22:59 INFO - 'USER': 'cltbld', 05:22:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:22:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:22:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:59 INFO - 'XPC_FLAGS': '0x0', 05:22:59 INFO - 'XPC_SERVICE_NAME': '0', 05:22:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:22:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:22:59 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 05:22:59 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 05:22:59 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 05:22:59 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 05:22:59 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 05:22:59 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 05:23:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:23:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:23:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:23:02 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 05:23:02 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 05:23:02 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 05:23:02 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 05:23:02 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 05:23:02 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 05:23:02 INFO - Downloading docopt-0.6.1.tar.gz 05:23:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:23:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:23:02 INFO - Running setup.py install for blobuploader 05:23:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:23:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:23:03 INFO - Running setup.py install for requests 05:23:03 INFO - Running setup.py install for docopt 05:23:03 INFO - Successfully installed blobuploader requests docopt 05:23:03 INFO - Cleaning up... 05:23:03 INFO - Return code: 0 05:23:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:03 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 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:23:03 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 05:23:03 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 05:23:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:23:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:03 INFO - 'HOME': '/Users/cltbld', 05:23:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:03 INFO - 'LOGNAME': 'cltbld', 05:23:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:03 INFO - 'MOZ_NO_REMOTE': '1', 05:23:03 INFO - 'NO_EM_RESTART': '1', 05:23:03 INFO - 'PAGER': '/bin/cat', 05:23:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:03 INFO - 'PWD': '/builds/slave/test', 05:23:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:03 INFO - 'SHELL': '/bin/bash', 05:23:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:23:03 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:23:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:03 INFO - 'USER': 'cltbld', 05:23:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:03 INFO - 'XPC_FLAGS': '0x0', 05:23:03 INFO - 'XPC_SERVICE_NAME': '0', 05:23:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-j37bkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ftnjbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-ab6XF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-NYJAxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-MA_c2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-h5Wd9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-XnzKWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-3ztsVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:04 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-VJbz4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:05 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-54n_ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:05 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-oZwfTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:05 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-4sk0aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:05 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Jm2GFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:05 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-FMy0Uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:05 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-lAxBSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:05 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-JTDCWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:05 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-9Kf0uW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:23:05 INFO - Running setup.py install for manifestparser 05:23:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Running setup.py install for mozcrash 05:23:06 INFO - Running setup.py install for mozdebug 05:23:06 INFO - Running setup.py install for mozdevice 05:23:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Running setup.py install for mozfile 05:23:06 INFO - Running setup.py install for mozhttpd 05:23:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Running setup.py install for mozinfo 05:23:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:23:06 INFO - Running setup.py install for mozInstall 05:23:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozleak 05:23:07 INFO - Running setup.py install for mozlog 05:23:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for moznetwork 05:23:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozprocess 05:23:07 INFO - Running setup.py install for mozprofile 05:23:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:23:07 INFO - Running setup.py install for mozrunner 05:23:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Running setup.py install for mozscreenshot 05:23:08 INFO - Running setup.py install for moztest 05:23:08 INFO - Running setup.py install for mozversion 05:23:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:23:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:23:08 INFO - Cleaning up... 05:23:08 INFO - Return code: 0 05:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:08 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 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:23:08 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 05:23:08 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 05:23:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:23:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:08 INFO - 'HOME': '/Users/cltbld', 05:23:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:08 INFO - 'LOGNAME': 'cltbld', 05:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:08 INFO - 'MOZ_NO_REMOTE': '1', 05:23:08 INFO - 'NO_EM_RESTART': '1', 05:23:08 INFO - 'PAGER': '/bin/cat', 05:23:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:08 INFO - 'PWD': '/builds/slave/test', 05:23:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:08 INFO - 'SHELL': '/bin/bash', 05:23:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:23:08 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:23:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:08 INFO - 'USER': 'cltbld', 05:23:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:08 INFO - 'XPC_FLAGS': '0x0', 05:23:08 INFO - 'XPC_SERVICE_NAME': '0', 05:23:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:23:08 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-O2cfXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:23:08 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-9QKgXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:23:08 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)) 05:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:23:08 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-00eRIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-kvZw9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-9B0MnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-duuH6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-X0Lxtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-lEoGOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-nUWcq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-WLkgYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-W2G2f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:23:09 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)) 05:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:23:09 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-oN1P5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:23:10 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)) 05:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:23:10 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Kb1V4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:23:10 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)) 05:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:23:10 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Xst_Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:23:10 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)) 05:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:10 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-RINMLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:23:10 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)) 05:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:23:10 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-VVGH7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:23:10 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)) 05:23:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:23:10 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-IyrfSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:23:10 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)) 05:23:10 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)) 05:23:10 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)) 05:23:10 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)) 05:23:10 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)) 05:23:10 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)) 05:23:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23:12 INFO - Downloading blessings-1.6.tar.gz 05:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:23:13 INFO - Installing collected packages: blessings 05:23:13 INFO - Running setup.py install for blessings 05:23:13 INFO - Successfully installed blessings 05:23:13 INFO - Cleaning up... 05:23:13 INFO - Return code: 0 05:23:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:23:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:13 INFO - Reading from file tmpfile_stdout 05:23:13 INFO - Current package versions: 05:23:13 INFO - blessings == 1.6 05:23:13 INFO - blobuploader == 1.2.4 05:23:13 INFO - docopt == 0.6.1 05:23:13 INFO - manifestparser == 1.1 05:23:13 INFO - mozInstall == 1.12 05:23:13 INFO - mozcrash == 0.17 05:23:13 INFO - mozdebug == 0.1 05:23:13 INFO - mozdevice == 0.48 05:23:13 INFO - mozfile == 1.2 05:23:13 INFO - mozhttpd == 0.7 05:23:13 INFO - mozinfo == 0.9 05:23:13 INFO - mozleak == 0.1 05:23:13 INFO - mozlog == 3.1 05:23:13 INFO - moznetwork == 0.27 05:23:13 INFO - mozprocess == 0.22 05:23:13 INFO - mozprofile == 0.28 05:23:13 INFO - mozrunner == 6.11 05:23:13 INFO - mozscreenshot == 0.1 05:23:13 INFO - mozsystemmonitor == 0.0 05:23:13 INFO - moztest == 0.7 05:23:13 INFO - mozversion == 1.4 05:23:13 INFO - psutil == 3.1.1 05:23:13 INFO - requests == 1.2.3 05:23:13 INFO - wsgiref == 0.1.2 05:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 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 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:23:13 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 05:23:13 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 05:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:13 INFO - 'HOME': '/Users/cltbld', 05:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:13 INFO - 'LOGNAME': 'cltbld', 05:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:13 INFO - 'MOZ_NO_REMOTE': '1', 05:23:13 INFO - 'NO_EM_RESTART': '1', 05:23:13 INFO - 'PAGER': '/bin/cat', 05:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:13 INFO - 'PWD': '/builds/slave/test', 05:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:13 INFO - 'SHELL': '/bin/bash', 05:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:23:13 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:13 INFO - 'USER': 'cltbld', 05:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:13 INFO - 'XPC_FLAGS': '0x0', 05:23:13 INFO - 'XPC_SERVICE_NAME': '0', 05:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 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)) 05:23:13 INFO - Cleaning up... 05:23:13 INFO - Return code: 0 05:23:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:23:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:23:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:13 INFO - 'HOME': '/Users/cltbld', 05:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:13 INFO - 'LOGNAME': 'cltbld', 05:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:13 INFO - 'MOZ_NO_REMOTE': '1', 05:23:13 INFO - 'NO_EM_RESTART': '1', 05:23:13 INFO - 'PAGER': '/bin/cat', 05:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:13 INFO - 'PWD': '/builds/slave/test', 05:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:13 INFO - 'SHELL': '/bin/bash', 05:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:23:13 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:13 INFO - 'USER': 'cltbld', 05:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:13 INFO - 'XPC_FLAGS': '0x0', 05:23:13 INFO - 'XPC_SERVICE_NAME': '0', 05:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:14 INFO - Downloading/unpacking jsonschema 05:23:14 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 05:23:14 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 05:23:14 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 05:23:14 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 05:23:14 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 05:23:14 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 05:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:23:16 INFO - Downloading/unpacking functools32 (from jsonschema) 05:23:16 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 05:23:16 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 05:23:16 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 05:23:16 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 05:23:16 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 05:23:16 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 05:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:23:16 INFO - warning: no files found matching '*.txt' 05:23:16 INFO - no previously-included directories found matching 'build' 05:23:16 INFO - no previously-included directories found matching 'dist' 05:23:16 INFO - no previously-included directories found matching '.git*' 05:23:16 INFO - Installing collected packages: jsonschema, functools32 05:23:16 INFO - Running setup.py install for functools32 05:23:17 INFO - warning: no files found matching '*.txt' 05:23:17 INFO - no previously-included directories found matching 'build' 05:23:17 INFO - no previously-included directories found matching 'dist' 05:23:17 INFO - no previously-included directories found matching '.git*' 05:23:17 INFO - Successfully installed jsonschema functools32 05:23:17 INFO - Cleaning up... 05:23:17 INFO - Return code: 0 05:23:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:23: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')]} 05:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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')]} 05:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cee9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cef9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2285b96a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, '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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 05:23:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:23:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:23:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:17 INFO - 'HOME': '/Users/cltbld', 05:23:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:17 INFO - 'LOGNAME': 'cltbld', 05:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:17 INFO - 'MOZ_NO_REMOTE': '1', 05:23:17 INFO - 'NO_EM_RESTART': '1', 05:23:17 INFO - 'PAGER': '/bin/cat', 05:23:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:17 INFO - 'PWD': '/builds/slave/test', 05:23:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:17 INFO - 'SHELL': '/bin/bash', 05:23:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:23:17 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:23:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:17 INFO - 'USER': 'cltbld', 05:23:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:17 INFO - 'XPC_FLAGS': '0x0', 05:23:17 INFO - 'XPC_SERVICE_NAME': '0', 05:23:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:17 INFO - Downloading/unpacking flake8 05:23:17 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 05:23:17 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 05:23:17 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 05:23:17 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 05:23:17 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 05:23:17 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 05:23:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:23:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23: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 05:23:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:23:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:23:20 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 05:23:20 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 05:23:20 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 05:23:20 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 05:23:20 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 05:23:20 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 05:23:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:23:20 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 05:23:20 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 05:23:20 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 05:23:20 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 05:23:20 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 05:23:20 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 05:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:21 INFO - no previously-included directories found matching 'docs/_build' 05:23:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:23:21 INFO - Running setup.py install for pep8 05:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:23:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:23:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:23:21 INFO - no previously-included directories found matching 'docs/_build' 05:23:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:23:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:23:21 INFO - Cleaning up... 05:23:21 INFO - Return code: 0 05:23:21 INFO - Running post-action listener: _resource_record_post_action 05:23:21 INFO - Running post-action listener: _start_resource_monitoring 05:23:21 INFO - Starting resource monitoring. 05:23:21 INFO - ##### 05:23:21 INFO - ##### Running install step. 05:23:21 INFO - ##### 05:23:21 INFO - Running pre-action listener: _resource_record_pre_action 05:23:21 INFO - Running main action method: install 05:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:23:21 INFO - Reading from file tmpfile_stdout 05:23:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:23:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:23:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:23:21 INFO - Reading from file tmpfile_stdout 05:23:21 INFO - Output received: 05:23:21 INFO - Usage: mozinstall [options] installer 05:23:21 INFO - Options: 05:23:21 INFO - -h, --help show this help message and exit 05:23:21 INFO - -d DEST, --destination=DEST 05:23:21 INFO - Directory to install application into. [default: 05:23:21 INFO - "/builds/slave/test"] 05:23:21 INFO - --app=APP Application being installed. [default: firefox] 05:23:21 INFO - mkdir: /builds/slave/test/build/application 05:23:21 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'] 05:23:21 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 05:23:55 INFO - Reading from file tmpfile_stdout 05:23:55 INFO - Output received: 05:23:55 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:23:55 INFO - Running post-action listener: _resource_record_post_action 05:23:55 INFO - ##### 05:23:55 INFO - ##### Running run-tests step. 05:23:55 INFO - ##### 05:23:55 INFO - Running pre-action listener: _resource_record_pre_action 05:23:55 INFO - Running main action method: run_tests 05:23:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:23:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:23:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:23:55 INFO - 2016-04-13 05:23:55.846 screenresolution[1640:7512] starting screenresolution argv=screenresolution get 05:23:55 INFO - 2016-04-13 05:23:55.849 screenresolution[1640:7512] Display 0: 1600x1200x32@60 05:23:55 INFO - 2016-04-13 05:23:55.854 screenresolution[1641:7514] starting screenresolution argv=screenresolution list 05:23:55 INFO - Available Modes on Display 0 05:23:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:23:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:23:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:23:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:23:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:23:56 INFO - Intel Iris: 05:23:56 INFO - Chipset Model: Intel Iris 05:23:56 INFO - Type: GPU 05:23:56 INFO - Bus: Built-In 05:23:56 INFO - VRAM (Dynamic, Max): 1536 MB 05:23:56 INFO - Vendor: Intel (0x8086) 05:23:56 INFO - Device ID: 0x0a2e 05:23:56 INFO - Revision ID: 0x0009 05:23:56 INFO - Displays: 05:23:56 INFO - Display: 05:23:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:23:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:23:56 INFO - Display Serial Number: 1600x1200 60 05:23:56 INFO - Main Display: Yes 05:23:56 INFO - Mirror: Off 05:23:56 INFO - Online: Yes 05:23:56 INFO - Rotation: Supported 05:23:56 INFO - Return code: 0 05:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:23:56 INFO - Python 2.7.3 05:23:56 INFO - Return code: 0 05:23:56 INFO - grabbing minidump binary from tooltool 05:23:56 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')]} 05:23:56 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 0x10cd88e00>, '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 0x10cbb1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd83b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:23:56 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 05:23:56 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 05:23:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:23:56 INFO - Return code: 0 05:23:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:23:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:23:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:23:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:23:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:23:57 INFO - Return code: 0 05:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AeWHGGWLU0/Render', 05:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:23:57 INFO - 'HOME': '/Users/cltbld', 05:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:23:57 INFO - 'LOGNAME': 'cltbld', 05:23:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:23:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:57 INFO - 'MOZ_NO_REMOTE': '1', 05:23:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:23:57 INFO - 'NO_EM_RESTART': '1', 05:23:57 INFO - 'PAGER': '/bin/cat', 05:23:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:57 INFO - 'PWD': '/builds/slave/test', 05:23:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:23:57 INFO - 'SHELL': '/bin/bash', 05:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7BpDI0KXM7/Listeners', 05:23:57 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 05:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:23:57 INFO - 'USER': 'cltbld', 05:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:57 INFO - 'XPC_FLAGS': '0x0', 05:23:57 INFO - 'XPC_SERVICE_NAME': '0', 05:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:23:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:23:57 INFO - mozversion application_buildid: 20160413030239 05:23:57 INFO - mozversion application_changeset: 564b225d553547fe4aa9a1039278f695c9507db9 05:23:57 INFO - mozversion application_display_name: Nightly 05:23:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:23:57 INFO - mozversion application_name: Firefox 05:23:57 INFO - mozversion application_remotingname: firefox 05:23:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:23:57 INFO - mozversion application_vendor: Mozilla 05:23:57 INFO - mozversion application_version: 48.0a1 05:23:57 INFO - mozversion platform_buildid: 20160413030239 05:23:57 INFO - mozversion platform_changeset: 564b225d553547fe4aa9a1039278f695c9507db9 05:23:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:23:57 INFO - mozversion platform_version: 48.0a1 05:23:57 INFO - using testdate: 1460550237 05:23:57 INFO - actual date: 1460550237 05:23:57 INFO - starting webserver on 'localhost:49270' 05:23:57 INFO - SUITE-START | Running 2 tests 05:23:57 INFO - TEST-START | dromaeo_css 05:23:57 INFO - operating with platform_type : mac_ 05:23:57 INFO - Initialising browser for dromaeo_css test... 05:23:57 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpkJfDNx/profile http://localhost:49270/getInfo.html) 05:24:00 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 05:24:00 INFO - PROCESS | 1659 | colorDepth:24 05:24:00 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 05:24:00 INFO - PROCESS | 1659 | __metrics 05:24:00 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:24:00 ERROR - PROCESS | 1659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:24:00 INFO - TEST-INFO | 1659: exit 0 05:24:00 INFO - Browser initialized. 05:24:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:24:00 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpkJfDNx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:12 INFO - PROCESS | 1662 | RSS: Main: 237473792 05:24:12 INFO - PROCESS | 1662 | 05:25:04 INFO - PROCESS | 1662 | 1460550304430 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] 05:27:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:27:16 INFO - PROCESS | 1662 | RSS: Main: 357347328 05:27:16 INFO - PROCESS | 1662 | 05:30:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:30:19 INFO - PROCESS | 1662 | RSS: Main: 374697984 05:30:19 INFO - PROCESS | 1662 | 05:33:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:33:22 INFO - PROCESS | 1662 | RSS: Main: 370290688 05:33:22 INFO - PROCESS | 1662 | 05:36:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:36:25 INFO - PROCESS | 1662 | RSS: Main: 372039680 05:36:25 INFO - PROCESS | 1662 | 05:39:28 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:39:29 INFO - PROCESS | 1662 | RSS: Main: 336269312 05:39:29 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:42:32 INFO - PROCESS | 1662 | RSS: Main: 386826240 05:42:32 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | __start_tp_report 05:42:32 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 05:42:32 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 05:42:32 INFO - PROCESS | 1662 | |i|pagename|runs| 05:42:32 INFO - PROCESS | 1662 | |0;dojo.html;3366.5623468949034;3438.123278563966;3469.5142680024787;3475.8262086895666;3495.9825200873993;5580.637258578189;5671.546276297897;5688.459596338346;5695.401982791809;5696.060150075238;5692.686902220376;5722.284714410699;5732.742026608813;5842.766289348421;5845.0647896336595;5042.924356134661;5050.595952323823;5060;5074.644774865761;5177;5229.372475302969;5250.133727934886;5255.579553635719;5279.868003299929;5296.708681022542;4982.227754698028;5070.340855688773;5088.4148322942965;5088.931324421876;5199.6360254782185;5118.923216151761;5125.897482050338;5144.382674079097;5154.53609175176;5155.510226528511;5070.062038522885;5105.719185444799;5127.410347810012;5141.485851414828;5172.793088276502;5489.094299440588;5571.749271282802;5601.991641504527;5604.439556044404;5678.119891416837;6167.969160154171;6205.255369355661;6218.098375735538;6225.564210505267;6233.501319894398;6147.631142131441;6224.688765561749;6237.157983672191;6260.718267677966;6262;5683;5732.627379220337;5776.508996735282;5798.275215598051;5820.039693450618;6249.031400132896;6252.030935205051;6255.624662520263;6267.9971204607955;6272.5922815016875;6057.636541807417;6062.878742425127;6067.332593414721;6069.635821850615;6092.634441933498;5962.672053037038;6055.757769689251;6143.986242270064;6154.5076393888385;6224.37756224383;6161.599496032743;6166.290876549254;6185.969070154621;6188.257409110845;6207;6201.968990155111;6202.503799696104;6207.006878899445;6224.875502490016;6225.564210505312;4794.7362895040405;4872.366592342973;4874.731889746098;4917.164082106051;4961.08219979305;4409.625181859514;4415.51429342772;4434.379186913835;4448.377227188196;4488.708233964782;5550.500454959073;5575.386707462176;5605;5611.80358687444;5615.9157612635845;6100.481459076028;6165.352637973038;6175.62946223219;6252.5935814171935;6279.026750853625;5582.553395728332;5600.411956744565;5606.915896261559;5626;5662.433756624305;5313.601479889024;5341.786328546815;5342.252084708144;5342.679439233659;5345.946540534623;6196.81409557714;6201.658908760061;6254.499640028877;6293.339199383999;6305.527085468608;6244.562880598496;6257.68711564429;6270.905936411049;6274.1843560336865;6278.968605157128;6230.408111229426;6273.215848018997;6310.305866354789;6320.209973753281;6327.462165715966;6022.156898034366;6067.878642427038;6135.325114237519;6137.723802428991;6180.783672571439;6165.475934545614;6207.844803879759;6218.22272215973;6232.875342493216;6240.937590624036;5133.460986596354;6066;6071.574989750675;6074.149619053424;6088.634681918922;5866.765329386777;5988.5508586855285;5994.820155395345;6022.668753218615;6109.755609775737;5875.529957603467;5877.23595932526;5883.470487656132;5900.380460051632;5912.940870591239;5950.137230101524;6054.122152287981;6098.451139397475;6109.541784366102;6111.358307377662;5776.393478684846;5857;5920.348761636303;5950.404959504015;5955.493783028491 05:42:32 INFO - PROCESS | 1662 | |1;ext.html;507.29992610197934;507.54574655683143;569.9000928208555;570.9571782116342;590.8463799412153;29005;38475.80762096189;39593;39594.604053959454;39602.207955840866;41694.58305416945;41926;42087.36868946968;42176.36735448971;42268.36597451033;7099.8225044373785;9399.248060155189;9653.27600429967;9653.565589548487;9657.034296570322;8572.399932004762;11475;11767.882321176807;11777.175597708163;11785.351805650685;9776.951115244414;11397.544098236061;11489.770204595903;11497.252678575866;11528.250663706875;8482.83034339316;11427.371494567795;11528.077753779677;11532.827007594893;11637.301761894314;11294.661160165208;11452.828207576893;11465.197436179471;11466.770664586746;11472.426378681115;37971.24057518862;38649.61350386488;38734.418983715266;38778.61221387778;38841.8347449577;3122.8750849965973;3156.684331566848;3172.9846449136285;3236.708696217328;3448.498162685407;28518;28947.71052289471;29169.56245656317;29635.851820740758;29793.553096703567;2662.3077999720017;2719.102696110279;2729.7471173355807;2742.2184677366854;2780.2771279467283;362049;362488;362871;362978;363097;60710.69644651748;61009.69495152496;61082.38917610767;61167.69416152891;61231.693841530505;66928.66535667388;68791.65604172047;68805.65597172083;68852.31147688559;69015.23939042383;14433.711325773425;15242.847571524364;16005.359785608678;16208.027518348938;16239;11522.711932201762;11763;12472.189307694971;12520.561780337644;12769.680757981125;17910.925344479372;18801.743790745197;19178.616427671368;19182.232710691416;19258.518537036685;7054.294570542905;8122.675092996332;8150.510969341858;8204.384671149688;8237.629306681214;913.196387179278;982.9901700983041;987.4667679453158;1013.3919648211014;1097.3251450358132;23259.883700581388;27095.32261693434;27624.447511049668;28168.154955351372;28244.8587757064;1077.4289626497969;1083.5774048121239;1151.7926773180907;1225.8835410635975;1272.7009152849073;12715.55495557651;13316.600501984956;14481.348339324755;14622.561323160322;14982.250887455584;636820;640922;649481;651730;652926;59569;60478.69760651168;60552.39447605467;60552.39447605555;60658;1305.1712162776705;1339.0158233698419;1429.485385261326;1441.942322307117;1473.8526147385176;28807.847686092322;28834.423311534072;28987.275318117216;29438;29541.26146846346;48933.75533122312;49492.75253623709;49874.750626246634;50147.74926125346;50199.24701129413;474807;476763;476901;477569;477662;22914.885425573433;23559.882200588887;23596.17413390523;24294.815691298645;26034.218973430827;34930.301393972484;35647.64352356443;36171.91484255477;40101.59898400979;42500;34206.82896585501;35178.64821351754;36759.26481470302;36999.81500092482;37446.43830342602;35181.120471988404;36015;36072.639273606925;36915.446268306536;36996.260074797814;36762.448563271035;37010.44484332791;37855.485780568466;38624.42063369108;38849.8345049649;29053.12840614785;31595.84202078975;31632.683673162974;31672.841635791672;31674.524882127247;23553.293401197992;23558.764412355657;24144.517109657358;24169.51660966806;24205.63691544593 05:42:32 INFO - PROCESS | 1662 | |2;jquery.html;369.9130704284491;379.7417755925969;389.8927794856414;400.33943992412514;403.1936127744511;18479.815201847978;20036.59926801463;20631;20754.688679669816;20792.856392898404;11975.461104250307;12303.446344914479;12303.876961230386;12378.566750163745;20250.89874550629;5165.8450246492475;5358.946410535903;5398.541124004464;5400.891982160374;5410.648307859996;3860.691144708431;4105.240530501852;5093.261477085839;5850.590458667895;6102.298235702907;5320.787168513255;5611.214429979786;6096.969515152418;6101.267847858263;6112.105247373306;6640.33596640337;6656.400923916846;6659.966700166468;6669.533132680738;6685.097511835937;3826.2730081284467;4064.410660454247;4066.755994640331;5198.116320225571;5810.82567522975;13657.385417656229;13713.628637136306;13754.862451375559;13913.721725565432;14002.92998535011;1977.604479104185;2135.4554588579967;2161.5460753241837;2168.5229249565227;2196.176433837311;9862.013798620152;10239.078482936497;10273.28087033908;10363.067323940806;10379.532921018572;1738.8784234169016;1769.8141695121956;1789.6331252093419;1801.6937120689515;1812.0939530234882;107574.46212768886;113178;113515;114748;115977.42011289974;9571.234301256021;11437.485313160927;11568.942155289338;11644.2533619956;11752.529898804123;15333.233338333039;15352.078875267296;15390.692186156439;15397.615059623598;15437.459688911058;8420.410571260076;8610.182032707007;8612.698555550525;8705.695300664573;8706.608202630898;6923.6884340204815;8294;8319.417640765208;8325.66697332112;8450.915490845136;3819.25524522721;4510.8421205257655;4630.166570017362;4640.280756482751;4679.555442232982;1798.4784412520485;1861.5811442425618;1875.8217969292896;1984.484034151131;1988.642044432016;887.8845750052452;958.5446912716404;967.8161149381594;970.4856426094182;1030.0266248395194;18835.340763073225;19511.414657560297;19845.702314465296;19912.30306939279;19992.800071999383;865.9610317535726;981.6809536900536;992.3748038735695;1006.3157053203892;1017.4709151241314;8131.105578386373;10314.896851031544;10764.461776911123;10806.945965270123;10819.459027048617;488825;549624;586831;619208;638259.5131316449;119993;120429.19356209664;123134;128284.07573886399;130439;991.3209451525584;1011.1455819832377;1011.898810118997;1013.9138173255355;1015.456730649114;18007.909960450637;18011.459656210336;18017.009064501577;18104.094795260447;18189.545261368043;49742.751286243336;50314.74842625763;50585;51037.72405689888;51506.48493515167;52916.4708352927;70515.64742176257;72005.91991120033;73523;74191;6882.827929301808;7031.683574239274;7344.779656610311;7463.402927765657;8311.376646751396;10758.515866785858;11710.00464960488;12637.431315590637;12690.238585684889;12708.491660333482;8889.511076890833;10737.516811743333;10897.782044359226;10950.123990080616;11222.326660400402;10966.616168434066;10990.725231868948;11079.667609971713;11184.440777960906;11303.9826415623;10134.695959121238;10905.127589792955;11010.064144547803;11310.94344528272;11436.71408214768;7606.695732170651;8094.109647938604;8202.753917382488;8355;8456.365772566958;9105.863412048957;11057.889421105687;11073.224874258725;11387.829182562435;11420.600278990196 05:42:32 INFO - PROCESS | 1662 | |3;mootools.html;1416.3626368134342;1601.8077830660322;1615.838416158384;1881.877677950933;2023.7369142011537;7886.171951945049;8543.145685431453;8606.268467180282;8782.692605758784;8795.032546419896;8438.620262088221;8641.351898607614;8650.697225597105;8651.221390074892;8668.52323122228;2182.3998400439846;2393.664886915833;2460.151247819504;2485.1674688979215;2487.813413993949;2490.7509249075038;2510.309664842174;2515.635232891239;2516.924492265235;2517.874106294678;2427.587310157269;2476.9009239630395;2477.4054226985486;2477.5168842075805;2477.7398373170827;2124.819390351814;2357.092519380034;2433.7809597136256;2446.1193970170725;2448.926532204037;2448.3879030242438;2464.162184857157;2483.8261321707487;2486.5275597636573;2487.6517287579754;8614.827703445959;8780.341474389383;8789.516576588285;8793.12068793122;8796.340274479375;5188.507091826271;5367.409584945653;5389.946100538984;5391.056565101131;5421.132618780976;3571.928561428783;3585.7310701697215;3603.6036036036016;3649.6350364963555;3675.3751862183494;1036.424784244744;1048.916086713061;1055.2138656700731;1066.6533376652542;1088.7931293054373;11435.313881167156;11438.771224575461;11452;11479.65561033162;11518.251313664585;4629.467611224685;4654.930176047362;4824.0834241494;4865.489123642037;4867.5132486751045;9750.902490974999;9803.411795292162;9804.607815687436;9805.705828825146;9831.705048848546;5344.038073146871;5355.571554275649;5357.357117145967;5387.191921211771;5423.240746295522;4402.141582391467;4554.3851580036935;4745.525447455227;4924.03981223658;4924.63065270099;3439.243366459375;3940.7438516496336;3993.7603743775467;4060.6548443382644;4120.649744771668;1340.6514306280437;1361.8706222908809;1364.522417154008;1373.3064802274987;1373.7458570164551;848.6096395658067;851.4635779458902;863.4603372891943;907.1427501011481;922.372786505183;5639.577031722637;5642.351129620064;5876.823695289148;5915.349311575723;5944.6730429826775;864.3733293362262;930.8603709443638;980.4803454169302;985.3348989432247;996.3473924579412;3780.1305699689224;3842.8270727817317;3939.074317535377;4016.9196616067516;4033.415154802537;9220;10077.54651040705;10315.690529284133;10549.103326217357;10624.043836054792;10467.738306542398;10471.790564188674;10489.423081730425;10594.258401911793;10597;7797.415193860483;8065.556394398364;8147;8147.144549822302;8157.592120393957;5632.605717599728;5697.54419646419;5755.223044888887;5817.563682723728;5822.330432000204;9769;9817.705468835946;9932.25508086882;9933.602655893972;9947.253955953478;9564.13922746956;9685.41887486753;9780.902190977999;9919.65281215154;10040.69877903664;6410.294867564658;6652.401283884474;6829.760958366433;6961.89557156633;7072.823179420556;8164.83670326602;8175.959120204361;8237.464564803508;8246.670133194844;8248.46384984974;6271;7176.928230717835;7254.637268136466;7279;7415.888761668687;7210.531315464478;7213.67538460781;7236.167840698387;7292.171609904843;7383.483156179016;5944.346121926671;6750.3924646782025;6957;6987.475939304674;6989.37095661393;4801.567858892577;4860.295257187759;4905.190643543775;4970.552650261494;5113.386393632639;4878.707277563358;4934.087193869145;4934.950650493449;4944.579710724484;5158.716270605153 05:42:32 INFO - PROCESS | 1662 | |4;prototype.html;303.33872158694066;310.7467414057543;313.4154801295583;314.67274035003595;321.24988152663525;5168.767405466753;5300.390455097665;5534.474224948628;5534.8653526027165;5952.404759524045;5413.296271484702;5424.620276580641;5574.749136288867;5894.764209431628;5927.229460170182;3738.8130593470355;3963.146534495159;4215.810288537015;4272.444582204309;4329.372241025049;4257.595528424795;4377.62790162835;4462.286034234523;4464.776761161945;4495.943453288474;4181.477315335583;4456.5766252205985;4461.107778444324;4467.463904331485;4470.396496472967;3921.4706014687936;4174.833006679744;4340.544242854487;4341.156542464691;4381.452318460192;3122.859471323773;3127.8123312601315;3714.182879766447;3742.8315725792404;3762.3792074307707;4461.732296062247;4824.758762061918;5465.207544906006;5628.380878103405;5656.830295091154;4254.489461264637;4816.181249187646;5019.218177546992;5042.218456139268;5045.772940217699;5144.845654630367;5617.269754931874;6145.938540614626;6168.84577885552;6171.907421388638;3543.5039094526787;4137.924139723664;4153.584641535853;4155.335146376596;4159.459270294872;5814;5869.413058694139;6033.155358249848;6486.902696459557;6582.243042050178;4189.350650649154;4226.408302837605;4228.830846766156;4245.405643209953;4249.617534421917;3790.8104594770703;4288.31386978082;4306.547812479707;4310.633596144363;4312.3181959036;4847.321375007431;5010.473900240495;5030.823921162815;5037.29477873098;5093.617978651616;6201.255849298113;6219.595726277777;6239.688015599202;6241.750329986749;6256.311805701369;1442.1203066129654;1467.772495263236;1468.0164289925776;1469.595861138174;1471.3820195517908;878.4202426398547;886.3441053620274;915.4827522449795;954.5752140297501;977.2426369563503;5673.687947162945;5674.716264186856;5765.423457654285;5778.653280803165;5802.47777700009;5066.240063990357;5317.282166907418;5818.5345172386105;5971.193888824953;6381.680915954184;5510.311211098613;5757.366689664133;5789.218455508452;5846.561507886926;5897.52819774417;3150.574672419194;3290.703836654665;3410.4202285611505;3433.3305005524185;3446.379651662675;6325.319263744887;6601.207855057328;6800.489963252677;6824.658767061627;6860.348266914635;6638.701258443381;6643.933560664332;6654.6672666366485;6701.396874281338;6725.226598941086;5721.370649228665;5969.31352894414;5982.042873140364;6756.864862702719;6796.728130874809;6462.450691691259;6473.320301368289;6473.802346565901;6475.417212450902;6484.870302593828;6334.746610135543;6362.297496318152;6369.45859601939;6402.903956440564;6444.742210311722;5899.026660600953;6369.649669268049;6546.18172728409;6769.221539522821;6781.593104413751;4182.28901086822;4182.372644103409;4223.387608796768;4224.8098835551855;4240.236757383701;5948.256467941507;6257.7184026719815;6357.491400688026;6431.938730109479;6474.417302442803;5851.765929362778;6033.818985430444;6112.8777424452155;6165.815025549241;6260.937390626035;4912.70523768575;5431.6740995540395;5847.590668653153;6176.35148309421;6191.19514463117;5862.970685146547;6038.0074575389135;6061.605995610271;6083.726232319467;6106.603070800384;4650.627949764078;5485.917711234414;6162.008772893971;6196.566240363131;6208.627482351073;4936.580390666833;5353.304070470814;5871.706414679164;6094.512439004958;6104.023356262976 05:42:32 INFO - PROCESS | 1662 | |5;yui.html;648.6562122075301;651.0559688451744;708.7342246657504;732.5787672088551;741.2846603028077;14773.926130369333;14923.030003049795;15224;15345.693086138284;15408.460703875367;9945.502724863763;14074;14085.929570352135;14152;14194.077384969969;726.2555880222761;744.5421066044371;895.3329769321864;908.0284096017248;920.4799288402065;767.6161919040479;917.9770505737376;920.8020275640736;921.8340698674236;922.4603606889978;975.4098770244007;976.1166144639113;977.8484334928097;978.1148061004767;978.442287895896;754.6868049759344;777.249953794591;778.0818634011864;778.1051790440981;975.6243846119224;704.5983789240136;725.905632267807;726.600369796615;727.581640556682;728.9526180798231;14999.925000374928;15062.698746025128;15086.471973480986;15088;15096.396144154221;12457.252564846047;12470.314132722697;12497.875021249762;12641.747165056739;12823.743525129445;8642.43824151428;9848.813386968917;9864.605415783431;9978.251631127694;10367.222458315657;3525.8589656413715;3551.627079156677;3576.7317451191266;3595.388783906742;3635.418333066723;77122;77557;78909.99999999943;79196;79360;9465.716028519155;9528.094830991045;9540.236781057498;9716.902830971741;10061.39631622105;21572.137114515557;21573.784262157176;21583.352499425044;21588.89205553962;21590.352289431026;7547.28300811422;7711.344535714415;7720.189380115119;7754.844903101906;7886.64510097047;4153.522344930311;4160.209560183555;4267.253230684618;4268.317069268902;4286.507051689034;3498.1429549760473;3573.6247693992277;3591.174029973121;3595.8381872815785;3604.4052731299043;653.9901901471482;656.8226578823691;682.0791930893354;698.849747304332;710.5026481462996;505.61825821505266;542.1542393865503;570.5236127833306;578.7354630133173;579.6840721806625;7791.571463569559;8009.31920786728;8119.512829230265;8322.375821813388;8337.207965243293;504.35946348138395;558.6815515156403;589.602018637418;599.9820005399845;619.4022768028784;3391.626921038733;3591.6049234584175;3815.4276858471453;3879.903002424962;4010.498687664042;59020.70489647524;79805.60097199593;81630;82044;85957.57021214854;55939.720301399044;58872;61403.385966139766;71429;71703;64362.6781866097;68045;68127.31872681309;68623;69663.30336696669;8095.55474448911;8112.675492980451;8317.334613231049;8361.916380836357;8386.412951093365;41733.58266417297;41795.582044179166;42340.576594234895;42373.36439953341;42906.1418771629;60029.69985150046;61086;61309.693451532454;61435.771284573166;61724.69137654283;10992.450377481255;11177.497012634289;11178.832317515082;11311.377874216669;11332.320060796379;11496.367699776592;11793.351365674971;11861.05111591088;11929.463174157358;12032.75934481288;11319.207655464368;11322;11685.824712629148;11868.94231967111;11894.702632434259;11613.187076904536;11845.881541184823;11978.940105299418;11986.400679966142;12353.444095015926;11291.661250162508;11587.478563464496;11801.468933898166;11826.763464730486;11896.167268291136;9553.140217380469;9611.711648650551;9764.218862491125;9790.363626364548;9829.066238707312;9598.856017159887;9645.9035409645;9664.130228279488;9675.565174363;9699.709008729467 05:42:32 INFO - PROCESS | 1662 | __end_tp_report 05:42:32 INFO - PROCESS | 1662 | __start_cc_report 05:42:32 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1212 05:42:32 INFO - PROCESS | 1662 | __end_cc_report 05:42:32 INFO - PROCESS | 1662 | __startTimestamp1460551352514__endTimestamp 05:42:32 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | ------- Summary: start ------- 05:42:32 INFO - PROCESS | 1662 | Number of tests: 6 05:42:32 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5700.52 Median:5900.38 stddev:627.73 (10.6%) stddev-sans-first:602.36 05:42:32 INFO - PROCESS | 1662 | Values: 3366.6 3438.1 3469.5 3475.8 3496.0 5580.6 5671.5 5688.5 5695.4 5696.1 5692.7 5722.3 5732.7 5842.8 5845.1 5042.9 5050.6 5060.0 5074.6 5177.0 5229.4 5250.1 5255.6 5279.9 5296.7 4982.2 5070.3 5088.4 5088.9 5199.6 5118.9 5125.9 5144.4 5154.5 5155.5 5070.1 5105.7 5127.4 5141.5 5172.8 5489.1 5571.7 5602.0 5604.4 5678.1 6168.0 6205.3 6218.1 6225.6 6233.5 6147.6 6224.7 6237.2 6260.7 6262.0 5683.0 5732.6 5776.5 5798.3 5820.0 6249.0 6252.0 6255.6 6268.0 6272.6 6057.6 6062.9 6067.3 6069.6 6092.6 5962.7 6055.8 6144.0 6154.5 6224.4 6161.6 6166.3 6186.0 6188.3 6207.0 6202.0 6202.5 6207.0 6224.9 6225.6 4794.7 4872.4 4874.7 4917.2 4961.1 4409.6 4415.5 4434.4 4448.4 4488.7 5550.5 5575.4 5605.0 5611.8 5615.9 6100.5 6165.4 6175.6 6252.6 6279.0 5582.6 5600.4 5606.9 5626.0 5662.4 5313.6 5341.8 5342.3 5342.7 5345.9 6196.8 6201.7 6254.5 6293.3 6305.5 6244.6 6257.7 6270.9 6274.2 6279.0 6230.4 6273.2 6310.3 6320.2 6327.5 6022.2 6067.9 6135.3 6137.7 6180.8 6165.5 6207.8 6218.2 6232.9 6240.9 5133.5 6066.0 6071.6 6074.1 6088.6 5866.8 5988.6 5994.8 6022.7 6109.8 5875.5 5877.2 5883.5 5900.4 5912.9 5950.1 6054.1 6098.5 6109.5 6111.4 5776.4 5857.0 5920.3 5950.4 5955.5 05:42:32 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:63558.17 Median:19189.40 stddev:135994.44 (708.7%) stddev-sans-first:136293.54 05:42:32 INFO - PROCESS | 1662 | Values: 507.3 507.5 569.9 571.0 590.8 29005.0 38475.8 39593.0 39594.6 39602.2 41694.6 41926.0 42087.4 42176.4 42268.4 7099.8 9399.2 9653.3 9653.6 9657.0 8572.4 11475.0 11767.9 11777.2 11785.4 9777.0 11397.5 11489.8 11497.3 11528.3 8482.8 11427.4 11528.1 11532.8 11637.3 11294.7 11452.8 11465.2 11466.8 11472.4 37971.2 38649.6 38734.4 38778.6 38841.8 3122.9 3156.7 3173.0 3236.7 3448.5 28518.0 28947.7 29169.6 29635.9 29793.6 2662.3 2719.1 2729.7 2742.2 2780.3 362049.0 362488.0 362871.0 362978.0 363097.0 60710.7 61009.7 61082.4 61167.7 61231.7 66928.7 68791.7 68805.7 68852.3 69015.2 14433.7 15242.8 16005.4 16208.0 16239.0 11522.7 11763.0 12472.2 12520.6 12769.7 17910.9 18801.7 19178.6 19182.2 19258.5 7054.3 8122.7 8150.5 8204.4 8237.6 913.2 983.0 987.5 1013.4 1097.3 23259.9 27095.3 27624.4 28168.2 28244.9 1077.4 1083.6 1151.8 1225.9 1272.7 12715.6 13316.6 14481.3 14622.6 14982.3 636820.0 640922.0 649481.0 651730.0 652926.0 59569.0 60478.7 60552.4 60552.4 60658.0 1305.2 1339.0 1429.5 1441.9 1473.9 28807.8 28834.4 28987.3 29438.0 29541.3 48933.8 49492.8 49874.8 50147.7 50199.2 474807.0 476763.0 476901.0 477569.0 477662.0 22914.9 23559.9 23596.2 24294.8 26034.2 34930.3 35647.6 36171.9 40101.6 42500.0 34206.8 35178.6 36759.3 36999.8 37446.4 35181.1 36015.0 36072.6 36915.4 36996.3 36762.4 37010.4 37855.5 38624.4 38849.8 29053.1 31595.8 31632.7 31672.8 31674.5 23553.3 23558.8 24144.5 24169.5 24205.6 05:42:32 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:33180.76 Median:20692.84 stddev:96644.78 (467.0%) stddev-sans-first:96884.50 05:42:32 INFO - PROCESS | 1662 | Values: 369.9 379.7 389.9 400.3 403.2 18479.8 20036.6 20631.0 20754.7 20792.9 11975.5 12303.4 12303.9 12378.6 20250.9 5165.8 5358.9 5398.5 5400.9 5410.6 3860.7 4105.2 5093.3 5850.6 6102.3 5320.8 5611.2 6097.0 6101.3 6112.1 6640.3 6656.4 6660.0 6669.5 6685.1 3826.3 4064.4 4066.8 5198.1 5810.8 13657.4 13713.6 13754.9 13913.7 14002.9 1977.6 2135.5 2161.5 2168.5 2196.2 9862.0 10239.1 10273.3 10363.1 10379.5 1738.9 1769.8 1789.6 1801.7 1812.1 107574.5 113178.0 113515.0 114748.0 115977.4 9571.2 11437.5 11568.9 11644.3 11752.5 15333.2 15352.1 15390.7 15397.6 15437.5 8420.4 8610.2 8612.7 8705.7 8706.6 6923.7 8294.0 8319.4 8325.7 8450.9 3819.3 4510.8 4630.2 4640.3 4679.6 1798.5 1861.6 1875.8 1984.5 1988.6 887.9 958.5 967.8 970.5 1030.0 18835.3 19511.4 19845.7 19912.3 19992.8 866.0 981.7 992.4 1006.3 1017.5 8131.1 10314.9 10764.5 10806.9 10819.5 488825.0 549624.0 586831.0 619208.0 638259.5 119993.0 120429.2 123134.0 128284.1 130439.0 991.3 1011.1 1011.9 1013.9 1015.5 18007.9 18011.5 18017.0 18104.1 18189.5 49742.8 50314.7 50585.0 51037.7 51506.5 52916.5 70515.6 72005.9 73523.0 74191.0 6882.8 7031.7 7344.8 7463.4 8311.4 10758.5 11710.0 12637.4 12690.2 12708.5 8889.5 10737.5 10897.8 10950.1 11222.3 10966.6 10990.7 11079.7 11184.4 11304.0 10134.7 10905.1 11010.1 11310.9 11436.7 7606.7 8094.1 8202.8 8355.0 8456.4 9105.9 11057.9 11073.2 11387.8 11420.6 05:42:32 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5636.83 Median:5266.27 stddev:3089.39 (58.7%) stddev-sans-first:3081.77 05:42:32 INFO - PROCESS | 1662 | Values: 1416.4 1601.8 1615.8 1881.9 2023.7 7886.2 8543.1 8606.3 8782.7 8795.0 8438.6 8641.4 8650.7 8651.2 8668.5 2182.4 2393.7 2460.2 2485.2 2487.8 2490.8 2510.3 2515.6 2516.9 2517.9 2427.6 2476.9 2477.4 2477.5 2477.7 2124.8 2357.1 2433.8 2446.1 2448.9 2448.4 2464.2 2483.8 2486.5 2487.7 8614.8 8780.3 8789.5 8793.1 8796.3 5188.5 5367.4 5389.9 5391.1 5421.1 3571.9 3585.7 3603.6 3649.6 3675.4 1036.4 1048.9 1055.2 1066.7 1088.8 11435.3 11438.8 11452.0 11479.7 11518.3 4629.5 4654.9 4824.1 4865.5 4867.5 9750.9 9803.4 9804.6 9805.7 9831.7 5344.0 5355.6 5357.4 5387.2 5423.2 4402.1 4554.4 4745.5 4924.0 4924.6 3439.2 3940.7 3993.8 4060.7 4120.6 1340.7 1361.9 1364.5 1373.3 1373.7 848.6 851.5 863.5 907.1 922.4 5639.6 5642.4 5876.8 5915.3 5944.7 864.4 930.9 980.5 985.3 996.3 3780.1 3842.8 3939.1 4016.9 4033.4 9220.0 10077.5 10315.7 10549.1 10624.0 10467.7 10471.8 10489.4 10594.3 10597.0 7797.4 8065.6 8147.0 8147.1 8157.6 5632.6 5697.5 5755.2 5817.6 5822.3 9769.0 9817.7 9932.3 9933.6 9947.3 9564.1 9685.4 9780.9 9919.7 10040.7 6410.3 6652.4 6829.8 6961.9 7072.8 8164.8 8176.0 8237.5 8246.7 8248.5 6271.0 7176.9 7254.6 7279.0 7415.9 7210.5 7213.7 7236.2 7292.2 7383.5 5944.3 6750.4 6957.0 6987.5 6989.4 4801.6 4860.3 4905.2 4970.6 5113.4 4878.7 4934.1 4935.0 4944.6 5158.7 05:42:32 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4985.27 Median:5622.83 stddev:1570.29 (27.9%) stddev-sans-first:1534.87 05:42:32 INFO - PROCESS | 1662 | Values: 303.3 310.7 313.4 314.7 321.2 5168.8 5300.4 5534.5 5534.9 5952.4 5413.3 5424.6 5574.7 5894.8 5927.2 3738.8 3963.1 4215.8 4272.4 4329.4 4257.6 4377.6 4462.3 4464.8 4495.9 4181.5 4456.6 4461.1 4467.5 4470.4 3921.5 4174.8 4340.5 4341.2 4381.5 3122.9 3127.8 3714.2 3742.8 3762.4 4461.7 4824.8 5465.2 5628.4 5656.8 4254.5 4816.2 5019.2 5042.2 5045.8 5144.8 5617.3 6145.9 6168.8 6171.9 3543.5 4137.9 4153.6 4155.3 4159.5 5814.0 5869.4 6033.2 6486.9 6582.2 4189.4 4226.4 4228.8 4245.4 4249.6 3790.8 4288.3 4306.5 4310.6 4312.3 4847.3 5010.5 5030.8 5037.3 5093.6 6201.3 6219.6 6239.7 6241.8 6256.3 1442.1 1467.8 1468.0 1469.6 1471.4 878.4 886.3 915.5 954.6 977.2 5673.7 5674.7 5765.4 5778.7 5802.5 5066.2 5317.3 5818.5 5971.2 6381.7 5510.3 5757.4 5789.2 5846.6 5897.5 3150.6 3290.7 3410.4 3433.3 3446.4 6325.3 6601.2 6800.5 6824.7 6860.3 6638.7 6643.9 6654.7 6701.4 6725.2 5721.4 5969.3 5982.0 6756.9 6796.7 6462.5 6473.3 6473.8 6475.4 6484.9 6334.7 6362.3 6369.5 6402.9 6444.7 5899.0 6369.6 6546.2 6769.2 6781.6 4182.3 4182.4 4223.4 4224.8 4240.2 5948.3 6257.7 6357.5 6431.9 6474.4 5851.8 6033.8 6112.9 6165.8 6260.9 4912.7 5431.7 5847.6 6176.4 6191.2 5863.0 6038.0 6061.6 6083.7 6106.6 4650.6 5485.9 6162.0 6196.6 6208.6 4936.6 5353.3 5871.7 6094.5 6104.0 05:42:32 INFO - PROCESS | 1662 | 05:42:32 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:16993.22 Median:61356.54 stddev:22849.71 (37.2%) stddev-sans-first:22880.85 05:42:32 INFO - PROCESS | 1662 | Values: 648.7 651.1 708.7 732.6 741.3 14773.9 14923.0 15224.0 15345.7 15408.5 9945.5 14074.0 14085.9 14152.0 14194.1 726.3 744.5 895.3 908.0 920.5 767.6 918.0 920.8 921.8 922.5 975.4 976.1 977.8 978.1 978.4 754.7 777.2 778.1 778.1 975.6 704.6 725.9 726.6 727.6 729.0 14999.9 15062.7 15086.5 15088.0 15096.4 12457.3 12470.3 12497.9 12641.7 12823.7 8642.4 9848.8 9864.6 9978.3 10367.2 3525.9 3551.6 3576.7 3595.4 3635.4 77122.0 77557.0 78910.0 79196.0 79360.0 9465.7 9528.1 9540.2 9716.9 10061.4 21572.1 21573.8 21583.4 21588.9 21590.4 7547.3 7711.3 7720.2 7754.8 7886.6 4153.5 4160.2 4267.3 4268.3 4286.5 3498.1 3573.6 3591.2 3595.8 3604.4 654.0 656.8 682.1 698.8 710.5 505.6 542.2 570.5 578.7 579.7 7791.6 8009.3 8119.5 8322.4 8337.2 504.4 558.7 589.6 600.0 619.4 3391.6 3591.6 3815.4 3879.9 4010.5 59020.7 79805.6 81630.0 82044.0 85957.6 55939.7 58872.0 61403.4 71429.0 71703.0 64362.7 68045.0 68127.3 68623.0 69663.3 8095.6 8112.7 8317.3 8361.9 8386.4 41733.6 41795.6 42340.6 42373.4 42906.1 60029.7 61086.0 61309.7 61435.8 61724.7 10992.5 11177.5 11178.8 11311.4 11332.3 11496.4 11793.4 11861.1 11929.5 12032.8 11319.2 11322.0 11685.8 11868.9 11894.7 11613.2 11845.9 11978.9 11986.4 12353.4 11291.7 11587.5 11801.5 11826.8 11896.2 9553.1 9611.7 9764.2 9790.4 9829.1 9598.9 9645.9 9664.1 9675.6 9699.7 05:42:32 INFO - PROCESS | 1662 | -------- Summary: end -------- 05:42:32 INFO - PROCESS | 1662 | 05:42:33 INFO - TEST-INFO | 1662: exit 0 05:42:33 INFO - TEST-OK | dromaeo_css | took 1115468ms 05:42:33 INFO - TEST-START | kraken 05:42:33 INFO - operating with platform_type : mac_ 05:42:33 INFO - Initialising browser for kraken test... 05:42:33 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpqkGAED/profile http://localhost:49270/getInfo.html) 05:42:35 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:42:35 INFO - PROCESS | 1672 | colorDepth:24 05:42:35 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:42:35 INFO - PROCESS | 1672 | __metrics 05:42:35 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:42:35 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:42:36 INFO - TEST-INFO | 1672: exit 0 05:42:36 INFO - Browser initialized. 05:42:36 INFO - Running cycle 1/1 for kraken test... 05:42:36 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpqkGAED/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:48 INFO - PROCESS | 1675 | RSS: Main: 237477888 05:42:48 INFO - PROCESS | 1675 | 05:42:50 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:42:51 INFO - PROCESS | 1675 | RSS: Main: 285671424 05:42:51 INFO - PROCESS | 1675 | 05:42:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:42:54 INFO - PROCESS | 1675 | RSS: Main: 298917888 05:42:54 INFO - PROCESS | 1675 | 05:42:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:42:59 INFO - PROCESS | 1675 | RSS: Main: 385794048 05:42:59 INFO - PROCESS | 1675 | 05:43:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:43:01 INFO - PROCESS | 1675 | RSS: Main: 286244864 05:43:01 INFO - PROCESS | 1675 | 05:43:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:04 INFO - PROCESS | 1675 | RSS: Main: 290664448 05:43:04 INFO - PROCESS | 1675 | 05:43:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:07 INFO - PROCESS | 1675 | RSS: Main: 327090176 05:43:07 INFO - PROCESS | 1675 | 05:43:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:11 INFO - PROCESS | 1675 | RSS: Main: 328359936 05:43:11 INFO - PROCESS | 1675 | 05:43:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:43:14 INFO - PROCESS | 1675 | RSS: Main: 326086656 05:43:14 INFO - PROCESS | 1675 | 05:43:16 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:16 INFO - PROCESS | 1675 | RSS: Main: 319655936 05:43:16 INFO - PROCESS | 1675 | 05:43:18 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:19 INFO - PROCESS | 1675 | RSS: Main: 326197248 05:43:19 INFO - PROCESS | 1675 | 05:43:21 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:22 INFO - PROCESS | 1675 | RSS: Main: 329228288 05:43:22 INFO - PROCESS | 1675 | 05:43:25 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:25 INFO - PROCESS | 1675 | RSS: Main: 334262272 05:43:25 INFO - PROCESS | 1675 | 05:43:28 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:43:29 INFO - PROCESS | 1675 | RSS: Main: 332029952 05:43:29 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:43:31 INFO - PROCESS | 1675 | RSS: Main: 395948032 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | __start_tp_report 05:43:31 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:43:31 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:43:31 INFO - PROCESS | 1675 | |i|pagename|runs| 05:43:31 INFO - PROCESS | 1675 | |0;ai-astar;113;111;111;112;112;113;118;116;164;167 05:43:31 INFO - PROCESS | 1675 | |1;audio-beat-detection;154;114;143;167;120;145;144;113;163;113 05:43:31 INFO - PROCESS | 1675 | |2;audio-dft;216;253;189;182;186;183;184;183;186;186 05:43:31 INFO - PROCESS | 1675 | |3;audio-fft;78;72;85;91;55;58;62;76;83;56 05:43:31 INFO - PROCESS | 1675 | |4;audio-oscillator;95;97;136;79;77;76;126;79;76;125 05:43:31 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;89;86;91;87;89;86;88;128;83;116 05:43:31 INFO - PROCESS | 1675 | |6;imaging-darkroom;95;95;96;96;106;123;95;96;94;95 05:43:31 INFO - PROCESS | 1675 | |7;imaging-desaturate;86;84;85;85;87;85;87;86;86;87 05:43:31 INFO - PROCESS | 1675 | |8;json-parse-financial;57;58;58;57;60;60;58;74;62;57 05:43:31 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;62;97;104;104;82;67;67;66;66 05:43:31 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;86;86;85;88;88;86;100;113;114;87 05:43:31 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;144;144;147;149;145;142;143;162;200;156 05:43:31 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;169;169;167;179;169;170;168;176;165;161 05:43:31 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;68;70;68;67;69;66;69;69;69;66 05:43:31 INFO - PROCESS | 1675 | __end_tp_report 05:43:31 INFO - PROCESS | 1675 | __start_cc_report 05:43:31 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1967 05:43:31 INFO - PROCESS | 1675 | __end_cc_report 05:43:31 INFO - PROCESS | 1675 | __startTimestamp1460551411358__endTimestamp 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:43:31 INFO - PROCESS | 1675 | Number of tests: 14 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:123.70 Median:114.50 stddev:22.15 (19.3%) stddev-sans-first:23.15 05:43:31 INFO - PROCESS | 1675 | Values: 113.0 111.0 111.0 112.0 112.0 113.0 118.0 116.0 164.0 167.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:144.50 stddev:21.03 (14.6%) stddev-sans-first:21.45 05:43:31 INFO - PROCESS | 1675 | Values: 154.0 114.0 143.0 167.0 120.0 145.0 144.0 113.0 163.0 113.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:194.80 Median:186.00 stddev:22.76 (12.2%) stddev-sans-first:22.81 05:43:31 INFO - PROCESS | 1675 | Values: 216.0 253.0 189.0 182.0 186.0 183.0 184.0 183.0 186.0 186.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:71.60 Median:77.00 stddev:13.09 (17.0%) stddev-sans-first:13.68 05:43:31 INFO - PROCESS | 1675 | Values: 78.0 72.0 85.0 91.0 55.0 58.0 62.0 76.0 83.0 56.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:78.00 stddev:23.75 (30.5%) stddev-sans-first:25.19 05:43:31 INFO - PROCESS | 1675 | Values: 95.0 97.0 136.0 79.0 77.0 76.0 126.0 79.0 76.0 125.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:87.50 stddev:15.03 (17.2%) stddev-sans-first:15.81 05:43:31 INFO - PROCESS | 1675 | Values: 89.0 86.0 91.0 87.0 89.0 86.0 88.0 128.0 83.0 116.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:99.10 Median:95.00 stddev:9.07 (9.6%) stddev-sans-first:9.50 05:43:31 INFO - PROCESS | 1675 | Values: 95.0 95.0 96.0 96.0 106.0 123.0 95.0 96.0 94.0 95.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.03 (1.2%) stddev-sans-first:1.09 05:43:31 INFO - PROCESS | 1675 | Values: 86.0 84.0 85.0 85.0 87.0 85.0 87.0 86.0 86.0 87.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.00 stddev:5.15 (8.7%) stddev-sans-first:5.34 05:43:31 INFO - PROCESS | 1675 | Values: 57.0 58.0 58.0 57.0 60.0 60.0 58.0 74.0 62.0 57.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:77.80 Median:66.50 stddev:17.45 (26.2%) stddev-sans-first:17.66 05:43:31 INFO - PROCESS | 1675 | Values: 63.0 62.0 97.0 104.0 104.0 82.0 67.0 67.0 66.0 66.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:86.00 stddev:11.48 (13.3%) stddev-sans-first:11.87 05:43:31 INFO - PROCESS | 1675 | Values: 86.0 86.0 85.0 88.0 88.0 86.0 100.0 113.0 114.0 87.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:148.00 stddev:17.63 (11.9%) stddev-sans-first:18.38 05:43:31 INFO - PROCESS | 1675 | Values: 144.0 144.0 147.0 149.0 145.0 142.0 143.0 162.0 200.0 156.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.00 stddev:5.10 (3.0%) stddev-sans-first:5.41 05:43:31 INFO - PROCESS | 1675 | Values: 169.0 169.0 167.0 179.0 169.0 170.0 168.0 176.0 165.0 161.0 05:43:31 INFO - PROCESS | 1675 | 05:43:31 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 05:43:31 INFO - PROCESS | 1675 | Values: 68.0 70.0 68.0 67.0 69.0 66.0 69.0 69.0 69.0 66.0 05:43:31 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:43:31 INFO - PROCESS | 1675 | 05:43:32 INFO - TEST-INFO | 1675: exit 0 05:43:32 INFO - TEST-OK | kraken | took 59029ms 05:43:32 INFO - SUITE-END | took 1174s 05:43:32 INFO - Completed test suite (00:19:34) 05:43:32 INFO - javascript benchmark 05:43:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.5623468949034, 3438.123278563966, 3469.5142680024787, 3475.8262086895666, 3495.9825200873993, 5580.637258578189, 5671.546276297897, 5688.459596338346, 5695.401982791809, 5696.060150075238, 5692.686902220376, 5722.284714410699, 5732.742026608813, 5842.766289348421, 5845.0647896336595, 5042.924356134661, 5050.595952323823, 5060.0, 5074.644774865761, 5177.0, 5229.372475302969, 5250.133727934886, 5255.579553635719, 5279.868003299929, 5296.708681022542, 4982.227754698028, 5070.340855688773, 5088.4148322942965, 5088.931324421876, 5199.6360254782185, 5118.923216151761, 5125.897482050338, 5144.382674079097, 5154.53609175176, 5155.510226528511, 5070.062038522885, 5105.719185444799, 5127.410347810012, 5141.485851414828, 5172.793088276502, 5489.094299440588, 5571.749271282802, 5601.991641504527, 5604.439556044404, 5678.119891416837, 6167.969160154171, 6205.255369355661, 6218.098375735538, 6225.564210505267, 6233.501319894398, 6147.631142131441, 6224.688765561749, 6237.157983672191, 6260.718267677966, 6262.0, 5683.0, 5732.627379220337, 5776.508996735282, 5798.275215598051, 5820.039693450618, 6249.031400132896, 6252.030935205051, 6255.624662520263, 6267.9971204607955, 6272.5922815016875, 6057.636541807417, 6062.878742425127, 6067.332593414721, 6069.635821850615, 6092.634441933498, 5962.672053037038, 6055.757769689251, 6143.986242270064, 6154.5076393888385, 6224.37756224383, 6161.599496032743, 6166.290876549254, 6185.969070154621, 6188.257409110845, 6207.0, 6201.968990155111, 6202.503799696104, 6207.006878899445, 6224.875502490016, 6225.564210505312, 4794.7362895040405, 4872.366592342973, 4874.731889746098, 4917.164082106051, 4961.08219979305, 4409.625181859514, 4415.51429342772, 4434.379186913835, 4448.377227188196, 4488.708233964782, 5550.500454959073, 5575.386707462176, 5605.0, 5611.80358687444, 5615.9157612635845, 6100.481459076028, 6165.352637973038, 6175.62946223219, 6252.5935814171935, 6279.026750853625, 5582.553395728332, 5600.411956744565, 5606.915896261559, 5626.0, 5662.433756624305, 5313.601479889024, 5341.786328546815, 5342.252084708144, 5342.679439233659, 5345.946540534623, 6196.81409557714, 6201.658908760061, 6254.499640028877, 6293.339199383999, 6305.527085468608, 6244.562880598496, 6257.68711564429, 6270.905936411049, 6274.1843560336865, 6278.968605157128, 6230.408111229426, 6273.215848018997, 6310.305866354789, 6320.209973753281, 6327.462165715966, 6022.156898034366, 6067.878642427038, 6135.325114237519, 6137.723802428991, 6180.783672571439, 6165.475934545614, 6207.844803879759, 6218.22272215973, 6232.875342493216, 6240.937590624036, 5133.460986596354, 6066.0, 6071.574989750675, 6074.149619053424, 6088.634681918922, 5866.765329386777, 5988.5508586855285, 5994.820155395345, 6022.668753218615, 6109.755609775737, 5875.529957603467, 5877.23595932526, 5883.470487656132, 5900.380460051632, 5912.940870591239, 5950.137230101524, 6054.122152287981, 6098.451139397475, 6109.541784366102, 6111.358307377662, 5776.393478684846, 5857.0, 5920.348761636303, 5950.404959504015, 5955.493783028491], "value": 5661.0259009624915, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.29992610197934, 507.54574655683143, 569.9000928208555, 570.9571782116342, 590.8463799412153, 29005.0, 38475.80762096189, 39593.0, 39594.604053959454, 39602.207955840866, 41694.58305416945, 41926.0, 42087.36868946968, 42176.36735448971, 42268.36597451033, 7099.8225044373785, 9399.248060155189, 9653.27600429967, 9653.565589548487, 9657.034296570322, 8572.399932004762, 11475.0, 11767.882321176807, 11777.175597708163, 11785.351805650685, 9776.951115244414, 11397.544098236061, 11489.770204595903, 11497.252678575866, 11528.250663706875, 8482.83034339316, 11427.371494567795, 11528.077753779677, 11532.827007594893, 11637.301761894314, 11294.661160165208, 11452.828207576893, 11465.197436179471, 11466.770664586746, 11472.426378681115, 37971.24057518862, 38649.61350386488, 38734.418983715266, 38778.61221387778, 38841.8347449577, 3122.8750849965973, 3156.684331566848, 3172.9846449136285, 3236.708696217328, 3448.498162685407, 28518.0, 28947.71052289471, 29169.56245656317, 29635.851820740758, 29793.553096703567, 2662.3077999720017, 2719.102696110279, 2729.7471173355807, 2742.2184677366854, 2780.2771279467283, 362049.0, 362488.0, 362871.0, 362978.0, 363097.0, 60710.69644651748, 61009.69495152496, 61082.38917610767, 61167.69416152891, 61231.693841530505, 66928.66535667388, 68791.65604172047, 68805.65597172083, 68852.31147688559, 69015.23939042383, 14433.711325773425, 15242.847571524364, 16005.359785608678, 16208.027518348938, 16239.0, 11522.711932201762, 11763.0, 12472.189307694971, 12520.561780337644, 12769.680757981125, 17910.925344479372, 18801.743790745197, 19178.616427671368, 19182.232710691416, 19258.518537036685, 7054.294570542905, 8122.675092996332, 8150.510969341858, 8204.384671149688, 8237.629306681214, 913.196387179278, 982.9901700983041, 987.4667679453158, 1013.3919648211014, 1097.3251450358132, 23259.883700581388, 27095.32261693434, 27624.447511049668, 28168.154955351372, 28244.8587757064, 1077.4289626497969, 1083.5774048121239, 1151.7926773180907, 1225.8835410635975, 1272.7009152849073, 12715.55495557651, 13316.600501984956, 14481.348339324755, 14622.561323160322, 14982.250887455584, 636820.0, 640922.0, 649481.0, 651730.0, 652926.0, 59569.0, 60478.69760651168, 60552.39447605467, 60552.39447605555, 60658.0, 1305.1712162776705, 1339.0158233698419, 1429.485385261326, 1441.942322307117, 1473.8526147385176, 28807.847686092322, 28834.423311534072, 28987.275318117216, 29438.0, 29541.26146846346, 48933.75533122312, 49492.75253623709, 49874.750626246634, 50147.74926125346, 50199.24701129413, 474807.0, 476763.0, 476901.0, 477569.0, 477662.0, 22914.885425573433, 23559.882200588887, 23596.17413390523, 24294.815691298645, 26034.218973430827, 34930.301393972484, 35647.64352356443, 36171.91484255477, 40101.59898400979, 42500.0, 34206.82896585501, 35178.64821351754, 36759.26481470302, 36999.81500092482, 37446.43830342602, 35181.120471988404, 36015.0, 36072.639273606925, 36915.446268306536, 36996.260074797814, 36762.448563271035, 37010.44484332791, 37855.485780568466, 38624.42063369108, 38849.8345049649, 29053.12840614785, 31595.84202078975, 31632.683673162974, 31672.841635791672, 31674.524882127247, 23553.293401197992, 23558.764412355657, 24144.517109657358, 24169.51660966806, 24205.63691544593], "value": 19523.87597217132, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.9130704284491, 379.7417755925969, 389.8927794856414, 400.33943992412514, 403.1936127744511, 18479.815201847978, 20036.59926801463, 20631.0, 20754.688679669816, 20792.856392898404, 11975.461104250307, 12303.446344914479, 12303.876961230386, 12378.566750163745, 20250.89874550629, 5165.8450246492475, 5358.946410535903, 5398.541124004464, 5400.891982160374, 5410.648307859996, 3860.691144708431, 4105.240530501852, 5093.261477085839, 5850.590458667895, 6102.298235702907, 5320.787168513255, 5611.214429979786, 6096.969515152418, 6101.267847858263, 6112.105247373306, 6640.33596640337, 6656.400923916846, 6659.966700166468, 6669.533132680738, 6685.097511835937, 3826.2730081284467, 4064.410660454247, 4066.755994640331, 5198.116320225571, 5810.82567522975, 13657.385417656229, 13713.628637136306, 13754.862451375559, 13913.721725565432, 14002.92998535011, 1977.604479104185, 2135.4554588579967, 2161.5460753241837, 2168.5229249565227, 2196.176433837311, 9862.013798620152, 10239.078482936497, 10273.28087033908, 10363.067323940806, 10379.532921018572, 1738.8784234169016, 1769.8141695121956, 1789.6331252093419, 1801.6937120689515, 1812.0939530234882, 107574.46212768886, 113178.0, 113515.0, 114748.0, 115977.42011289974, 9571.234301256021, 11437.485313160927, 11568.942155289338, 11644.2533619956, 11752.529898804123, 15333.233338333039, 15352.078875267296, 15390.692186156439, 15397.615059623598, 15437.459688911058, 8420.410571260076, 8610.182032707007, 8612.698555550525, 8705.695300664573, 8706.608202630898, 6923.6884340204815, 8294.0, 8319.417640765208, 8325.66697332112, 8450.915490845136, 3819.25524522721, 4510.8421205257655, 4630.166570017362, 4640.280756482751, 4679.555442232982, 1798.4784412520485, 1861.5811442425618, 1875.8217969292896, 1984.484034151131, 1988.642044432016, 887.8845750052452, 958.5446912716404, 967.8161149381594, 970.4856426094182, 1030.0266248395194, 18835.340763073225, 19511.414657560297, 19845.702314465296, 19912.30306939279, 19992.800071999383, 865.9610317535726, 981.6809536900536, 992.3748038735695, 1006.3157053203892, 1017.4709151241314, 8131.105578386373, 10314.896851031544, 10764.461776911123, 10806.945965270123, 10819.459027048617, 488825.0, 549624.0, 586831.0, 619208.0, 638259.5131316449, 119993.0, 120429.19356209664, 123134.0, 128284.07573886399, 130439.0, 991.3209451525584, 1011.1455819832377, 1011.898810118997, 1013.9138173255355, 1015.456730649114, 18007.909960450637, 18011.459656210336, 18017.009064501577, 18104.094795260447, 18189.545261368043, 49742.751286243336, 50314.74842625763, 50585.0, 51037.72405689888, 51506.48493515167, 52916.4708352927, 70515.64742176257, 72005.91991120033, 73523.0, 74191.0, 6882.827929301808, 7031.683574239274, 7344.779656610311, 7463.402927765657, 8311.376646751396, 10758.515866785858, 11710.00464960488, 12637.431315590637, 12690.238585684889, 12708.491660333482, 8889.511076890833, 10737.516811743333, 10897.782044359226, 10950.123990080616, 11222.326660400402, 10966.616168434066, 10990.725231868948, 11079.667609971713, 11184.440777960906, 11303.9826415623, 10134.695959121238, 10905.127589792955, 11010.064144547803, 11310.94344528272, 11436.71408214768, 7606.695732170651, 8094.109647938604, 8202.753917382488, 8355.0, 8456.365772566958, 9105.863412048957, 11057.889421105687, 11073.224874258725, 11387.829182562435, 11420.600278990196], "value": 9049.834328345198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1416.3626368134342, 1601.8077830660322, 1615.838416158384, 1881.877677950933, 2023.7369142011537, 7886.171951945049, 8543.145685431453, 8606.268467180282, 8782.692605758784, 8795.032546419896, 8438.620262088221, 8641.351898607614, 8650.697225597105, 8651.221390074892, 8668.52323122228, 2182.3998400439846, 2393.664886915833, 2460.151247819504, 2485.1674688979215, 2487.813413993949, 2490.7509249075038, 2510.309664842174, 2515.635232891239, 2516.924492265235, 2517.874106294678, 2427.587310157269, 2476.9009239630395, 2477.4054226985486, 2477.5168842075805, 2477.7398373170827, 2124.819390351814, 2357.092519380034, 2433.7809597136256, 2446.1193970170725, 2448.926532204037, 2448.3879030242438, 2464.162184857157, 2483.8261321707487, 2486.5275597636573, 2487.6517287579754, 8614.827703445959, 8780.341474389383, 8789.516576588285, 8793.12068793122, 8796.340274479375, 5188.507091826271, 5367.409584945653, 5389.946100538984, 5391.056565101131, 5421.132618780976, 3571.928561428783, 3585.7310701697215, 3603.6036036036016, 3649.6350364963555, 3675.3751862183494, 1036.424784244744, 1048.916086713061, 1055.2138656700731, 1066.6533376652542, 1088.7931293054373, 11435.313881167156, 11438.771224575461, 11452.0, 11479.65561033162, 11518.251313664585, 4629.467611224685, 4654.930176047362, 4824.0834241494, 4865.489123642037, 4867.5132486751045, 9750.902490974999, 9803.411795292162, 9804.607815687436, 9805.705828825146, 9831.705048848546, 5344.038073146871, 5355.571554275649, 5357.357117145967, 5387.191921211771, 5423.240746295522, 4402.141582391467, 4554.3851580036935, 4745.525447455227, 4924.03981223658, 4924.63065270099, 3439.243366459375, 3940.7438516496336, 3993.7603743775467, 4060.6548443382644, 4120.649744771668, 1340.6514306280437, 1361.8706222908809, 1364.522417154008, 1373.3064802274987, 1373.7458570164551, 848.6096395658067, 851.4635779458902, 863.4603372891943, 907.1427501011481, 922.372786505183, 5639.577031722637, 5642.351129620064, 5876.823695289148, 5915.349311575723, 5944.6730429826775, 864.3733293362262, 930.8603709443638, 980.4803454169302, 985.3348989432247, 996.3473924579412, 3780.1305699689224, 3842.8270727817317, 3939.074317535377, 4016.9196616067516, 4033.415154802537, 9220.0, 10077.54651040705, 10315.690529284133, 10549.103326217357, 10624.043836054792, 10467.738306542398, 10471.790564188674, 10489.423081730425, 10594.258401911793, 10597.0, 7797.415193860483, 8065.556394398364, 8147.0, 8147.144549822302, 8157.592120393957, 5632.605717599728, 5697.54419646419, 5755.223044888887, 5817.563682723728, 5822.330432000204, 9769.0, 9817.705468835946, 9932.25508086882, 9933.602655893972, 9947.253955953478, 9564.13922746956, 9685.41887486753, 9780.902190977999, 9919.65281215154, 10040.69877903664, 6410.294867564658, 6652.401283884474, 6829.760958366433, 6961.89557156633, 7072.823179420556, 8164.83670326602, 8175.959120204361, 8237.464564803508, 8246.670133194844, 8248.46384984974, 6271.0, 7176.928230717835, 7254.637268136466, 7279.0, 7415.888761668687, 7210.531315464478, 7213.67538460781, 7236.167840698387, 7292.171609904843, 7383.483156179016, 5944.346121926671, 6750.3924646782025, 6957.0, 6987.475939304674, 6989.37095661393, 4801.567858892577, 4860.295257187759, 4905.190643543775, 4970.552650261494, 5113.386393632639, 4878.707277563358, 4934.087193869145, 4934.950650493449, 4944.579710724484, 5158.716270605153], "value": 4578.527859038819, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.33872158694066, 310.7467414057543, 313.4154801295583, 314.67274035003595, 321.24988152663525, 5168.767405466753, 5300.390455097665, 5534.474224948628, 5534.8653526027165, 5952.404759524045, 5413.296271484702, 5424.620276580641, 5574.749136288867, 5894.764209431628, 5927.229460170182, 3738.8130593470355, 3963.146534495159, 4215.810288537015, 4272.444582204309, 4329.372241025049, 4257.595528424795, 4377.62790162835, 4462.286034234523, 4464.776761161945, 4495.943453288474, 4181.477315335583, 4456.5766252205985, 4461.107778444324, 4467.463904331485, 4470.396496472967, 3921.4706014687936, 4174.833006679744, 4340.544242854487, 4341.156542464691, 4381.452318460192, 3122.859471323773, 3127.8123312601315, 3714.182879766447, 3742.8315725792404, 3762.3792074307707, 4461.732296062247, 4824.758762061918, 5465.207544906006, 5628.380878103405, 5656.830295091154, 4254.489461264637, 4816.181249187646, 5019.218177546992, 5042.218456139268, 5045.772940217699, 5144.845654630367, 5617.269754931874, 6145.938540614626, 6168.84577885552, 6171.907421388638, 3543.5039094526787, 4137.924139723664, 4153.584641535853, 4155.335146376596, 4159.459270294872, 5814.0, 5869.413058694139, 6033.155358249848, 6486.902696459557, 6582.243042050178, 4189.350650649154, 4226.408302837605, 4228.830846766156, 4245.405643209953, 4249.617534421917, 3790.8104594770703, 4288.31386978082, 4306.547812479707, 4310.633596144363, 4312.3181959036, 4847.321375007431, 5010.473900240495, 5030.823921162815, 5037.29477873098, 5093.617978651616, 6201.255849298113, 6219.595726277777, 6239.688015599202, 6241.750329986749, 6256.311805701369, 1442.1203066129654, 1467.772495263236, 1468.0164289925776, 1469.595861138174, 1471.3820195517908, 878.4202426398547, 886.3441053620274, 915.4827522449795, 954.5752140297501, 977.2426369563503, 5673.687947162945, 5674.716264186856, 5765.423457654285, 5778.653280803165, 5802.47777700009, 5066.240063990357, 5317.282166907418, 5818.5345172386105, 5971.193888824953, 6381.680915954184, 5510.311211098613, 5757.366689664133, 5789.218455508452, 5846.561507886926, 5897.52819774417, 3150.574672419194, 3290.703836654665, 3410.4202285611505, 3433.3305005524185, 3446.379651662675, 6325.319263744887, 6601.207855057328, 6800.489963252677, 6824.658767061627, 6860.348266914635, 6638.701258443381, 6643.933560664332, 6654.6672666366485, 6701.396874281338, 6725.226598941086, 5721.370649228665, 5969.31352894414, 5982.042873140364, 6756.864862702719, 6796.728130874809, 6462.450691691259, 6473.320301368289, 6473.802346565901, 6475.417212450902, 6484.870302593828, 6334.746610135543, 6362.297496318152, 6369.45859601939, 6402.903956440564, 6444.742210311722, 5899.026660600953, 6369.649669268049, 6546.18172728409, 6769.221539522821, 6781.593104413751, 4182.28901086822, 4182.372644103409, 4223.387608796768, 4224.8098835551855, 4240.236757383701, 5948.256467941507, 6257.7184026719815, 6357.491400688026, 6431.938730109479, 6474.417302442803, 5851.765929362778, 6033.818985430444, 6112.8777424452155, 6165.815025549241, 6260.937390626035, 4912.70523768575, 5431.6740995540395, 5847.590668653153, 6176.35148309421, 6191.19514463117, 5862.970685146547, 6038.0074575389135, 6061.605995610271, 6083.726232319467, 6106.603070800384, 4650.627949764078, 5485.917711234414, 6162.008772893971, 6196.566240363131, 6208.627482351073, 4936.580390666833, 5353.304070470814, 5871.706414679164, 6094.512439004958, 6104.023356262976], "value": 4474.611118999982, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.6562122075301, 651.0559688451744, 708.7342246657504, 732.5787672088551, 741.2846603028077, 14773.926130369333, 14923.030003049795, 15224.0, 15345.693086138284, 15408.460703875367, 9945.502724863763, 14074.0, 14085.929570352135, 14152.0, 14194.077384969969, 726.2555880222761, 744.5421066044371, 895.3329769321864, 908.0284096017248, 920.4799288402065, 767.6161919040479, 917.9770505737376, 920.8020275640736, 921.8340698674236, 922.4603606889978, 975.4098770244007, 976.1166144639113, 977.8484334928097, 978.1148061004767, 978.442287895896, 754.6868049759344, 777.249953794591, 778.0818634011864, 778.1051790440981, 975.6243846119224, 704.5983789240136, 725.905632267807, 726.600369796615, 727.581640556682, 728.9526180798231, 14999.925000374928, 15062.698746025128, 15086.471973480986, 15088.0, 15096.396144154221, 12457.252564846047, 12470.314132722697, 12497.875021249762, 12641.747165056739, 12823.743525129445, 8642.43824151428, 9848.813386968917, 9864.605415783431, 9978.251631127694, 10367.222458315657, 3525.8589656413715, 3551.627079156677, 3576.7317451191266, 3595.388783906742, 3635.418333066723, 77122.0, 77557.0, 78909.99999999943, 79196.0, 79360.0, 9465.716028519155, 9528.094830991045, 9540.236781057498, 9716.902830971741, 10061.39631622105, 21572.137114515557, 21573.784262157176, 21583.352499425044, 21588.89205553962, 21590.352289431026, 7547.28300811422, 7711.344535714415, 7720.189380115119, 7754.844903101906, 7886.64510097047, 4153.522344930311, 4160.209560183555, 4267.253230684618, 4268.317069268902, 4286.507051689034, 3498.1429549760473, 3573.6247693992277, 3591.174029973121, 3595.8381872815785, 3604.4052731299043, 653.9901901471482, 656.8226578823691, 682.0791930893354, 698.849747304332, 710.5026481462996, 505.61825821505266, 542.1542393865503, 570.5236127833306, 578.7354630133173, 579.6840721806625, 7791.571463569559, 8009.31920786728, 8119.512829230265, 8322.375821813388, 8337.207965243293, 504.35946348138395, 558.6815515156403, 589.602018637418, 599.9820005399845, 619.4022768028784, 3391.626921038733, 3591.6049234584175, 3815.4276858471453, 3879.903002424962, 4010.498687664042, 59020.70489647524, 79805.60097199593, 81630.0, 82044.0, 85957.57021214854, 55939.720301399044, 58872.0, 61403.385966139766, 71429.0, 71703.0, 64362.6781866097, 68045.0, 68127.31872681309, 68623.0, 69663.30336696669, 8095.55474448911, 8112.675492980451, 8317.334613231049, 8361.916380836357, 8386.412951093365, 41733.58266417297, 41795.582044179166, 42340.576594234895, 42373.36439953341, 42906.1418771629, 60029.69985150046, 61086.0, 61309.693451532454, 61435.771284573166, 61724.69137654283, 10992.450377481255, 11177.497012634289, 11178.832317515082, 11311.377874216669, 11332.320060796379, 11496.367699776592, 11793.351365674971, 11861.05111591088, 11929.463174157358, 12032.75934481288, 11319.207655464368, 11322.0, 11685.824712629148, 11868.94231967111, 11894.702632434259, 11613.187076904536, 11845.881541184823, 11978.940105299418, 11986.400679966142, 12353.444095015926, 11291.661250162508, 11587.478563464496, 11801.468933898166, 11826.763464730486, 11896.167268291136, 9553.140217380469, 9611.711648650551, 9764.218862491125, 9790.363626364548, 9829.066238707312, 9598.856017159887, 9645.9035409645, 9664.130228279488, 9675.565174363, 9699.709008729467], "value": 6752.527461454502, "unit": "score"}], "name": "dromaeo_css", "value": 7191.97821677679, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 112.0, 112.0, 113.0, 118.0, 116.0, 164.0, 167.0], "value": 123.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 114.0, 143.0, 167.0, 120.0, 145.0, 144.0, 113.0, 163.0, 113.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 253.0, 189.0, 182.0, 186.0, 183.0, 184.0, 183.0, 186.0, 186.0], "value": 194.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 85.0, 91.0, 55.0, 58.0, 62.0, 76.0, 83.0, 56.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 136.0, 79.0, 77.0, 76.0, 126.0, 79.0, 76.0, 125.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 91.0, 87.0, 89.0, 86.0, 88.0, 128.0, 83.0, 116.0], "value": 94.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 106.0, 123.0, 95.0, 96.0, 94.0, 95.0], "value": 99.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 85.0, 87.0, 85.0, 87.0, 86.0, 86.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 60.0, 60.0, 58.0, 74.0, 62.0, 57.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 97.0, 104.0, 104.0, 82.0, 67.0, 67.0, 66.0, 66.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 88.0, 88.0, 86.0, 100.0, 113.0, 114.0, 87.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 147.0, 149.0, 145.0, 142.0, 143.0, 162.0, 200.0, 156.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 167.0, 179.0, 169.0, 170.0, 168.0, 176.0, 165.0, 161.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 67.0, 69.0, 66.0, 69.0, 69.0, 69.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1525.3, "alertThreshold": 2.0}]} 05:43:32 INFO - Return code: 0 05:43:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:43:32 ERROR - # TBPL SUCCESS # 05:43:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:43:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:43:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:43:32 INFO - 2016-04-13 05:43:32.689 screenresolution[1679:9684] starting screenresolution argv=screenresolution get 05:43:32 INFO - 2016-04-13 05:43:32.692 screenresolution[1679:9684] Display 0: 1600x1200x32@60 05:43:32 INFO - 2016-04-13 05:43:32.698 screenresolution[1680:9687] starting screenresolution argv=screenresolution list 05:43:32 INFO - Available Modes on Display 0 05:43:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:43:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:43:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:43:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:43:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:43:32 INFO - Intel Iris: 05:43:32 INFO - Chipset Model: Intel Iris 05:43:32 INFO - Type: GPU 05:43:32 INFO - Bus: Built-In 05:43:32 INFO - VRAM (Dynamic, Max): 1536 MB 05:43:32 INFO - Vendor: Intel (0x8086) 05:43:32 INFO - Device ID: 0x0a2e 05:43:32 INFO - Revision ID: 0x0009 05:43:32 INFO - Displays: 05:43:32 INFO - Display: 05:43:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:43:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:43:32 INFO - Display Serial Number: 1600x1200 60 05:43:32 INFO - Main Display: Yes 05:43:32 INFO - Mirror: Off 05:43:32 INFO - Online: Yes 05:43:32 INFO - Rotation: Supported 05:43:32 INFO - Return code: 0 05:43:32 INFO - Running post-action listener: _resource_record_post_action 05:43:32 INFO - Running post-run listener: _resource_record_post_run 05:43:33 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37570048; Write bytes: 692392448; Read time: 392; Write time: 1962 05:43:33 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 389306880; Write bytes: 383588352; Read time: 29871; Write time: 718 05:43:33 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35751424; Write bytes: 295483904; Read time: 372; Write time: 1214 05:43:33 INFO - Running post-run listener: _upload_blobber_files 05:43:33 INFO - Blob upload gear active. 05:43:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:43:33 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 05:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:43:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:35 INFO - (blobuploader) - INFO - Done attempting. 05:43:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:43:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:43:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:43:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:43:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:43:36 INFO - (blobuploader) - INFO - Done attempting. 05:43:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:43:36 INFO - Return code: 0 05:43:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:43:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:43:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0294b5b0f77acaf7377f24b8537e4e0ff8f9db7a149a8a2c5b151b44b0af58827cba47d831d015adf3fd979fe2d72fcb8da3bc59f8feefc0fe57e38139f98eee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a44ca9bbcbbc1fb22968591110a1fb5052f0440f3874b4b2ff7ed096d2cad384bdcc6877d9eada0efa0a34df3a453640f5dbcabb991e66578cc3d14119b603"} 05:43:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:43:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:43:36 INFO - Contents: 05:43:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0294b5b0f77acaf7377f24b8537e4e0ff8f9db7a149a8a2c5b151b44b0af58827cba47d831d015adf3fd979fe2d72fcb8da3bc59f8feefc0fe57e38139f98eee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a44ca9bbcbbc1fb22968591110a1fb5052f0440f3874b4b2ff7ed096d2cad384bdcc6877d9eada0efa0a34df3a453640f5dbcabb991e66578cc3d14119b603"} 05:43:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:43:36 INFO - Copying logs to upload dir... 05:43:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:43:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.113632 ========= master_lag: 1.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-13 05:43:37.323028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 05:43:37.328181) ========= 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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0294b5b0f77acaf7377f24b8537e4e0ff8f9db7a149a8a2c5b151b44b0af58827cba47d831d015adf3fd979fe2d72fcb8da3bc59f8feefc0fe57e38139f98eee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a44ca9bbcbbc1fb22968591110a1fb5052f0440f3874b4b2ff7ed096d2cad384bdcc6877d9eada0efa0a34df3a453640f5dbcabb991e66578cc3d14119b603"} build_url:https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/N2VuAvshTDibQRWULlf--g/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0294b5b0f77acaf7377f24b8537e4e0ff8f9db7a149a8a2c5b151b44b0af58827cba47d831d015adf3fd979fe2d72fcb8da3bc59f8feefc0fe57e38139f98eee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a44ca9bbcbbc1fb22968591110a1fb5052f0440f3874b4b2ff7ed096d2cad384bdcc6877d9eada0efa0a34df3a453640f5dbcabb991e66578cc3d14119b603"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 05:43:37.360280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:43:37.360650) ========= 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.AeWHGGWLU0/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.7BpDI0KXM7/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 05:43:37.409530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 05:43:37.409898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 05:43:37.410313) ========= ========= Total master_lag: 1.23 =========