builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0134 starttime: 1460029330.32 results: success (0) buildid: 20160407043445 builduid: 791ce4986a8f422082227cbb55f327a7 revision: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.321232) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.321694) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.328088) ========= 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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005780 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.352727) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.357104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.376565) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.376947) ========= 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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005485 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.426048) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.426404) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.426839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.433221) ========= 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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-07 04:42:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-04-07 04:42:10 (19.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.610226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.610598) ========= 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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.026784 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:10.667985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-07 04:42:10.668393) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-07 04:42:10,749 truncating revision to first 12 chars 2016-04-07 04:42:10,749 Setting DEBUG logging. 2016-04-07 04:42:10,749 attempt 1/10 2016-04-07 04:42:10,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68c0b7d6f16c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 04:42:12,495 unpacking tar archive at: mozilla-central-68c0b7d6f16c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.156599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-07 04:42:12.848785) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:12.849224) ========= echo 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 program finished with exit code 0 elapsedTime=0.005489 script_repo_revision: '68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:12.907472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:12.908265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 04:42:12.924012) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-07 04:42:12.924707) ========= /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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:13 INFO - MultiFileLogger online at 20160407 04:42:13 in /builds/slave/test 04:42:13 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 04:42:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:42:13 INFO - {'append_to_log': False, 04:42:13 INFO - 'base_work_dir': '/builds/slave/test', 04:42:13 INFO - 'blob_upload_branch': 'Firefox', 04:42:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:42:13 INFO - 'branch': 'Firefox', 04:42:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:42:13 INFO - 'config_files': ('talos/mac_config.py',), 04:42:13 INFO - 'default_actions': ('clobber', 04:42:13 INFO - 'read-buildbot-config', 04:42:13 INFO - 'download-and-extract', 04:42:13 INFO - 'populate-webroot', 04:42:13 INFO - 'create-virtualenv', 04:42:13 INFO - 'install', 04:42:13 INFO - 'run-tests'), 04:42:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:42:13 INFO - 'download_minidump_stackwalk': True, 04:42:13 INFO - 'download_symbols': 'ondemand', 04:42:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:42:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:42:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:42:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:42:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:42:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:42:13 INFO - 'installer_path': 'installer.exe', 04:42:13 INFO - 'log_level': 'info', 04:42:13 INFO - 'log_name': 'talos', 04:42:13 INFO - 'log_to_console': True, 04:42:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:42:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:42:13 INFO - 'opt_config_files': (), 04:42:13 INFO - 'pip_index': False, 04:42:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:13 INFO - 'cmd': ('bash', 04:42:13 INFO - '-c', 04:42:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:13 INFO - 'enabled': True, 04:42:13 INFO - 'halt_on_failure': False, 04:42:13 INFO - 'name': 'check_screen_resolution'},), 04:42:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:42:13 INFO - 'cmd': ('bash', 04:42:13 INFO - '-c', 04:42:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:42:13 INFO - 'enabled': True, 04:42:13 INFO - 'halt_on_failure': False, 04:42:13 INFO - 'name': 'check_screen_resolution'},), 04:42:13 INFO - 'run_cmd_checks_enabled': True, 04:42:13 INFO - 'sps_profile': False, 04:42:13 INFO - 'sps_profile_interval': 0, 04:42:13 INFO - 'suite': 'dromaeojs', 04:42:13 INFO - 'system_bits': '32', 04:42:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:42:13 INFO - 'title': 't-yosemite-r7-0134', 04:42:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:42:13 INFO - 'use_talos_json': True, 04:42:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:42:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:42:13 INFO - 'work_dir': 'build'} 04:42:13 INFO - ##### 04:42:13 INFO - ##### Running clobber step. 04:42:13 INFO - ##### 04:42:13 INFO - Running pre-action listener: _resource_record_pre_action 04:42:13 INFO - Running main action method: clobber 04:42:13 INFO - rmtree: /builds/slave/test/build 04:42:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - ##### 04:42:14 INFO - ##### Running read-buildbot-config step. 04:42:14 INFO - ##### 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: read_buildbot_config 04:42:14 INFO - Using buildbot properties: 04:42:14 INFO - { 04:42:14 INFO - "project": "", 04:42:14 INFO - "product": "firefox", 04:42:14 INFO - "script_repo_revision": "production", 04:42:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:42:14 INFO - "repository": "", 04:42:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:42:14 INFO - "buildid": "20160407043445", 04:42:14 INFO - "stage_platform": "macosx64", 04:42:14 INFO - "basedir": "/builds/slave/test", 04:42:14 INFO - "buildnumber": 194, 04:42:14 INFO - "platform": "yosemite_r7", 04:42:14 INFO - "mozci_request": { 04:42:14 INFO - "priority": -1, 04:42:14 INFO - "type": "trigger_all_talos_jobs", 04:42:14 INFO - "times": 6 04:42:14 INFO - }, 04:42:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:42:14 INFO - "slavebuilddir": "test", 04:42:14 INFO - "branch": "mozilla-central", 04:42:14 INFO - "revision": "68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8", 04:42:14 INFO - "slavename": "t-yosemite-r7-0134", 04:42:14 INFO - "builduid": "791ce4986a8f422082227cbb55f327a7", 04:42:14 INFO - "repo_path": "mozilla-central" 04:42:14 INFO - } 04:42:14 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg. 04:42:14 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json. 04:42:14 INFO - Running post-action listener: _resource_record_post_action 04:42:14 INFO - ##### 04:42:14 INFO - ##### Running download-and-extract step. 04:42:14 INFO - ##### 04:42:14 INFO - Running pre-action listener: _resource_record_pre_action 04:42:14 INFO - Running main action method: download_and_extract 04:42:14 INFO - mkdir: /builds/slave/test/build/tests 04:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json 04:42:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/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 04:42:14 INFO - Downloaded 1199 bytes. 04:42:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:42:14 INFO - Using the following test package requirements: 04:42:14 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:42:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:14 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:42:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:14 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:42:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:14 INFO - u'jsshell-mac.zip'], 04:42:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:14 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:42:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:42:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:14 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:42:14 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:14 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:42:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:14 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:42:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:42:14 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:42:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/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 04:42:15 INFO - Downloaded 17964225 bytes. 04:42:15 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'] 04:42:15 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 04:42:18 INFO - Return code: 0 04:42:18 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 04:42:18 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')]} 04:42:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:42:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/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 04:42:18 INFO - Downloaded 17964225 bytes. 04:42:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:42:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:42:22 INFO - Return code: 0 04:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip 04:42:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/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 04:42:22 INFO - Downloaded 10847617 bytes. 04:42:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:42:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:42:22 INFO - Return code: 0 04:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:42:24 INFO - Downloaded 108925595 bytes. 04:42:24 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:24 INFO - mkdir: /builds/slave/test/properties 04:42:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:24 INFO - Contents: 04:42:24 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg 04:42:24 INFO - Running post-action listener: _resource_record_post_action 04:42:24 INFO - Running post-action listener: set_extra_try_arguments 04:42:24 INFO - ##### 04:42:24 INFO - ##### Running populate-webroot step. 04:42:24 INFO - ##### 04:42:24 INFO - Running pre-action listener: _resource_record_pre_action 04:42:24 INFO - Running main action method: populate_webroot 04:42:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:24 INFO - '--tppagecycles', 04:42:24 INFO - '7'], 04:42:24 INFO - 'tests': ['tsvgm']}}, 04:42:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['damp', 'tps']}, 04:42:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'tests': ['damp', 'tps']}, 04:42:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['dromaeo_dom']}, 04:42:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['a11yr', 04:42:24 INFO - 'ts_paint', 04:42:24 INFO - 'tpaint', 04:42:24 INFO - 'sessionrestore', 04:42:24 INFO - 'sessionrestore_no_auto_restore', 04:42:24 INFO - 'tabpaint']}, 04:42:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['tsvgx', 04:42:24 INFO - 'tsvgr_opacity', 04:42:24 INFO - 'tart', 04:42:24 INFO - 'tscrollx', 04:42:24 INFO - 'cart']}, 04:42:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:24 INFO - 'tsvgr_opacity', 04:42:24 INFO - 'tart', 04:42:24 INFO - 'tscrollx', 04:42:24 INFO - 'cart']}, 04:42:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--disable-e10s'], 04:42:24 INFO - 'tests': ['tp5o']}, 04:42:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'tests': ['tp5o']}, 04:42:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--disable-e10s', 04:42:24 INFO - '--xperf_path', 04:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:24 INFO - 'tests': ['tp5n']}, 04:42:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:42:24 INFO - 'talos_options': ['--xperf_path', 04:42:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:24 INFO - 'tests': ['tp5n']}}, 04:42:24 INFO - 'talos.zip': {'path': '', 04:42:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:24 INFO - Running post-action listener: _resource_record_post_action 04:42:24 INFO - ##### 04:42:24 INFO - ##### Running create-virtualenv step. 04:42:24 INFO - ##### 04:42:24 INFO - Running pre-action listener: _resource_record_pre_action 04:42:24 INFO - Running main action method: create_virtualenv 04:42:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:24 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 04:42:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:24 INFO - Using real prefix '/tools/python27' 04:42:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:28 INFO - Installing pip.................done. 04:42:28 INFO - Return code: 0 04:42:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:28 INFO - 'HOME': '/Users/cltbld', 04:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:28 INFO - 'LOGNAME': 'cltbld', 04:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:28 INFO - 'MOZ_NO_REMOTE': '1', 04:42:28 INFO - 'NO_EM_RESTART': '1', 04:42:28 INFO - 'PAGER': '/bin/cat', 04:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:28 INFO - 'PWD': '/builds/slave/test', 04:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:28 INFO - 'SHELL': '/bin/bash', 04:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:28 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:28 INFO - 'USER': 'cltbld', 04:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:28 INFO - 'XPC_FLAGS': '0x0', 04:42:28 INFO - 'XPC_SERVICE_NAME': '0', 04:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:28 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 04:42:28 INFO - Cleaning up... 04:42:28 INFO - Return code: 0 04:42:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:28 INFO - 'HOME': '/Users/cltbld', 04:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:28 INFO - 'LOGNAME': 'cltbld', 04:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:28 INFO - 'MOZ_NO_REMOTE': '1', 04:42:28 INFO - 'NO_EM_RESTART': '1', 04:42:28 INFO - 'PAGER': '/bin/cat', 04:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:28 INFO - 'PWD': '/builds/slave/test', 04:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:28 INFO - 'SHELL': '/bin/bash', 04:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:28 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:28 INFO - 'USER': 'cltbld', 04:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:28 INFO - 'XPC_FLAGS': '0x0', 04:42:28 INFO - 'XPC_SERVICE_NAME': '0', 04:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:28 INFO - Downloading/unpacking psutil>=0.7.1 04:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:31 INFO - Installing collected packages: psutil 04:42:31 INFO - Running setup.py install for psutil 04:42:32 INFO - building 'psutil._psutil_osx' extension 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 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 04:42:32 INFO - building 'psutil._psutil_posix' extension 04:42:32 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 04:42:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:42:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:42:32 INFO - ^ 04:42:32 INFO - 1 warning generated. 04:42:32 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 04:42:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:33 INFO - Successfully installed psutil 04:42:33 INFO - Cleaning up... 04:42:33 INFO - Return code: 0 04:42:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:42: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')]} 04:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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')]} 04:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:33 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 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:33 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 04:42:33 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 04:42:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:33 INFO - 'HOME': '/Users/cltbld', 04:42:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:33 INFO - 'LOGNAME': 'cltbld', 04:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:33 INFO - 'MOZ_NO_REMOTE': '1', 04:42:33 INFO - 'NO_EM_RESTART': '1', 04:42:33 INFO - 'PAGER': '/bin/cat', 04:42:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:33 INFO - 'PWD': '/builds/slave/test', 04:42:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:33 INFO - 'SHELL': '/bin/bash', 04:42:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:33 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:33 INFO - 'USER': 'cltbld', 04:42:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:33 INFO - 'XPC_FLAGS': '0x0', 04:42:33 INFO - 'XPC_SERVICE_NAME': '0', 04:42:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:33 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 04:42:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:42:35 INFO - Installing collected packages: mozsystemmonitor 04:42:35 INFO - Running setup.py install for mozsystemmonitor 04:42:36 INFO - Successfully installed mozsystemmonitor 04:42:36 INFO - Cleaning up... 04:42:36 INFO - Return code: 0 04:42:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 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 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:36 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 04:42:36 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 04:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:36 INFO - 'HOME': '/Users/cltbld', 04:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:36 INFO - 'LOGNAME': 'cltbld', 04:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:36 INFO - 'MOZ_NO_REMOTE': '1', 04:42:36 INFO - 'NO_EM_RESTART': '1', 04:42:36 INFO - 'PAGER': '/bin/cat', 04:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:36 INFO - 'PWD': '/builds/slave/test', 04:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:36 INFO - 'SHELL': '/bin/bash', 04:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:36 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:36 INFO - 'USER': 'cltbld', 04:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:36 INFO - 'XPC_FLAGS': '0x0', 04:42:36 INFO - 'XPC_SERVICE_NAME': '0', 04:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:36 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:39 INFO - Downloading docopt-0.6.1.tar.gz 04:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:40 INFO - Running setup.py install for blobuploader 04:42:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:40 INFO - Running setup.py install for requests 04:42:40 INFO - Running setup.py install for docopt 04:42:40 INFO - Successfully installed blobuploader requests docopt 04:42:40 INFO - Cleaning up... 04:42:40 INFO - Return code: 0 04:42:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:40 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 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:40 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 04:42:40 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 04:42:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:40 INFO - 'HOME': '/Users/cltbld', 04:42:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:40 INFO - 'LOGNAME': 'cltbld', 04:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:40 INFO - 'MOZ_NO_REMOTE': '1', 04:42:40 INFO - 'NO_EM_RESTART': '1', 04:42:40 INFO - 'PAGER': '/bin/cat', 04:42:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:40 INFO - 'PWD': '/builds/slave/test', 04:42:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:40 INFO - 'SHELL': '/bin/bash', 04:42:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:40 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:40 INFO - 'USER': 'cltbld', 04:42:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:40 INFO - 'XPC_FLAGS': '0x0', 04:42:40 INFO - 'XPC_SERVICE_NAME': '0', 04:42:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:41 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hN0XXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:41 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-WU_E_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:41 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-gPS8f5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:41 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-xW_Zxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:41 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-NSwgw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:41 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-rZnvpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:41 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-4aoUFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:41 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-GnXWyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-xU7x6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-KCTUan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-KtDOox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-AsaRTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-xdXgZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Dnxgvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-mMTSRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-5yhHGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:42 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-M0gsNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:42 INFO - Running setup.py install for manifestparser 04:42:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:43 INFO - Running setup.py install for mozcrash 04:42:43 INFO - Running setup.py install for mozdebug 04:42:43 INFO - Running setup.py install for mozdevice 04:42:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:42:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:43 INFO - Running setup.py install for mozfile 04:42:43 INFO - Running setup.py install for mozhttpd 04:42:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:43 INFO - Running setup.py install for mozinfo 04:42:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Running setup.py install for mozInstall 04:42:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Running setup.py install for mozleak 04:42:44 INFO - Running setup.py install for mozlog 04:42:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Running setup.py install for moznetwork 04:42:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Running setup.py install for mozprocess 04:42:44 INFO - Running setup.py install for mozprofile 04:42:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:44 INFO - Running setup.py install for mozrunner 04:42:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:45 INFO - Running setup.py install for mozscreenshot 04:42:45 INFO - Running setup.py install for moztest 04:42:45 INFO - Running setup.py install for mozversion 04:42:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:45 INFO - Cleaning up... 04:42:45 INFO - Return code: 0 04:42:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:45 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 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:45 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 04:42:45 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 04:42:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:45 INFO - 'HOME': '/Users/cltbld', 04:42:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:45 INFO - 'LOGNAME': 'cltbld', 04:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:45 INFO - 'MOZ_NO_REMOTE': '1', 04:42:45 INFO - 'NO_EM_RESTART': '1', 04:42:45 INFO - 'PAGER': '/bin/cat', 04:42:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:45 INFO - 'PWD': '/builds/slave/test', 04:42:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:45 INFO - 'SHELL': '/bin/bash', 04:42:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:45 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:45 INFO - 'USER': 'cltbld', 04:42:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:45 INFO - 'XPC_FLAGS': '0x0', 04:42:45 INFO - 'XPC_SERVICE_NAME': '0', 04:42:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:45 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-2hiXvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:45 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)) 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:45 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-uAOKPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-5VpTHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-0eo2zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-NH7zfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hiGun1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-d_fpl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-nRgsnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-jSCq_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hCu4Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:46 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)) 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:46 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-MXHpVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:47 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)) 04:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:47 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-cGdOZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:47 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)) 04:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:47 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-PflYdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:47 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)) 04:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:47 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-nk9tYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:47 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)) 04:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:47 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ZHa1GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:47 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)) 04:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:47 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-QHq24f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:47 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)) 04:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:47 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-47fuHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:47 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)) 04:42:47 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)) 04:42:47 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)) 04:42:47 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)) 04:42:47 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)) 04:42:47 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)) 04:42:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:47 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 04:42:47 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 04:42:47 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 04:42:47 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 04:42:47 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 04:42:47 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 04:42:50 INFO - Downloading blessings-1.6.tar.gz 04:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:50 INFO - Installing collected packages: blessings 04:42:50 INFO - Running setup.py install for blessings 04:42:50 INFO - Successfully installed blessings 04:42:50 INFO - Cleaning up... 04:42:50 INFO - Return code: 0 04:42:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:50 INFO - Reading from file tmpfile_stdout 04:42:50 INFO - Current package versions: 04:42:50 INFO - blessings == 1.6 04:42:50 INFO - blobuploader == 1.2.4 04:42:50 INFO - docopt == 0.6.1 04:42:50 INFO - manifestparser == 1.1 04:42:50 INFO - mozInstall == 1.12 04:42:50 INFO - mozcrash == 0.17 04:42:50 INFO - mozdebug == 0.1 04:42:50 INFO - mozdevice == 0.48 04:42:50 INFO - mozfile == 1.2 04:42:50 INFO - mozhttpd == 0.7 04:42:50 INFO - mozinfo == 0.9 04:42:50 INFO - mozleak == 0.1 04:42:50 INFO - mozlog == 3.1 04:42:50 INFO - moznetwork == 0.27 04:42:50 INFO - mozprocess == 0.22 04:42:50 INFO - mozprofile == 0.28 04:42:50 INFO - mozrunner == 6.11 04:42:50 INFO - mozscreenshot == 0.1 04:42:50 INFO - mozsystemmonitor == 0.0 04:42:50 INFO - moztest == 0.7 04:42:50 INFO - mozversion == 1.4 04:42:50 INFO - psutil == 3.1.1 04:42:50 INFO - requests == 1.2.3 04:42:50 INFO - wsgiref == 0.1.2 04:42:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:50 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')]} 04:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:50 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')]} 04:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:50 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 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:50 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 04:42:50 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 04:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:50 INFO - 'HOME': '/Users/cltbld', 04:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:50 INFO - 'LOGNAME': 'cltbld', 04:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:50 INFO - 'MOZ_NO_REMOTE': '1', 04:42:50 INFO - 'NO_EM_RESTART': '1', 04:42:50 INFO - 'PAGER': '/bin/cat', 04:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:50 INFO - 'PWD': '/builds/slave/test', 04:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:50 INFO - 'SHELL': '/bin/bash', 04:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:50 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:50 INFO - 'USER': 'cltbld', 04:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:50 INFO - 'XPC_FLAGS': '0x0', 04:42:50 INFO - 'XPC_SERVICE_NAME': '0', 04:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 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)) 04:42:50 INFO - Cleaning up... 04:42:50 INFO - Return code: 0 04:42:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42:50 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')]} 04:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:50 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')]} 04:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:50 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 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:50 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 04:42:50 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 04:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:50 INFO - 'HOME': '/Users/cltbld', 04:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:50 INFO - 'LOGNAME': 'cltbld', 04:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:50 INFO - 'MOZ_NO_REMOTE': '1', 04:42:50 INFO - 'NO_EM_RESTART': '1', 04:42:50 INFO - 'PAGER': '/bin/cat', 04:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:50 INFO - 'PWD': '/builds/slave/test', 04:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:50 INFO - 'SHELL': '/bin/bash', 04:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:50 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:50 INFO - 'USER': 'cltbld', 04:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:50 INFO - 'XPC_FLAGS': '0x0', 04:42:50 INFO - 'XPC_SERVICE_NAME': '0', 04:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:51 INFO - Downloading/unpacking jsonschema 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:53 INFO - Downloading/unpacking functools32 (from jsonschema) 04:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:54 INFO - warning: no files found matching '*.txt' 04:42:54 INFO - no previously-included directories found matching 'build' 04:42:54 INFO - no previously-included directories found matching 'dist' 04:42:54 INFO - no previously-included directories found matching '.git*' 04:42:54 INFO - Installing collected packages: jsonschema, functools32 04:42:54 INFO - Running setup.py install for functools32 04:42:54 INFO - warning: no files found matching '*.txt' 04:42:54 INFO - no previously-included directories found matching 'build' 04:42:54 INFO - no previously-included directories found matching 'dist' 04:42:54 INFO - no previously-included directories found matching '.git*' 04:42:54 INFO - Successfully installed jsonschema functools32 04:42:54 INFO - Cleaning up... 04:42:54 INFO - Return code: 0 04:42:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:42:54 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')]} 04:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:54 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')]} 04:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:54 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 0x10ba4ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba5b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd87acb3810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, '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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:42:54 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 04:42:54 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 04:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:54 INFO - 'HOME': '/Users/cltbld', 04:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:54 INFO - 'LOGNAME': 'cltbld', 04:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:54 INFO - 'MOZ_NO_REMOTE': '1', 04:42:54 INFO - 'NO_EM_RESTART': '1', 04:42:54 INFO - 'PAGER': '/bin/cat', 04:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:54 INFO - 'PWD': '/builds/slave/test', 04:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:54 INFO - 'SHELL': '/bin/bash', 04:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:42:54 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:54 INFO - 'USER': 'cltbld', 04:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:54 INFO - 'XPC_FLAGS': '0x0', 04:42:54 INFO - 'XPC_SERVICE_NAME': '0', 04:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:54 INFO - Downloading/unpacking flake8 04:42:54 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 04:42:54 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 04:42:54 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 04:42:54 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 04:42:54 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 04:42:54 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 04:42:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:42:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42: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 04:42:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:42:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:42:57 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 04:42:57 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 04:42:57 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 04:42:57 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 04:42:57 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 04:42:57 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 04:42:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:42:57 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 04:42:57 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 04:42:57 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 04:42:57 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 04:42:57 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 04:42:57 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 04:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:42:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:58 INFO - no previously-included directories found matching 'docs/_build' 04:42:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:42:58 INFO - Running setup.py install for pep8 04:42:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:42:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:42:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:42:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:42:58 INFO - no previously-included directories found matching 'docs/_build' 04:42:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:42:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:42:58 INFO - Cleaning up... 04:42:58 INFO - Return code: 0 04:42:58 INFO - Running post-action listener: _resource_record_post_action 04:42:58 INFO - Running post-action listener: _start_resource_monitoring 04:42:58 INFO - Starting resource monitoring. 04:42:58 INFO - ##### 04:42:58 INFO - ##### Running install step. 04:42:58 INFO - ##### 04:42:58 INFO - Running pre-action listener: _resource_record_pre_action 04:42:58 INFO - Running main action method: install 04:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:58 INFO - Reading from file tmpfile_stdout 04:42:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:58 INFO - Reading from file tmpfile_stdout 04:42:58 INFO - Output received: 04:42:58 INFO - Usage: mozinstall [options] installer 04:42:58 INFO - Options: 04:42:58 INFO - -h, --help show this help message and exit 04:42:58 INFO - -d DEST, --destination=DEST 04:42:58 INFO - Directory to install application into. [default: 04:42:58 INFO - "/builds/slave/test"] 04:42:58 INFO - --app=APP Application being installed. [default: firefox] 04:42:58 INFO - mkdir: /builds/slave/test/build/application 04:42:58 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'] 04:42:58 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 04:43:33 INFO - Reading from file tmpfile_stdout 04:43:33 INFO - Output received: 04:43:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:43:33 INFO - Running post-action listener: _resource_record_post_action 04:43:33 INFO - ##### 04:43:33 INFO - ##### Running run-tests step. 04:43:33 INFO - ##### 04:43:33 INFO - Running pre-action listener: _resource_record_pre_action 04:43:33 INFO - Running main action method: run_tests 04:43:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:33 INFO - 2016-04-07 04:43:33.082 screenresolution[1666:7708] starting screenresolution argv=screenresolution get 04:43:33 INFO - 2016-04-07 04:43:33.085 screenresolution[1666:7708] Display 0: 1600x1200x32@60 04:43:33 INFO - 2016-04-07 04:43:33.091 screenresolution[1667:7710] starting screenresolution argv=screenresolution list 04:43:33 INFO - Available Modes on Display 0 04:43:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:33 INFO - Intel Iris: 04:43:33 INFO - Chipset Model: Intel Iris 04:43:33 INFO - Type: GPU 04:43:33 INFO - Bus: Built-In 04:43:33 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:33 INFO - Vendor: Intel (0x8086) 04:43:33 INFO - Device ID: 0x0a2e 04:43:33 INFO - Revision ID: 0x0009 04:43:33 INFO - Displays: 04:43:33 INFO - Display: 04:43:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:33 INFO - Display Serial Number: 1600x1200 60 04:43:33 INFO - Main Display: Yes 04:43:33 INFO - Mirror: Off 04:43:33 INFO - Online: Yes 04:43:33 INFO - Rotation: Supported 04:43:33 INFO - Return code: 0 04:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:33 INFO - Python 2.7.3 04:43:33 INFO - Return code: 0 04:43:33 INFO - grabbing minidump binary from tooltool 04:43: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')]} 04:43:33 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 0x10b8eae00>, '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 0x10b713db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b8e5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:33 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 04:43:33 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 04:43:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:33 INFO - Return code: 0 04:43:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:43:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:43:34 INFO - Return code: 0 04:43:34 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--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 04:43:34 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/Nightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --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 04:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rP7xTBOpDV/Render', 04:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:34 INFO - 'HOME': '/Users/cltbld', 04:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:34 INFO - 'LOGNAME': 'cltbld', 04:43:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:34 INFO - 'MOZ_NO_REMOTE': '1', 04:43:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:34 INFO - 'NO_EM_RESTART': '1', 04:43:34 INFO - 'PAGER': '/bin/cat', 04:43:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:34 INFO - 'PWD': '/builds/slave/test', 04:43:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:34 INFO - 'SHELL': '/bin/bash', 04:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xbtDUZB5lO/Listeners', 04:43:34 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:34 INFO - 'USER': 'cltbld', 04:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:34 INFO - 'XPC_FLAGS': '0x0', 04:43:34 INFO - 'XPC_SERVICE_NAME': '0', 04:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:34 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--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 04:43:34 INFO - mozversion application_buildid: 20160406030021 04:43:34 INFO - mozversion application_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:43:34 INFO - mozversion application_display_name: Nightly 04:43:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:34 INFO - mozversion application_name: Firefox 04:43:34 INFO - mozversion application_remotingname: firefox 04:43:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:34 INFO - mozversion application_vendor: Mozilla 04:43:34 INFO - mozversion application_version: 48.0a1 04:43:34 INFO - mozversion platform_buildid: 20160406030021 04:43:34 INFO - mozversion platform_changeset: 68c0b7d6f16ce5bb023e08050102b5f2fe4aacd8 04:43:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:34 INFO - mozversion platform_version: 48.0a1 04:43:34 INFO - using testdate: 1460029414 04:43:34 INFO - actual date: 1460029414 04:43:34 INFO - starting webserver on 'localhost:49272' 04:43:34 INFO - SUITE-START | Running 2 tests 04:43:34 INFO - TEST-START | dromaeo_css 04:43:34 INFO - operating with platform_type : mac_ 04:43:34 INFO - Initialising browser for dromaeo_css test... 04:43:34 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpHOWbjd/profile http://localhost:49272/getInfo.html) 04:43:37 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 04:43:37 INFO - PROCESS | 1685 | colorDepth:24 04:43:37 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 04:43:37 INFO - PROCESS | 1685 | __metrics 04:43:37 INFO - PROCESS | 1685 | 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" 04:43:37 ERROR - PROCESS | 1685 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:43:37 INFO - TEST-INFO | 1685: exit 0 04:43:37 INFO - Browser initialized. 04:43:37 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:37 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpHOWbjd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:49 INFO - PROCESS | 1687 | RSS: Main: 236400640 04:43:49 INFO - PROCESS | 1687 | 04:44:40 INFO - PROCESS | 1687 | 1460029480856 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] 04:46:51 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 04:46:52 INFO - PROCESS | 1687 | RSS: Main: 343998464 04:46:52 INFO - PROCESS | 1687 | 04:49:54 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 04:49:55 INFO - PROCESS | 1687 | RSS: Main: 364703744 04:49:55 INFO - PROCESS | 1687 | 04:52:57 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 04:52:58 INFO - PROCESS | 1687 | RSS: Main: 365600768 04:52:58 INFO - PROCESS | 1687 | 04:56:00 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 04:56:01 INFO - PROCESS | 1687 | RSS: Main: 320569344 04:56:01 INFO - PROCESS | 1687 | 04:59:04 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 04:59:04 INFO - PROCESS | 1687 | RSS: Main: 324775936 04:59:04 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 05:02:07 INFO - PROCESS | 1687 | RSS: Main: 429735936 05:02:07 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | __start_tp_report 05:02:07 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 05:02:07 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 05:02:07 INFO - PROCESS | 1687 | |i|pagename|runs| 05:02:07 INFO - PROCESS | 1687 | |0;dojo.html;3025.969740302596;3026.198057514758;3439.2949445363697;3482.5298584691077;3509.035015370774;5521.365043020054;5611.8316450506445;5648.830535083949;5684.744186511606;5687.601867869245;5664.376918538957;5669.291338582677;5714.428557144294;5836.766529338822;5865.618734782247;5064.468230835764;5095.898082038376;5106.361704786902;5123.923141152885;5222.399424066224;5240.9213861792105;5247.501487358695;5261.263423120766;5296.576273898079;5301.6818990860675;5053.898922021557;5076.593872490192;5136.895567452997;5166.88911883943;5189.662671926313;5111.131107711698;5135.537801597837;5135.589152867799;5139.254808052811;5143.897122057538;5077.64456488046;5099.08216521026;5114.693118412907;5115;5142.871428214287;5499.092649712793;5580.414056524088;5602.663840169562;5675;5711.600187986843;6126;6149.0776383542825;6153.476954458832;6163.8150855474405;6168.629882207037;6144.907826382608;6151.384861513813;6182.814515564541;6198.008318668992;6199;5688.516476099495;5706.172604972256;5796.42035796417;5800.4199580042505;5804.2744656917885;6212.669030650617;6245.156903817927;6260.123582698426;6262.655553944577;6268.655223962634;6054.122152287981;6054.8183554493435;6094.9695251524345;6102.969485152635;6118.235220597426;6087.299960504599;6148.508119350441;6151.0773383992755;6166.876662466726;6169.784057558054;6097.373446762125;6112.724927378279;6121.87979361315;6126.517673797278;6140.4428991762525;6126.426068710516;6144.354842741537;6160.630362178194;6162.630242185483;6167.6916154193;4864.294677271847;4867.58625516835;4923.335349727741;4923.48303428142;4941.357623508921;4342;4346.130773845243;4466.6873318867365;4467.039586488921;4479.350494178326;5624.240727501817;5635.408282130399;5669.971650141723;5676.8864622707315;5720.8283751487525;6231.127642130105;6273.686315684197;6278.46633036197;6290.779822706275;6291.905621415683;5510.256115424447;5580.386157522669;5620.718964051781;5650.3219613646625;5651.321841378978;5329.173978033411;5332.466753324714;5346.893062138735;5374.8656283592445;5431.103867861759;6262.749490020348;6263.467605253604;6266.373362663697;6279.058141278845;6282.842928926813;6126.548209435115;6147.569670123227;6237.625742455467;6268;6283.842903927439;6267.4045965633195;6273.215848018997;6287.779927702509;6288.779892703734;6295.3389894060465;6121.816345509642;6201.3178550358525;6204.317525072329;6204.472619827366;6218.284897236876;6076.6961651916345;6148.354422785722;6219.720112595034;6234.844128896814;6255.749770009149;6099.340048628031;6099.512039036777;6104.277264894319;6109.403503511079;6136.815895523141;5933.643981361132;6076.270847498328;6096.268447786117;6111;6123.601965872204;5767.625104368202;5924.407559244041;5972.581919265784;6003.429674180946;6044.637321760709;6060.818175454743;6083.482903953213;6115.969420152871;6125.908111378244;6129.3564175762685;4924.901501970012;5782.5373970081455;5990.910136347871;5994.370591088047;6004.189434426296 05:02:07 INFO - PROCESS | 1687 | |1;ext.html;494.67104375590236;560.8738033942363;577.6332029161481;626.8025571944838;633.2685747961106;23411.882940585296;29187.562186567193;29296.414071718555;36759.4486082709;37157;39441.605583944154;39955.800220998855;39988.20023599526;40067.599324006755;40261;9330.300227482914;9564.856527152098;9571.712848614517;9574.234061275116;9578.856317155249;9252.398594091395;9401.905980940172;9418;9427.434353938752;9429.481378524179;9355.204807591363;9383.202427793645;9438.952805235964;9474.336796424253;9576.186024187953;9473;9534.427934323963;9552.14030737237;9569.56936937836;9573.569189386495;9391.154796068387;9534.09426104519;9534.189593884528;9550.713478595584;9554.378965367297;38594.03514912121;38697.61302386996;38928;38952.41571376432;39007.60992390068;3172.2069482629345;3210.4060748761553;3249.7400207983305;3262.5269335946155;3446.9482957755654;28097.43805123886;28389;28605.71394286051;28698;29239.2690182745;2661.2681512584195;2736.179146256135;2740.4656092062055;2741.8354898706143;2745.4509098180442;470277;471053;471427.64286178694;472978;473078;44076.55923440788;44848.77575612101;62797;64063.35936640667;64451.03323450152;44221.115577688266;44388.77805611016;44509.66471005875;44652.883677908314;44694;15132;15245.085294882343;15256;15299.694006120038;15318.463853765288;12322.89093981546;12434.129610927148;12438.875611243771;12439.564615238423;12465.439055242536;13719.794203086962;13971.441142354395;14021.649458763408;14022.789658155136;14124.30508339006;5473.75368108436;6073.544484163705;6292.860427454687;6344.746210151542;6358.205224346957;940.7930255343813;943.2077055273603;1034.6637342863448;1145.007686625266;1157.907367410605;28756.281092972426;28761.71238287632;29255.56116658252;29388.265293367836;29667.406651867273;1082.951267192978;1110.8000559899135;1138.8007098757685;1185.5713864792904;1215.3801561203672;11959.701007474709;14658.926705366619;14738.778918316233;15117;15132.848671513364;525614;533325;540317;540937.2953135209;543052;58305.708471458216;58686.70656646775;58753.82492350129;59093;59278.70360648169;1301.6550614087275;1426.9072510286799;1429.9285035748171;1447.3776276201545;1467.449706360115;28359.007434739684;28960.565591515722;28974.710252898043;29036.7096329034;30820.691793081784;52658.473415265355;53006.469935300156;53707;53772;53852.730736346064;411328;414814;415668;415982.9200853976;416156;37022.040261343944;40950.59049409468;43298;43946;44863.775681121384;41693.74918752442;41975.7901210492;42423;42981.355279670206;43350.56649433466;34705;35102.12244693801;35238;35889.102772430895;35973.460398094576;34849.47725784166;34914;35247.647523524436;35468.64531354757;35560.82219588885;35815.64184358123;36275.63724362723;36335;36823.89528314155;37547.249055019296;32350;32640.96142213698;33158.67365305361;33248.66751332456;33351.666483334855;24399.634005490287;24697.259082227563;24939.501209975337;25010;25151 05:02:07 INFO - PROCESS | 1687 | |2;jquery.html;352.93941705175945;360.310006337863;363.244451540795;366.88259756877795;373.75705791235674;19004.334848280312;19323.710144347828;19667.409977700674;19747.40757777269;19766.505837354074;20051.29820456284;20699.586008279824;20953.266635667755;21153.259635912746;21157.57684846302;5649.774009039644;5847.181394604759;5887.0286402743495;5897.203877476529;5897.3218079920925;4236.216299984498;4402.691811573191;4462.843800466984;5956.22569066023;6532.379423954717;6454.709538070774;6459.9354006460035;6461.903071453932;6464.644444555547;6474.449671777905;5126.794928202868;6233.625982441068;6342.587731797442;6393.296737358887;6434.517411194132;3709.7217708671956;5311.415744268127;5566.777328906839;5571.164325351189;5581.469760372758;23492.76507234923;23938.52122957531;24209.63685544718;25484;25657.871710641513;1934.912928918188;2261.8869056547105;2541.758532939368;2618.6726659167603;2830.6178665880047;6785.830354241183;6792.252852186256;6824.624645644488;6830.931690683079;7334.339909408125;1592.3153044190992;1630.6820170066842;1630.828762979882;1667.3580671441462;1715.3738885306898;68868;86987;91196;91951;92318.15363692756;10371.481425928674;10388.013138751807;10447.164226861833;10498.580056797642;10590.682279531626;12802.231866088065;12816.295103769382;12821;12884.033697472727;12890.419931103123;8331.916680833236;8480.703175388955;8485.490870547786;8561.957190214009;8588.141185881363;8818.118188181259;8827.984781750052;8837.558122093998;8921.286297096216;8929.73210803677;6035.517158627387;6148.661823599745;6152.292486364126;6165.383461653889;6167.5682702210415;1733.3586572968084;1768.6462707458559;1772.5391398236293;1791.2208189437636;1793.757842691246;916.445550441973;965.9806803863884;976.345848281653;1012.9493525323704;1032.9276950613385;20370.898145509178;20630.58738825245;20637.896810515853;20944.162233510488;20961.68557471639;877.88587483628;898.3666515106834;960.9663661771805;974.2936371130874;1022.2231104360591;11234.887651123385;11375.31748095117;11382.203245772882;11386.544538218544;11421.486033128529;587162;594060;604390;615438;623303;59216;59409.405905941254;75659.62170189114;99294.5035274819;100035.49982250042;928.1831987850649;1013.1135256650431;1029.6807989523272;1062.8512008318842;1066.1737153705785;18131.909340453214;18576.943523905386;19074.52313692169;19091;19173;46257.9003202472;47472;48100.75949620229;48460.5153948456;48473.75763121162;50613.493865060875;66581.66709166423;66764.99852502314;67313;67850.98223526552;7411.851163069733;7502.399808015455;7529.585872776831;7573.659185336784;7846;9354.29842761782;11250.943745281222;12205.755884882075;12211.023118150704;12248.816267756169;9008.864867026869;10337.483125843828;10572.788544228919;10651.254412191072;10661.94669026681;10229.079382855578;10245.899590583764;10248.333858299187;10509.001644843727;10622.575096996034;8086.676532938616;10509.947450263006;10727.839082413926;10776.515056822618;10946.452677366258;7429.219931907072;7509.361704254981;7574.280443357872;7686.6541005656;7777.066751989797;10436.269461137648;10595.152387808803;10617.893821062;10726.570937162425;10828.837567436338 05:02:07 INFO - PROCESS | 1687 | |3;mootools.html;1525.961850953726;1559.6802655455633;1808.6834803909321;1904.847612191023;1972.921083156673;8665.090165532614;8710.782230444242;8860.069692682273;8865.246454051414;8889.822203555934;6428.710708018139;8000.319972802319;8524.659013639463;8714.215720585145;8760.342974276922;2457.152282462552;2500.374756408331;2503.249025292414;2505.5114252720728;2506.235598142566;2153.450870028141;2415.3478560788576;2500.3999040230306;2504.949901001979;2509.8619575923317;1849.759531260941;1965.8722183058128;2478.1450399612195;2482.913098041569;2484.254723582918;2406.7713567211085;2425.1996841042414;2432.3189506937997;2464.2114523352534;2465.568525508047;2403.6034054381007;2440.572899742556;2453.7055553333535;2455.889484973163;2459.3359792855827;8877.467351958903;8929.598168082452;8944.552772361421;8946.64213431462;8982.461052336881;4683.157031734287;5464.972675136639;5583.748731307101;5618.887622247573;5638.097904335286;2926.3708302715017;3567.839447224881;3673.265346930598;3700.9444858327147;3701;1027.984580231297;1048.1614708233383;1050;1052.310736467615;1057.5716834681966;12268.877311226863;12347.62957111288;12359.691007724789;12362.75274494514;12396.132270740962;4860.3195552622665;4917.286993385939;4933.580645645088;4973.328600638867;5009;10332.070113689804;10343.327683700536;10351.534180961875;10366.222533310032;10367.533460994273;5582.97208513963;5584.246126772834;5594.776208951678;5603.719814009283;5622.718864056781;4947.332110165082;5024.397072351341;5046.9747651261505;5083.949160508421;5089.898202035939;3927.5286965563746;3938.586448422874;3964.1080756829483;3990.38149086892;3992.48097747291;1058.7988282226352;1192.5229908036854;1243.7699025680279;1291.231717128307;1324.218710960538;1294.0941341061296;1302.5310888080282;1328.3491089366141;1374.8144000559996;1375.7592421326428;8138.633761480747;8142.511449312941;8437.620307086196;8441.915580844236;8452.450590711584;1162.7674465107013;1176.2236923630362;1184.3604453594962;1195.8744331845205;1214.5991822698488;6275.403836635513;6302.180716506825;6351.04734289851;6372.681365931685;6375.139356186948;10419.06228439444;10709;10719.410432426135;10846.728831779112;10870.347779133119;10675.306105103144;10728;10753.83869241962;10868.891311086945;10914.126869850394;8314.958425207835;8457.703980360659;8490.915090849136;8543.0602633709;8567.700130495403;7977.361811054986;7995.440319177602;8064.758057258292;8081.111077781322;8124.918750812652;9433.622655093719;9781.657641982496;9818;9933.205343572641;9960.452175130438;9992.850107248252;10103.444310562989;10267.486625668538;10330.276880618585;10341.965803419598;7065.434765218667;7083.008378826866;7111.182214045244;7173.856522869409;7197.640117993975;8295.253427191581;8348.248657620843;8382.155925696337;8386.32909367237;8394.916050839658;6842.794716158523;6987;7389.150247721581;7522.398208143226;7620.80947976305;7317.707291708272;7325.377342925911;7370.668319925723;7398.741044063432;7407.777766667009;6961.269066747918;7407.222241664547;7414.814629634302;7465.850682986418;7484.176740558643;6979.8604027918145;6985.057017302599;7033.859322813412;7043.436525078084;7051.612161330971;6872.759453419107;7076.787696369117;7196.748113815991;7226.674799634135;7227.638618068971 05:02:07 INFO - PROCESS | 1687 | |4;prototype.html;316.12433559041455;320.02392702258123;327.2065241788662;329.0966297513326;332.312113924177;6498.870022599545;6509;6557.245916719578;6587.473002159828;6605.669716514167;6539.574927629713;6547.083408322838;6549.312322206171;6557.83605409865;6563.245226798919;4642.396488456496;4747.85756427306;4769.618430525549;4810.687305325143;4843.539863712942;4717.221658426355;4784.210605250129;4801.399825021872;4811.2302031674935;4823.493533179018;4771.42742870856;4782.04359128174;4788.449328327252;4799.856004319876;4820.301056346828;4611.746353950548;4689.671722979409;4777.713337199779;4787.712737235742;4803.255495398219;4104.938425923614;4107.466029416157;4111.2188684150215;4111.753294802292;4129.710920235585;6212.627242365473;6247.937520624827;6313.842153946142;6345.460635845959;6358.936410635881;5052.837847295143;5273.630845840793;5688.687122208277;5710.7430165642645;5724.16999535065;6933.0293758873795;6936.861262774716;6938.306169383021;6944.965275173642;6949.965250173716;4306.849260275907;4468.4414448193975;4473.351364052227;4485.3944717463055;4518.051209246062;7174.605396703179;7324.707011719524;7329.413646908234;7344.081989751281;7354.963225183893;4551.590356867898;4557.202489564379;4559.475660299042;4563.543645635476;4567.4062371892105;4610.170169369479;4631.374764406829;4631.467381251132;4633.467151277646;4641.466231383367;5496.203050557647;5507.586930980193;5511.807086751945;5519.641223320471;5528.861778455571;6680.5323627345615;6942.618156001468;6943.618101004493;6976.441884649216;7015.333543313377;1585.4926423544587;1602.9358825646843;1612.387292828741;1613.3304678558268;1617.6279455725248;954.2604481526872;980.9901900980899;1012.8176928152856;1012.9290949633455;1041.2555023158477;6340.682965851689;6505.7397704092255;6513.1532900722605;6544.541882068304;6548.8362790930605;7238.022866913005;7243.0946131733535;7247.9637601811655;7252.456065795086;7269.927300727031;5705.429457054344;6208.348123447064;6464.321246269168;6521.217453905561;6582.275949645536;3119.407312610597;3812.9809350953624;3839.6544311012144;3860.247251785931;3872.980635096863;7214.134303883463;7536;7539.359154471931;7568.508046976929;7595.202503737028;7411.629418529052;7437.739679111313;7446.95742596037;7464.776056718307;7465.216152303929;7519.624018799038;7528.096628404626;7530.774076777706;7532.058492688414;7550.169481357156;6866.141732283465;7264.600446975256;7265.09186351706;7270.200277969525;7272.23641517633;7056.7530136444975;7118.466115041289;7122.145342558926;7125.073740413713;7142.9285707144345;7510.549367037996;7526.24737526243;7548.660310285941;7548.735794247175;7557.848843022999;3495.877644282438;4597.586217240464;4600.608948239437;4601.907961840678;4607.378003969556;6746.224184218878;7202.315780000891;7206.315400036988;7206.89189662166;7239.8914016290855;5712.457316554921;6708.765193218214;7030.402415794715;7033.472489563405;7039.507234493536;6054.878902422015;6706.396424321834;6887.242403335729;7010.509264351446;7023.367896889305;5768.278965129359;6671.099401580725;6820.147481564804;6877;6899.586024838526;6744;7002.649867506502;7018;7018.473614479037;7035.648217589202;6601.108850305147;6660.333966603301;6699.665016749241;6828.248892621708;6842.657867106725 05:02:07 INFO - PROCESS | 1687 | |5;yui.html;638.9712462939167;671.6910221298202;690.354518525179;691.8685449764541;702.2836706559312;14433.71132577349;14791;14796.926015369922;14803.777943330859;14804.6298842529;13598.72802543951;13626.977976651766;13685.794713079287;13720.58838234852;13736.175829450214;718.0629278791175;727.0693512304259;876.5748611923228;890.4078787606234;891.6611687558718;897.6050537763364;899.3884158772032;904.5612877754284;905.1717678324326;906.2795077913075;956.4404823178448;960.4237457525498;961.6393852305386;961.7932144588912;964.5322018820866;759.4266328921657;769.2307692307664;771.1478815908453;933.3280038372361;953.9475328856945;687.1959807025792;703.0192880931123;704.837887285922;705.0798707686467;705.5766540075965;14756.704865902622;14807.925960370128;14837.406503739838;14842.406303747837;14859.925700371428;12598.937005314914;12647.430865610977;12716.809247861289;12810.423530941036;13074.346282685923;9795.90204097957;9912.405255684682;10114.747131321776;10254.69235922916;10689.358638481715;3100.2404410919244;3485;3486.3027394521196;3493.266414053052;3529.1353618363664;74667.62666186634;77058;77058.22941770566;77246.22753772503;77434;9294.163525282622;9687.17658998993;9719.56261968213;9794.902050979541;9842.704718858446;21673.45816354572;21833;21833.563328733337;21839.45401364947;21850.453738656342;7378.889316660255;7417;7486.213947535539;7553.055868016498;7633.351165150913;3853.537575490959;3911.7457365271166;3915.8433662653174;3929.528456585228;3961.603839616015;3494.825258737053;3525.25969546393;3556.6621170988715;3557.9110522236633;3566.4828599853395;563.6815199412318;603.9365866584034;613.3222788818381;621.0963048764038;631.6210273835753;552.9364123125893;571.794154104522;574.5489790514426;592.6088781404253;596.8955432799243;7705.4220933430215;7875.330596899214;7949.64226609804;8032.844528305657;8049.879251811228;561.8904313658797;571.7370009795541;584.4885724990634;590.8138936235072;605.7122866638312;3377.712894403954;3476.91307717304;3703.8888833335045;3748.981255093707;3942.802859856996;85398.57300713581;86174;87072;87382.12617873868;87593.1240687585;74669.62665186639;74760;74887;75024;75850.62074689592;49235.75382123138;65465;66044.99999999904;66217.00674489887;66746.66626666836;6475.935240647534;7256.2018178001435;7510.511816732113;7685.423593230418;7709.953672602972;47683.76158119187;48051;48881.755591221816;49291;50397.968162546174;58330;59035.40964590299;63632.68183659052;63687.363126368145;63901;10806.513706883366;10892.673219803419;11063.889361106609;11989;11999.220050696676;12084.214526055779;12120.757584848077;12167.45246463929;12185.086118541321;12357.93821030889;11372.772544548898;11802.94098529502;11864;11905.464254108412;11941.76116477683;11312.6040588579;11339.603113891304;11405.657830265105;11625;11848.70378240551;10948.34309941406;11138.27601205919;11162.720931976766;11519.366434846164;11806.763864722829;9367.110124538158;9578.521073946415;9744;9905.033902197867;10744.677659670222;7532.7740167795055;8481.618327175169;8744.912550874664;8941.865872012055;9546.093121153479 05:02:07 INFO - PROCESS | 1687 | __end_tp_report 05:02:07 INFO - PROCESS | 1687 | __start_cc_report 05:02:07 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1052 05:02:07 INFO - PROCESS | 1687 | __end_cc_report 05:02:07 INFO - PROCESS | 1687 | __startTimestamp1460030527716__endTimestamp 05:02:07 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | ------- Summary: start ------- 05:02:07 INFO - PROCESS | 1687 | Number of tests: 6 05:02:07 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | [#0] dojo.html Cycles:165 Average:5703.77 Median:5994.37 stddev:646.65 (10.8%) stddev-sans-first:613.56 05:02:07 INFO - PROCESS | 1687 | Values: 3026.0 3026.2 3439.3 3482.5 3509.0 5521.4 5611.8 5648.8 5684.7 5687.6 5664.4 5669.3 5714.4 5836.8 5865.6 5064.5 5095.9 5106.4 5123.9 5222.4 5240.9 5247.5 5261.3 5296.6 5301.7 5053.9 5076.6 5136.9 5166.9 5189.7 5111.1 5135.5 5135.6 5139.3 5143.9 5077.6 5099.1 5114.7 5115.0 5142.9 5499.1 5580.4 5602.7 5675.0 5711.6 6126.0 6149.1 6153.5 6163.8 6168.6 6144.9 6151.4 6182.8 6198.0 6199.0 5688.5 5706.2 5796.4 5800.4 5804.3 6212.7 6245.2 6260.1 6262.7 6268.7 6054.1 6054.8 6095.0 6103.0 6118.2 6087.3 6148.5 6151.1 6166.9 6169.8 6097.4 6112.7 6121.9 6126.5 6140.4 6126.4 6144.4 6160.6 6162.6 6167.7 4864.3 4867.6 4923.3 4923.5 4941.4 4342.0 4346.1 4466.7 4467.0 4479.4 5624.2 5635.4 5670.0 5676.9 5720.8 6231.1 6273.7 6278.5 6290.8 6291.9 5510.3 5580.4 5620.7 5650.3 5651.3 5329.2 5332.5 5346.9 5374.9 5431.1 6262.7 6263.5 6266.4 6279.1 6282.8 6126.5 6147.6 6237.6 6268.0 6283.8 6267.4 6273.2 6287.8 6288.8 6295.3 6121.8 6201.3 6204.3 6204.5 6218.3 6076.7 6148.4 6219.7 6234.8 6255.7 6099.3 6099.5 6104.3 6109.4 6136.8 5933.6 6076.3 6096.3 6111.0 6123.6 5767.6 5924.4 5972.6 6003.4 6044.6 6060.8 6083.5 6116.0 6125.9 6129.4 4924.9 5782.5 5990.9 5994.4 6004.2 05:02:07 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | [#1] ext.html Cycles:180 Average:61166.86 Median:38812.81 stddev:126900.77 (327.0%) stddev-sans-first:127175.00 05:02:07 INFO - PROCESS | 1687 | Values: 494.7 560.9 577.6 626.8 633.3 23411.9 29187.6 29296.4 36759.4 37157.0 39441.6 39955.8 39988.2 40067.6 40261.0 9330.3 9564.9 9571.7 9574.2 9578.9 9252.4 9401.9 9418.0 9427.4 9429.5 9355.2 9383.2 9439.0 9474.3 9576.2 9473.0 9534.4 9552.1 9569.6 9573.6 9391.2 9534.1 9534.2 9550.7 9554.4 38594.0 38697.6 38928.0 38952.4 39007.6 3172.2 3210.4 3249.7 3262.5 3446.9 28097.4 28389.0 28605.7 28698.0 29239.3 2661.3 2736.2 2740.5 2741.8 2745.5 470277.0 471053.0 471427.6 472978.0 473078.0 44076.6 44848.8 62797.0 64063.4 64451.0 44221.1 44388.8 44509.7 44652.9 44694.0 15132.0 15245.1 15256.0 15299.7 15318.5 12322.9 12434.1 12438.9 12439.6 12465.4 13719.8 13971.4 14021.6 14022.8 14124.3 5473.8 6073.5 6292.9 6344.7 6358.2 940.8 943.2 1034.7 1145.0 1157.9 28756.3 28761.7 29255.6 29388.3 29667.4 1083.0 1110.8 1138.8 1185.6 1215.4 11959.7 14658.9 14738.8 15117.0 15132.8 525614.0 533325.0 540317.0 540937.3 543052.0 58305.7 58686.7 58753.8 59093.0 59278.7 1301.7 1426.9 1429.9 1447.4 1467.4 28359.0 28960.6 28974.7 29036.7 30820.7 52658.5 53006.5 53707.0 53772.0 53852.7 411328.0 414814.0 415668.0 415982.9 416156.0 37022.0 40950.6 43298.0 43946.0 44863.8 41693.7 41975.8 42423.0 42981.4 43350.6 34705.0 35102.1 35238.0 35889.1 35973.5 34849.5 34914.0 35247.6 35468.6 35560.8 35815.6 36275.6 36335.0 36823.9 37547.2 32350.0 32641.0 33158.7 33248.7 33351.7 24399.6 24697.3 24939.5 25010.0 25151.0 05:02:07 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | [#2] jquery.html Cycles:180 Average:32133.63 Median:2304.99 stddev:99301.76 (4308.1%) stddev-sans-first:99551.65 05:02:07 INFO - PROCESS | 1687 | Values: 352.9 360.3 363.2 366.9 373.8 19004.3 19323.7 19667.4 19747.4 19766.5 20051.3 20699.6 20953.3 21153.3 21157.6 5649.8 5847.2 5887.0 5897.2 5897.3 4236.2 4402.7 4462.8 5956.2 6532.4 6454.7 6459.9 6461.9 6464.6 6474.4 5126.8 6233.6 6342.6 6393.3 6434.5 3709.7 5311.4 5566.8 5571.2 5581.5 23492.8 23938.5 24209.6 25484.0 25657.9 1934.9 2261.9 2541.8 2618.7 2830.6 6785.8 6792.3 6824.6 6830.9 7334.3 1592.3 1630.7 1630.8 1667.4 1715.4 68868.0 86987.0 91196.0 91951.0 92318.2 10371.5 10388.0 10447.2 10498.6 10590.7 12802.2 12816.3 12821.0 12884.0 12890.4 8331.9 8480.7 8485.5 8562.0 8588.1 8818.1 8828.0 8837.6 8921.3 8929.7 6035.5 6148.7 6152.3 6165.4 6167.6 1733.4 1768.6 1772.5 1791.2 1793.8 916.4 966.0 976.3 1012.9 1032.9 20370.9 20630.6 20637.9 20944.2 20961.7 877.9 898.4 961.0 974.3 1022.2 11234.9 11375.3 11382.2 11386.5 11421.5 587162.0 594060.0 604390.0 615438.0 623303.0 59216.0 59409.4 75659.6 99294.5 100035.5 928.2 1013.1 1029.7 1062.9 1066.2 18131.9 18576.9 19074.5 19091.0 19173.0 46257.9 47472.0 48100.8 48460.5 48473.8 50613.5 66581.7 66765.0 67313.0 67851.0 7411.9 7502.4 7529.6 7573.7 7846.0 9354.3 11250.9 12205.8 12211.0 12248.8 9008.9 10337.5 10572.8 10651.3 10661.9 10229.1 10245.9 10248.3 10509.0 10622.6 8086.7 10509.9 10727.8 10776.5 10946.5 7429.2 7509.4 7574.3 7686.7 7777.1 10436.3 10595.2 10617.9 10726.6 10828.8 05:02:07 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | [#3] mootools.html Cycles:180 Average:6106.77 Median:5016.70 stddev:3241.62 (64.6%) stddev-sans-first:3232.43 05:02:07 INFO - PROCESS | 1687 | Values: 1526.0 1559.7 1808.7 1904.8 1972.9 8665.1 8710.8 8860.1 8865.2 8889.8 6428.7 8000.3 8524.7 8714.2 8760.3 2457.2 2500.4 2503.2 2505.5 2506.2 2153.5 2415.3 2500.4 2504.9 2509.9 1849.8 1965.9 2478.1 2482.9 2484.3 2406.8 2425.2 2432.3 2464.2 2465.6 2403.6 2440.6 2453.7 2455.9 2459.3 8877.5 8929.6 8944.6 8946.6 8982.5 4683.2 5465.0 5583.7 5618.9 5638.1 2926.4 3567.8 3673.3 3700.9 3701.0 1028.0 1048.2 1050.0 1052.3 1057.6 12268.9 12347.6 12359.7 12362.8 12396.1 4860.3 4917.3 4933.6 4973.3 5009.0 10332.1 10343.3 10351.5 10366.2 10367.5 5583.0 5584.2 5594.8 5603.7 5622.7 4947.3 5024.4 5047.0 5083.9 5089.9 3927.5 3938.6 3964.1 3990.4 3992.5 1058.8 1192.5 1243.8 1291.2 1324.2 1294.1 1302.5 1328.3 1374.8 1375.8 8138.6 8142.5 8437.6 8441.9 8452.5 1162.8 1176.2 1184.4 1195.9 1214.6 6275.4 6302.2 6351.0 6372.7 6375.1 10419.1 10709.0 10719.4 10846.7 10870.3 10675.3 10728.0 10753.8 10868.9 10914.1 8315.0 8457.7 8490.9 8543.1 8567.7 7977.4 7995.4 8064.8 8081.1 8124.9 9433.6 9781.7 9818.0 9933.2 9960.5 9992.9 10103.4 10267.5 10330.3 10342.0 7065.4 7083.0 7111.2 7173.9 7197.6 8295.3 8348.2 8382.2 8386.3 8394.9 6842.8 6987.0 7389.2 7522.4 7620.8 7317.7 7325.4 7370.7 7398.7 7407.8 6961.3 7407.2 7414.8 7465.9 7484.2 6979.9 6985.1 7033.9 7043.4 7051.6 6872.8 7076.8 7196.7 7226.7 7227.6 05:02:07 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | [#4] prototype.html Cycles:180 Average:5683.50 Median:6542.06 stddev:1832.88 (28.0%) stddev-sans-first:1793.20 05:02:07 INFO - PROCESS | 1687 | Values: 316.1 320.0 327.2 329.1 332.3 6498.9 6509.0 6557.2 6587.5 6605.7 6539.6 6547.1 6549.3 6557.8 6563.2 4642.4 4747.9 4769.6 4810.7 4843.5 4717.2 4784.2 4801.4 4811.2 4823.5 4771.4 4782.0 4788.4 4799.9 4820.3 4611.7 4689.7 4777.7 4787.7 4803.3 4104.9 4107.5 4111.2 4111.8 4129.7 6212.6 6247.9 6313.8 6345.5 6358.9 5052.8 5273.6 5688.7 5710.7 5724.2 6933.0 6936.9 6938.3 6945.0 6950.0 4306.8 4468.4 4473.4 4485.4 4518.1 7174.6 7324.7 7329.4 7344.1 7355.0 4551.6 4557.2 4559.5 4563.5 4567.4 4610.2 4631.4 4631.5 4633.5 4641.5 5496.2 5507.6 5511.8 5519.6 5528.9 6680.5 6942.6 6943.6 6976.4 7015.3 1585.5 1602.9 1612.4 1613.3 1617.6 954.3 981.0 1012.8 1012.9 1041.3 6340.7 6505.7 6513.2 6544.5 6548.8 7238.0 7243.1 7248.0 7252.5 7269.9 5705.4 6208.3 6464.3 6521.2 6582.3 3119.4 3813.0 3839.7 3860.2 3873.0 7214.1 7536.0 7539.4 7568.5 7595.2 7411.6 7437.7 7447.0 7464.8 7465.2 7519.6 7528.1 7530.8 7532.1 7550.2 6866.1 7264.6 7265.1 7270.2 7272.2 7056.8 7118.5 7122.1 7125.1 7142.9 7510.5 7526.2 7548.7 7548.7 7557.8 3495.9 4597.6 4600.6 4601.9 4607.4 6746.2 7202.3 7206.3 7206.9 7239.9 5712.5 6708.8 7030.4 7033.5 7039.5 6054.9 6706.4 6887.2 7010.5 7023.4 5768.3 6671.1 6820.1 6877.0 6899.6 6744.0 7002.6 7018.0 7018.5 7035.6 6601.1 6660.3 6699.7 6828.2 6842.7 05:02:07 INFO - PROCESS | 1687 | 05:02:07 INFO - PROCESS | 1687 | [#5] yui.html Cycles:180 Average:17499.41 Median:594.75 stddev:24067.23 (4046.6%) stddev-sans-first:24101.44 05:02:07 INFO - PROCESS | 1687 | Values: 639.0 671.7 690.4 691.9 702.3 14433.7 14791.0 14796.9 14803.8 14804.6 13598.7 13627.0 13685.8 13720.6 13736.2 718.1 727.1 876.6 890.4 891.7 897.6 899.4 904.6 905.2 906.3 956.4 960.4 961.6 961.8 964.5 759.4 769.2 771.1 933.3 953.9 687.2 703.0 704.8 705.1 705.6 14756.7 14807.9 14837.4 14842.4 14859.9 12598.9 12647.4 12716.8 12810.4 13074.3 9795.9 9912.4 10114.7 10254.7 10689.4 3100.2 3485.0 3486.3 3493.3 3529.1 74667.6 77058.0 77058.2 77246.2 77434.0 9294.2 9687.2 9719.6 9794.9 9842.7 21673.5 21833.0 21833.6 21839.5 21850.5 7378.9 7417.0 7486.2 7553.1 7633.4 3853.5 3911.7 3915.8 3929.5 3961.6 3494.8 3525.3 3556.7 3557.9 3566.5 563.7 603.9 613.3 621.1 631.6 552.9 571.8 574.5 592.6 596.9 7705.4 7875.3 7949.6 8032.8 8049.9 561.9 571.7 584.5 590.8 605.7 3377.7 3476.9 3703.9 3749.0 3942.8 85398.6 86174.0 87072.0 87382.1 87593.1 74669.6 74760.0 74887.0 75024.0 75850.6 49235.8 65465.0 66045.0 66217.0 66746.7 6475.9 7256.2 7510.5 7685.4 7710.0 47683.8 48051.0 48881.8 49291.0 50398.0 58330.0 59035.4 63632.7 63687.4 63901.0 10806.5 10892.7 11063.9 11989.0 11999.2 12084.2 12120.8 12167.5 12185.1 12357.9 11372.8 11802.9 11864.0 11905.5 11941.8 11312.6 11339.6 11405.7 11625.0 11848.7 10948.3 11138.3 11162.7 11519.4 11806.8 9367.1 9578.5 9744.0 9905.0 10744.7 7532.8 8481.6 8744.9 8941.9 9546.1 05:02:07 INFO - PROCESS | 1687 | -------- Summary: end -------- 05:02:07 INFO - PROCESS | 1687 | 05:02:08 INFO - TEST-INFO | 1687: exit 0 05:02:08 INFO - TEST-OK | dromaeo_css | took 1113319ms 05:02:08 INFO - TEST-START | kraken 05:02:08 INFO - operating with platform_type : mac_ 05:02:08 INFO - Initialising browser for kraken test... 05:02:08 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpFNbYlV/profile http://localhost:49272/getInfo.html) 05:02:10 INFO - PROCESS | 1697 | __metrics Screen width/height:1600/1200 05:02:10 INFO - PROCESS | 1697 | colorDepth:24 05:02:10 INFO - PROCESS | 1697 | Browser inner width/height: 1024/689 05:02:10 INFO - PROCESS | 1697 | __metrics 05:02:10 INFO - PROCESS | 1697 | 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:02:10 ERROR - PROCESS | 1697 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:02:11 INFO - TEST-INFO | 1697: exit 0 05:02:11 INFO - Browser initialized. 05:02:11 INFO - Running cycle 1/1 for kraken test... 05:02:11 INFO - TEST-INFO | started process 1699 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpFNbYlV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:22 INFO - PROCESS | 1699 | RSS: Main: 236490752 05:02:22 INFO - PROCESS | 1699 | 05:02:25 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:26 INFO - PROCESS | 1699 | RSS: Main: 282259456 05:02:26 INFO - PROCESS | 1699 | 05:02:28 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 05:02:29 INFO - PROCESS | 1699 | RSS: Main: 292659200 05:02:29 INFO - PROCESS | 1699 | 05:02:32 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 05:02:33 INFO - PROCESS | 1699 | RSS: Main: 277925888 05:02:33 INFO - PROCESS | 1699 | 05:02:35 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 05:02:35 INFO - PROCESS | 1699 | RSS: Main: 280944640 05:02:35 INFO - PROCESS | 1699 | 05:02:37 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:38 INFO - PROCESS | 1699 | RSS: Main: 281038848 05:02:38 INFO - PROCESS | 1699 | 05:02:41 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:41 INFO - PROCESS | 1699 | RSS: Main: 281178112 05:02:41 INFO - PROCESS | 1699 | 05:02:44 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:45 INFO - PROCESS | 1699 | RSS: Main: 281276416 05:02:45 INFO - PROCESS | 1699 | 05:02:48 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 05:02:48 INFO - PROCESS | 1699 | RSS: Main: 281452544 05:02:48 INFO - PROCESS | 1699 | 05:02:50 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:50 INFO - PROCESS | 1699 | RSS: Main: 316096512 05:02:50 INFO - PROCESS | 1699 | 05:02:52 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:53 INFO - PROCESS | 1699 | RSS: Main: 316104704 05:02:53 INFO - PROCESS | 1699 | 05:02:55 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:56 INFO - PROCESS | 1699 | RSS: Main: 323055616 05:02:56 INFO - PROCESS | 1699 | 05:02:58 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:59 INFO - PROCESS | 1699 | RSS: Main: 323956736 05:02:59 INFO - PROCESS | 1699 | 05:03:01 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:02 INFO - PROCESS | 1699 | RSS: Main: 323747840 05:03:02 INFO - PROCESS | 1699 | 05:03:03 INFO - PROCESS | 1699 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 05:03:04 INFO - PROCESS | 1699 | RSS: Main: 387002368 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | __start_tp_report 05:03:04 INFO - PROCESS | 1699 | _x_x_mozilla_page_load 05:03:04 INFO - PROCESS | 1699 | _x_x_mozilla_page_load_details 05:03:04 INFO - PROCESS | 1699 | |i|pagename|runs| 05:03:04 INFO - PROCESS | 1699 | |0;ai-astar;113;109;114;112;111;114;117;112;112;112 05:03:04 INFO - PROCESS | 1699 | |1;audio-beat-detection;161;121;144;158;119;144;151;146;195;139 05:03:04 INFO - PROCESS | 1699 | |2;audio-dft;185;184;187;185;186;184;185;184;182;183 05:03:04 INFO - PROCESS | 1699 | |3;audio-fft;78;73;72;99;78;83;83;85;79;55 05:03:04 INFO - PROCESS | 1699 | |4;audio-oscillator;94;96;127;78;79;82;113;80;79;110 05:03:04 INFO - PROCESS | 1699 | |5;imaging-gaussian-blur;92;87;92;88;91;89;92;88;92;88 05:03:04 INFO - PROCESS | 1699 | |6;imaging-darkroom;95;97;96;96;96;96;96;95;95;94 05:03:04 INFO - PROCESS | 1699 | |7;imaging-desaturate;86;106;137;135;88;86;86;85;87;86 05:03:04 INFO - PROCESS | 1699 | |8;json-parse-financial;56;55;53;53;53;55;51;64;56;53 05:03:04 INFO - PROCESS | 1699 | |9;json-stringify-tinderbox;67;70;74;80;74;68;70;68;69;71 05:03:04 INFO - PROCESS | 1699 | |10;stanford-crypto-aes;85;84;84;82;84;83;82;79;75;82 05:03:04 INFO - PROCESS | 1699 | |11;stanford-crypto-ccm;139;135;130;121;134;124;124;121;134;125 05:03:04 INFO - PROCESS | 1699 | |12;stanford-crypto-pbkdf2;140;129;139;140;143;127;141;139;137;137 05:03:04 INFO - PROCESS | 1699 | |13;stanford-crypto-sha256-iterative;67;67;62;62;63;62;62;65;66;67 05:03:04 INFO - PROCESS | 1699 | __end_tp_report 05:03:04 INFO - PROCESS | 1699 | __start_cc_report 05:03:04 INFO - PROCESS | 1699 | _x_x_mozilla_cycle_collect,1291 05:03:04 INFO - PROCESS | 1699 | __end_cc_report 05:03:04 INFO - PROCESS | 1699 | __startTimestamp1460030584246__endTimestamp 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | ------- Summary: start ------- 05:03:04 INFO - PROCESS | 1699 | Number of tests: 14 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:2.12 (1.9%) stddev-sans-first:2.24 05:03:04 INFO - PROCESS | 1699 | Values: 113.0 109.0 114.0 112.0 111.0 114.0 117.0 112.0 112.0 112.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:148.50 stddev:21.53 (14.5%) stddev-sans-first:22.30 05:03:04 INFO - PROCESS | 1699 | Values: 161.0 121.0 144.0 158.0 119.0 144.0 151.0 146.0 195.0 139.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.43 (0.8%) stddev-sans-first:1.51 05:03:04 INFO - PROCESS | 1699 | Values: 185.0 184.0 187.0 185.0 186.0 184.0 185.0 184.0 182.0 183.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#3] audio-fft Cycles:10 Average:78.50 Median:81.00 stddev:11.20 (13.8%) stddev-sans-first:11.88 05:03:04 INFO - PROCESS | 1699 | Values: 78.0 73.0 72.0 99.0 78.0 83.0 83.0 85.0 79.0 55.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:79.50 stddev:17.50 (22.0%) stddev-sans-first:18.56 05:03:04 INFO - PROCESS | 1699 | Values: 94.0 96.0 127.0 78.0 79.0 82.0 113.0 80.0 79.0 110.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:91.50 stddev:2.08 (2.3%) stddev-sans-first:2.06 05:03:04 INFO - PROCESS | 1699 | Values: 92.0 87.0 92.0 88.0 91.0 89.0 92.0 88.0 92.0 88.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 05:03:04 INFO - PROCESS | 1699 | Values: 95.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 94.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#7] imaging-desaturate Cycles:10 Average:98.20 Median:86.00 stddev:20.87 (24.3%) stddev-sans-first:21.66 05:03:04 INFO - PROCESS | 1699 | Values: 86.0 106.0 137.0 135.0 88.0 86.0 86.0 85.0 87.0 86.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:3.57 (6.5%) stddev-sans-first:3.77 05:03:04 INFO - PROCESS | 1699 | Values: 56.0 55.0 53.0 53.0 53.0 55.0 51.0 64.0 56.0 53.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:70.50 stddev:3.93 (5.6%) stddev-sans-first:3.88 05:03:04 INFO - PROCESS | 1699 | Values: 67.0 70.0 74.0 80.0 74.0 68.0 70.0 68.0 69.0 71.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.50 stddev:2.98 (3.6%) stddev-sans-first:2.96 05:03:04 INFO - PROCESS | 1699 | Values: 85.0 84.0 84.0 82.0 84.0 83.0 82.0 79.0 75.0 82.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:132.00 stddev:6.50 (4.9%) stddev-sans-first:5.73 05:03:04 INFO - PROCESS | 1699 | Values: 139.0 135.0 130.0 121.0 134.0 124.0 124.0 121.0 134.0 125.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:139.50 stddev:5.18 (3.7%) stddev-sans-first:5.40 05:03:04 INFO - PROCESS | 1699 | Values: 140.0 129.0 139.0 140.0 143.0 127.0 141.0 139.0 137.0 137.0 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - PROCESS | 1699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.50 stddev:2.31 (3.5%) stddev-sans-first:2.24 05:03:04 INFO - PROCESS | 1699 | Values: 67.0 67.0 62.0 62.0 63.0 62.0 62.0 65.0 66.0 67.0 05:03:04 INFO - PROCESS | 1699 | -------- Summary: end -------- 05:03:04 INFO - PROCESS | 1699 | 05:03:04 INFO - TEST-INFO | 1699: exit 0 05:03:04 INFO - TEST-OK | kraken | took 56677ms 05:03:04 INFO - SUITE-END | took 1169s 05:03:04 INFO - Completed test suite (00:19:30) 05:03:04 INFO - javascript benchmark 05:03:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3025.969740302596, 3026.198057514758, 3439.2949445363697, 3482.5298584691077, 3509.035015370774, 5521.365043020054, 5611.8316450506445, 5648.830535083949, 5684.744186511606, 5687.601867869245, 5664.376918538957, 5669.291338582677, 5714.428557144294, 5836.766529338822, 5865.618734782247, 5064.468230835764, 5095.898082038376, 5106.361704786902, 5123.923141152885, 5222.399424066224, 5240.9213861792105, 5247.501487358695, 5261.263423120766, 5296.576273898079, 5301.6818990860675, 5053.898922021557, 5076.593872490192, 5136.895567452997, 5166.88911883943, 5189.662671926313, 5111.131107711698, 5135.537801597837, 5135.589152867799, 5139.254808052811, 5143.897122057538, 5077.64456488046, 5099.08216521026, 5114.693118412907, 5115.0, 5142.871428214287, 5499.092649712793, 5580.414056524088, 5602.663840169562, 5675.0, 5711.600187986843, 6126.0, 6149.0776383542825, 6153.476954458832, 6163.8150855474405, 6168.629882207037, 6144.907826382608, 6151.384861513813, 6182.814515564541, 6198.008318668992, 6199.0, 5688.516476099495, 5706.172604972256, 5796.42035796417, 5800.4199580042505, 5804.2744656917885, 6212.669030650617, 6245.156903817927, 6260.123582698426, 6262.655553944577, 6268.655223962634, 6054.122152287981, 6054.8183554493435, 6094.9695251524345, 6102.969485152635, 6118.235220597426, 6087.299960504599, 6148.508119350441, 6151.0773383992755, 6166.876662466726, 6169.784057558054, 6097.373446762125, 6112.724927378279, 6121.87979361315, 6126.517673797278, 6140.4428991762525, 6126.426068710516, 6144.354842741537, 6160.630362178194, 6162.630242185483, 6167.6916154193, 4864.294677271847, 4867.58625516835, 4923.335349727741, 4923.48303428142, 4941.357623508921, 4342.0, 4346.130773845243, 4466.6873318867365, 4467.039586488921, 4479.350494178326, 5624.240727501817, 5635.408282130399, 5669.971650141723, 5676.8864622707315, 5720.8283751487525, 6231.127642130105, 6273.686315684197, 6278.46633036197, 6290.779822706275, 6291.905621415683, 5510.256115424447, 5580.386157522669, 5620.718964051781, 5650.3219613646625, 5651.321841378978, 5329.173978033411, 5332.466753324714, 5346.893062138735, 5374.8656283592445, 5431.103867861759, 6262.749490020348, 6263.467605253604, 6266.373362663697, 6279.058141278845, 6282.842928926813, 6126.548209435115, 6147.569670123227, 6237.625742455467, 6268.0, 6283.842903927439, 6267.4045965633195, 6273.215848018997, 6287.779927702509, 6288.779892703734, 6295.3389894060465, 6121.816345509642, 6201.3178550358525, 6204.317525072329, 6204.472619827366, 6218.284897236876, 6076.6961651916345, 6148.354422785722, 6219.720112595034, 6234.844128896814, 6255.749770009149, 6099.340048628031, 6099.512039036777, 6104.277264894319, 6109.403503511079, 6136.815895523141, 5933.643981361132, 6076.270847498328, 6096.268447786117, 6111.0, 6123.601965872204, 5767.625104368202, 5924.407559244041, 5972.581919265784, 6003.429674180946, 6044.637321760709, 6060.818175454743, 6083.482903953213, 6115.969420152871, 6125.908111378244, 6129.3564175762685, 4924.901501970012, 5782.5373970081455, 5990.910136347871, 5994.370591088047, 6004.189434426296], "unit": "score", "name": "dojo.html", "value": 5661.085095285095}, {"lowerIsBetter": false, "replicates": [494.67104375590236, 560.8738033942363, 577.6332029161481, 626.8025571944838, 633.2685747961106, 23411.882940585296, 29187.562186567193, 29296.414071718555, 36759.4486082709, 37157.0, 39441.605583944154, 39955.800220998855, 39988.20023599526, 40067.599324006755, 40261.0, 9330.300227482914, 9564.856527152098, 9571.712848614517, 9574.234061275116, 9578.856317155249, 9252.398594091395, 9401.905980940172, 9418.0, 9427.434353938752, 9429.481378524179, 9355.204807591363, 9383.202427793645, 9438.952805235964, 9474.336796424253, 9576.186024187953, 9473.0, 9534.427934323963, 9552.14030737237, 9569.56936937836, 9573.569189386495, 9391.154796068387, 9534.09426104519, 9534.189593884528, 9550.713478595584, 9554.378965367297, 38594.03514912121, 38697.61302386996, 38928.0, 38952.41571376432, 39007.60992390068, 3172.2069482629345, 3210.4060748761553, 3249.7400207983305, 3262.5269335946155, 3446.9482957755654, 28097.43805123886, 28389.0, 28605.71394286051, 28698.0, 29239.2690182745, 2661.2681512584195, 2736.179146256135, 2740.4656092062055, 2741.8354898706143, 2745.4509098180442, 470277.0, 471053.0, 471427.64286178694, 472978.0, 473078.0, 44076.55923440788, 44848.77575612101, 62797.0, 64063.35936640667, 64451.03323450152, 44221.115577688266, 44388.77805611016, 44509.66471005875, 44652.883677908314, 44694.0, 15132.0, 15245.085294882343, 15256.0, 15299.694006120038, 15318.463853765288, 12322.89093981546, 12434.129610927148, 12438.875611243771, 12439.564615238423, 12465.439055242536, 13719.794203086962, 13971.441142354395, 14021.649458763408, 14022.789658155136, 14124.30508339006, 5473.75368108436, 6073.544484163705, 6292.860427454687, 6344.746210151542, 6358.205224346957, 940.7930255343813, 943.2077055273603, 1034.6637342863448, 1145.007686625266, 1157.907367410605, 28756.281092972426, 28761.71238287632, 29255.56116658252, 29388.265293367836, 29667.406651867273, 1082.951267192978, 1110.8000559899135, 1138.8007098757685, 1185.5713864792904, 1215.3801561203672, 11959.701007474709, 14658.926705366619, 14738.778918316233, 15117.0, 15132.848671513364, 525614.0, 533325.0, 540317.0, 540937.2953135209, 543052.0, 58305.708471458216, 58686.70656646775, 58753.82492350129, 59093.0, 59278.70360648169, 1301.6550614087275, 1426.9072510286799, 1429.9285035748171, 1447.3776276201545, 1467.449706360115, 28359.007434739684, 28960.565591515722, 28974.710252898043, 29036.7096329034, 30820.691793081784, 52658.473415265355, 53006.469935300156, 53707.0, 53772.0, 53852.730736346064, 411328.0, 414814.0, 415668.0, 415982.9200853976, 416156.0, 37022.040261343944, 40950.59049409468, 43298.0, 43946.0, 44863.775681121384, 41693.74918752442, 41975.7901210492, 42423.0, 42981.355279670206, 43350.56649433466, 34705.0, 35102.12244693801, 35238.0, 35889.102772430895, 35973.460398094576, 34849.47725784166, 34914.0, 35247.647523524436, 35468.64531354757, 35560.82219588885, 35815.64184358123, 36275.63724362723, 36335.0, 36823.89528314155, 37547.249055019296, 32350.0, 32640.96142213698, 33158.67365305361, 33248.66751332456, 33351.666483334855, 24399.634005490287, 24697.259082227563, 24939.501209975337, 25010.0, 25151.0], "unit": "score", "name": "ext.html", "value": 18959.439441409588}, {"lowerIsBetter": false, "replicates": [352.93941705175945, 360.310006337863, 363.244451540795, 366.88259756877795, 373.75705791235674, 19004.334848280312, 19323.710144347828, 19667.409977700674, 19747.40757777269, 19766.505837354074, 20051.29820456284, 20699.586008279824, 20953.266635667755, 21153.259635912746, 21157.57684846302, 5649.774009039644, 5847.181394604759, 5887.0286402743495, 5897.203877476529, 5897.3218079920925, 4236.216299984498, 4402.691811573191, 4462.843800466984, 5956.22569066023, 6532.379423954717, 6454.709538070774, 6459.9354006460035, 6461.903071453932, 6464.644444555547, 6474.449671777905, 5126.794928202868, 6233.625982441068, 6342.587731797442, 6393.296737358887, 6434.517411194132, 3709.7217708671956, 5311.415744268127, 5566.777328906839, 5571.164325351189, 5581.469760372758, 23492.76507234923, 23938.52122957531, 24209.63685544718, 25484.0, 25657.871710641513, 1934.912928918188, 2261.8869056547105, 2541.758532939368, 2618.6726659167603, 2830.6178665880047, 6785.830354241183, 6792.252852186256, 6824.624645644488, 6830.931690683079, 7334.339909408125, 1592.3153044190992, 1630.6820170066842, 1630.828762979882, 1667.3580671441462, 1715.3738885306898, 68868.0, 86987.0, 91196.0, 91951.0, 92318.15363692756, 10371.481425928674, 10388.013138751807, 10447.164226861833, 10498.580056797642, 10590.682279531626, 12802.231866088065, 12816.295103769382, 12821.0, 12884.033697472727, 12890.419931103123, 8331.916680833236, 8480.703175388955, 8485.490870547786, 8561.957190214009, 8588.141185881363, 8818.118188181259, 8827.984781750052, 8837.558122093998, 8921.286297096216, 8929.73210803677, 6035.517158627387, 6148.661823599745, 6152.292486364126, 6165.383461653889, 6167.5682702210415, 1733.3586572968084, 1768.6462707458559, 1772.5391398236293, 1791.2208189437636, 1793.757842691246, 916.445550441973, 965.9806803863884, 976.345848281653, 1012.9493525323704, 1032.9276950613385, 20370.898145509178, 20630.58738825245, 20637.896810515853, 20944.162233510488, 20961.68557471639, 877.88587483628, 898.3666515106834, 960.9663661771805, 974.2936371130874, 1022.2231104360591, 11234.887651123385, 11375.31748095117, 11382.203245772882, 11386.544538218544, 11421.486033128529, 587162.0, 594060.0, 604390.0, 615438.0, 623303.0, 59216.0, 59409.405905941254, 75659.62170189114, 99294.5035274819, 100035.49982250042, 928.1831987850649, 1013.1135256650431, 1029.6807989523272, 1062.8512008318842, 1066.1737153705785, 18131.909340453214, 18576.943523905386, 19074.52313692169, 19091.0, 19173.0, 46257.9003202472, 47472.0, 48100.75949620229, 48460.5153948456, 48473.75763121162, 50613.493865060875, 66581.66709166423, 66764.99852502314, 67313.0, 67850.98223526552, 7411.851163069733, 7502.399808015455, 7529.585872776831, 7573.659185336784, 7846.0, 9354.29842761782, 11250.943745281222, 12205.755884882075, 12211.023118150704, 12248.816267756169, 9008.864867026869, 10337.483125843828, 10572.788544228919, 10651.254412191072, 10661.94669026681, 10229.079382855578, 10245.899590583764, 10248.333858299187, 10509.001644843727, 10622.575096996034, 8086.676532938616, 10509.947450263006, 10727.839082413926, 10776.515056822618, 10946.452677366258, 7429.219931907072, 7509.361704254981, 7574.280443357872, 7686.6541005656, 7777.066751989797, 10436.269461137648, 10595.152387808803, 10617.893821062, 10726.570937162425, 10828.837567436338], "unit": "score", "name": "jquery.html", "value": 9044.619353780752}, {"lowerIsBetter": false, "replicates": [1525.961850953726, 1559.6802655455633, 1808.6834803909321, 1904.847612191023, 1972.921083156673, 8665.090165532614, 8710.782230444242, 8860.069692682273, 8865.246454051414, 8889.822203555934, 6428.710708018139, 8000.319972802319, 8524.659013639463, 8714.215720585145, 8760.342974276922, 2457.152282462552, 2500.374756408331, 2503.249025292414, 2505.5114252720728, 2506.235598142566, 2153.450870028141, 2415.3478560788576, 2500.3999040230306, 2504.949901001979, 2509.8619575923317, 1849.759531260941, 1965.8722183058128, 2478.1450399612195, 2482.913098041569, 2484.254723582918, 2406.7713567211085, 2425.1996841042414, 2432.3189506937997, 2464.2114523352534, 2465.568525508047, 2403.6034054381007, 2440.572899742556, 2453.7055553333535, 2455.889484973163, 2459.3359792855827, 8877.467351958903, 8929.598168082452, 8944.552772361421, 8946.64213431462, 8982.461052336881, 4683.157031734287, 5464.972675136639, 5583.748731307101, 5618.887622247573, 5638.097904335286, 2926.3708302715017, 3567.839447224881, 3673.265346930598, 3700.9444858327147, 3701.0, 1027.984580231297, 1048.1614708233383, 1050.0, 1052.310736467615, 1057.5716834681966, 12268.877311226863, 12347.62957111288, 12359.691007724789, 12362.75274494514, 12396.132270740962, 4860.3195552622665, 4917.286993385939, 4933.580645645088, 4973.328600638867, 5009.0, 10332.070113689804, 10343.327683700536, 10351.534180961875, 10366.222533310032, 10367.533460994273, 5582.97208513963, 5584.246126772834, 5594.776208951678, 5603.719814009283, 5622.718864056781, 4947.332110165082, 5024.397072351341, 5046.9747651261505, 5083.949160508421, 5089.898202035939, 3927.5286965563746, 3938.586448422874, 3964.1080756829483, 3990.38149086892, 3992.48097747291, 1058.7988282226352, 1192.5229908036854, 1243.7699025680279, 1291.231717128307, 1324.218710960538, 1294.0941341061296, 1302.5310888080282, 1328.3491089366141, 1374.8144000559996, 1375.7592421326428, 8138.633761480747, 8142.511449312941, 8437.620307086196, 8441.915580844236, 8452.450590711584, 1162.7674465107013, 1176.2236923630362, 1184.3604453594962, 1195.8744331845205, 1214.5991822698488, 6275.403836635513, 6302.180716506825, 6351.04734289851, 6372.681365931685, 6375.139356186948, 10419.06228439444, 10709.0, 10719.410432426135, 10846.728831779112, 10870.347779133119, 10675.306105103144, 10728.0, 10753.83869241962, 10868.891311086945, 10914.126869850394, 8314.958425207835, 8457.703980360659, 8490.915090849136, 8543.0602633709, 8567.700130495403, 7977.361811054986, 7995.440319177602, 8064.758057258292, 8081.111077781322, 8124.918750812652, 9433.622655093719, 9781.657641982496, 9818.0, 9933.205343572641, 9960.452175130438, 9992.850107248252, 10103.444310562989, 10267.486625668538, 10330.276880618585, 10341.965803419598, 7065.434765218667, 7083.008378826866, 7111.182214045244, 7173.856522869409, 7197.640117993975, 8295.253427191581, 8348.248657620843, 8382.155925696337, 8386.32909367237, 8394.916050839658, 6842.794716158523, 6987.0, 7389.150247721581, 7522.398208143226, 7620.80947976305, 7317.707291708272, 7325.377342925911, 7370.668319925723, 7398.741044063432, 7407.777766667009, 6961.269066747918, 7407.222241664547, 7414.814629634302, 7465.850682986418, 7484.176740558643, 6979.8604027918145, 6985.057017302599, 7033.859322813412, 7043.436525078084, 7051.612161330971, 6872.759453419107, 7076.787696369117, 7196.748113815991, 7226.674799634135, 7227.638618068971], "unit": "score", "name": "mootools.html", "value": 4972.547598219094}, {"lowerIsBetter": false, "replicates": [316.12433559041455, 320.02392702258123, 327.2065241788662, 329.0966297513326, 332.312113924177, 6498.870022599545, 6509.0, 6557.245916719578, 6587.473002159828, 6605.669716514167, 6539.574927629713, 6547.083408322838, 6549.312322206171, 6557.83605409865, 6563.245226798919, 4642.396488456496, 4747.85756427306, 4769.618430525549, 4810.687305325143, 4843.539863712942, 4717.221658426355, 4784.210605250129, 4801.399825021872, 4811.2302031674935, 4823.493533179018, 4771.42742870856, 4782.04359128174, 4788.449328327252, 4799.856004319876, 4820.301056346828, 4611.746353950548, 4689.671722979409, 4777.713337199779, 4787.712737235742, 4803.255495398219, 4104.938425923614, 4107.466029416157, 4111.2188684150215, 4111.753294802292, 4129.710920235585, 6212.627242365473, 6247.937520624827, 6313.842153946142, 6345.460635845959, 6358.936410635881, 5052.837847295143, 5273.630845840793, 5688.687122208277, 5710.7430165642645, 5724.16999535065, 6933.0293758873795, 6936.861262774716, 6938.306169383021, 6944.965275173642, 6949.965250173716, 4306.849260275907, 4468.4414448193975, 4473.351364052227, 4485.3944717463055, 4518.051209246062, 7174.605396703179, 7324.707011719524, 7329.413646908234, 7344.081989751281, 7354.963225183893, 4551.590356867898, 4557.202489564379, 4559.475660299042, 4563.543645635476, 4567.4062371892105, 4610.170169369479, 4631.374764406829, 4631.467381251132, 4633.467151277646, 4641.466231383367, 5496.203050557647, 5507.586930980193, 5511.807086751945, 5519.641223320471, 5528.861778455571, 6680.5323627345615, 6942.618156001468, 6943.618101004493, 6976.441884649216, 7015.333543313377, 1585.4926423544587, 1602.9358825646843, 1612.387292828741, 1613.3304678558268, 1617.6279455725248, 954.2604481526872, 980.9901900980899, 1012.8176928152856, 1012.9290949633455, 1041.2555023158477, 6340.682965851689, 6505.7397704092255, 6513.1532900722605, 6544.541882068304, 6548.8362790930605, 7238.022866913005, 7243.0946131733535, 7247.9637601811655, 7252.456065795086, 7269.927300727031, 5705.429457054344, 6208.348123447064, 6464.321246269168, 6521.217453905561, 6582.275949645536, 3119.407312610597, 3812.9809350953624, 3839.6544311012144, 3860.247251785931, 3872.980635096863, 7214.134303883463, 7536.0, 7539.359154471931, 7568.508046976929, 7595.202503737028, 7411.629418529052, 7437.739679111313, 7446.95742596037, 7464.776056718307, 7465.216152303929, 7519.624018799038, 7528.096628404626, 7530.774076777706, 7532.058492688414, 7550.169481357156, 6866.141732283465, 7264.600446975256, 7265.09186351706, 7270.200277969525, 7272.23641517633, 7056.7530136444975, 7118.466115041289, 7122.145342558926, 7125.073740413713, 7142.9285707144345, 7510.549367037996, 7526.24737526243, 7548.660310285941, 7548.735794247175, 7557.848843022999, 3495.877644282438, 4597.586217240464, 4600.608948239437, 4601.907961840678, 4607.378003969556, 6746.224184218878, 7202.315780000891, 7206.315400036988, 7206.89189662166, 7239.8914016290855, 5712.457316554921, 6708.765193218214, 7030.402415794715, 7033.472489563405, 7039.507234493536, 6054.878902422015, 6706.396424321834, 6887.242403335729, 7010.509264351446, 7023.367896889305, 5768.278965129359, 6671.099401580725, 6820.147481564804, 6877.0, 6899.586024838526, 6744.0, 7002.649867506502, 7018.0, 7018.473614479037, 7035.648217589202, 6601.108850305147, 6660.333966603301, 6699.665016749241, 6828.248892621708, 6842.657867106725], "unit": "score", "name": "prototype.html", "value": 5065.432525790324}, {"lowerIsBetter": false, "replicates": [638.9712462939167, 671.6910221298202, 690.354518525179, 691.8685449764541, 702.2836706559312, 14433.71132577349, 14791.0, 14796.926015369922, 14803.777943330859, 14804.6298842529, 13598.72802543951, 13626.977976651766, 13685.794713079287, 13720.58838234852, 13736.175829450214, 718.0629278791175, 727.0693512304259, 876.5748611923228, 890.4078787606234, 891.6611687558718, 897.6050537763364, 899.3884158772032, 904.5612877754284, 905.1717678324326, 906.2795077913075, 956.4404823178448, 960.4237457525498, 961.6393852305386, 961.7932144588912, 964.5322018820866, 759.4266328921657, 769.2307692307664, 771.1478815908453, 933.3280038372361, 953.9475328856945, 687.1959807025792, 703.0192880931123, 704.837887285922, 705.0798707686467, 705.5766540075965, 14756.704865902622, 14807.925960370128, 14837.406503739838, 14842.406303747837, 14859.925700371428, 12598.937005314914, 12647.430865610977, 12716.809247861289, 12810.423530941036, 13074.346282685923, 9795.90204097957, 9912.405255684682, 10114.747131321776, 10254.69235922916, 10689.358638481715, 3100.2404410919244, 3485.0, 3486.3027394521196, 3493.266414053052, 3529.1353618363664, 74667.62666186634, 77058.0, 77058.22941770566, 77246.22753772503, 77434.0, 9294.163525282622, 9687.17658998993, 9719.56261968213, 9794.902050979541, 9842.704718858446, 21673.45816354572, 21833.0, 21833.563328733337, 21839.45401364947, 21850.453738656342, 7378.889316660255, 7417.0, 7486.213947535539, 7553.055868016498, 7633.351165150913, 3853.537575490959, 3911.7457365271166, 3915.8433662653174, 3929.528456585228, 3961.603839616015, 3494.825258737053, 3525.25969546393, 3556.6621170988715, 3557.9110522236633, 3566.4828599853395, 563.6815199412318, 603.9365866584034, 613.3222788818381, 621.0963048764038, 631.6210273835753, 552.9364123125893, 571.794154104522, 574.5489790514426, 592.6088781404253, 596.8955432799243, 7705.4220933430215, 7875.330596899214, 7949.64226609804, 8032.844528305657, 8049.879251811228, 561.8904313658797, 571.7370009795541, 584.4885724990634, 590.8138936235072, 605.7122866638312, 3377.712894403954, 3476.91307717304, 3703.8888833335045, 3748.981255093707, 3942.802859856996, 85398.57300713581, 86174.0, 87072.0, 87382.12617873868, 87593.1240687585, 74669.62665186639, 74760.0, 74887.0, 75024.0, 75850.62074689592, 49235.75382123138, 65465.0, 66044.99999999904, 66217.00674489887, 66746.66626666836, 6475.935240647534, 7256.2018178001435, 7510.511816732113, 7685.423593230418, 7709.953672602972, 47683.76158119187, 48051.0, 48881.755591221816, 49291.0, 50397.968162546174, 58330.0, 59035.40964590299, 63632.68183659052, 63687.363126368145, 63901.0, 10806.513706883366, 10892.673219803419, 11063.889361106609, 11989.0, 11999.220050696676, 12084.214526055779, 12120.757584848077, 12167.45246463929, 12185.086118541321, 12357.93821030889, 11372.772544548898, 11802.94098529502, 11864.0, 11905.464254108412, 11941.76116477683, 11312.6040588579, 11339.603113891304, 11405.657830265105, 11625.0, 11848.70378240551, 10948.34309941406, 11138.27601205919, 11162.720931976766, 11519.366434846164, 11806.763864722829, 9367.110124538158, 9578.521073946415, 9744.0, 9905.033902197867, 10744.677659670222, 7532.7740167795055, 8481.618327175169, 8744.912550874664, 8941.865872012055, 9546.093121153479], "unit": "score", "name": "yui.html", "value": 6721.333567280175}], "name": "dromaeo_css", "value": 7401.162527957901}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 114.0, 112.0, 111.0, 114.0, 117.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [161.0, 121.0, 144.0, 158.0, 119.0, 144.0, 151.0, 146.0, 195.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 187.0, 185.0, 186.0, 184.0, 185.0, 184.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 184.5}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 72.0, 99.0, 78.0, 83.0, 83.0, 85.0, 79.0, 55.0], "unit": "score", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 127.0, 78.0, 79.0, 82.0, 113.0, 80.0, 79.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [92.0, 87.0, 92.0, 88.0, 91.0, 89.0, 92.0, 88.0, 92.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.9}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 95.6}, {"lowerIsBetter": true, "replicates": [86.0, 106.0, 137.0, 135.0, 88.0, 86.0, 86.0, 85.0, 87.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 98.2}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 53.0, 53.0, 53.0, 55.0, 51.0, 64.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 74.0, 80.0, 74.0, 68.0, 70.0, 68.0, 69.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 84.0, 82.0, 84.0, 83.0, 82.0, 79.0, 75.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [139.0, 135.0, 130.0, 121.0, 134.0, 124.0, 124.0, 121.0, 134.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.7}, {"lowerIsBetter": true, "replicates": [140.0, 129.0, 139.0, 140.0, 143.0, 127.0, 141.0, 139.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 62.0, 62.0, 63.0, 62.0, 62.0, 65.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1439.1}]} 05:03:05 INFO - Return code: 0 05:03:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:03:05 ERROR - # TBPL SUCCESS # 05:03:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:03:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:03:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:03:05 INFO - 2016-04-07 05:03:05.089 screenresolution[1703:9934] starting screenresolution argv=screenresolution get 05:03:05 INFO - 2016-04-07 05:03:05.092 screenresolution[1703:9934] Display 0: 1600x1200x32@60 05:03:05 INFO - 2016-04-07 05:03:05.098 screenresolution[1704:9937] starting screenresolution argv=screenresolution list 05:03:05 INFO - Available Modes on Display 0 05:03:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:03:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:03:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:03:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:03:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:03:05 INFO - Intel Iris: 05:03:05 INFO - Chipset Model: Intel Iris 05:03:05 INFO - Type: GPU 05:03:05 INFO - Bus: Built-In 05:03:05 INFO - VRAM (Dynamic, Max): 1536 MB 05:03:05 INFO - Vendor: Intel (0x8086) 05:03:05 INFO - Device ID: 0x0a2e 05:03:05 INFO - Revision ID: 0x0009 05:03:05 INFO - Displays: 05:03:05 INFO - Display: 05:03:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:03:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:03:05 INFO - Display Serial Number: 1600x1200 60 05:03:05 INFO - Main Display: Yes 05:03:05 INFO - Mirror: Off 05:03:05 INFO - Online: Yes 05:03:05 INFO - Rotation: Supported 05:03:05 INFO - Return code: 0 05:03:05 INFO - Running post-action listener: _resource_record_post_action 05:03:05 INFO - Running post-run listener: _resource_record_post_run 05:03:06 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 37193216; Write bytes: 692429312; Read time: 384; Write time: 1909 05:03:06 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 383771136; Write bytes: 377624576; Read time: 29422; Write time: 748 05:03:06 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 35980800; Write bytes: 297343488; Read time: 374; Write time: 1117 05:03:06 INFO - Running post-run listener: _upload_blobber_files 05:03:06 INFO - Blob upload gear active. 05:03:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:06 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:03:06 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:03:06 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:03:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:08 INFO - (blobuploader) - INFO - Done attempting. 05:03:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:10 INFO - (blobuploader) - INFO - Done attempting. 05:03:10 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:10 INFO - Return code: 0 05:03:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe411091e2d675a14b5acaae3c4d5fda3d23398fb2be6334cb20e1df965fc2caeaa35ab620d0452f1c38554680e4276391375c83c5b2d76e7cbfa7cc68530612", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab6efb4dfbf1e6395af6df0b646611f9bedb70f1a2d19854aa60f786748caa38e7596374e8197afcdc0b1657e83182563b0bddcc05dacdf71d03a04ebaf9e709"} 05:03:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:10 INFO - Contents: 05:03:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe411091e2d675a14b5acaae3c4d5fda3d23398fb2be6334cb20e1df965fc2caeaa35ab620d0452f1c38554680e4276391375c83c5b2d76e7cbfa7cc68530612", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab6efb4dfbf1e6395af6df0b646611f9bedb70f1a2d19854aa60f786748caa38e7596374e8197afcdc0b1657e83182563b0bddcc05dacdf71d03a04ebaf9e709"} 05:03:10 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:10 INFO - Copying logs to upload dir... 05:03:10 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.505829 ========= master_lag: 3.69 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-07 05:03:14.120488) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:14.124261) ========= 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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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/fe411091e2d675a14b5acaae3c4d5fda3d23398fb2be6334cb20e1df965fc2caeaa35ab620d0452f1c38554680e4276391375c83c5b2d76e7cbfa7cc68530612", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab6efb4dfbf1e6395af6df0b646611f9bedb70f1a2d19854aa60f786748caa38e7596374e8197afcdc0b1657e83182563b0bddcc05dacdf71d03a04ebaf9e709"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011016 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1459936821/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe411091e2d675a14b5acaae3c4d5fda3d23398fb2be6334cb20e1df965fc2caeaa35ab620d0452f1c38554680e4276391375c83c5b2d76e7cbfa7cc68530612", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab6efb4dfbf1e6395af6df0b646611f9bedb70f1a2d19854aa60f786748caa38e7596374e8197afcdc0b1657e83182563b0bddcc05dacdf71d03a04ebaf9e709"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:14.159062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:14.159368) ========= 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.rP7xTBOpDV/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.xbtDUZB5lO/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005106 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:03:14.243586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:03:14.243891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:03:14.244856) ========= ========= Total master_lag: 3.98 =========