builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0018 starttime: 1458169718.77 results: success (0) buildid: 20160316025750 builduid: a6bfc521402f4a5fa4eb8f83ce9a3aee revision: 341344bdec8f10bf50646cd6ef2355361435cbf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.767642) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.768064) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.768375) ========= 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.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.006021 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.793129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.793405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.810490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.810764) ========= 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.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005436 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.859856) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.860170) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.860515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:38.860797) ========= 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.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-16 16:08:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.43M=0.001s 2016-03-16 16:08:39 (8.43 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171457 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:39.051299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:39.051610) ========= 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.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.020481 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:39.100884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 16:08:39.101448) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 341344bdec8f10bf50646cd6ef2355361435cbf6 --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 341344bdec8f10bf50646cd6ef2355361435cbf6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-16 16:08:39,169 truncating revision to first 12 chars 2016-03-16 16:08:39,169 Setting DEBUG logging. 2016-03-16 16:08:39,169 attempt 1/10 2016-03-16 16:08:39,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/341344bdec8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 16:08:39,955 unpacking tar archive at: mozilla-central-341344bdec8f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.026563 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-16 16:08:40.256615) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:40.256965) ========= echo 341344bdec8f10bf50646cd6ef2355361435cbf6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'341344bdec8f10bf50646cd6ef2355361435cbf6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 341344bdec8f10bf50646cd6ef2355361435cbf6 program finished with exit code 0 elapsedTime=0.005136 script_repo_revision: '341344bdec8f10bf50646cd6ef2355361435cbf6' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:40.279157) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:40.279468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-16 16:08:40.293288) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-16 16:08:40.293633) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:08:40 INFO - MultiFileLogger online at 20160316 16:08:40 in /builds/slave/test 16:08:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:08:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:08:40 INFO - {'append_to_log': False, 16:08:40 INFO - 'base_work_dir': '/builds/slave/test', 16:08:40 INFO - 'blob_upload_branch': 'Firefox', 16:08:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:08:40 INFO - 'branch': 'Firefox', 16:08:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:08:40 INFO - 'config_files': ('talos/mac_config.py',), 16:08:40 INFO - 'default_actions': ('clobber', 16:08:40 INFO - 'read-buildbot-config', 16:08:40 INFO - 'download-and-extract', 16:08:40 INFO - 'populate-webroot', 16:08:40 INFO - 'create-virtualenv', 16:08:40 INFO - 'install', 16:08:40 INFO - 'run-tests'), 16:08:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:08:40 INFO - 'download_minidump_stackwalk': True, 16:08:40 INFO - 'download_symbols': 'ondemand', 16:08:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:08:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:08:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:08:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:08:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:08:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:08:40 INFO - 'installer_path': 'installer.exe', 16:08:40 INFO - 'log_level': 'info', 16:08:40 INFO - 'log_name': 'talos', 16:08:40 INFO - 'log_to_console': True, 16:08:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:08:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:08:40 INFO - 'opt_config_files': (), 16:08:40 INFO - 'pip_index': False, 16:08:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:08:40 INFO - 'cmd': ('bash', 16:08:40 INFO - '-c', 16:08:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:08:40 INFO - 'enabled': True, 16:08:40 INFO - 'halt_on_failure': False, 16:08:40 INFO - 'name': 'check_screen_resolution'},), 16:08:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:08:40 INFO - 'cmd': ('bash', 16:08:40 INFO - '-c', 16:08:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:08:40 INFO - 'enabled': True, 16:08:40 INFO - 'halt_on_failure': False, 16:08:40 INFO - 'name': 'check_screen_resolution'},), 16:08:40 INFO - 'run_cmd_checks_enabled': True, 16:08:40 INFO - 'sps_profile': False, 16:08:40 INFO - 'sps_profile_interval': 0, 16:08:40 INFO - 'suite': 'dromaeojs-e10s', 16:08:40 INFO - 'system_bits': '32', 16:08:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:08:40 INFO - 'title': 't-yosemite-r7-0018', 16:08:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:08:40 INFO - 'use_talos_json': True, 16:08:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:08:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:08:40 INFO - 'work_dir': 'build'} 16:08:40 INFO - ##### 16:08:40 INFO - ##### Running clobber step. 16:08:40 INFO - ##### 16:08:40 INFO - Running pre-action listener: _resource_record_pre_action 16:08:40 INFO - Running main action method: clobber 16:08:40 INFO - rmtree: /builds/slave/test/build 16:08:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:08:41 INFO - Running post-action listener: _resource_record_post_action 16:08:41 INFO - ##### 16:08:41 INFO - ##### Running read-buildbot-config step. 16:08:41 INFO - ##### 16:08:41 INFO - Running pre-action listener: _resource_record_pre_action 16:08:41 INFO - Running main action method: read_buildbot_config 16:08:41 INFO - Using buildbot properties: 16:08:41 INFO - { 16:08:41 INFO - "project": "", 16:08:41 INFO - "product": "firefox", 16:08:41 INFO - "script_repo_revision": "production", 16:08:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:08:41 INFO - "repository": "", 16:08:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:08:41 INFO - "buildid": "20160316025750", 16:08:41 INFO - "pgo_build": "False", 16:08:41 INFO - "basedir": "/builds/slave/test", 16:08:41 INFO - "buildnumber": 198, 16:08:41 INFO - "slavename": "t-yosemite-r7-0018", 16:08:41 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:08:41 INFO - "platform": "yosemite_r7", 16:08:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:08:41 INFO - "branch": "mozilla-central", 16:08:41 INFO - "repo_path": "mozilla-central", 16:08:41 INFO - "revision": "341344bdec8f10bf50646cd6ef2355361435cbf6", 16:08:41 INFO - "stage_platform": "macosx64", 16:08:41 INFO - "builduid": "a6bfc521402f4a5fa4eb8f83ce9a3aee", 16:08:41 INFO - "slavebuilddir": "test" 16:08:41 INFO - } 16:08:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 16:08:41 INFO - Running post-action listener: _resource_record_post_action 16:08:41 INFO - ##### 16:08:41 INFO - ##### Running download-and-extract step. 16:08:41 INFO - ##### 16:08:41 INFO - Running pre-action listener: _resource_record_pre_action 16:08:41 INFO - Running main action method: download_and_extract 16:08:41 INFO - mkdir: /builds/slave/test/build/tests 16:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:41 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 16:08:43 INFO - Downloaded 1199 bytes. 16:08:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:08:43 INFO - Using the following test package requirements: 16:08:43 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:08:43 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:08:43 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 16:08:43 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:08:43 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 16:08:43 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:08:43 INFO - u'jsshell-mac.zip'], 16:08:43 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:08:43 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 16:08:43 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:08:43 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:08:43 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 16:08:43 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:08:43 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 16:08:43 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:08:43 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 16:08:43 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:08:43 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 16:08:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:43 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:08:44 INFO - Downloaded 17854313 bytes. 16:08:44 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'] 16:08:44 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 16:08:47 INFO - Return code: 0 16:08:47 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 16:08:47 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')]} 16:08:47 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:08:48 INFO - Downloaded 17854313 bytes. 16:08:48 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'] 16:08:48 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 16:08:52 INFO - Return code: 0 16:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:08:52 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:08:53 INFO - Downloaded 10846462 bytes. 16:08:53 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'] 16:08:53 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 16:08:53 INFO - Return code: 0 16:08:53 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')]} 16:08:53 INFO - https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:08:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:08:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:08:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 16:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 16:08:56 INFO - Downloaded 111192012 bytes. 16:08:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:08:56 INFO - mkdir: /builds/slave/test/properties 16:08:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:08:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:08:56 INFO - Contents: 16:08:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:08:57 INFO - Running post-action listener: _resource_record_post_action 16:08:57 INFO - Running post-action listener: set_extra_try_arguments 16:08:57 INFO - ##### 16:08:57 INFO - ##### Running populate-webroot step. 16:08:57 INFO - ##### 16:08:57 INFO - Running pre-action listener: _resource_record_pre_action 16:08:57 INFO - Running main action method: populate_webroot 16:08:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:08:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:08:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:08:57 INFO - '--tppagecycles', 16:08:57 INFO - '7'], 16:08:57 INFO - 'tests': ['tsvgm']}}, 16:08:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:08:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:08:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:08:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:08:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:08:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:57 INFO - 'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:08:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:57 INFO - 'tests': ['damp', 'tps']}, 16:08:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:57 INFO - 'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['damp', 'tps']}, 16:08:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:08:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:08:57 INFO - 'other': {'tests': ['a11yr', 16:08:57 INFO - 'ts_paint', 16:08:57 INFO - 'tpaint', 16:08:57 INFO - 'sessionrestore', 16:08:57 INFO - 'sessionrestore_no_auto_restore', 16:08:57 INFO - 'tabpaint']}, 16:08:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['a11yr', 16:08:57 INFO - 'ts_paint', 16:08:57 INFO - 'tpaint', 16:08:57 INFO - 'sessionrestore', 16:08:57 INFO - 'sessionrestore_no_auto_restore', 16:08:57 INFO - 'tabpaint']}, 16:08:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['a11yr', 16:08:57 INFO - 'ts_paint', 16:08:57 INFO - 'tpaint', 16:08:57 INFO - 'sessionrestore', 16:08:57 INFO - 'sessionrestore_no_auto_restore', 16:08:57 INFO - 'tabpaint']}, 16:08:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['a11yr', 16:08:57 INFO - 'ts_paint', 16:08:57 INFO - 'tpaint', 16:08:57 INFO - 'sessionrestore', 16:08:57 INFO - 'sessionrestore_no_auto_restore', 16:08:57 INFO - 'tabpaint']}, 16:08:57 INFO - 'other_l64': {'tests': ['a11yr', 16:08:57 INFO - 'ts_paint', 16:08:57 INFO - 'tpaint', 16:08:57 INFO - 'sessionrestore', 16:08:57 INFO - 'sessionrestore_no_auto_restore', 16:08:57 INFO - 'tabpaint']}, 16:08:57 INFO - 'other_nol64': {'tests': ['a11yr', 16:08:57 INFO - 'ts_paint', 16:08:57 INFO - 'tpaint', 16:08:57 INFO - 'sessionrestore', 16:08:57 INFO - 'sessionrestore_no_auto_restore', 16:08:57 INFO - 'tabpaint']}, 16:08:57 INFO - 'svgr': {'tests': ['tsvgx', 16:08:57 INFO - 'tsvgr_opacity', 16:08:57 INFO - 'tart', 16:08:57 INFO - 'tscrollx', 16:08:57 INFO - 'cart']}, 16:08:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['tsvgx', 16:08:57 INFO - 'tsvgr_opacity', 16:08:57 INFO - 'tart', 16:08:57 INFO - 'tscrollx', 16:08:57 INFO - 'cart']}, 16:08:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:57 INFO - 'tests': ['tp5o']}, 16:08:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:57 INFO - 'talos_options': ['--e10s'], 16:08:57 INFO - 'tests': ['tp5o']}, 16:08:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:57 INFO - 'talos_options': ['--xperf_path', 16:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:08:57 INFO - 'tests': ['tp5n']}, 16:08:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:08:57 INFO - 'talos_options': ['--e10s', 16:08:57 INFO - '--xperf_path', 16:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:08:57 INFO - 'tests': ['tp5n']}}, 16:08:57 INFO - 'talos.zip': {'path': '', 16:08:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:08:57 INFO - Running post-action listener: _resource_record_post_action 16:08:57 INFO - ##### 16:08:57 INFO - ##### Running create-virtualenv step. 16:08:57 INFO - ##### 16:08:57 INFO - Running pre-action listener: _resource_record_pre_action 16:08:57 INFO - Running main action method: create_virtualenv 16:08:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:08:57 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 16:08:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:08:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:08:57 INFO - Using real prefix '/tools/python27' 16:08:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:08:58 INFO - Installing distribute.............................................................................................................................................................................................done. 16:09:01 INFO - Installing pip.................done. 16:09:01 INFO - Return code: 0 16:09:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:01 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 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:01 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 16:09:01 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 16:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:01 INFO - 'HOME': '/Users/cltbld', 16:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:01 INFO - 'LOGNAME': 'cltbld', 16:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:01 INFO - 'MOZ_NO_REMOTE': '1', 16:09:01 INFO - 'NO_EM_RESTART': '1', 16:09:01 INFO - 'PAGER': '/bin/cat', 16:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:01 INFO - 'PWD': '/builds/slave/test', 16:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:01 INFO - 'SHELL': '/bin/bash', 16:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:01 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:01 INFO - 'USER': 'cltbld', 16:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:01 INFO - 'XPC_FLAGS': '0x0', 16:09:01 INFO - 'XPC_SERVICE_NAME': '0', 16:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:01 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 16:09:01 INFO - Cleaning up... 16:09:01 INFO - Return code: 0 16:09:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:01 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 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:01 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 16:09:01 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 16:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:01 INFO - 'HOME': '/Users/cltbld', 16:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:01 INFO - 'LOGNAME': 'cltbld', 16:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:01 INFO - 'MOZ_NO_REMOTE': '1', 16:09:01 INFO - 'NO_EM_RESTART': '1', 16:09:01 INFO - 'PAGER': '/bin/cat', 16:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:01 INFO - 'PWD': '/builds/slave/test', 16:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:01 INFO - 'SHELL': '/bin/bash', 16:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:01 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:01 INFO - 'USER': 'cltbld', 16:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:01 INFO - 'XPC_FLAGS': '0x0', 16:09:01 INFO - 'XPC_SERVICE_NAME': '0', 16:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:01 INFO - Downloading/unpacking psutil>=0.7.1 16:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:09:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:09:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:09:04 INFO - Installing collected packages: psutil 16:09:04 INFO - Running setup.py install for psutil 16:09:05 INFO - building 'psutil._psutil_osx' extension 16:09:05 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 16:09:05 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 16:09:05 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 16:09:05 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 16:09:05 INFO - building 'psutil._psutil_posix' extension 16:09:05 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 16:09:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:09:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:09:05 INFO - ^ 16:09:05 INFO - 1 warning generated. 16:09:05 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 16:09:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:09:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:09:05 INFO - Successfully installed psutil 16:09:05 INFO - Cleaning up... 16:09:05 INFO - Return code: 0 16:09:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:09:05 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')]} 16:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:05 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')]} 16:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:05 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 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:05 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 16:09:05 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 16:09:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:05 INFO - 'HOME': '/Users/cltbld', 16:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:05 INFO - 'LOGNAME': 'cltbld', 16:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:05 INFO - 'MOZ_NO_REMOTE': '1', 16:09:05 INFO - 'NO_EM_RESTART': '1', 16:09:05 INFO - 'PAGER': '/bin/cat', 16:09:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:05 INFO - 'PWD': '/builds/slave/test', 16:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:05 INFO - 'SHELL': '/bin/bash', 16:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:05 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:05 INFO - 'USER': 'cltbld', 16:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:05 INFO - 'XPC_FLAGS': '0x0', 16:09:05 INFO - 'XPC_SERVICE_NAME': '0', 16:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:09:06 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 16:09:06 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 16:09:06 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 16:09:06 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 16:09:06 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 16:09:06 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 16:09:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:09:08 INFO - Installing collected packages: mozsystemmonitor 16:09:08 INFO - Running setup.py install for mozsystemmonitor 16:09:08 INFO - Successfully installed mozsystemmonitor 16:09:08 INFO - Cleaning up... 16:09:08 INFO - Return code: 0 16:09:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:08 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 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:08 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 16:09:08 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 16:09:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:08 INFO - 'HOME': '/Users/cltbld', 16:09:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:08 INFO - 'LOGNAME': 'cltbld', 16:09:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:08 INFO - 'MOZ_NO_REMOTE': '1', 16:09:08 INFO - 'NO_EM_RESTART': '1', 16:09:08 INFO - 'PAGER': '/bin/cat', 16:09:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:08 INFO - 'PWD': '/builds/slave/test', 16:09:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:08 INFO - 'SHELL': '/bin/bash', 16:09:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:08 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:08 INFO - 'USER': 'cltbld', 16:09:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:08 INFO - 'XPC_FLAGS': '0x0', 16:09:08 INFO - 'XPC_SERVICE_NAME': '0', 16:09:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:09:09 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 16:09:09 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 16:09:09 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 16:09:09 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 16:09:09 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 16:09:09 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 16:09:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:09:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:09:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:09:12 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 16:09:12 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 16:09:12 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 16:09:12 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 16:09:12 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 16:09:12 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 16:09:12 INFO - Downloading docopt-0.6.1.tar.gz 16:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:09:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:09:12 INFO - Running setup.py install for blobuploader 16:09:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:09:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:09:12 INFO - Running setup.py install for requests 16:09:13 INFO - Running setup.py install for docopt 16:09:13 INFO - Successfully installed blobuploader requests docopt 16:09:13 INFO - Cleaning up... 16:09:13 INFO - Return code: 0 16:09:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:13 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 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:13 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 16:09:13 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 16:09:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:13 INFO - 'HOME': '/Users/cltbld', 16:09:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:13 INFO - 'LOGNAME': 'cltbld', 16:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:13 INFO - 'MOZ_NO_REMOTE': '1', 16:09:13 INFO - 'NO_EM_RESTART': '1', 16:09:13 INFO - 'PAGER': '/bin/cat', 16:09:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:13 INFO - 'PWD': '/builds/slave/test', 16:09:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:13 INFO - 'SHELL': '/bin/bash', 16:09:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:13 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:13 INFO - 'USER': 'cltbld', 16:09:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:13 INFO - 'XPC_FLAGS': '0x0', 16:09:13 INFO - 'XPC_SERVICE_NAME': '0', 16:09:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:09:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-pcQOCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:09:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-b_hWD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:09:13 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-OnM01K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-67rX7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-UDasV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-DZvVMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-LIwri0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-ApYZ47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-MqE57n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-nAzs4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-sWmA3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:09:14 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-A5msQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:09:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-3bm4k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:09:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-H6EWfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:09:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-aA9_XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:09:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-y2w5SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:09:15 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-VUFwuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:09:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:09:15 INFO - Running setup.py install for manifestparser 16:09:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:09:15 INFO - Running setup.py install for mozcrash 16:09:15 INFO - Running setup.py install for mozdebug 16:09:15 INFO - Running setup.py install for mozdevice 16:09:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:09:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:09:16 INFO - Running setup.py install for mozfile 16:09:16 INFO - Running setup.py install for mozhttpd 16:09:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:09:16 INFO - Running setup.py install for mozinfo 16:09:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:09:16 INFO - Running setup.py install for mozInstall 16:09:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:09:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:09:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:09:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:09:16 INFO - Running setup.py install for mozleak 16:09:16 INFO - Running setup.py install for mozlog 16:09:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:09:17 INFO - Running setup.py install for moznetwork 16:09:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:09:17 INFO - Running setup.py install for mozprocess 16:09:17 INFO - Running setup.py install for mozprofile 16:09:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:09:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:09:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:09:17 INFO - Running setup.py install for mozrunner 16:09:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:09:17 INFO - Running setup.py install for mozscreenshot 16:09:17 INFO - Running setup.py install for moztest 16:09:17 INFO - Running setup.py install for mozversion 16:09:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:09:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:09:18 INFO - Cleaning up... 16:09:18 INFO - Return code: 0 16:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:09: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')]} 16:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09: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')]} 16:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:18 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 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:18 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 16:09:18 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 16:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:18 INFO - 'HOME': '/Users/cltbld', 16:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:18 INFO - 'LOGNAME': 'cltbld', 16:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:18 INFO - 'MOZ_NO_REMOTE': '1', 16:09:18 INFO - 'NO_EM_RESTART': '1', 16:09:18 INFO - 'PAGER': '/bin/cat', 16:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:18 INFO - 'PWD': '/builds/slave/test', 16:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:18 INFO - 'SHELL': '/bin/bash', 16:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:18 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:18 INFO - 'USER': 'cltbld', 16:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:18 INFO - 'XPC_FLAGS': '0x0', 16:09:18 INFO - 'XPC_SERVICE_NAME': '0', 16:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:09:18 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-TpbMmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:09:18 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-401dDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:09:18 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-kAEExh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:09:18 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-8A9rF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:09:18 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-wRwCPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:09:18 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)) 16:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:09:18 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-x5VNHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-QaOqrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-zl95mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-f1uhYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-BiXP78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-KeWib3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-Cdx00G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-IFLRst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-7jdszI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:09:19 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)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-C0h1NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:09:19 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-YVpqXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:09:20 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)) 16:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:09:20 INFO - Running setup.py (path:/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/pip-xKFxWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:09:20 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)) 16:09:20 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)) 16:09:20 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)) 16:09:20 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)) 16:09:20 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)) 16:09:20 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)) 16:09:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:22 INFO - Downloading blessings-1.6.tar.gz 16:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:09:22 INFO - Installing collected packages: blessings 16:09:22 INFO - Running setup.py install for blessings 16:09:22 INFO - Successfully installed blessings 16:09:22 INFO - Cleaning up... 16:09:22 INFO - Return code: 0 16:09:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:09:23 INFO - Reading from file tmpfile_stdout 16:09:23 INFO - Current package versions: 16:09:23 INFO - blessings == 1.6 16:09:23 INFO - blobuploader == 1.2.4 16:09:23 INFO - docopt == 0.6.1 16:09:23 INFO - manifestparser == 1.1 16:09:23 INFO - mozInstall == 1.12 16:09:23 INFO - mozcrash == 0.17 16:09:23 INFO - mozdebug == 0.1 16:09:23 INFO - mozdevice == 0.48 16:09:23 INFO - mozfile == 1.2 16:09:23 INFO - mozhttpd == 0.7 16:09:23 INFO - mozinfo == 0.9 16:09:23 INFO - mozleak == 0.1 16:09:23 INFO - mozlog == 3.1 16:09:23 INFO - moznetwork == 0.27 16:09:23 INFO - mozprocess == 0.22 16:09:23 INFO - mozprofile == 0.28 16:09:23 INFO - mozrunner == 6.11 16:09:23 INFO - mozscreenshot == 0.1 16:09:23 INFO - mozsystemmonitor == 0.0 16:09:23 INFO - moztest == 0.7 16:09:23 INFO - mozversion == 1.4 16:09:23 INFO - psutil == 3.1.1 16:09:23 INFO - requests == 1.2.3 16:09:23 INFO - wsgiref == 0.1.2 16:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:23 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 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:23 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 16:09:23 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 16:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:23 INFO - 'HOME': '/Users/cltbld', 16:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:23 INFO - 'LOGNAME': 'cltbld', 16:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:23 INFO - 'MOZ_NO_REMOTE': '1', 16:09:23 INFO - 'NO_EM_RESTART': '1', 16:09:23 INFO - 'PAGER': '/bin/cat', 16:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:23 INFO - 'PWD': '/builds/slave/test', 16:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:23 INFO - 'SHELL': '/bin/bash', 16:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:23 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:23 INFO - 'USER': 'cltbld', 16:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:23 INFO - 'XPC_FLAGS': '0x0', 16:09:23 INFO - 'XPC_SERVICE_NAME': '0', 16:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 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)) 16:09:23 INFO - Cleaning up... 16:09:23 INFO - Return code: 0 16:09:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:09:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:23 INFO - 'HOME': '/Users/cltbld', 16:09:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:23 INFO - 'LOGNAME': 'cltbld', 16:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:23 INFO - 'MOZ_NO_REMOTE': '1', 16:09:23 INFO - 'NO_EM_RESTART': '1', 16:09:23 INFO - 'PAGER': '/bin/cat', 16:09:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:23 INFO - 'PWD': '/builds/slave/test', 16:09:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:23 INFO - 'SHELL': '/bin/bash', 16:09:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:23 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:23 INFO - 'USER': 'cltbld', 16:09:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:23 INFO - 'XPC_FLAGS': '0x0', 16:09:23 INFO - 'XPC_SERVICE_NAME': '0', 16:09:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:23 INFO - Downloading/unpacking jsonschema 16:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:09:26 INFO - Downloading/unpacking functools32 (from jsonschema) 16:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:09:26 INFO - warning: no files found matching '*.txt' 16:09:26 INFO - no previously-included directories found matching 'build' 16:09:26 INFO - no previously-included directories found matching 'dist' 16:09:26 INFO - no previously-included directories found matching '.git*' 16:09:26 INFO - Installing collected packages: jsonschema, functools32 16:09:26 INFO - Running setup.py install for functools32 16:09:26 INFO - warning: no files found matching '*.txt' 16:09:26 INFO - no previously-included directories found matching 'build' 16:09:26 INFO - no previously-included directories found matching 'dist' 16:09:26 INFO - no previously-included directories found matching '.git*' 16:09:26 INFO - Successfully installed jsonschema functools32 16:09:26 INFO - Cleaning up... 16:09:26 INFO - Return code: 0 16:09:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:09:26 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')]} 16:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:26 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')]} 16:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:26 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 0x1050fca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051034c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca0b5956a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, '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.co3lPCWUv5/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.2NjZLE5TNo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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 16:09:26 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 16:09:26 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 16:09:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:09:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:09:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:09:26 INFO - 'HOME': '/Users/cltbld', 16:09:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:09:26 INFO - 'LOGNAME': 'cltbld', 16:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:26 INFO - 'MOZ_NO_REMOTE': '1', 16:09:26 INFO - 'NO_EM_RESTART': '1', 16:09:26 INFO - 'PAGER': '/bin/cat', 16:09:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:26 INFO - 'PWD': '/builds/slave/test', 16:09:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:09:26 INFO - 'SHELL': '/bin/bash', 16:09:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:09:26 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:09:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:09:26 INFO - 'USER': 'cltbld', 16:09:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:09:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:26 INFO - 'XPC_FLAGS': '0x0', 16:09:26 INFO - 'XPC_SERVICE_NAME': '0', 16:09:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:27 INFO - Downloading/unpacking flake8 16:09:27 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 16:09:27 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 16:09:27 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 16:09:27 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 16:09:27 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 16:09:27 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 16:09:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:09:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:09:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:09:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:09:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:09:30 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 16:09:30 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 16:09:30 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 16:09:30 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 16:09:30 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 16:09:30 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 16:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:09:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:09:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:09:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:09:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:09:30 INFO - no previously-included directories found matching 'docs/_build' 16:09:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:09:30 INFO - Running setup.py install for pep8 16:09:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:09:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:09:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:09:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:09:30 INFO - no previously-included directories found matching 'docs/_build' 16:09:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:09:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:09:31 INFO - Cleaning up... 16:09:31 INFO - Return code: 0 16:09:31 INFO - Running post-action listener: _resource_record_post_action 16:09:31 INFO - Running post-action listener: _start_resource_monitoring 16:09:31 INFO - Starting resource monitoring. 16:09:31 INFO - ##### 16:09:31 INFO - ##### Running install step. 16:09:31 INFO - ##### 16:09:31 INFO - Running pre-action listener: _resource_record_pre_action 16:09:31 INFO - Running main action method: install 16:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:09:31 INFO - Reading from file tmpfile_stdout 16:09:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:09:31 INFO - Reading from file tmpfile_stdout 16:09:31 INFO - Output received: 16:09:31 INFO - Usage: mozinstall [options] installer 16:09:31 INFO - Options: 16:09:31 INFO - -h, --help show this help message and exit 16:09:31 INFO - -d DEST, --destination=DEST 16:09:31 INFO - Directory to install application into. [default: 16:09:31 INFO - "/builds/slave/test"] 16:09:31 INFO - --app=APP Application being installed. [default: firefox] 16:09:31 INFO - mkdir: /builds/slave/test/build/application 16:09:31 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'] 16:09:31 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 16:10:05 INFO - Reading from file tmpfile_stdout 16:10:05 INFO - Output received: 16:10:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:10:05 INFO - Running post-action listener: _resource_record_post_action 16:10:05 INFO - ##### 16:10:05 INFO - ##### Running run-tests step. 16:10:05 INFO - ##### 16:10:05 INFO - Running pre-action listener: _resource_record_pre_action 16:10:05 INFO - Running main action method: run_tests 16:10:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:10:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:10:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:10:05 INFO - 2016-03-16 16:10:05.286 screenresolution[2751:19347] starting screenresolution argv=screenresolution get 16:10:05 INFO - 2016-03-16 16:10:05.289 screenresolution[2751:19347] Display 0: 1600x1200x32@60 16:10:05 INFO - 2016-03-16 16:10:05.295 screenresolution[2752:19349] starting screenresolution argv=screenresolution list 16:10:05 INFO - Available Modes on Display 0 16:10:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:10:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:10:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:10:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:10:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:10:05 INFO - Intel Iris: 16:10:05 INFO - Chipset Model: Intel Iris 16:10:05 INFO - Type: GPU 16:10:05 INFO - Bus: Built-In 16:10:05 INFO - VRAM (Dynamic, Max): 1536 MB 16:10:05 INFO - Vendor: Intel (0x8086) 16:10:05 INFO - Device ID: 0x0a2e 16:10:05 INFO - Revision ID: 0x0009 16:10:05 INFO - Displays: 16:10:05 INFO - Display: 16:10:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:10:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:10:05 INFO - Display Serial Number: 1600x1200 60 16:10:05 INFO - Main Display: Yes 16:10:05 INFO - Mirror: Off 16:10:05 INFO - Online: Yes 16:10:05 INFO - Rotation: Supported 16:10:05 INFO - Return code: 0 16:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:10:05 INFO - Python 2.7.3 16:10:05 INFO - Return code: 0 16:10:05 INFO - grabbing minidump binary from tooltool 16:10:05 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')]} 16:10:05 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 0x104fa0d30>, '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 0x104dc4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f97b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:10:05 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 16:10:05 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 16:10:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:10:05 INFO - Return code: 0 16:10:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:10:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:10:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:10:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:10:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:10:06 INFO - Return code: 0 16:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.co3lPCWUv5/Render', 16:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:06 INFO - 'HOME': '/Users/cltbld', 16:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:06 INFO - 'LOGNAME': 'cltbld', 16:10:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:06 INFO - 'MOZ_NO_REMOTE': '1', 16:10:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:06 INFO - 'NO_EM_RESTART': '1', 16:10:06 INFO - 'PAGER': '/bin/cat', 16:10:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:06 INFO - 'PWD': '/builds/slave/test', 16:10:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:06 INFO - 'SHELL': '/bin/bash', 16:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2NjZLE5TNo/Listeners', 16:10:06 INFO - 'TMPDIR': '/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/', 16:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:06 INFO - 'USER': 'cltbld', 16:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:06 INFO - 'XPC_FLAGS': '0x0', 16:10:06 INFO - 'XPC_SERVICE_NAME': '0', 16:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:10:07 INFO - mozversion application_buildid: 20160316025750 16:10:07 INFO - mozversion application_changeset: 341344bdec8f10bf50646cd6ef2355361435cbf6 16:10:07 INFO - mozversion application_display_name: Nightly 16:10:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:10:07 INFO - mozversion application_name: Firefox 16:10:07 INFO - mozversion application_remotingname: firefox 16:10:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:10:07 INFO - mozversion application_vendor: Mozilla 16:10:07 INFO - mozversion application_version: 48.0a1 16:10:07 INFO - mozversion platform_buildid: 20160316025750 16:10:07 INFO - mozversion platform_changeset: 341344bdec8f10bf50646cd6ef2355361435cbf6 16:10:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:10:07 INFO - mozversion platform_version: 48.0a1 16:10:07 INFO - using testdate: 1458169807 16:10:07 INFO - actual date: 1458169807 16:10:07 INFO - starting webserver on 'localhost:49737' 16:10:07 INFO - SUITE-START | Running 2 tests 16:10:07 INFO - TEST-START | dromaeo_css 16:10:07 INFO - operating with platform_type : mac_ 16:10:07 INFO - Initialising browser for dromaeo_css test... 16:10:07 INFO - TEST-INFO | started process 2770 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpPYQT30/profile http://localhost:49737/getInfo.html) 16:10:09 INFO - PROCESS | 2770 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:10:09 INFO - PROCESS | 2770 | __metrics Screen width/height:1600/1200 16:10:09 INFO - PROCESS | 2770 | colorDepth:24 16:10:09 INFO - PROCESS | 2770 | Browser inner width/height: 1024/689 16:10:09 INFO - PROCESS | 2770 | __metrics 16:10:09 ERROR - PROCESS | 2770 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 16:10:10 INFO - TEST-INFO | 2770: exit 0 16:10:10 INFO - Browser initialized. 16:10:10 INFO - Running cycle 1/1 for dromaeo_css test... 16:10:10 INFO - TEST-INFO | started process 2774 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmpPYQT30/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:22 INFO - PROCESS | 2774 | RSS: Main: 255733760 16:10:22 INFO - PROCESS | 2774 | 16:11:12 INFO - PROCESS | 2774 | 1458169872337 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] 16:13:23 INFO - PROCESS | 2774 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49737/tests/dromaeo/cssquery-ext.html) 16:13:24 INFO - PROCESS | 2774 | RSS: Main: 268574720 16:13:24 INFO - PROCESS | 2774 | 16:16:26 INFO - PROCESS | 2774 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-ext.html (next: http://localhost:49737/tests/dromaeo/cssquery-jquery.html) 16:16:27 INFO - PROCESS | 2774 | RSS: Main: 281591808 16:16:27 INFO - PROCESS | 2774 | 16:19:29 INFO - PROCESS | 2774 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49737/tests/dromaeo/cssquery-mootools.html) 16:19:29 INFO - PROCESS | 2774 | RSS: Main: 282632192 16:19:29 INFO - PROCESS | 2774 | 16:22:31 INFO - PROCESS | 2774 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49737/tests/dromaeo/cssquery-prototype.html) 16:22:32 INFO - PROCESS | 2774 | RSS: Main: 284147712 16:22:32 INFO - PROCESS | 2774 | 16:25:34 INFO - PROCESS | 2774 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49737/tests/dromaeo/cssquery-yui.html) 16:25:35 INFO - PROCESS | 2774 | RSS: Main: 287432704 16:25:35 INFO - PROCESS | 2774 | 16:28:37 INFO - PROCESS | 2774 | Cycle 1(1): loaded http://localhost:49737/tests/dromaeo/cssquery-yui.html (next: http://localhost:49737/tests/dromaeo/cssquery-dojo.html) 16:28:38 INFO - PROCESS | 2774 | RSS: Main: 288944128 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - PROCESS | 2774 | __start_tp_report 16:28:38 INFO - PROCESS | 2774 | _x_x_mozilla_page_load 16:28:38 INFO - PROCESS | 2774 | _x_x_mozilla_page_load_details 16:28:38 INFO - PROCESS | 2774 | |i|pagename|runs| 16:28:38 INFO - PROCESS | 2774 | |0;dojo.html;3450.7066899313563;3501.8424170912313;3517;3528.999999999998;3542.6280240574724;5771.7979870704585;5773.1051686988585;5837.8832423351505;5839.153322768201;5841.649501029941;5679.744411501482;5848.327442344132;5869.090291004901;5924.970375148118;6004.789832355868;5239.397469291032;5286.629935904488;5328.520433161015;5355.143177091666;5391.73041347933;5245.082110630643;5371.086915224401;5402.243685883979;5449.073657478219;5450.29146210992;5149.871253218699;5203.765830537635;5323.494268044529;5351.117065684158;5366.141417373241;5283.339582552181;5294.311739473882;5303.098473259516;5304.522592966651;5309.787608495655;5240.3187585614005;5255.500727430888;5289.788408463657;5301.204819277101;5319;5568.638038527482;5623.240862483553;5759.136129580555;5805.622634528742;5857.824265272006;6140.986737188358;6173.938260617381;6205.503559715212;6210.65841378724;6213.099100630383;6145.371476558716;6212.502999760053;6225.1284820124765;6227.190465239535;6229.781957631507;5881.206037184968;5910.615809972381;5924.763009479659;5953.107033944856;5991.460768530853;6233.812985610439;6293.842653933688;6310.652914089677;6322.589031712924;6350.587211831216;5947.078202878561;6122.977604208209;6241.531885108635;6268.09112678659;6270.7491700331475;6145.016797312409;6163.075538669146;6215.06773983906;6232.189815323979;6236.469900058546;6116.785912493041;6166.506679465632;6167.753289868445;6226.968865155645;6244.687765611701;5114.872128196825;6116.3053375860445;6136.815895523141;6187.783427580013;6221.595596286227;4951.207806750975;4960.181570040902;4966.478519755446;4973.32860063894;5019.698818070854;4409.867703968886;4433.357163211316;4445.777711114431;4447.2217361962175;4466.531014243523;5768.625039372428;5887.852803679943;5943.851403714942;5988.371221021817;6024.518038556905;6206.162168107338;6227.906581401283;6237.844053898689;6253.906191407133;6274.592151510137;6021.789237376758;6023.156758053876;6027.126066720301;6051.546134039964;6077.474378982348;5292;5376.731163441812;5447.073997420448;5502.174673798962;5505.119180931032;6333.155136320718;6358.046293056079;6372.490200784019;6381.425671689571;6388.361163883575;6219.875602488016;6235.96882015587;6239.220097487814;6243.875122497616;6253;6218.533609979179;6316.210473690789;6355.14205582259;6392.20097487814;6418.293987661447;6182.196314479269;6204.689765511616;6216.720247588779;6246.562740608114;6263.091851681572;6138.388398386059;6224.502039836892;6229.875402492015;6237;6239.438450539473;6025.969870150621;6114.084479019511;6128.1726966858905;6136.938630613637;6171.56799024064;4761.381020467317;6007.969960150172;6171.56799024064;6172.783952561639;6219.626822390671;5968.820935371946;6044.093385992136;6062.090686397076;6117.449429551361;6125.724342404514;6065.5754097212775;6126.090206827809;6158.261008678987;6173.506119510518;6176.135341052166;5007.949920500749;5364.946350536445;5880.882382352243;6056.6971651418135;6091.269047714125 16:28:38 INFO - PROCESS | 2774 | |1;ext.html;552.4613501835709;591.2579712460861;596.4959609130283;624.659560539506;655.9737610495579;27938.580921286197;38196.809015954954;38382.424263636065;38412;38444.61555384445;39464.80267598658;39466.8026659867;39507.40738888919;39713;39812.402813957815;9323.766905827357;9468.857967130498;9505.239580833551;9515.80968380632;9532;9306.208972237335;9589.42463452195;9605.039496050409;9609;9614.75963100921;8307.875381869277;8315.501069935823;9422.434653920753;9559.56981935811;9636.662716804913;9430.481323527203;9448.811023779486;9488.667896623585;9568.947415784258;9602.183814375787;8726.607302671395;9316.161545460942;9409.670661526881;9450.007749186374;9463.432194068379;32442.513362299585;38800.22399551993;39148.80425597854;39208.21583568341;39269.60730392688;2402.3633737059695;2586.7154612992554;3044;3128.311771410286;3206.695363940422;23197.304080877602;26179.738202617922;28054.859725701444;28267.293317667016;28359.582020899077;2773.0017193810213;2778.9861050694817;2818.5349417346115;2871.3826527296524;2872.7989040767156;314501.4274928634;315600;316780.41609791806;317111.9999999977;318162;44730.55269447329;45812.770936145105;45916.54083459189;46006;62127.689361552904;45390.319145212845;45399;45559.08881822345;45825.54174458279;45870.54129458663;15363.231838408035;15392.692146157015;15527.84472155264;15541.222938853012;15545.30046147926;12085.697857553632;12406.503739850485;12465.501379944883;12482;12650.30423326726;14875.553733388017;14972.47596334123;14977.176255306063;14977.475788347356;14985.550433487013;6640.402363787186;6760.808298854741;6796.354346337189;6801.4898882584;6807.162066242186;984.9359791613522;989.9059589339146;1065.6003998500562;1089.3518356577824;1116.5980247111033;24144.63783043256;29565.85217073901;29580.55629165564;29851.402971940875;29910.700892991226;1094.5949998500605;1105.8285965675334;1142.3945308986251;1142.4116579961326;1213.168979249217;14852.851471485363;14944.327505262072;15022.399104035716;15396.538103856677;15399.846001539841;273114.6344268266;741078;741923;742547;745599;58295.41704582985;58527;58725;59201.447913125354;59220.70389648024;1433.4982756035304;1455.8107446032159;1469.2506821520888;1473.3369983507464;1480.6816534445145;28604.570931435628;29565;29619;29687.85156074206;30301.93943211977;50140.74648133826;55971;57313;57512.849743004066;57517.71241143935;505720;511503;514523.42738287564;518524;521192;33040;40273.19453610853;40728.92710728903;41010.384844227956;41772.164556708085;46841;46944;46961.76519117383;47760.044799103125;49073;37627.81186094052;39023.024424389616;39249.82250532488;40064.799676001436;40170.59829401786;32147.839260803546;37712.05719856916;37794.43308350432;38392.84821455361;38792.418113727756;38003.23993520059;38184.04539886414;38646.2270754589;38693.419598706605;38945.61054389533;30973.69026309708;32396;32440;32562.348753025282;33125.17187070342;20209.898950505154;23854.403639908447;23955.760442395353;24395.878020609784;24729 16:28:38 INFO - PROCESS | 2774 | |2;jquery.html;356.3265428340437;361.3964678986093;367.87860006197957;369.8040038779448;372.3260897775029;17906.37327693531;18561.257549698013;19666.508337291576;19672.606547869033;19712.507187320323;14749.631259218524;19830.60338793223;20252.088656010477;20450.59098818023;20788.960551972377;5406.135018397067;5581.888362232753;5678.545716342704;5703.54371650267;5712.857178570527;5476.7535460904155;5583.748731307081;5677.772889084452;5707.77168913243;5713.143028545731;5630.60585758995;5652.604317697763;5668.546516278709;5677.8580535486735;5683.3464151622675;5443.618946673734;5522.116461366202;5643.238162848024;5649.0114230009585;5660.037793575102;4849.83025594106;4856.295837103636;4858.222684370484;4862.586680132193;4882.780274887638;23523.411914702097;23592.528149437087;23683.40791480227;24297.514049719084;24301.756982430303;2101.5166511702396;2255.0979608156704;2430.2952143878256;2581.5611346071214;2839.219214715949;9037.141471560257;9509.809803803884;9549.904500954972;9635.951820240924;14715.55853324402;1732.480255923218;1779.0926627419979;1788.3115000724686;1794.5334213104686;1804.359452394394;92908.6063709045;100253.49619755709;104292.47853760683;104833.42749858758;106274.46862765714;10211.591536338612;10949.288296260876;10953.397563133945;11098;11145.888541114648;13253.469861205636;13268.469261229442;13291.268980205989;13307.268100254385;13320.93339533296;8092.554909479917;8101.554414507141;8238.217369349903;8298.419110662317;8366.832663346699;8389.748307550783;8391.118932512121;8404.11756765543;8420.073791882887;8513.361497887683;4324.632406245441;4346.217680817484;4392.07766369066;4420.270655341897;4432.534583868712;1707.163489889945;1861.8882867028021;1909.5989842133308;1909.9713504297447;1941.504916246348;850.6214734443237;963.4700914496999;978.7944531648291;989.1493315748451;1086.2993369276771;15458.84541154574;19318.903405482884;19363.225470981284;19464.70802937957;19612;962.6726912849665;995.7610173558294;1032.1123833503182;1036.5180191211123;1043.8695163104612;9706.70879873605;10379.481025948824;10386.065254127165;10405.895941040493;10410.271281010408;597146;602552;604231;613559;617479;110838;112294;113098;114032.42983785029;115910;870.7213691618621;877.1754550722301;1023.5138309303021;1042.9987212276149;1045.1116550931647;16149.335359665523;17253;17422.912885435493;17497.38759143424;17807.376741813976;37647.24705505929;39582.80208598939;47485;47558.524414756794;49480;71234;71463.28536714567;71645.56708865898;73908;74560.62719686367;7335.376492998155;7386.372158366599;7458.589777562069;7488.588127653032;7519.774406767806;9703.223742100474;11518.769624607294;11700.414979250832;11956.641300760992;11969.341686207343;7768.7669369918995;9988.450635215133;10191.03185197405;10327.586896524055;10464.319819211727;9571.458560332721;10003.949980250052;10080.798384032425;10161.796764064826;10245.385276883411;9208.907910920805;10272.845907311246;10491;10568.471576420994;10624.575016999543;7361.4110871129105;7438.256174382518;7508.474406791473;7565.1465390979565;7721.806954826175;9838.36050656705;10240.743981400525;10323.741906452398;10535.99908008738;10570.2600817942 16:28:38 INFO - PROCESS | 2774 | |3;mootools.html;1496.730588494071;1590.82279113456;1879.6428678551074;2011.9899400502995;2012.6377252094617;7875.094364148124;8549.273311768491;8621.65513379465;8802.647894084237;8819.470831750099;8702.216800487955;8708.608112634947;8781.077986811388;8815.735527934155;8817.603207855645;2462.692163479565;2480.6527086207943;2480.702315722107;2493.127405408111;2495.8752062396898;2383.559041577305;2452.766987136228;2501.8874150663264;2509.623556466526;2517.8237523373373;2466.136852101768;2492.3146134812982;2492.5513407586627;2508.184839927031;2511.468004517243;2441.475082857194;2463.5688754467988;2479.305794377577;2487.9253622391175;2503.7746602805837;2459.8155138364696;2487.067349743846;2487.291122030231;2504.7119581248025;2504.812139089557;8882.245009174228;8892.555372231427;8906.421082629608;8930.258599573086;8956.820863582692;5388.757505912244;5516.117421212587;5527.060399732055;5557;5562.221289019541;3586.5158203642695;3646.7082633389264;3697.722670799674;3723.4973278607313;3767.811609419518;1020.6784862768204;1056.4928834159646;1056.8361903904906;1064.6965614799744;1067.770429357692;10173.186145108448;11885.643430697093;11999.940000299943;12089.39553022354;12103.15277930554;4278.358246263023;4915.746484646393;4947.554720075211;4990.925136122961;5001.224810154432;10291.125254353314;10317.019883111092;10347.068763811292;10352.016558426938;10356.741081473023;4696.319033740088;5464.3442786865835;5485.396606373296;5486.259354987025;5514.751836167382;4405.581469760367;4822.71063736177;4898.559129678346;4919.926201106986;4960.454350021495;3396.5075064115563;3878.70909681775;3974.4038394241097;3975.4633124528395;3994.8801535953967;1129.8249820187077;1245.5702782540009;1297.0661123990712;1329.5678904356123;1331.7269959658247;1361.1220762608061;1386.383059538516;1390.8887289016855;1397.8322601287707;1417.1567917089315;8196;8228.711995080144;8364.456310339809;8388.832223355499;8423.031351394546;493.1296262097401;505.5500604462032;517.5290485658034;519.4182515582496;521.1817446608864;6187.288461826947;6211.192544969125;6251.124842521959;6260.311365749764;6268.811935641938;10572.577096916191;10847.728806779736;10956.34261944286;10969.725756856142;10987.230893837355;10660.147188224923;10735.89264107349;10817.945910270555;10931.344119352865;10946.39794811293;8329.458585192064;8412.789680258042;8423.284020858297;8439.31213757251;8494.915050849537;7839.725609603636;7909.9209007909185;7943.84112317762;8028.558429286445;8043.597820109088;9423.811523769624;9634.951825240829;9693.70918872435;9693.854592181264;9732.659356922473;9819.116279534876;10045.849312260469;10081.546330415296;10117.29178957466;10189.592416303265;6737.326267373223;7296.270372962874;7368.115826100902;7608.16310205888;7641.923580764121;8196.918030819616;8202.425830191829;8216.137305582828;8228;8248.793780155544;7276.527025743309;7360.926390736024;7380.372668323038;7462.216467270859;7507.324340809353;7221.855562888608;7288.760910645097;7310.305520975498;7322.487425880137;7345.926540734738;7727.072751269883;7787.883181752165;7794;7810.882836757567;7840.059192896889;6983.580985140908;7007.7196912122945;7008.7546935857;7082.716691332495;7095.645217739196;7057.36483716468;7077.504574679723;7127.144742630918;7131.108611423572;7139.678714457966 16:28:38 INFO - PROCESS | 2774 | |4;prototype.html;324.65586478332966;331.9834008299586;333.00597715818276;335.6576292181976;339.3975693144669;5658.292713410824;6890.310968903107;7048.189458212307;7050.682719277632;7089.149302083744;6917.965410172955;6923.20383155936;6924.54990425622;6937.167539895207;6941.097657304556;4849.660523763338;4946.653734238605;5082.923756143642;5117.769700363474;5138.177891537364;5085.1863701807715;5086.516780905808;5093.465186155456;5154.07226699194;5179.093658609747;4145.922060264323;4354;4926.408830940274;5096.566791822699;5102.31118798963;4192.434021407132;4202.85290014851;5100.795968161269;5119.616028797818;5122.335241046675;4357.498887627931;4357.869263922087;4367.192069467159;4369.3009118541195;4405.691601587891;5629.183768353607;6271.96864015677;6752.426043786284;6757.189137303555;6786.4570834333135;4882.41411030675;5826.213461182729;5833.095870140135;5887.8528036799;5923.200367950315;7368.410527157815;7374.446916481232;7377.40980721541;7394.445416593723;7400.1489828669855;4651;4652.674312798105;4667.906641867144;4668.463126740435;4684.8360307389075;7774.844503109963;7867.527948323119;7869.937558429596;7877.369810415153;7914.604269786545;4554.590086892195;4730.479647238801;4741.170295198395;4754.548317909793;4759.381280433521;4759.405074365704;4814.542618451242;4824.6863953842885;4835.226363781778;4835.95164048362;4720.858374248778;5688.658680479184;5833.591648584558;5864.618799778001;5892.646441213541;7382.077240344957;7382.18795932447;7401.888971665429;7412.814679632945;7449.143348514882;1661.6676664667116;1689.6874078295555;1697.5077227604104;1697.8217287184914;1699.124950650416;1043.441758659129;1069.0756638051475;1074.065562960214;1087.1302957633861;1098.368438148052;6847.897281540781;6942.062821519131;6948.44412447003;6962.651867406609;6971.128608923885;7392.889106663404;7614.048243969504;7624.313811756969;7632.656530456143;7640.73257435987;6270.2789179244055;6510.25132109804;6969.825754356181;6976.372126508639;6985.126859142607;4028.1943611277275;4074.3888416737727;4080.836766529365;4090.2228576570355;4094.0788322627172;7704.30661240491;8056.872037914696;8185.386096042702;8186.795330116675;8190.836183276301;7785.805354866174;8080.797980050545;8084.797880052928;8088.514689118554;8096.149904259968;8082.11096779342;8145.551994640352;8175.427720059539;8176.836463270702;8177.345812335118;7758.68965241384;7772.261635144652;7776.377889768692;7784.727534536264;7793.376529877482;7587.355074818703;7636.694532218649;7657.157712651715;7674.6930122794465;7675.769726907978;6581.769638062645;7396.519226250277;7940.205979402013;8156.796080098045;8205.917940820515;4740.928886066781;4770.713757174581;4801.615870730263;4809.254565542346;4812.470628230962;6914.619695916773;7141.392981596622;7735.613219338898;7740.26467485588;7794.2985131338455;6071.574989750675;7424.480286380118;7453.142888567884;7477.70089196426;7496.475246732676;7201.927980720336;7422.035135432359;7479.813004674927;7517.1731109579;7535.359494442814;7161.785146445615;7209.675564599501;7223.638818058971;7224.277572242734;7247.8550428990075;7451.217622149813;7453.403727701662;7469.850602987801;7469.925300746923;7483;6971.372576468142;7233.891491627524;7239.674214660247;7283.817904552428;7303.160136584361 16:28:38 INFO - PROCESS | 2774 | |5;yui.html;747.8579069976707;759.3962799574341;779.5283853268771;781.663884529652;807.3339494916695;14900.552983410502;17660.73508897366;18160;18168.27326906924;18679.252829886824;14419;16450;16538.92496987695;16562.751558726628;16590.25343859526;766.203148725325;921.3964853021265;946.9100435458621;947.2185447006214;948.6252930092609;936.283742936654;940.3182692547916;951.9381240219399;954.88063992001;961.8845738511388;991.9156871665881;996.9601215951353;1013.9949300253488;1014.8376259798433;1019.7705516258857;962.8170647576973;978.280963491833;985.7387792235099;992.2607657295325;1009.3741880034353;707.2220557386885;749.4454103963083;751.5866273549581;753.5252790741853;755.7392699518657;15455.30451129702;15629.765553516707;15760.921195394065;15780.526584202493;15799.842001579953;12310.199837010656;12359.938200308941;12403.875961240363;12516.249025058434;12618.305993170372;9988.300818942676;10065.647702330383;10222.846657300146;10242.7439314017;10466.267361284714;3436.415809312423;3441.5353927219753;3464.3937310970477;3519.3137338219058;3560.9109772255642;77946;79425.99999999942;79885;80566;81227.18772812255;9011;9253.95373023144;9308;9316;9456.290778191664;21183.258585949417;21260.574788504142;21316.253931112336;21327.46681332979;21333.57332853334;7131.89302160468;7220.602866842374;7241.927580724126;7272.090988626422;7417.629118544051;3809.1619843634357;3812;3817.3319669057805;3825.6174382562076;3850.0567360996733;3563.3407819553468;3571.767835090711;3591.1560783215923;3601.441776524643;3619.2399596085115;629.8079085878759;639.4947991087082;642.1940464716844;643.7907680004017;651.4560342114293;475.51972507766715;542.7232111623101;557.1531272465829;583.439897698206;609.107657282075;7196.676149573282;8061.959690201512;8160.469569477965;8303.709370172015;8358.707445239388;559.8908212898446;578.733782460073;590.6721769418015;625.4558534075384;635.2599221906427;3007.161087295919;3717.5353080864893;3743.2700623378723;3784.848606055782;3997.420374045747;87843.56078219568;88255.55872220726;88865.55567222122;91219.54390228007;93771.53114234385;76422.61788691022;76899;77953.22046779573;79756.80364794533;81339.40214540205;67833.64332713417;69137.65431172813;69739.99999999898;70684.64657676782;71590.926136108;6970.337817907291;8054.7112462008145;8490.405671602928;8640.783980400289;8728.476291422536;43508.34737478877;46187.6143715689;47466.813329667035;48173.27740083831;50125.74937125291;65161.674191628736;69130.65434672996;69172;70014.29985700078;70399.64800175966;10965;10986;11015.669529914116;11076.39079850616;11285.435728213391;11204.719882003015;11306.038986685895;11615.6515304541;12127.514899403925;13071.934640326737;11371.772564548828;11402.20184587104;11453.19827612059;11741.941290293495;12008.879911201126;11546.711332216426;11719.941400292944;11762.411879405825;11793.29240245588;11854.881451185724;11178.888211117785;11306.717332066764;11324.773504530029;11595.8260626089;11671.474783634927;9243.676471323472;9448.102430269113;9653.420794752337;9654.324197306121;9707.5042313363;9533.952330238304;9573.808523829344;9622.47076410804;9665.226781857295;9731.9026809731 16:28:38 INFO - PROCESS | 2774 | __end_tp_report 16:28:38 INFO - PROCESS | 2774 | __start_cc_report 16:28:38 INFO - PROCESS | 2774 | _x_x_mozilla_cycle_collect,366 16:28:38 INFO - PROCESS | 2774 | __end_cc_report 16:28:38 INFO - PROCESS | 2774 | __startTimestamp1458170918161__endTimestamp 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - PROCESS | 2774 | ------- Summary: start ------- 16:28:38 INFO - PROCESS | 2774 | Number of tests: 6 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - PROCESS | 2774 | [#0] dojo.html Cycles:165 Average:5784.90 Median:6044.09 stddev:621.46 (10.3%) stddev-sans-first:595.78 16:28:38 INFO - PROCESS | 2774 | Values: 3450.7 3501.8 3517.0 3529.0 3542.6 5771.8 5773.1 5837.9 5839.2 5841.6 5679.7 5848.3 5869.1 5925.0 6004.8 5239.4 5286.6 5328.5 5355.1 5391.7 5245.1 5371.1 5402.2 5449.1 5450.3 5149.9 5203.8 5323.5 5351.1 5366.1 5283.3 5294.3 5303.1 5304.5 5309.8 5240.3 5255.5 5289.8 5301.2 5319.0 5568.6 5623.2 5759.1 5805.6 5857.8 6141.0 6173.9 6205.5 6210.7 6213.1 6145.4 6212.5 6225.1 6227.2 6229.8 5881.2 5910.6 5924.8 5953.1 5991.5 6233.8 6293.8 6310.7 6322.6 6350.6 5947.1 6123.0 6241.5 6268.1 6270.7 6145.0 6163.1 6215.1 6232.2 6236.5 6116.8 6166.5 6167.8 6227.0 6244.7 5114.9 6116.3 6136.8 6187.8 6221.6 4951.2 4960.2 4966.5 4973.3 5019.7 4409.9 4433.4 4445.8 4447.2 4466.5 5768.6 5887.9 5943.9 5988.4 6024.5 6206.2 6227.9 6237.8 6253.9 6274.6 6021.8 6023.2 6027.1 6051.5 6077.5 5292.0 5376.7 5447.1 5502.2 5505.1 6333.2 6358.0 6372.5 6381.4 6388.4 6219.9 6236.0 6239.2 6243.9 6253.0 6218.5 6316.2 6355.1 6392.2 6418.3 6182.2 6204.7 6216.7 6246.6 6263.1 6138.4 6224.5 6229.9 6237.0 6239.4 6026.0 6114.1 6128.2 6136.9 6171.6 4761.4 6008.0 6171.6 6172.8 6219.6 5968.8 6044.1 6062.1 6117.4 6125.7 6065.6 6126.1 6158.3 6173.5 6176.1 5007.9 5364.9 5880.9 6056.7 6091.3 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - PROCESS | 2774 | [#1] ext.html Cycles:180 Average:62945.47 Median:38796.32 stddev:140562.02 (362.3%) stddev-sans-first:140878.27 16:28:38 INFO - PROCESS | 2774 | Values: 552.5 591.3 596.5 624.7 656.0 27938.6 38196.8 38382.4 38412.0 38444.6 39464.8 39466.8 39507.4 39713.0 39812.4 9323.8 9468.9 9505.2 9515.8 9532.0 9306.2 9589.4 9605.0 9609.0 9614.8 8307.9 8315.5 9422.4 9559.6 9636.7 9430.5 9448.8 9488.7 9568.9 9602.2 8726.6 9316.2 9409.7 9450.0 9463.4 32442.5 38800.2 39148.8 39208.2 39269.6 2402.4 2586.7 3044.0 3128.3 3206.7 23197.3 26179.7 28054.9 28267.3 28359.6 2773.0 2779.0 2818.5 2871.4 2872.8 314501.4 315600.0 316780.4 317112.0 318162.0 44730.6 45812.8 45916.5 46006.0 62127.7 45390.3 45399.0 45559.1 45825.5 45870.5 15363.2 15392.7 15527.8 15541.2 15545.3 12085.7 12406.5 12465.5 12482.0 12650.3 14875.6 14972.5 14977.2 14977.5 14985.6 6640.4 6760.8 6796.4 6801.5 6807.2 984.9 989.9 1065.6 1089.4 1116.6 24144.6 29565.9 29580.6 29851.4 29910.7 1094.6 1105.8 1142.4 1142.4 1213.2 14852.9 14944.3 15022.4 15396.5 15399.8 273114.6 741078.0 741923.0 742547.0 745599.0 58295.4 58527.0 58725.0 59201.4 59220.7 1433.5 1455.8 1469.3 1473.3 1480.7 28604.6 29565.0 29619.0 29687.9 30301.9 50140.7 55971.0 57313.0 57512.8 57517.7 505720.0 511503.0 514523.4 518524.0 521192.0 33040.0 40273.2 40728.9 41010.4 41772.2 46841.0 46944.0 46961.8 47760.0 49073.0 37627.8 39023.0 39249.8 40064.8 40170.6 32147.8 37712.1 37794.4 38392.8 38792.4 38003.2 38184.0 38646.2 38693.4 38945.6 30973.7 32396.0 32440.0 32562.3 33125.2 20209.9 23854.4 23955.8 24395.9 24729.0 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - PROCESS | 2774 | [#2] jquery.html Cycles:180 Average:33506.83 Median:358.86 stddev:100553.62 (28020.2%) stddev-sans-first:100804.88 16:28:38 INFO - PROCESS | 2774 | Values: 356.3 361.4 367.9 369.8 372.3 17906.4 18561.3 19666.5 19672.6 19712.5 14749.6 19830.6 20252.1 20450.6 20789.0 5406.1 5581.9 5678.5 5703.5 5712.9 5476.8 5583.7 5677.8 5707.8 5713.1 5630.6 5652.6 5668.5 5677.9 5683.3 5443.6 5522.1 5643.2 5649.0 5660.0 4849.8 4856.3 4858.2 4862.6 4882.8 23523.4 23592.5 23683.4 24297.5 24301.8 2101.5 2255.1 2430.3 2581.6 2839.2 9037.1 9509.8 9549.9 9636.0 14715.6 1732.5 1779.1 1788.3 1794.5 1804.4 92908.6 100253.5 104292.5 104833.4 106274.5 10211.6 10949.3 10953.4 11098.0 11145.9 13253.5 13268.5 13291.3 13307.3 13320.9 8092.6 8101.6 8238.2 8298.4 8366.8 8389.7 8391.1 8404.1 8420.1 8513.4 4324.6 4346.2 4392.1 4420.3 4432.5 1707.2 1861.9 1909.6 1910.0 1941.5 850.6 963.5 978.8 989.1 1086.3 15458.8 19318.9 19363.2 19464.7 19612.0 962.7 995.8 1032.1 1036.5 1043.9 9706.7 10379.5 10386.1 10405.9 10410.3 597146.0 602552.0 604231.0 613559.0 617479.0 110838.0 112294.0 113098.0 114032.4 115910.0 870.7 877.2 1023.5 1043.0 1045.1 16149.3 17253.0 17422.9 17497.4 17807.4 37647.2 39582.8 47485.0 47558.5 49480.0 71234.0 71463.3 71645.6 73908.0 74560.6 7335.4 7386.4 7458.6 7488.6 7519.8 9703.2 11518.8 11700.4 11956.6 11969.3 7768.8 9988.5 10191.0 10327.6 10464.3 9571.5 10003.9 10080.8 10161.8 10245.4 9208.9 10272.8 10491.0 10568.5 10624.6 7361.4 7438.3 7508.5 7565.1 7721.8 9838.4 10240.7 10323.7 10536.0 10570.3 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - PROCESS | 2774 | [#3] mootools.html Cycles:180 Average:6086.25 Median:2753.39 stddev:3227.57 (117.2%) stddev-sans-first:3218.19 16:28:38 INFO - PROCESS | 2774 | Values: 1496.7 1590.8 1879.6 2012.0 2012.6 7875.1 8549.3 8621.7 8802.6 8819.5 8702.2 8708.6 8781.1 8815.7 8817.6 2462.7 2480.7 2480.7 2493.1 2495.9 2383.6 2452.8 2501.9 2509.6 2517.8 2466.1 2492.3 2492.6 2508.2 2511.5 2441.5 2463.6 2479.3 2487.9 2503.8 2459.8 2487.1 2487.3 2504.7 2504.8 8882.2 8892.6 8906.4 8930.3 8956.8 5388.8 5516.1 5527.1 5557.0 5562.2 3586.5 3646.7 3697.7 3723.5 3767.8 1020.7 1056.5 1056.8 1064.7 1067.8 10173.2 11885.6 11999.9 12089.4 12103.2 4278.4 4915.7 4947.6 4990.9 5001.2 10291.1 10317.0 10347.1 10352.0 10356.7 4696.3 5464.3 5485.4 5486.3 5514.8 4405.6 4822.7 4898.6 4919.9 4960.5 3396.5 3878.7 3974.4 3975.5 3994.9 1129.8 1245.6 1297.1 1329.6 1331.7 1361.1 1386.4 1390.9 1397.8 1417.2 8196.0 8228.7 8364.5 8388.8 8423.0 493.1 505.6 517.5 519.4 521.2 6187.3 6211.2 6251.1 6260.3 6268.8 10572.6 10847.7 10956.3 10969.7 10987.2 10660.1 10735.9 10817.9 10931.3 10946.4 8329.5 8412.8 8423.3 8439.3 8494.9 7839.7 7909.9 7943.8 8028.6 8043.6 9423.8 9635.0 9693.7 9693.9 9732.7 9819.1 10045.8 10081.5 10117.3 10189.6 6737.3 7296.3 7368.1 7608.2 7641.9 8196.9 8202.4 8216.1 8228.0 8248.8 7276.5 7360.9 7380.4 7462.2 7507.3 7221.9 7288.8 7310.3 7322.5 7345.9 7727.1 7787.9 7794.0 7810.9 7840.1 6983.6 7007.7 7008.8 7082.7 7095.6 7057.4 7077.5 7127.1 7131.1 7139.7 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - PROCESS | 2774 | [#4] prototype.html Cycles:180 Average:6019.94 Median:6930.86 stddev:1979.21 (28.6%) stddev-sans-first:1938.05 16:28:38 INFO - PROCESS | 2774 | Values: 324.7 332.0 333.0 335.7 339.4 5658.3 6890.3 7048.2 7050.7 7089.1 6918.0 6923.2 6924.5 6937.2 6941.1 4849.7 4946.7 5082.9 5117.8 5138.2 5085.2 5086.5 5093.5 5154.1 5179.1 4145.9 4354.0 4926.4 5096.6 5102.3 4192.4 4202.9 5100.8 5119.6 5122.3 4357.5 4357.9 4367.2 4369.3 4405.7 5629.2 6272.0 6752.4 6757.2 6786.5 4882.4 5826.2 5833.1 5887.9 5923.2 7368.4 7374.4 7377.4 7394.4 7400.1 4651.0 4652.7 4667.9 4668.5 4684.8 7774.8 7867.5 7869.9 7877.4 7914.6 4554.6 4730.5 4741.2 4754.5 4759.4 4759.4 4814.5 4824.7 4835.2 4836.0 4720.9 5688.7 5833.6 5864.6 5892.6 7382.1 7382.2 7401.9 7412.8 7449.1 1661.7 1689.7 1697.5 1697.8 1699.1 1043.4 1069.1 1074.1 1087.1 1098.4 6847.9 6942.1 6948.4 6962.7 6971.1 7392.9 7614.0 7624.3 7632.7 7640.7 6270.3 6510.3 6969.8 6976.4 6985.1 4028.2 4074.4 4080.8 4090.2 4094.1 7704.3 8056.9 8185.4 8186.8 8190.8 7785.8 8080.8 8084.8 8088.5 8096.1 8082.1 8145.6 8175.4 8176.8 8177.3 7758.7 7772.3 7776.4 7784.7 7793.4 7587.4 7636.7 7657.2 7674.7 7675.8 6581.8 7396.5 7940.2 8156.8 8205.9 4740.9 4770.7 4801.6 4809.3 4812.5 6914.6 7141.4 7735.6 7740.3 7794.3 6071.6 7424.5 7453.1 7477.7 7496.5 7201.9 7422.0 7479.8 7517.2 7535.4 7161.8 7209.7 7223.6 7224.3 7247.9 7451.2 7453.4 7469.9 7469.9 7483.0 6971.4 7233.9 7239.7 7283.8 7303.2 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - PROCESS | 2774 | [#5] yui.html Cycles:180 Average:18290.15 Median:617.28 stddev:25417.37 (4117.6%) stddev-sans-first:25454.54 16:28:38 INFO - PROCESS | 2774 | Values: 747.9 759.4 779.5 781.7 807.3 14900.6 17660.7 18160.0 18168.3 18679.3 14419.0 16450.0 16538.9 16562.8 16590.3 766.2 921.4 946.9 947.2 948.6 936.3 940.3 951.9 954.9 961.9 991.9 997.0 1014.0 1014.8 1019.8 962.8 978.3 985.7 992.3 1009.4 707.2 749.4 751.6 753.5 755.7 15455.3 15629.8 15760.9 15780.5 15799.8 12310.2 12359.9 12403.9 12516.2 12618.3 9988.3 10065.6 10222.8 10242.7 10466.3 3436.4 3441.5 3464.4 3519.3 3560.9 77946.0 79426.0 79885.0 80566.0 81227.2 9011.0 9254.0 9308.0 9316.0 9456.3 21183.3 21260.6 21316.3 21327.5 21333.6 7131.9 7220.6 7241.9 7272.1 7417.6 3809.2 3812.0 3817.3 3825.6 3850.1 3563.3 3571.8 3591.2 3601.4 3619.2 629.8 639.5 642.2 643.8 651.5 475.5 542.7 557.2 583.4 609.1 7196.7 8062.0 8160.5 8303.7 8358.7 559.9 578.7 590.7 625.5 635.3 3007.2 3717.5 3743.3 3784.8 3997.4 87843.6 88255.6 88865.6 91219.5 93771.5 76422.6 76899.0 77953.2 79756.8 81339.4 67833.6 69137.7 69740.0 70684.6 71590.9 6970.3 8054.7 8490.4 8640.8 8728.5 43508.3 46187.6 47466.8 48173.3 50125.7 65161.7 69130.7 69172.0 70014.3 70399.6 10965.0 10986.0 11015.7 11076.4 11285.4 11204.7 11306.0 11615.7 12127.5 13071.9 11371.8 11402.2 11453.2 11741.9 12008.9 11546.7 11719.9 11762.4 11793.3 11854.9 11178.9 11306.7 11324.8 11595.8 11671.5 9243.7 9448.1 9653.4 9654.3 9707.5 9534.0 9573.8 9622.5 9665.2 9731.9 16:28:38 INFO - PROCESS | 2774 | -------- Summary: end -------- 16:28:38 INFO - PROCESS | 2774 | 16:28:38 INFO - TEST-INFO | 2774: exit 0 16:28:38 INFO - TEST-OK | dromaeo_css | took 1111730ms 16:28:38 INFO - TEST-START | kraken 16:28:38 INFO - operating with platform_type : mac_ 16:28:38 INFO - Initialising browser for kraken test... 16:28:38 INFO - TEST-INFO | started process 2781 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmppW0VVf/profile http://localhost:49737/getInfo.html) 16:28:41 INFO - PROCESS | 2781 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:28:41 INFO - PROCESS | 2781 | __metrics Screen width/height:1600/1200 16:28:41 INFO - PROCESS | 2781 | colorDepth:24 16:28:41 INFO - PROCESS | 2781 | Browser inner width/height: 1024/689 16:28:41 INFO - PROCESS | 2781 | __metrics 16:28:41 ERROR - PROCESS | 2781 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 16:28:42 INFO - TEST-INFO | 2781: exit 0 16:28:42 INFO - Browser initialized. 16:28:42 INFO - Running cycle 1/1 for kraken test... 16:28:42 INFO - TEST-INFO | started process 2784 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/tmppW0VVf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:28:54 INFO - PROCESS | 2784 | RSS: Main: 255234048 16:28:54 INFO - PROCESS | 2784 | 16:28:57 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-beat-detection) 16:28:57 INFO - PROCESS | 2784 | RSS: Main: 267997184 16:28:57 INFO - PROCESS | 2784 | 16:29:00 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-dft) 16:29:01 INFO - PROCESS | 2784 | RSS: Main: 276934656 16:29:01 INFO - PROCESS | 2784 | 16:29:04 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-fft) 16:29:04 INFO - PROCESS | 2784 | RSS: Main: 279584768 16:29:04 INFO - PROCESS | 2784 | 16:29:06 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49737/tests/kraken/driver.html?testName=audio-oscillator) 16:29:07 INFO - PROCESS | 2784 | RSS: Main: 281436160 16:29:07 INFO - PROCESS | 2784 | 16:29:09 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:29:10 INFO - PROCESS | 2784 | RSS: Main: 282513408 16:29:10 INFO - PROCESS | 2784 | 16:29:13 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-darkroom) 16:29:13 INFO - PROCESS | 2784 | RSS: Main: 284139520 16:29:13 INFO - PROCESS | 2784 | 16:29:16 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49737/tests/kraken/driver.html?testName=imaging-desaturate) 16:29:17 INFO - PROCESS | 2784 | RSS: Main: 282218496 16:29:17 INFO - PROCESS | 2784 | 16:29:19 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49737/tests/kraken/driver.html?testName=json-parse-financial) 16:29:20 INFO - PROCESS | 2784 | RSS: Main: 284176384 16:29:20 INFO - PROCESS | 2784 | 16:29:22 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49737/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:29:22 INFO - PROCESS | 2784 | RSS: Main: 283992064 16:29:22 INFO - PROCESS | 2784 | 16:29:24 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:29:25 INFO - PROCESS | 2784 | RSS: Main: 283410432 16:29:25 INFO - PROCESS | 2784 | 16:29:27 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:29:28 INFO - PROCESS | 2784 | RSS: Main: 283389952 16:29:28 INFO - PROCESS | 2784 | 16:29:30 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:29:31 INFO - PROCESS | 2784 | RSS: Main: 284098560 16:29:31 INFO - PROCESS | 2784 | 16:29:33 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:29:34 INFO - PROCESS | 2784 | RSS: Main: 283009024 16:29:34 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | Cycle 1(1): loaded http://localhost:49737/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49737/tests/kraken/driver.html?testName=ai-astar) 16:29:36 INFO - PROCESS | 2784 | RSS: Main: 285884416 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | __start_tp_report 16:29:36 INFO - PROCESS | 2784 | _x_x_mozilla_page_load 16:29:36 INFO - PROCESS | 2784 | _x_x_mozilla_page_load_details 16:29:36 INFO - PROCESS | 2784 | |i|pagename|runs| 16:29:36 INFO - PROCESS | 2784 | |0;ai-astar;115;111;95;165;171;149;116;113;115;115 16:29:36 INFO - PROCESS | 2784 | |1;audio-beat-detection;153;122;148;157;124;173;164;123;157;114 16:29:36 INFO - PROCESS | 2784 | |2;audio-dft;195;193;194;204;220;204;196;194;204;197 16:29:36 INFO - PROCESS | 2784 | |3;audio-fft;61;81;72;130;80;49;63;87;63;76 16:29:36 INFO - PROCESS | 2784 | |4;audio-oscillator;82;88;119;64;90;115;143;108;117;158 16:29:36 INFO - PROCESS | 2784 | |5;imaging-gaussian-blur;90;87;88;86;105;97;90;86;89;86 16:29:36 INFO - PROCESS | 2784 | |6;imaging-darkroom;114;97;97;105;151;95;97;94;95;104 16:29:36 INFO - PROCESS | 2784 | |7;imaging-desaturate;94;93;91;92;96;93;93;93;93;89 16:29:36 INFO - PROCESS | 2784 | |8;json-parse-financial;53;55;55;48;49;55;68;90;82;78 16:29:36 INFO - PROCESS | 2784 | |9;json-stringify-tinderbox;65;67;68;89;68;74;72;71;72;89 16:29:36 INFO - PROCESS | 2784 | |10;stanford-crypto-aes;107;71;96;74;89;110;112;110;95;86 16:29:36 INFO - PROCESS | 2784 | |11;stanford-crypto-ccm;132;134;139;135;109;136;131;129;139;137 16:29:36 INFO - PROCESS | 2784 | |12;stanford-crypto-pbkdf2;126;143;139;138;142;132;140;139;142;130 16:29:36 INFO - PROCESS | 2784 | |13;stanford-crypto-sha256-iterative;69;68;72;70;68;69;70;66;71;65 16:29:36 INFO - PROCESS | 2784 | __end_tp_report 16:29:36 INFO - PROCESS | 2784 | __start_cc_report 16:29:36 INFO - PROCESS | 2784 | _x_x_mozilla_cycle_collect,971 16:29:36 INFO - PROCESS | 2784 | __end_cc_report 16:29:36 INFO - PROCESS | 2784 | __startTimestamp1458170976518__endTimestamp 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | ------- Summary: start ------- 16:29:36 INFO - PROCESS | 2784 | Number of tests: 14 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#0] ai-astar Cycles:10 Average:126.50 Median:132.50 stddev:25.58 (19.3%) stddev-sans-first:26.79 16:29:36 INFO - PROCESS | 2784 | Values: 115.0 111.0 95.0 165.0 171.0 149.0 116.0 113.0 115.0 115.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:155.00 stddev:20.81 (13.4%) stddev-sans-first:21.79 16:29:36 INFO - PROCESS | 2784 | Values: 153.0 122.0 148.0 157.0 124.0 173.0 164.0 123.0 157.0 114.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#2] audio-dft Cycles:10 Average:200.10 Median:200.50 stddev:8.29 (4.1%) stddev-sans-first:8.59 16:29:36 INFO - PROCESS | 2784 | Values: 195.0 193.0 194.0 204.0 220.0 204.0 196.0 194.0 204.0 197.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#3] audio-fft Cycles:10 Average:76.20 Median:74.00 stddev:22.07 (29.8%) stddev-sans-first:22.72 16:29:36 INFO - PROCESS | 2784 | Values: 61.0 81.0 72.0 130.0 80.0 49.0 63.0 87.0 63.0 76.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:111.00 stddev:28.50 (25.7%) stddev-sans-first:28.58 16:29:36 INFO - PROCESS | 2784 | Values: 82.0 88.0 119.0 64.0 90.0 115.0 143.0 108.0 117.0 158.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:88.50 stddev:6.10 (6.9%) stddev-sans-first:6.46 16:29:36 INFO - PROCESS | 2784 | Values: 90.0 87.0 88.0 86.0 105.0 97.0 90.0 86.0 89.0 86.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:95.00 stddev:17.36 (18.3%) stddev-sans-first:18.09 16:29:36 INFO - PROCESS | 2784 | Values: 114.0 97.0 97.0 105.0 151.0 95.0 97.0 94.0 95.0 104.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:93.00 stddev:1.83 (2.0%) stddev-sans-first:1.88 16:29:36 INFO - PROCESS | 2784 | Values: 94.0 93.0 91.0 92.0 96.0 93.0 93.0 93.0 93.0 89.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:61.50 stddev:15.10 (24.6%) stddev-sans-first:15.55 16:29:36 INFO - PROCESS | 2784 | Values: 53.0 55.0 55.0 48.0 49.0 55.0 68.0 90.0 82.0 78.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:72.00 stddev:8.61 (12.0%) stddev-sans-first:8.56 16:29:36 INFO - PROCESS | 2784 | Values: 65.0 67.0 68.0 89.0 68.0 74.0 72.0 71.0 72.0 89.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#10] stanford-crypto-aes Cycles:10 Average:95.00 Median:80.00 stddev:14.97 (18.7%) stddev-sans-first:15.24 16:29:36 INFO - PROCESS | 2784 | Values: 107.0 71.0 96.0 74.0 89.0 110.0 112.0 110.0 95.0 86.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:135.50 stddev:8.76 (6.5%) stddev-sans-first:9.29 16:29:36 INFO - PROCESS | 2784 | Values: 132.0 134.0 139.0 135.0 109.0 136.0 131.0 129.0 139.0 137.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:139.50 stddev:5.76 (4.1%) stddev-sans-first:4.50 16:29:36 INFO - PROCESS | 2784 | Values: 126.0 143.0 139.0 138.0 142.0 132.0 140.0 139.0 142.0 130.0 16:29:36 INFO - PROCESS | 2784 | 16:29:36 INFO - PROCESS | 2784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:2.15 (3.1%) stddev-sans-first:2.28 16:29:36 INFO - PROCESS | 2784 | Values: 69.0 68.0 72.0 70.0 68.0 69.0 70.0 66.0 71.0 65.0 16:29:36 INFO - PROCESS | 2784 | -------- Summary: end -------- 16:29:36 INFO - PROCESS | 2784 | 16:29:37 INFO - TEST-INFO | 2784: exit 0 16:29:37 INFO - TEST-OK | kraken | took 58543ms 16:29:37 INFO - SUITE-END | took 1170s 16:29:37 INFO - Completed test suite (00:19:30) 16:29:37 INFO - javascript benchmark 16:29:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3450.7066899313563, 3501.8424170912313, 3517.0, 3528.999999999998, 3542.6280240574724, 5771.7979870704585, 5773.1051686988585, 5837.8832423351505, 5839.153322768201, 5841.649501029941, 5679.744411501482, 5848.327442344132, 5869.090291004901, 5924.970375148118, 6004.789832355868, 5239.397469291032, 5286.629935904488, 5328.520433161015, 5355.143177091666, 5391.73041347933, 5245.082110630643, 5371.086915224401, 5402.243685883979, 5449.073657478219, 5450.29146210992, 5149.871253218699, 5203.765830537635, 5323.494268044529, 5351.117065684158, 5366.141417373241, 5283.339582552181, 5294.311739473882, 5303.098473259516, 5304.522592966651, 5309.787608495655, 5240.3187585614005, 5255.500727430888, 5289.788408463657, 5301.204819277101, 5319.0, 5568.638038527482, 5623.240862483553, 5759.136129580555, 5805.622634528742, 5857.824265272006, 6140.986737188358, 6173.938260617381, 6205.503559715212, 6210.65841378724, 6213.099100630383, 6145.371476558716, 6212.502999760053, 6225.1284820124765, 6227.190465239535, 6229.781957631507, 5881.206037184968, 5910.615809972381, 5924.763009479659, 5953.107033944856, 5991.460768530853, 6233.812985610439, 6293.842653933688, 6310.652914089677, 6322.589031712924, 6350.587211831216, 5947.078202878561, 6122.977604208209, 6241.531885108635, 6268.09112678659, 6270.7491700331475, 6145.016797312409, 6163.075538669146, 6215.06773983906, 6232.189815323979, 6236.469900058546, 6116.785912493041, 6166.506679465632, 6167.753289868445, 6226.968865155645, 6244.687765611701, 5114.872128196825, 6116.3053375860445, 6136.815895523141, 6187.783427580013, 6221.595596286227, 4951.207806750975, 4960.181570040902, 4966.478519755446, 4973.32860063894, 5019.698818070854, 4409.867703968886, 4433.357163211316, 4445.777711114431, 4447.2217361962175, 4466.531014243523, 5768.625039372428, 5887.852803679943, 5943.851403714942, 5988.371221021817, 6024.518038556905, 6206.162168107338, 6227.906581401283, 6237.844053898689, 6253.906191407133, 6274.592151510137, 6021.789237376758, 6023.156758053876, 6027.126066720301, 6051.546134039964, 6077.474378982348, 5292.0, 5376.731163441812, 5447.073997420448, 5502.174673798962, 5505.119180931032, 6333.155136320718, 6358.046293056079, 6372.490200784019, 6381.425671689571, 6388.361163883575, 6219.875602488016, 6235.96882015587, 6239.220097487814, 6243.875122497616, 6253.0, 6218.533609979179, 6316.210473690789, 6355.14205582259, 6392.20097487814, 6418.293987661447, 6182.196314479269, 6204.689765511616, 6216.720247588779, 6246.562740608114, 6263.091851681572, 6138.388398386059, 6224.502039836892, 6229.875402492015, 6237.0, 6239.438450539473, 6025.969870150621, 6114.084479019511, 6128.1726966858905, 6136.938630613637, 6171.56799024064, 4761.381020467317, 6007.969960150172, 6171.56799024064, 6172.783952561639, 6219.626822390671, 5968.820935371946, 6044.093385992136, 6062.090686397076, 6117.449429551361, 6125.724342404514, 6065.5754097212775, 6126.090206827809, 6158.261008678987, 6173.506119510518, 6176.135341052166, 5007.949920500749, 5364.946350536445, 5880.882382352243, 6056.6971651418135, 6091.269047714125], "unit": "score", "name": "dojo.html", "value": 5747.86827157841}, {"lowerIsBetter": false, "replicates": [552.4613501835709, 591.2579712460861, 596.4959609130283, 624.659560539506, 655.9737610495579, 27938.580921286197, 38196.809015954954, 38382.424263636065, 38412.0, 38444.61555384445, 39464.80267598658, 39466.8026659867, 39507.40738888919, 39713.0, 39812.402813957815, 9323.766905827357, 9468.857967130498, 9505.239580833551, 9515.80968380632, 9532.0, 9306.208972237335, 9589.42463452195, 9605.039496050409, 9609.0, 9614.75963100921, 8307.875381869277, 8315.501069935823, 9422.434653920753, 9559.56981935811, 9636.662716804913, 9430.481323527203, 9448.811023779486, 9488.667896623585, 9568.947415784258, 9602.183814375787, 8726.607302671395, 9316.161545460942, 9409.670661526881, 9450.007749186374, 9463.432194068379, 32442.513362299585, 38800.22399551993, 39148.80425597854, 39208.21583568341, 39269.60730392688, 2402.3633737059695, 2586.7154612992554, 3044.0, 3128.311771410286, 3206.695363940422, 23197.304080877602, 26179.738202617922, 28054.859725701444, 28267.293317667016, 28359.582020899077, 2773.0017193810213, 2778.9861050694817, 2818.5349417346115, 2871.3826527296524, 2872.7989040767156, 314501.4274928634, 315600.0, 316780.41609791806, 317111.9999999977, 318162.0, 44730.55269447329, 45812.770936145105, 45916.54083459189, 46006.0, 62127.689361552904, 45390.319145212845, 45399.0, 45559.08881822345, 45825.54174458279, 45870.54129458663, 15363.231838408035, 15392.692146157015, 15527.84472155264, 15541.222938853012, 15545.30046147926, 12085.697857553632, 12406.503739850485, 12465.501379944883, 12482.0, 12650.30423326726, 14875.553733388017, 14972.47596334123, 14977.176255306063, 14977.475788347356, 14985.550433487013, 6640.402363787186, 6760.808298854741, 6796.354346337189, 6801.4898882584, 6807.162066242186, 984.9359791613522, 989.9059589339146, 1065.6003998500562, 1089.3518356577824, 1116.5980247111033, 24144.63783043256, 29565.85217073901, 29580.55629165564, 29851.402971940875, 29910.700892991226, 1094.5949998500605, 1105.8285965675334, 1142.3945308986251, 1142.4116579961326, 1213.168979249217, 14852.851471485363, 14944.327505262072, 15022.399104035716, 15396.538103856677, 15399.846001539841, 273114.6344268266, 741078.0, 741923.0, 742547.0, 745599.0, 58295.41704582985, 58527.0, 58725.0, 59201.447913125354, 59220.70389648024, 1433.4982756035304, 1455.8107446032159, 1469.2506821520888, 1473.3369983507464, 1480.6816534445145, 28604.570931435628, 29565.0, 29619.0, 29687.85156074206, 30301.93943211977, 50140.74648133826, 55971.0, 57313.0, 57512.849743004066, 57517.71241143935, 505720.0, 511503.0, 514523.42738287564, 518524.0, 521192.0, 33040.0, 40273.19453610853, 40728.92710728903, 41010.384844227956, 41772.164556708085, 46841.0, 46944.0, 46961.76519117383, 47760.044799103125, 49073.0, 37627.81186094052, 39023.024424389616, 39249.82250532488, 40064.799676001436, 40170.59829401786, 32147.839260803546, 37712.05719856916, 37794.43308350432, 38392.84821455361, 38792.418113727756, 38003.23993520059, 38184.04539886414, 38646.2270754589, 38693.419598706605, 38945.61054389533, 30973.69026309708, 32396.0, 32440.0, 32562.348753025282, 33125.17187070342, 20209.898950505154, 23854.403639908447, 23955.760442395353, 24395.878020609784, 24729.0], "unit": "score", "name": "ext.html", "value": 19123.013108608862}, {"lowerIsBetter": false, "replicates": [356.3265428340437, 361.3964678986093, 367.87860006197957, 369.8040038779448, 372.3260897775029, 17906.37327693531, 18561.257549698013, 19666.508337291576, 19672.606547869033, 19712.507187320323, 14749.631259218524, 19830.60338793223, 20252.088656010477, 20450.59098818023, 20788.960551972377, 5406.135018397067, 5581.888362232753, 5678.545716342704, 5703.54371650267, 5712.857178570527, 5476.7535460904155, 5583.748731307081, 5677.772889084452, 5707.77168913243, 5713.143028545731, 5630.60585758995, 5652.604317697763, 5668.546516278709, 5677.8580535486735, 5683.3464151622675, 5443.618946673734, 5522.116461366202, 5643.238162848024, 5649.0114230009585, 5660.037793575102, 4849.83025594106, 4856.295837103636, 4858.222684370484, 4862.586680132193, 4882.780274887638, 23523.411914702097, 23592.528149437087, 23683.40791480227, 24297.514049719084, 24301.756982430303, 2101.5166511702396, 2255.0979608156704, 2430.2952143878256, 2581.5611346071214, 2839.219214715949, 9037.141471560257, 9509.809803803884, 9549.904500954972, 9635.951820240924, 14715.55853324402, 1732.480255923218, 1779.0926627419979, 1788.3115000724686, 1794.5334213104686, 1804.359452394394, 92908.6063709045, 100253.49619755709, 104292.47853760683, 104833.42749858758, 106274.46862765714, 10211.591536338612, 10949.288296260876, 10953.397563133945, 11098.0, 11145.888541114648, 13253.469861205636, 13268.469261229442, 13291.268980205989, 13307.268100254385, 13320.93339533296, 8092.554909479917, 8101.554414507141, 8238.217369349903, 8298.419110662317, 8366.832663346699, 8389.748307550783, 8391.118932512121, 8404.11756765543, 8420.073791882887, 8513.361497887683, 4324.632406245441, 4346.217680817484, 4392.07766369066, 4420.270655341897, 4432.534583868712, 1707.163489889945, 1861.8882867028021, 1909.5989842133308, 1909.9713504297447, 1941.504916246348, 850.6214734443237, 963.4700914496999, 978.7944531648291, 989.1493315748451, 1086.2993369276771, 15458.84541154574, 19318.903405482884, 19363.225470981284, 19464.70802937957, 19612.0, 962.6726912849665, 995.7610173558294, 1032.1123833503182, 1036.5180191211123, 1043.8695163104612, 9706.70879873605, 10379.481025948824, 10386.065254127165, 10405.895941040493, 10410.271281010408, 597146.0, 602552.0, 604231.0, 613559.0, 617479.0, 110838.0, 112294.0, 113098.0, 114032.42983785029, 115910.0, 870.7213691618621, 877.1754550722301, 1023.5138309303021, 1042.9987212276149, 1045.1116550931647, 16149.335359665523, 17253.0, 17422.912885435493, 17497.38759143424, 17807.376741813976, 37647.24705505929, 39582.80208598939, 47485.0, 47558.524414756794, 49480.0, 71234.0, 71463.28536714567, 71645.56708865898, 73908.0, 74560.62719686367, 7335.376492998155, 7386.372158366599, 7458.589777562069, 7488.588127653032, 7519.774406767806, 9703.223742100474, 11518.769624607294, 11700.414979250832, 11956.641300760992, 11969.341686207343, 7768.7669369918995, 9988.450635215133, 10191.03185197405, 10327.586896524055, 10464.319819211727, 9571.458560332721, 10003.949980250052, 10080.798384032425, 10161.796764064826, 10245.385276883411, 9208.907910920805, 10272.845907311246, 10491.0, 10568.471576420994, 10624.575016999543, 7361.4110871129105, 7438.256174382518, 7508.474406791473, 7565.1465390979565, 7721.806954826175, 9838.36050656705, 10240.743981400525, 10323.741906452398, 10535.99908008738, 10570.2600817942], "unit": "score", "name": "jquery.html", "value": 9047.275809580746}, {"lowerIsBetter": false, "replicates": [1496.730588494071, 1590.82279113456, 1879.6428678551074, 2011.9899400502995, 2012.6377252094617, 7875.094364148124, 8549.273311768491, 8621.65513379465, 8802.647894084237, 8819.470831750099, 8702.216800487955, 8708.608112634947, 8781.077986811388, 8815.735527934155, 8817.603207855645, 2462.692163479565, 2480.6527086207943, 2480.702315722107, 2493.127405408111, 2495.8752062396898, 2383.559041577305, 2452.766987136228, 2501.8874150663264, 2509.623556466526, 2517.8237523373373, 2466.136852101768, 2492.3146134812982, 2492.5513407586627, 2508.184839927031, 2511.468004517243, 2441.475082857194, 2463.5688754467988, 2479.305794377577, 2487.9253622391175, 2503.7746602805837, 2459.8155138364696, 2487.067349743846, 2487.291122030231, 2504.7119581248025, 2504.812139089557, 8882.245009174228, 8892.555372231427, 8906.421082629608, 8930.258599573086, 8956.820863582692, 5388.757505912244, 5516.117421212587, 5527.060399732055, 5557.0, 5562.221289019541, 3586.5158203642695, 3646.7082633389264, 3697.722670799674, 3723.4973278607313, 3767.811609419518, 1020.6784862768204, 1056.4928834159646, 1056.8361903904906, 1064.6965614799744, 1067.770429357692, 10173.186145108448, 11885.643430697093, 11999.940000299943, 12089.39553022354, 12103.15277930554, 4278.358246263023, 4915.746484646393, 4947.554720075211, 4990.925136122961, 5001.224810154432, 10291.125254353314, 10317.019883111092, 10347.068763811292, 10352.016558426938, 10356.741081473023, 4696.319033740088, 5464.3442786865835, 5485.396606373296, 5486.259354987025, 5514.751836167382, 4405.581469760367, 4822.71063736177, 4898.559129678346, 4919.926201106986, 4960.454350021495, 3396.5075064115563, 3878.70909681775, 3974.4038394241097, 3975.4633124528395, 3994.8801535953967, 1129.8249820187077, 1245.5702782540009, 1297.0661123990712, 1329.5678904356123, 1331.7269959658247, 1361.1220762608061, 1386.383059538516, 1390.8887289016855, 1397.8322601287707, 1417.1567917089315, 8196.0, 8228.711995080144, 8364.456310339809, 8388.832223355499, 8423.031351394546, 493.1296262097401, 505.5500604462032, 517.5290485658034, 519.4182515582496, 521.1817446608864, 6187.288461826947, 6211.192544969125, 6251.124842521959, 6260.311365749764, 6268.811935641938, 10572.577096916191, 10847.728806779736, 10956.34261944286, 10969.725756856142, 10987.230893837355, 10660.147188224923, 10735.89264107349, 10817.945910270555, 10931.344119352865, 10946.39794811293, 8329.458585192064, 8412.789680258042, 8423.284020858297, 8439.31213757251, 8494.915050849537, 7839.725609603636, 7909.9209007909185, 7943.84112317762, 8028.558429286445, 8043.597820109088, 9423.811523769624, 9634.951825240829, 9693.70918872435, 9693.854592181264, 9732.659356922473, 9819.116279534876, 10045.849312260469, 10081.546330415296, 10117.29178957466, 10189.592416303265, 6737.326267373223, 7296.270372962874, 7368.115826100902, 7608.16310205888, 7641.923580764121, 8196.918030819616, 8202.425830191829, 8216.137305582828, 8228.0, 8248.793780155544, 7276.527025743309, 7360.926390736024, 7380.372668323038, 7462.216467270859, 7507.324340809353, 7221.855562888608, 7288.760910645097, 7310.305520975498, 7322.487425880137, 7345.926540734738, 7727.072751269883, 7787.883181752165, 7794.0, 7810.882836757567, 7840.059192896889, 6983.580985140908, 7007.7196912122945, 7008.7546935857, 7082.716691332495, 7095.645217739196, 7057.36483716468, 7077.504574679723, 7127.144742630918, 7131.108611423572, 7139.678714457966], "unit": "score", "name": "mootools.html", "value": 4884.251043782844}, {"lowerIsBetter": false, "replicates": [324.65586478332966, 331.9834008299586, 333.00597715818276, 335.6576292181976, 339.3975693144669, 5658.292713410824, 6890.310968903107, 7048.189458212307, 7050.682719277632, 7089.149302083744, 6917.965410172955, 6923.20383155936, 6924.54990425622, 6937.167539895207, 6941.097657304556, 4849.660523763338, 4946.653734238605, 5082.923756143642, 5117.769700363474, 5138.177891537364, 5085.1863701807715, 5086.516780905808, 5093.465186155456, 5154.07226699194, 5179.093658609747, 4145.922060264323, 4354.0, 4926.408830940274, 5096.566791822699, 5102.31118798963, 4192.434021407132, 4202.85290014851, 5100.795968161269, 5119.616028797818, 5122.335241046675, 4357.498887627931, 4357.869263922087, 4367.192069467159, 4369.3009118541195, 4405.691601587891, 5629.183768353607, 6271.96864015677, 6752.426043786284, 6757.189137303555, 6786.4570834333135, 4882.41411030675, 5826.213461182729, 5833.095870140135, 5887.8528036799, 5923.200367950315, 7368.410527157815, 7374.446916481232, 7377.40980721541, 7394.445416593723, 7400.1489828669855, 4651.0, 4652.674312798105, 4667.906641867144, 4668.463126740435, 4684.8360307389075, 7774.844503109963, 7867.527948323119, 7869.937558429596, 7877.369810415153, 7914.604269786545, 4554.590086892195, 4730.479647238801, 4741.170295198395, 4754.548317909793, 4759.381280433521, 4759.405074365704, 4814.542618451242, 4824.6863953842885, 4835.226363781778, 4835.95164048362, 4720.858374248778, 5688.658680479184, 5833.591648584558, 5864.618799778001, 5892.646441213541, 7382.077240344957, 7382.18795932447, 7401.888971665429, 7412.814679632945, 7449.143348514882, 1661.6676664667116, 1689.6874078295555, 1697.5077227604104, 1697.8217287184914, 1699.124950650416, 1043.441758659129, 1069.0756638051475, 1074.065562960214, 1087.1302957633861, 1098.368438148052, 6847.897281540781, 6942.062821519131, 6948.44412447003, 6962.651867406609, 6971.128608923885, 7392.889106663404, 7614.048243969504, 7624.313811756969, 7632.656530456143, 7640.73257435987, 6270.2789179244055, 6510.25132109804, 6969.825754356181, 6976.372126508639, 6985.126859142607, 4028.1943611277275, 4074.3888416737727, 4080.836766529365, 4090.2228576570355, 4094.0788322627172, 7704.30661240491, 8056.872037914696, 8185.386096042702, 8186.795330116675, 8190.836183276301, 7785.805354866174, 8080.797980050545, 8084.797880052928, 8088.514689118554, 8096.149904259968, 8082.11096779342, 8145.551994640352, 8175.427720059539, 8176.836463270702, 8177.345812335118, 7758.68965241384, 7772.261635144652, 7776.377889768692, 7784.727534536264, 7793.376529877482, 7587.355074818703, 7636.694532218649, 7657.157712651715, 7674.6930122794465, 7675.769726907978, 6581.769638062645, 7396.519226250277, 7940.205979402013, 8156.796080098045, 8205.917940820515, 4740.928886066781, 4770.713757174581, 4801.615870730263, 4809.254565542346, 4812.470628230962, 6914.619695916773, 7141.392981596622, 7735.613219338898, 7740.26467485588, 7794.2985131338455, 6071.574989750675, 7424.480286380118, 7453.142888567884, 7477.70089196426, 7496.475246732676, 7201.927980720336, 7422.035135432359, 7479.813004674927, 7517.1731109579, 7535.359494442814, 7161.785146445615, 7209.675564599501, 7223.638818058971, 7224.277572242734, 7247.8550428990075, 7451.217622149813, 7453.403727701662, 7469.850602987801, 7469.925300746923, 7483.0, 6971.372576468142, 7233.891491627524, 7239.674214660247, 7283.817904552428, 7303.160136584361], "unit": "score", "name": "prototype.html", "value": 5353.939346315679}, {"lowerIsBetter": false, "replicates": [747.8579069976707, 759.3962799574341, 779.5283853268771, 781.663884529652, 807.3339494916695, 14900.552983410502, 17660.73508897366, 18160.0, 18168.27326906924, 18679.252829886824, 14419.0, 16450.0, 16538.92496987695, 16562.751558726628, 16590.25343859526, 766.203148725325, 921.3964853021265, 946.9100435458621, 947.2185447006214, 948.6252930092609, 936.283742936654, 940.3182692547916, 951.9381240219399, 954.88063992001, 961.8845738511388, 991.9156871665881, 996.9601215951353, 1013.9949300253488, 1014.8376259798433, 1019.7705516258857, 962.8170647576973, 978.280963491833, 985.7387792235099, 992.2607657295325, 1009.3741880034353, 707.2220557386885, 749.4454103963083, 751.5866273549581, 753.5252790741853, 755.7392699518657, 15455.30451129702, 15629.765553516707, 15760.921195394065, 15780.526584202493, 15799.842001579953, 12310.199837010656, 12359.938200308941, 12403.875961240363, 12516.249025058434, 12618.305993170372, 9988.300818942676, 10065.647702330383, 10222.846657300146, 10242.7439314017, 10466.267361284714, 3436.415809312423, 3441.5353927219753, 3464.3937310970477, 3519.3137338219058, 3560.9109772255642, 77946.0, 79425.99999999942, 79885.0, 80566.0, 81227.18772812255, 9011.0, 9253.95373023144, 9308.0, 9316.0, 9456.290778191664, 21183.258585949417, 21260.574788504142, 21316.253931112336, 21327.46681332979, 21333.57332853334, 7131.89302160468, 7220.602866842374, 7241.927580724126, 7272.090988626422, 7417.629118544051, 3809.1619843634357, 3812.0, 3817.3319669057805, 3825.6174382562076, 3850.0567360996733, 3563.3407819553468, 3571.767835090711, 3591.1560783215923, 3601.441776524643, 3619.2399596085115, 629.8079085878759, 639.4947991087082, 642.1940464716844, 643.7907680004017, 651.4560342114293, 475.51972507766715, 542.7232111623101, 557.1531272465829, 583.439897698206, 609.107657282075, 7196.676149573282, 8061.959690201512, 8160.469569477965, 8303.709370172015, 8358.707445239388, 559.8908212898446, 578.733782460073, 590.6721769418015, 625.4558534075384, 635.2599221906427, 3007.161087295919, 3717.5353080864893, 3743.2700623378723, 3784.848606055782, 3997.420374045747, 87843.56078219568, 88255.55872220726, 88865.55567222122, 91219.54390228007, 93771.53114234385, 76422.61788691022, 76899.0, 77953.22046779573, 79756.80364794533, 81339.40214540205, 67833.64332713417, 69137.65431172813, 69739.99999999898, 70684.64657676782, 71590.926136108, 6970.337817907291, 8054.7112462008145, 8490.405671602928, 8640.783980400289, 8728.476291422536, 43508.34737478877, 46187.6143715689, 47466.813329667035, 48173.27740083831, 50125.74937125291, 65161.674191628736, 69130.65434672996, 69172.0, 70014.29985700078, 70399.64800175966, 10965.0, 10986.0, 11015.669529914116, 11076.39079850616, 11285.435728213391, 11204.719882003015, 11306.038986685895, 11615.6515304541, 12127.514899403925, 13071.934640326737, 11371.772564548828, 11402.20184587104, 11453.19827612059, 11741.941290293495, 12008.879911201126, 11546.711332216426, 11719.941400292944, 11762.411879405825, 11793.29240245588, 11854.881451185724, 11178.888211117785, 11306.717332066764, 11324.773504530029, 11595.8260626089, 11671.474783634927, 9243.676471323472, 9448.102430269113, 9653.420794752337, 9654.324197306121, 9707.5042313363, 9533.952330238304, 9573.808523829344, 9622.47076410804, 9665.226781857295, 9731.9026809731], "unit": "score", "name": "yui.html", "value": 6973.666490720845}], "name": "dromaeo_css", "value": 7523.575740681838}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 95.0, 165.0, 171.0, 149.0, 116.0, 113.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 126.5}, {"lowerIsBetter": true, "replicates": [153.0, 122.0, 148.0, 157.0, 124.0, 173.0, 164.0, 123.0, 157.0, 114.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [195.0, 193.0, 194.0, 204.0, 220.0, 204.0, 196.0, 194.0, 204.0, 197.0], "unit": "score", "name": "audio-dft", "value": 200.1}, {"lowerIsBetter": true, "replicates": [61.0, 81.0, 72.0, 130.0, 80.0, 49.0, 63.0, 87.0, 63.0, 76.0], "unit": "score", "name": "audio-fft", "value": 76.2}, {"lowerIsBetter": true, "replicates": [82.0, 88.0, 119.0, 64.0, 90.0, 115.0, 143.0, 108.0, 117.0, 158.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 88.0, 86.0, 105.0, 97.0, 90.0, 86.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.4}, {"lowerIsBetter": true, "replicates": [114.0, 97.0, 97.0, 105.0, 151.0, 95.0, 97.0, 94.0, 95.0, 104.0], "unit": "score", "name": "imaging-darkroom", "value": 104.9}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 91.0, 92.0, 96.0, 93.0, 93.0, 93.0, 93.0, 89.0], "unit": "score", "name": "imaging-desaturate", "value": 92.7}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 55.0, 48.0, 49.0, 55.0, 68.0, 90.0, 82.0, 78.0], "unit": "score", "name": "json-parse-financial", "value": 63.3}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 68.0, 89.0, 68.0, 74.0, 72.0, 71.0, 72.0, 89.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.5}, {"lowerIsBetter": true, "replicates": [107.0, 71.0, 96.0, 74.0, 89.0, 110.0, 112.0, 110.0, 95.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 95.0}, {"lowerIsBetter": true, "replicates": [132.0, 134.0, 139.0, 135.0, 109.0, 136.0, 131.0, 129.0, 139.0, 137.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.1}, {"lowerIsBetter": true, "replicates": [126.0, 143.0, 139.0, 138.0, 142.0, 132.0, 140.0, 139.0, 142.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 72.0, 70.0, 68.0, 69.0, 70.0, 66.0, 71.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1512.4999999999998}]} 16:29:37 INFO - Return code: 0 16:29:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:29:37 ERROR - # TBPL SUCCESS # 16:29:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:29:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:29:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:29:37 INFO - 2016-03-16 16:29:37.840 screenresolution[2789:22073] starting screenresolution argv=screenresolution get 16:29:37 INFO - 2016-03-16 16:29:37.843 screenresolution[2789:22073] Display 0: 1600x1200x32@60 16:29:37 INFO - 2016-03-16 16:29:37.849 screenresolution[2790:22077] starting screenresolution argv=screenresolution list 16:29:37 INFO - Available Modes on Display 0 16:29:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:29:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:29:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:29:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:29:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:29:38 INFO - Intel Iris: 16:29:38 INFO - Chipset Model: Intel Iris 16:29:38 INFO - Type: GPU 16:29:38 INFO - Bus: Built-In 16:29:38 INFO - VRAM (Dynamic, Max): 1536 MB 16:29:38 INFO - Vendor: Intel (0x8086) 16:29:38 INFO - Device ID: 0x0a2e 16:29:38 INFO - Revision ID: 0x0009 16:29:38 INFO - Displays: 16:29:38 INFO - Display: 16:29:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:29:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:29:38 INFO - Display Serial Number: 1600x1200 60 16:29:38 INFO - Main Display: Yes 16:29:38 INFO - Mirror: Off 16:29:38 INFO - Online: Yes 16:29:38 INFO - Rotation: Supported 16:29:38 INFO - Return code: 0 16:29:38 INFO - Running post-action listener: _resource_record_post_action 16:29:38 INFO - Running post-run listener: _resource_record_post_run 16:29:39 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 2457600; Write bytes: 706899968; Read time: 39; Write time: 2142 16:29:39 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402330112; Write bytes: 404039168; Read time: 30545; Write time: 811 16:29:39 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 2457600; Write bytes: 302012928; Read time: 39; Write time: 1328 16:29:39 INFO - Running post-run listener: _upload_blobber_files 16:29:39 INFO - Blob upload gear active. 16:29:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:29:39 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 16:29:39 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'] 16:29:39 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 16:29:39 INFO - (blobuploader) - INFO - Open directory for files ... 16:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:29:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:29:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:29:40 INFO - (blobuploader) - INFO - Done attempting. 16:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:29:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:29:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:29:41 INFO - (blobuploader) - INFO - Done attempting. 16:29:41 INFO - (blobuploader) - INFO - Iteration through files over. 16:29:41 INFO - Return code: 0 16:29:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:29:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:29:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74c264ca9acbdb8e0ee6e0fa8db0d39cce1b8e2a0d17c97290425a2eb64613a249cc091a3e4f39d8d9f023ea4710b29317edaab0c5ac558894e535d77ee6ca01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79b7dda1ea09731233e5e6f515b5ef99d78d4a053b108f411e32b801d540a9eb4ff66fbcea99e4f6ee4a69bfe5059b0855074ad7904e93f06c2fe35072d732a6"} 16:29:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:29:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:29:41 INFO - Contents: 16:29:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74c264ca9acbdb8e0ee6e0fa8db0d39cce1b8e2a0d17c97290425a2eb64613a249cc091a3e4f39d8d9f023ea4710b29317edaab0c5ac558894e535d77ee6ca01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79b7dda1ea09731233e5e6f515b5ef99d78d4a053b108f411e32b801d540a9eb4ff66fbcea99e4f6ee4a69bfe5059b0855074ad7904e93f06c2fe35072d732a6"} 16:29:41 INFO - Running post-run listener: copy_logs_to_upload_dir 16:29:41 INFO - Copying logs to upload dir... 16:29:41 INFO - mkdir: /builds/slave/test/build/upload/logs 16:29:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.025170 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-16 16:29:41.370832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 16:29:41.374412) ========= 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.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74c264ca9acbdb8e0ee6e0fa8db0d39cce1b8e2a0d17c97290425a2eb64613a249cc091a3e4f39d8d9f023ea4710b29317edaab0c5ac558894e535d77ee6ca01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79b7dda1ea09731233e5e6f515b5ef99d78d4a053b108f411e32b801d540a9eb4ff66fbcea99e4f6ee4a69bfe5059b0855074ad7904e93f06c2fe35072d732a6"} build_url:https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011531 build_url: 'https://queue.taskcluster.net/v1/task/Sjj4Z3ReSfiNpRH87aCO6w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74c264ca9acbdb8e0ee6e0fa8db0d39cce1b8e2a0d17c97290425a2eb64613a249cc091a3e4f39d8d9f023ea4710b29317edaab0c5ac558894e535d77ee6ca01", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79b7dda1ea09731233e5e6f515b5ef99d78d4a053b108f411e32b801d540a9eb4ff66fbcea99e4f6ee4a69bfe5059b0855074ad7904e93f06c2fe35072d732a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 16:29:41.408661) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:29:41.409012) ========= 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.co3lPCWUv5/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.2NjZLE5TNo/Listeners TMPDIR=/var/folders/hm/lhr5g3j56fn9glwbkp7zqg7c00000w/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.005317 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 16:29:41.460677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 16:29:41.461382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 16:29:41.462113) ========= ========= Total master_lag: 0.38 =========