builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0106 starttime: 1460030740.04 results: success (0) buildid: 20160407044324 builduid: c14c87a5c99b4805b39375bdf8f1b9d7 revision: 2355485d9a8e09c7cfe47063bd192b72ec34d286 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.038187) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.038686) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.039033) ========= 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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005780 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.062758) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.063165) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.079953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.080385) ========= 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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005462 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.129045) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.129386) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.129781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.131970) ========= 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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-07 05:05:40-- 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% 7.83M=0.001s 2016-04-07 05:05:40 (7.83 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.319057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.319418) ========= 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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.020209 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:40.369774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:05:40.370191) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2355485d9a8e09c7cfe47063bd192b72ec34d286 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2355485d9a8e09c7cfe47063bd192b72ec34d286 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-07 05:05:40,450 truncating revision to first 12 chars 2016-04-07 05:05:40,451 Setting DEBUG logging. 2016-04-07 05:05:40,451 attempt 1/10 2016-04-07 05:05:40,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2355485d9a8e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-07 05:05:41,425 unpacking tar archive at: mozilla-aurora-2355485d9a8e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.232700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-07 05:05:41.619910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.620329) ========= echo 2355485d9a8e09c7cfe47063bd192b72ec34d286 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2355485d9a8e09c7cfe47063bd192b72ec34d286'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 2355485d9a8e09c7cfe47063bd192b72ec34d286 program finished with exit code 0 elapsedTime=0.005538 script_repo_revision: '2355485d9a8e09c7cfe47063bd192b72ec34d286' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.671363) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.671741) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-07 05:05:41.685820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-07 05:05:41.686259) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:05:41 INFO - MultiFileLogger online at 20160407 05:05:41 in /builds/slave/test 05:05:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:05:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:41 INFO - {'append_to_log': False, 05:05:41 INFO - 'base_work_dir': '/builds/slave/test', 05:05:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:05:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:41 INFO - 'branch': 'Mozilla-Aurora', 05:05:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:41 INFO - 'config_files': ('talos/mac_config.py',), 05:05:41 INFO - 'default_actions': ('clobber', 05:05:41 INFO - 'read-buildbot-config', 05:05:41 INFO - 'download-and-extract', 05:05:41 INFO - 'populate-webroot', 05:05:41 INFO - 'create-virtualenv', 05:05:41 INFO - 'install', 05:05:41 INFO - 'run-tests'), 05:05:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:41 INFO - 'download_minidump_stackwalk': True, 05:05:41 INFO - 'download_symbols': 'ondemand', 05:05:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:41 INFO - 'installer_path': 'installer.exe', 05:05:41 INFO - 'log_level': 'info', 05:05:41 INFO - 'log_name': 'talos', 05:05:41 INFO - 'log_to_console': True, 05:05:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:05:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:05:41 INFO - 'opt_config_files': (), 05:05:41 INFO - 'pip_index': False, 05:05:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:41 INFO - 'cmd': ('bash', 05:05:41 INFO - '-c', 05:05:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:41 INFO - 'enabled': True, 05:05:41 INFO - 'halt_on_failure': False, 05:05:41 INFO - 'name': 'check_screen_resolution'},), 05:05:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:05:41 INFO - 'cmd': ('bash', 05:05:41 INFO - '-c', 05:05:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:05:41 INFO - 'enabled': True, 05:05:41 INFO - 'halt_on_failure': False, 05:05:41 INFO - 'name': 'check_screen_resolution'},), 05:05:41 INFO - 'run_cmd_checks_enabled': True, 05:05:41 INFO - 'sps_profile': False, 05:05:41 INFO - 'sps_profile_interval': 0, 05:05:41 INFO - 'suite': 'dromaeojs-e10s', 05:05:41 INFO - 'system_bits': '32', 05:05:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:41 INFO - 'title': 't-yosemite-r7-0106', 05:05:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:41 INFO - 'use_talos_json': True, 05:05:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:41 INFO - 'work_dir': 'build'} 05:05:41 INFO - ##### 05:05:41 INFO - ##### Running clobber step. 05:05:41 INFO - ##### 05:05:41 INFO - Running pre-action listener: _resource_record_pre_action 05:05:41 INFO - Running main action method: clobber 05:05:41 INFO - rmtree: /builds/slave/test/build 05:05:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:44 INFO - Running post-action listener: _resource_record_post_action 05:05:44 INFO - ##### 05:05:44 INFO - ##### Running read-buildbot-config step. 05:05:44 INFO - ##### 05:05:44 INFO - Running pre-action listener: _resource_record_pre_action 05:05:44 INFO - Running main action method: read_buildbot_config 05:05:44 INFO - Using buildbot properties: 05:05:44 INFO - { 05:05:44 INFO - "project": "", 05:05:44 INFO - "product": "firefox", 05:05:44 INFO - "script_repo_revision": "production", 05:05:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 05:05:44 INFO - "repository": "", 05:05:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 05:05:44 INFO - "buildid": "20160407044324", 05:05:44 INFO - "stage_platform": "macosx64", 05:05:44 INFO - "basedir": "/builds/slave/test", 05:05:44 INFO - "buildnumber": 247, 05:05:44 INFO - "platform": "yosemite_r7", 05:05:44 INFO - "mozci_request": { 05:05:44 INFO - "priority": -1, 05:05:44 INFO - "type": "trigger_all_talos_jobs", 05:05:44 INFO - "times": 6 05:05:44 INFO - }, 05:05:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:05:44 INFO - "slavebuilddir": "test", 05:05:44 INFO - "branch": "mozilla-aurora", 05:05:44 INFO - "revision": "2355485d9a8e09c7cfe47063bd192b72ec34d286", 05:05:44 INFO - "slavename": "t-yosemite-r7-0106", 05:05:44 INFO - "builduid": "c14c87a5c99b4805b39375bdf8f1b9d7", 05:05:44 INFO - "repo_path": "releases/mozilla-aurora" 05:05:44 INFO - } 05:05:44 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg. 05:05:44 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json. 05:05:44 INFO - Running post-action listener: _resource_record_post_action 05:05:44 INFO - ##### 05:05:44 INFO - ##### Running download-and-extract step. 05:05:44 INFO - ##### 05:05:44 INFO - Running pre-action listener: _resource_record_pre_action 05:05:44 INFO - Running main action method: download_and_extract 05:05:44 INFO - mkdir: /builds/slave/test/build/tests 05:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json 05:05:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 05:05:44 INFO - Downloaded 1277 bytes. 05:05:44 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 05:05:44 INFO - Using the following test package requirements: 05:05:44 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:05:44 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:44 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 05:05:44 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:44 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 05:05:44 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:44 INFO - u'jsshell-mac.zip'], 05:05:44 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:44 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 05:05:44 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:05:44 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:44 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 05:05:44 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:44 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 05:05:44 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:44 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 05:05:44 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 05:05:44 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 05:05:44 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 05:05:44 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:44 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip 05:05:44 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:05:44 INFO - Downloaded 17904082 bytes. 05:05:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:05:47 INFO - Return code: 0 05:05:47 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:05: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')]} 05:05:47 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip 05:05:47 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 05:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:05:47 INFO - Downloaded 17904082 bytes. 05:05:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:05:51 INFO - Return code: 0 05:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:51 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip 05:05:51 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 05:05:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:05:51 INFO - Downloaded 10845168 bytes. 05:05:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:05:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:05:51 INFO - Return code: 0 05:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:05:51 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:05:51 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 05:05:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 05:05:56 INFO - Downloaded 115185382 bytes. 05:05:56 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:05:56 INFO - mkdir: /builds/slave/test/properties 05:05:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:56 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:56 INFO - Contents: 05:05:56 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg 05:05:57 INFO - Running post-action listener: _resource_record_post_action 05:05:57 INFO - Running post-action listener: set_extra_try_arguments 05:05:57 INFO - ##### 05:05:57 INFO - ##### Running populate-webroot step. 05:05:57 INFO - ##### 05:05:57 INFO - Running pre-action listener: _resource_record_pre_action 05:05:57 INFO - Running main action method: populate_webroot 05:05:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:57 INFO - '--tppagecycles', 05:05:57 INFO - '7'], 05:05:57 INFO - 'tests': ['tsvgm']}}, 05:05:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:05:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:05:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:57 INFO - 'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:57 INFO - 'tests': ['damp', 'tps']}, 05:05:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:57 INFO - 'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['damp', 'tps']}, 05:05:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:05:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:57 INFO - 'other': {'tests': ['a11yr', 05:05:57 INFO - 'ts_paint', 05:05:57 INFO - 'tpaint', 05:05:57 INFO - 'sessionrestore', 05:05:57 INFO - 'sessionrestore_no_auto_restore', 05:05:57 INFO - 'tabpaint']}, 05:05:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['a11yr', 05:05:57 INFO - 'ts_paint', 05:05:57 INFO - 'tpaint', 05:05:57 INFO - 'sessionrestore', 05:05:57 INFO - 'sessionrestore_no_auto_restore', 05:05:57 INFO - 'tabpaint']}, 05:05:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['a11yr', 05:05:57 INFO - 'ts_paint', 05:05:57 INFO - 'tpaint', 05:05:57 INFO - 'sessionrestore', 05:05:57 INFO - 'sessionrestore_no_auto_restore', 05:05:57 INFO - 'tabpaint']}, 05:05:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['a11yr', 05:05:57 INFO - 'ts_paint', 05:05:57 INFO - 'tpaint', 05:05:57 INFO - 'sessionrestore', 05:05:57 INFO - 'sessionrestore_no_auto_restore', 05:05:57 INFO - 'tabpaint']}, 05:05:57 INFO - 'other_l64': {'tests': ['a11yr', 05:05:57 INFO - 'ts_paint', 05:05:57 INFO - 'tpaint', 05:05:57 INFO - 'sessionrestore', 05:05:57 INFO - 'sessionrestore_no_auto_restore', 05:05:57 INFO - 'tabpaint']}, 05:05:57 INFO - 'other_nol64': {'tests': ['a11yr', 05:05:57 INFO - 'ts_paint', 05:05:57 INFO - 'tpaint', 05:05:57 INFO - 'sessionrestore', 05:05:57 INFO - 'sessionrestore_no_auto_restore', 05:05:57 INFO - 'tabpaint']}, 05:05:57 INFO - 'svgr': {'tests': ['tsvgx', 05:05:57 INFO - 'tsvgr_opacity', 05:05:57 INFO - 'tart', 05:05:57 INFO - 'tscrollx', 05:05:57 INFO - 'cart']}, 05:05:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['tsvgx', 05:05:57 INFO - 'tsvgr_opacity', 05:05:57 INFO - 'tart', 05:05:57 INFO - 'tscrollx', 05:05:57 INFO - 'cart']}, 05:05:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:57 INFO - 'tests': ['tp5o']}, 05:05:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:57 INFO - 'talos_options': ['--e10s'], 05:05:57 INFO - 'tests': ['tp5o']}, 05:05:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:57 INFO - 'talos_options': ['--xperf_path', 05:05:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:57 INFO - 'tests': ['tp5n']}, 05:05:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:57 INFO - 'talos_options': ['--e10s', 05:05:57 INFO - '--xperf_path', 05:05:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:57 INFO - 'tests': ['tp5n']}}, 05:05:57 INFO - 'talos.zip': {'path': '', 05:05:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:57 INFO - Running post-action listener: _resource_record_post_action 05:05:57 INFO - ##### 05:05:57 INFO - ##### Running create-virtualenv step. 05:05:57 INFO - ##### 05:05:57 INFO - Running pre-action listener: _resource_record_pre_action 05:05:57 INFO - Running main action method: create_virtualenv 05:05:57 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05: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 05:05:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:57 INFO - Using real prefix '/tools/python27' 05:05:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:58 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:01 INFO - Installing pip.................done. 05:06:01 INFO - Return code: 0 05:06:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06: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 05:06: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 05:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:01 INFO - 'HOME': '/Users/cltbld', 05:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:01 INFO - 'LOGNAME': 'cltbld', 05:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:01 INFO - 'MOZ_NO_REMOTE': '1', 05:06:01 INFO - 'NO_EM_RESTART': '1', 05:06:01 INFO - 'PAGER': '/bin/cat', 05:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:01 INFO - 'PWD': '/builds/slave/test', 05:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:01 INFO - 'SHELL': '/bin/bash', 05:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:01 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:01 INFO - 'USER': 'cltbld', 05:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:01 INFO - 'XPC_FLAGS': '0x0', 05:06:01 INFO - 'XPC_SERVICE_NAME': '0', 05:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06: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 05:06:01 INFO - Cleaning up... 05:06:01 INFO - Return code: 0 05:06:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06: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 05:06: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 05:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:01 INFO - 'HOME': '/Users/cltbld', 05:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:01 INFO - 'LOGNAME': 'cltbld', 05:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:01 INFO - 'MOZ_NO_REMOTE': '1', 05:06:01 INFO - 'NO_EM_RESTART': '1', 05:06:01 INFO - 'PAGER': '/bin/cat', 05:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:01 INFO - 'PWD': '/builds/slave/test', 05:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:01 INFO - 'SHELL': '/bin/bash', 05:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:01 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:01 INFO - 'USER': 'cltbld', 05:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:01 INFO - 'XPC_FLAGS': '0x0', 05:06:01 INFO - 'XPC_SERVICE_NAME': '0', 05:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:01 INFO - Downloading/unpacking psutil>=0.7.1 05:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:04 INFO - Installing collected packages: psutil 05:06:04 INFO - Running setup.py install for psutil 05:06:05 INFO - building 'psutil._psutil_osx' extension 05:06: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 05:06: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 05:06: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 05:06: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 05:06:05 INFO - building 'psutil._psutil_posix' extension 05:06: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 05:06:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:06:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:06:05 INFO - ^ 05:06:05 INFO - 1 warning generated. 05:06: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 05:06:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:05 INFO - Successfully installed psutil 05:06:05 INFO - Cleaning up... 05:06:05 INFO - Return code: 0 05:06:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06: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 05:06: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 05:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:05 INFO - 'HOME': '/Users/cltbld', 05:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:05 INFO - 'LOGNAME': 'cltbld', 05:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:05 INFO - 'MOZ_NO_REMOTE': '1', 05:06:05 INFO - 'NO_EM_RESTART': '1', 05:06:05 INFO - 'PAGER': '/bin/cat', 05:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:05 INFO - 'PWD': '/builds/slave/test', 05:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:05 INFO - 'SHELL': '/bin/bash', 05:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:05 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:05 INFO - 'USER': 'cltbld', 05:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:05 INFO - 'XPC_FLAGS': '0x0', 05:06:05 INFO - 'XPC_SERVICE_NAME': '0', 05:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06: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) 05:06:08 INFO - Installing collected packages: mozsystemmonitor 05:06:08 INFO - Running setup.py install for mozsystemmonitor 05:06:08 INFO - Successfully installed mozsystemmonitor 05:06:08 INFO - Cleaning up... 05:06:08 INFO - Return code: 0 05:06:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06: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 05:06: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 05:06:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:08 INFO - 'HOME': '/Users/cltbld', 05:06:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:08 INFO - 'LOGNAME': 'cltbld', 05:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:08 INFO - 'MOZ_NO_REMOTE': '1', 05:06:08 INFO - 'NO_EM_RESTART': '1', 05:06:08 INFO - 'PAGER': '/bin/cat', 05:06:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:08 INFO - 'PWD': '/builds/slave/test', 05:06:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:08 INFO - 'SHELL': '/bin/bash', 05:06:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:08 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:08 INFO - 'USER': 'cltbld', 05:06:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:08 INFO - 'XPC_FLAGS': '0x0', 05:06:08 INFO - 'XPC_SERVICE_NAME': '0', 05:06:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:11 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:12 INFO - Downloading docopt-0.6.1.tar.gz 05:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:12 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:12 INFO - Running setup.py install for blobuploader 05:06:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:13 INFO - Running setup.py install for requests 05:06:13 INFO - Running setup.py install for docopt 05:06:13 INFO - Successfully installed blobuploader requests docopt 05:06:13 INFO - Cleaning up... 05:06:13 INFO - Return code: 0 05:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06: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 05:06: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 05:06:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:13 INFO - 'HOME': '/Users/cltbld', 05:06:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:13 INFO - 'LOGNAME': 'cltbld', 05:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:13 INFO - 'MOZ_NO_REMOTE': '1', 05:06:13 INFO - 'NO_EM_RESTART': '1', 05:06:13 INFO - 'PAGER': '/bin/cat', 05:06:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:13 INFO - 'PWD': '/builds/slave/test', 05:06:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:13 INFO - 'SHELL': '/bin/bash', 05:06:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:13 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:13 INFO - 'USER': 'cltbld', 05:06:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:13 INFO - 'XPC_FLAGS': '0x0', 05:06:13 INFO - 'XPC_SERVICE_NAME': '0', 05:06:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-8iNZRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-YS75BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-pavbnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-bPgt61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Qe9UQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-JNj_7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-6285rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-b07OQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-gvJk8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:14 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-XIU8Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-qlIHQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-EfmErG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-_sIkfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-kuxsc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-TRMUiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-dGi3FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:15 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-eOPMo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:15 INFO - Running setup.py install for manifestparser 05:06:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:15 INFO - Running setup.py install for mozcrash 05:06:16 INFO - Running setup.py install for mozdebug 05:06:16 INFO - Running setup.py install for mozdevice 05:06:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:16 INFO - Running setup.py install for mozfile 05:06:16 INFO - Running setup.py install for mozhttpd 05:06:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:16 INFO - Running setup.py install for mozinfo 05:06:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:16 INFO - Running setup.py install for mozInstall 05:06:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:16 INFO - Running setup.py install for mozleak 05:06:17 INFO - Running setup.py install for mozlog 05:06:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:17 INFO - Running setup.py install for moznetwork 05:06:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:17 INFO - Running setup.py install for mozprocess 05:06:17 INFO - Running setup.py install for mozprofile 05:06:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:17 INFO - Running setup.py install for mozrunner 05:06:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:17 INFO - Running setup.py install for mozscreenshot 05:06:18 INFO - Running setup.py install for moztest 05:06:18 INFO - Running setup.py install for mozversion 05:06:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:18 INFO - Cleaning up... 05:06:18 INFO - Return code: 0 05:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06: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 05:06: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 05:06:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:18 INFO - 'HOME': '/Users/cltbld', 05:06:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:18 INFO - 'LOGNAME': 'cltbld', 05:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:18 INFO - 'MOZ_NO_REMOTE': '1', 05:06:18 INFO - 'NO_EM_RESTART': '1', 05:06:18 INFO - 'PAGER': '/bin/cat', 05:06:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:18 INFO - 'PWD': '/builds/slave/test', 05:06:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:18 INFO - 'SHELL': '/bin/bash', 05:06:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:18 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:18 INFO - 'USER': 'cltbld', 05:06:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:18 INFO - 'XPC_FLAGS': '0x0', 05:06:18 INFO - 'XPC_SERVICE_NAME': '0', 05:06:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:18 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-iPJzDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06: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)) 05:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:18 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-oFQVyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06: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)) 05:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:18 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-3l_U8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06: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)) 05:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:18 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-nn1aAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-cVk1wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-sk3aWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06: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)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xPEFrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06: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)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-nmf_Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06: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)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-JGDsmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06: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)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Hhkoj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06: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)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-HYd58k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06: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)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-cSt_Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06: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)) 05:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:19 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9PjiaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-LxYCn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-3FyE57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-U5fRyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06: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)) 05:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:20 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-uQ1sWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:22 INFO - Downloading blessings-1.6.tar.gz 05:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:22 INFO - Installing collected packages: blessings 05:06:22 INFO - Running setup.py install for blessings 05:06:23 INFO - Successfully installed blessings 05:06:23 INFO - Cleaning up... 05:06:23 INFO - Return code: 0 05:06:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:23 INFO - Reading from file tmpfile_stdout 05:06:23 INFO - Current package versions: 05:06:23 INFO - blessings == 1.6 05:06:23 INFO - blobuploader == 1.2.4 05:06:23 INFO - docopt == 0.6.1 05:06:23 INFO - manifestparser == 1.1 05:06:23 INFO - mozInstall == 1.12 05:06:23 INFO - mozcrash == 0.17 05:06:23 INFO - mozdebug == 0.1 05:06:23 INFO - mozdevice == 0.48 05:06:23 INFO - mozfile == 1.2 05:06:23 INFO - mozhttpd == 0.7 05:06:23 INFO - mozinfo == 0.9 05:06:23 INFO - mozleak == 0.1 05:06:23 INFO - mozlog == 3.1 05:06:23 INFO - moznetwork == 0.27 05:06:23 INFO - mozprocess == 0.22 05:06:23 INFO - mozprofile == 0.28 05:06:23 INFO - mozrunner == 6.11 05:06:23 INFO - mozscreenshot == 0.1 05:06:23 INFO - mozsystemmonitor == 0.0 05:06:23 INFO - moztest == 0.7 05:06:23 INFO - mozversion == 1.4 05:06:23 INFO - psutil == 3.1.1 05:06:23 INFO - requests == 1.2.3 05:06:23 INFO - wsgiref == 0.1.2 05:06:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06: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 05:06: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 05:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:23 INFO - 'HOME': '/Users/cltbld', 05:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:23 INFO - 'LOGNAME': 'cltbld', 05:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:23 INFO - 'MOZ_NO_REMOTE': '1', 05:06:23 INFO - 'NO_EM_RESTART': '1', 05:06:23 INFO - 'PAGER': '/bin/cat', 05:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:23 INFO - 'PWD': '/builds/slave/test', 05:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:23 INFO - 'SHELL': '/bin/bash', 05:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:23 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:23 INFO - 'USER': 'cltbld', 05:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:23 INFO - 'XPC_FLAGS': '0x0', 05:06:23 INFO - 'XPC_SERVICE_NAME': '0', 05:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06: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)) 05:06:23 INFO - Cleaning up... 05:06:23 INFO - Return code: 0 05:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06: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 05:06: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 05:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:23 INFO - 'HOME': '/Users/cltbld', 05:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:23 INFO - 'LOGNAME': 'cltbld', 05:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:23 INFO - 'MOZ_NO_REMOTE': '1', 05:06:23 INFO - 'NO_EM_RESTART': '1', 05:06:23 INFO - 'PAGER': '/bin/cat', 05:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:23 INFO - 'PWD': '/builds/slave/test', 05:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:23 INFO - 'SHELL': '/bin/bash', 05:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:23 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:23 INFO - 'USER': 'cltbld', 05:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:23 INFO - 'XPC_FLAGS': '0x0', 05:06:23 INFO - 'XPC_SERVICE_NAME': '0', 05:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:24 INFO - Downloading/unpacking jsonschema 05:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:26 INFO - Downloading/unpacking functools32 (from jsonschema) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:26 INFO - warning: no files found matching '*.txt' 05:06:26 INFO - no previously-included directories found matching 'build' 05:06:26 INFO - no previously-included directories found matching 'dist' 05:06:26 INFO - no previously-included directories found matching '.git*' 05:06:26 INFO - Installing collected packages: jsonschema, functools32 05:06:26 INFO - Running setup.py install for functools32 05:06:27 INFO - warning: no files found matching '*.txt' 05:06:27 INFO - no previously-included directories found matching 'build' 05:06:27 INFO - no previously-included directories found matching 'dist' 05:06:27 INFO - no previously-included directories found matching '.git*' 05:06:27 INFO - Successfully installed jsonschema functools32 05:06:27 INFO - Cleaning up... 05:06:27 INFO - Return code: 0 05:06:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:27 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 0x10ebf9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec004c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc011493c90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, '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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:06:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:27 INFO - 'HOME': '/Users/cltbld', 05:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:27 INFO - 'LOGNAME': 'cltbld', 05:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:27 INFO - 'MOZ_NO_REMOTE': '1', 05:06:27 INFO - 'NO_EM_RESTART': '1', 05:06:27 INFO - 'PAGER': '/bin/cat', 05:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:27 INFO - 'PWD': '/builds/slave/test', 05:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:27 INFO - 'SHELL': '/bin/bash', 05:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:06:27 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:27 INFO - 'USER': 'cltbld', 05:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:27 INFO - 'XPC_FLAGS': '0x0', 05:06:27 INFO - 'XPC_SERVICE_NAME': '0', 05:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:27 INFO - Downloading/unpacking flake8 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:06:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:06:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:31 INFO - no previously-included directories found matching 'docs/_build' 05:06:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:06:31 INFO - Running setup.py install for pep8 05:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:06:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:06:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:06:31 INFO - no previously-included directories found matching 'docs/_build' 05:06:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:06:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:06:31 INFO - Cleaning up... 05:06:31 INFO - Return code: 0 05:06:31 INFO - Running post-action listener: _resource_record_post_action 05:06:31 INFO - Running post-action listener: _start_resource_monitoring 05:06:31 INFO - Starting resource monitoring. 05:06:31 INFO - ##### 05:06:31 INFO - ##### Running install step. 05:06:31 INFO - ##### 05:06:31 INFO - Running pre-action listener: _resource_record_pre_action 05:06:31 INFO - Running main action method: install 05:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:31 INFO - Reading from file tmpfile_stdout 05:06:31 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:31 INFO - Reading from file tmpfile_stdout 05:06:31 INFO - Output received: 05:06:31 INFO - Usage: mozinstall [options] installer 05:06:31 INFO - Options: 05:06:31 INFO - -h, --help show this help message and exit 05:06:31 INFO - -d DEST, --destination=DEST 05:06:31 INFO - Directory to install application into. [default: 05:06:31 INFO - "/builds/slave/test"] 05:06:31 INFO - --app=APP Application being installed. [default: firefox] 05:06:31 INFO - mkdir: /builds/slave/test/build/application 05:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:07:03 INFO - Reading from file tmpfile_stdout 05:07:03 INFO - Output received: 05:07:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:07:03 INFO - Running post-action listener: _resource_record_post_action 05:07:03 INFO - ##### 05:07:03 INFO - ##### Running run-tests step. 05:07:03 INFO - ##### 05:07:03 INFO - Running pre-action listener: _resource_record_pre_action 05:07:03 INFO - Running main action method: run_tests 05:07:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:03 INFO - 2016-04-07 05:07:03.837 screenresolution[1978:64445] starting screenresolution argv=screenresolution get 05:07:03 INFO - 2016-04-07 05:07:03.839 screenresolution[1978:64445] Display 0: 1600x1200x32@60 05:07:03 INFO - 2016-04-07 05:07:03.845 screenresolution[1979:64448] starting screenresolution argv=screenresolution list 05:07:03 INFO - Available Modes on Display 0 05:07:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:04 INFO - Intel Iris: 05:07:04 INFO - Chipset Model: Intel Iris 05:07:04 INFO - Type: GPU 05:07:04 INFO - Bus: Built-In 05:07:04 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:04 INFO - Vendor: Intel (0x8086) 05:07:04 INFO - Device ID: 0x0a2e 05:07:04 INFO - Revision ID: 0x0009 05:07:04 INFO - Displays: 05:07:04 INFO - Display: 05:07:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:04 INFO - Display Serial Number: 1600x1200 60 05:07:04 INFO - Main Display: Yes 05:07:04 INFO - Mirror: Off 05:07:04 INFO - Online: Yes 05:07:04 INFO - Rotation: Supported 05:07:04 INFO - Return code: 0 05:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:04 INFO - Python 2.7.3 05:07:04 INFO - Return code: 0 05:07:04 INFO - grabbing minidump binary from tooltool 05:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:04 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea9dd30>, '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 0x10e901db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ea94b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:07:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:07:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:04 INFO - Return code: 0 05:07:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:07:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:07:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:05 INFO - Return code: 0 05:07:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 05:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --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 05:07:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nKGiwGwjlk/Render', 05:07:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:05 INFO - 'HOME': '/Users/cltbld', 05:07:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:05 INFO - 'LOGNAME': 'cltbld', 05:07:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:05 INFO - 'MOZ_NO_REMOTE': '1', 05:07:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:05 INFO - 'NO_EM_RESTART': '1', 05:07:05 INFO - 'PAGER': '/bin/cat', 05:07:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:05 INFO - 'PWD': '/builds/slave/test', 05:07:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:05 INFO - 'SHELL': '/bin/bash', 05:07:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p0uFfu7ERr/Listeners', 05:07:05 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 05:07:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:05 INFO - 'USER': 'cltbld', 05:07:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:05 INFO - 'XPC_FLAGS': '0x0', 05:07:05 INFO - 'XPC_SERVICE_NAME': '0', 05:07:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--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 05:07:05 INFO - mozversion application_buildid: 20160406205952 05:07:05 INFO - mozversion application_changeset: 2355485d9a8e09c7cfe47063bd192b72ec34d286 05:07:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:07:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:05 INFO - mozversion application_name: Firefox 05:07:05 INFO - mozversion application_remotingname: firefox-dev 05:07:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:07:05 INFO - mozversion application_vendor: Mozilla 05:07:05 INFO - mozversion application_version: 47.0a2 05:07:05 INFO - mozversion platform_buildid: 20160406205952 05:07:05 INFO - mozversion platform_changeset: 2355485d9a8e09c7cfe47063bd192b72ec34d286 05:07:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:07:05 INFO - mozversion platform_version: 47.0a2 05:07:05 INFO - using testdate: 1460030825 05:07:05 INFO - actual date: 1460030825 05:07:05 INFO - starting webserver on 'localhost:50943' 05:07:05 INFO - SUITE-START | Running 2 tests 05:07:05 INFO - TEST-START | dromaeo_css 05:07:05 INFO - operating with platform_type : mac_ 05:07:05 INFO - Initialising browser for dromaeo_css test... 05:07:05 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpj6X9lJ/profile http://localhost:50943/getInfo.html) 05:07:08 INFO - PROCESS | 1997 | __metrics Screen width/height:1600/1200 05:07:08 INFO - PROCESS | 1997 | colorDepth:24 05:07:08 INFO - PROCESS | 1997 | Browser inner width/height: 1024/689 05:07:08 INFO - PROCESS | 1997 | __metrics 05:07:08 ERROR - PROCESS | 1997 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:07:08 INFO - TEST-INFO | 1997: exit 0 05:07:08 INFO - Browser initialized. 05:07:08 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:08 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpj6X9lJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:21 INFO - PROCESS | 2000 | RSS: Main: 217559040 05:07:21 INFO - PROCESS | 2000 | 05:08:10 INFO - PROCESS | 2000 | 1460030890669 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:10:21 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50943/tests/dromaeo/cssquery-ext.html) 05:10:22 INFO - PROCESS | 2000 | RSS: Main: 228052992 05:10:22 INFO - PROCESS | 2000 | 05:13:24 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-ext.html (next: http://localhost:50943/tests/dromaeo/cssquery-jquery.html) 05:13:24 INFO - PROCESS | 2000 | RSS: Main: 240472064 05:13:24 INFO - PROCESS | 2000 | 05:16:26 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50943/tests/dromaeo/cssquery-mootools.html) 05:16:27 INFO - PROCESS | 2000 | RSS: Main: 241950720 05:16:27 INFO - PROCESS | 2000 | 05:19:28 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50943/tests/dromaeo/cssquery-prototype.html) 05:19:29 INFO - PROCESS | 2000 | RSS: Main: 244047872 05:19:29 INFO - PROCESS | 2000 | 05:22:32 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50943/tests/dromaeo/cssquery-yui.html) 05:22:32 INFO - PROCESS | 2000 | RSS: Main: 246132736 05:22:32 INFO - PROCESS | 2000 | 05:25:34 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:50943/tests/dromaeo/cssquery-yui.html (next: http://localhost:50943/tests/dromaeo/cssquery-dojo.html) 05:25:35 INFO - PROCESS | 2000 | RSS: Main: 247848960 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - PROCESS | 2000 | __start_tp_report 05:25:35 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 05:25:35 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 05:25:35 INFO - PROCESS | 2000 | |i|pagename|runs| 05:25:35 INFO - PROCESS | 2000 | |0;dojo.html;2995.1912983494453;3497.545319108517;3516.068241915891;3530.841112149954;3556.430971044633;5143.305653736745;5147.665401748884;5704.229928959589;5709.115087161486;5726.599138060337;5651.1523271509295;5662.207290979266;5718.228039214715;5720.427957204278;5747.971260143693;5127.461616530267;5165.560927321163;5197.610179236553;5213.087709650796;5224.138017227153;4656.185167595674;5001.049800537904;5088.821891233808;5177.430482646906;5228.633995620308;4486.932696009562;4572.337011133383;5224.555912747421;5230.398504172012;5275.36695596529;5174.4825517448335;5185;5186.948130518685;5238.030964271603;5252.212168174766;4846.39420072491;4975.4029516457895;5041.72270525121;5068.341115654941;5135.3837539495125;4904.337914381548;5423.2136340230445;5597.216389705444;5619.353774315965;5623.212750214932;6040.124181993587;6179.412955769195;6231.781887633911;6269.341719119518;6270.435660790505;6198.783042593533;6249.6875156242;6277.372262773732;6294.8111556653375;6310.842228944267;5794.536437085023;5844.795432159896;5861.677607731531;5883.117532370093;5887.175795388606;6188.721507532172;6291.087792270096;6295.905561416583;6371.936280637227;6372.076048972873;6131.3766666500715;6182.381761823872;6191.752329906843;6219.720112594944;6244.968775156095;6289.591176573508;6298.1812364392335;6306.306306306395;6309.589876658002;6325.462335701425;6107.522607572277;6113.083037544404;6183.443490085824;6241.78153764616;6257.249130104326;6202.534809889276;6205.193324867829;6243.968780156161;6279.434850863353;6296.6851657417865;4168.0205151789305;4859.441164266154;4897.632677549198;4903.141950158708;4910.582600479;4312;4314.503832059353;4358.171947329997;4418.293073108287;4475.462944446622;5676.148577713294;5680.68756218412;5799.33307669615;5838.562107841929;5871.060630299217;6279.843003924939;6284.308726040132;6311.431971122621;6322.36776322364;6328.303886572473;5632.352279487911;5694.743736531866;5778.971105144447;5816.854578635568;5823.650580965155;5322.813701520428;5330.733463326818;5349.598780091431;5356.276902618175;5358.33020872391;6373.267074286517;6394;6396.584222025646;6407.8718425630295;6409.487241020801;6156.569040167145;6218.751249950133;6255.46828519581;6292.968535157295;6308.873822523616;6384.042393640991;6405.19935008124;6405.231372235362;6407.8718425630295;6434.195725534309;6259.624422534663;6263.467605253604;6273.905891411724;6278.905816412849;6281;6110.315755985069;6168.599041062316;6249.0626406039455;6262.499000079892;6315.936840631535;5911.599735227167;6058.909116363347;6129.877402452015;6135.815925522242;6137.202163718866;4876.536729010738;6076.696165191811;6098.908516372347;6120.846978825565;6152.446279834837;4757.215059515142;5086.54221120101;5858.7070646468355;5935.762569497172;5959.374265702038;6159.260888693386;6183.350748171557;6185.381461853779;6190.1952746142715;6197.411245931629;5949.732262048305;5955.523558115254;6044.304904935989;6112.113743507255;6112.235970503687 05:25:35 INFO - PROCESS | 2000 | |1;ext.html;444.83025596508935;508.45595213121953;555.3419198250076;651.5862427358626;669.9649042229755;39245;39598.80200599;40000.599994000055;40131.39802902959;40212.396814047774;41372.75881723546;41450;41652.37521437181;41786;41850.58149418505;9463.716088517356;9657.034296570322;9657.22742180624;9661.565229564687;9708.466034368106;9570.665026724066;9825.803483930316;9890.703278901645;9915;9916.950415247913;9686.709398718014;9701.07839755222;9725.902740972571;9728.65949691761;9764;9762;9880.802383952318;9896.257780666407;9923.40459572428;9935.552900119512;9583.185429238523;9721.902780972241;9726.416415015121;9727;9756.756081097958;34992;41177.58822411767;41707.582924170674;41742;41865.79067104645;3043.3913217356394;3304.3556506481245;3352.8323583820957;3518.1732292911147;3929.155231625214;28077.71922280792;28545.85727071372;28550.857245713847;28570.857145714348;28896.8555157225;2758.462099890522;2784.2065011471836;2806.579013148024;2832.4476727038236;2874.8131371460995;402804;403493;404340;406183.96908015566;408863;49292.50707492951;58667;71237.57524849474;71683.64158179176;71789;48003.5199647999;48253;48291;48311.75844120757;48374.79063023453;16728.916355418143;17014.574635633962;17054.74417883733;17070.975741455553;17136;11951.462184201559;13475;13485.853702435206;13556.051076424752;13596.86403135956;12692.111552191443;13340.866591333963;15354.771618270512;15880.20598970047;15965.44120955761;6594.241662208908;6744.359285867835;6747.730090796314;6751.189857217068;6775.4240889524945;1003.1573478278282;1012.6810054832852;1017.6387382479113;1028.095276156977;1104.9447527623586;30693;31058.53412198819;31145.68854311428;31167.53248701271;31177.688223117933;1111.4165063341811;1184.5439505790162;1198.574506050357;1251.9624411267675;1287.3434548380205;15940.282687279101;16006;16069.839301607068;16075.035497870165;16365.83634163667;499540;501987;502906;507971;509473;63843.680781596726;63972.68013659902;64650.70698586002;64886.35113648898;64993.67503162454;1535.9769603455957;1553.930073146711;1576.2749135397617;1588.7140314743226;1590.3400088963183;30562.541561877035;31252.531212031383;31322.21694457657;31471.21321966969;31669.683303167596;50737.73155671138;50829.74585127199;51059;51096.74451627867;51216.74391628018;460126;462386;464006.03990940837;464278;466071;33725;35771;36147.819260903525;36323.81838090793;36378.818105909304;47366;47638.523614764796;48476;49531;54769;40367.79816100901;41218.793906031475;42491.937701556475;43157.3526397098;43292.78353608212;41273.380899285934;41837.908104595255;42150.578494214664;42236.155276893674;42376.364354535326;33938.66061339454;37360.43959340666;43029.56970430381;44620.55379446294;45100.32349514694;28675;35763.46354804732;39234.41148382719;39254.80372598119;40103;24243.272701818973;24656.124309875915;27834.721652784025;28127.071134919646;28434.57348139821 05:25:35 INFO - PROCESS | 2000 | |2;jquery.html;338.15124038662947;360.3711523391682;365.18017051718897;373.60584583264654;378.8295267129792;19838.90080549597;20004.89997550012;20547;20552.177912883486;20570.588588228227;17074.20720824314;20395.286164984227;20631.69052464214;20857.852818094998;21247.893760531177;5746.942530574693;6025.728842202111;6056.545759068065;6058;6079.422454866781;4359.498657654379;5324.840254792343;6315.778947736831;6584.407403333699;6852.691628876688;5468.125099984003;6517.446017088553;6520;6529.085927970064;6531.05299731541;5692.601517893749;5699.914501282484;5712.971435142839;5743.54051675865;5770.971145144268;5348.572114230852;5478.58910581708;5599.776008959637;5602.2717046783655;5609.775608975677;13488.055836091478;13534.458621655122;13678.247696376695;13745.312734363242;13770.862291377158;2103.5582527669208;2125.7449106107365;2135.8718476891436;2145.9785402145935;2729.945401091967;8755.3871229014;9122.81403417558;9349.766255843659;9461.148496635267;9931.205503559699;1611.9516414507466;1653.6940665976713;1673.5523771937308;1722.7932648082185;1748.9038102904335;78595;91066.63400049004;96883.51558242235;98759.50620246853;99463.50268248685;9357.39176953496;11623.941880290544;11629.76740465203;11672.88327116735;11750.823737643943;14366.928165359106;14416.711665766627;14418.13491190532;14470.27648617565;14494.420223190955;8814.382993190415;8926.86609700855;8978.551072446351;9010;9035.593398297093;9124.863127053099;9168.724938251864;9171.358004939724;9250.213731832735;9259.537023148816;4412.42638457005;4529.841455549106;4532.138893610204;4582.427196600425;4636.049609829976;1775.6537475192472;1843.4746097362188;1858.1823997441084;1933.0334832583708;1958.4222654317011;883.9381243312906;999.1773240595347;1013.3261381181579;1052.6736711619421;1070.7870632250656;20657.793422065886;21272.468188295417;21309.573808523743;21363.25228617022;21604.89197554002;942.3733217410482;1011.9291649584459;1064.2071656615872;1077.7952189084049;1093.6336327330275;9408;11131.387773672526;11138.3873886937;11809.996150327146;11823.704407389883;580053;584676;605309;612447;630021;98977;119459;120797;120895;123433;1091.5033659684825;1101.0860985382114;1112.9610463633735;1126.622581435212;1128.2891778179694;18577.16402761906;18726.782759120615;18956.336528221447;19017.71473427872;19138.712919305945;47693.28460073032;50844.49155508397;50853.745731271105;51874.48125518696;53485.73257133689;78153.60923195348;78224.60887695524;78351;78361.60819195867;78722.6063869677;8165.550894700611;8228.670853165806;8285.751427457186;8422;8446.66213351459;11136.721581960192;12336.259824410565;13368.06423550381;13555.59333220005;13829.930850345683;11218.887811121784;11342.886571134513;11365.772684546097;11669.88330116722;11770.82343764827;11031.117510598971;11290.209685321948;11409.201355905006;11621.941890290494;11725.530978760755;11486.851314868447;11703.707407314885;11765.647030589096;11824.527018919147;11852.407379631157;8016.4388492807275;8219.260266576037;8251;8302.916970830214;8523.147685231428;11318.60384886525;11760.58837940668;11960;11973.76052478963;12099.697507562381 05:25:35 INFO - PROCESS | 2000 | |3;mootools.html;1650.5460998225487;1672.7909011373579;1989.1844343819027;2014.2949967511381;2075;8097.514149151055;8784.824303513926;8905.421147625408;9121.589528471219;9127.406718563305;8796.032436431988;8849.601767920443;8870.379073464845;8876.511791851446;8940.59767310471;2492.875356232186;2513.987430062856;2516.5721827289403;2517.5216708825355;2526.557852375836;2432;2435.7686019828175;2444.2056331692183;2449.510097980402;2467.2104926423553;1947.269773834812;2095.465656257652;2469.8271121021535;2510.623406489023;2515.0317127905796;2484.1802205272215;2497.5254701606636;2498.3129639349145;2514.1326242446416;2524.4572416930264;2111.6621340585584;2494.8503089814667;2496.463260399023;2504.524140413334;2509.1092662105057;9018.323625728097;9068.591913363849;9120.45277283365;9124.22444092253;9133.77165570866;5587.944120558783;5675.262215911946;5691.857703557403;5708.286464191976;5746.712664366807;3610.945835812465;3670.7797532148156;3732.64539868712;3739.2895349883433;3764.3412402829667;945.2201933404968;1056.5298442193227;1099.6810924831789;1102.2835157147838;1106.3251416635926;11110.277831940979;12373.566925157666;12413.006959443133;12460.252384856938;12483.251004939642;4917.754112294371;4983.302337672656;5004.199328107486;5051;5103.362079740033;10400.115990140772;10429.426381549089;10450.954904509488;10496.947515262375;10506.001929816655;5597.496225339658;5608.66348019112;5615.6630602164005;5625.324961004706;5631.802886898939;4489.371487991683;4898.53463920927;4989.550940415307;5005.5745261653165;5078.21287700407;3974.2250261198787;4046.59534046593;4049.91900162001;4085.20338533983;4129;1325.1850112181132;1331.9933400332936;1336.4587342126454;1347.8315210598676;1347.9932600336936;1186.0807873897627;1189.3934093612147;1400.3348409505606;1433.168762117969;1448.9782653260208;8442.704505342284;8445.451045682012;8457.577121143919;8504.872426913602;8672.349573781992;1157.7279339355246;1205.0720944872573;1229.3668760588305;1278.5525066226746;1285.807128930668;6258.843528911722;6413.615183089029;6444.709988050549;6448.290688024314;6502.252240992252;10631.94684026575;10752.623658171926;10804.13566914645;10835.67492975212;10930.945345273223;10484.528196231187;10656.520456579472;10998.835017474745;11011.064059554867;11076.944615277032;8500.957495212608;8531.573421329032;8570.957145214234;8589.355798315151;8591.957040214758;7871.291583757489;8038.356931445587;8072.83854322922;8153.062397824327;8174.67301307941;9596;9635.277354198322;9787.902120978699;9927.156191723496;9948.154406875497;8682.175193356874;9950.900490994998;10121.89878101239;10341.172706183637;10375.896241037493;6991.720331186695;6993.160820701549;7402.519496100909;7506;7860.724874629361;7379.926200737924;8461.619227134917;8461.857649217276;8502.14978502145;8521.403501755065;7298.817529561803;7332.816679583053;7452.515586486861;7473.439492038227;7562.546247225184;7335.266473352622;7478.326950574475;7500.212477689764;7516.774496765106;7539.547627142389;7872.527648341118;7948.6423110961305;7970.442069055111;8007.439479236397;8025.518468891885;6994.685239164148;7176.533525320838;7191.352778249773;7197.784066478014;7223.783286501413;7303.671334790053;7359.8160045999275;7403.629818509161;7404.6667899945705;7409.370203532544 05:25:35 INFO - PROCESS | 2000 | |4;prototype.html;327.48421236552423;328.4006687794774;331.4018197154136;334.1779223111146;335.5470115344286;6464.741410343587;6864.450843932486;6918.5848849069025;6919.204291506466;6953.513254072204;6809.421199198074;6821.897671534931;6843.863122737543;6869.55347902386;6882.9311706883045;4776.94907120433;4872;4989.301497790294;5008.84973450797;5036.194208926572;4933.33399991002;4975.427825800025;4991.500849915015;5002;5012.69923804571;4910.165271903785;4916.483769204236;4946.505349465061;4951.678140920829;4953.1332016896895;4938.654294199426;4959.380077490314;4968;4970.6520543561965;4987.650864439491;4299.914001719948;4304.160688665712;4310.224159651261;4320.265554855682;4334.371516130143;6372.7132279047555;6579.539432239745;6604;6612.305707900698;6652.900206496906;4997.400311962551;6004.909926351108;6037.366076561985;6039.698015099228;6073.089036644538;7418.146913105008;7426.220246874054;7426.368758655521;7430.554166750012;7468.141163766182;4305.547917468652;4653.139169253699;4883.536064073907;4891.5353041461;4908.77910494025;7213.386862116727;7260.34656880878;7403.74086906961;7752.457327987043;7816.8827467588035;3982.561918188997;4800.3279540864305;4916.754162291871;4945.8021679132435;4955.2567114933045;5016.072026675077;5025.82409615669;5029.245613158056;5041.143005689041;5046.520580544842;5702.688381672238;5952.196453478811;5974.40255974399;5977.432143946318;5995.2805663319805;5574.303212098488;6494.870102597922;6789.32106789327;7434.925650743531;7461.552306861606;1474.7492926202572;1743.9302427902742;1757.8417942385247;1767.9558011049826;1774.8225177482407;968.2544440780559;1104.4091411095187;1146.5986904583328;1154.549725607014;1155.8439610652454;6858.759943402057;6870.896936545956;6895.448364130857;6902.206246281742;6920.134983127109;6115.449609535163;7588.582627955516;7619.542827430372;7622.847543049108;7628.160902300742;6854.314568543105;6874.484413668994;6890.414314783199;6899.689513971884;6909.170899491993;3816.561095474056;3994.201159768058;4018.2767101921936;4032.7177097602885;4048.554658987509;7576.128745194374;8008.159143289987;8045.718399855977;8048.953636027279;8122.431429799975;7966.28303452692;8010.519368837889;8013.158618345106;8014.919850801534;8035.156308587631;6740.561863478858;7891.684332626745;8099.311558517474;8107.148749381466;8129.227723366271;5626.2967129108865;6404.327545607644;7394.704211831467;7640.159582445815;7652.73215437457;7562.2059683734615;7568.4323675723435;7588.620568971419;7590.1650818408825;7620.5808680523105;7054.08296921397;8096.5546894921345;8106.83786324282;8131.2681858633005;8157.918420815716;4398.230309695854;4411.4926783420315;4672.369230153886;4802.831900883452;4824.49342819013;6582.605043697394;7351.595662238628;7356.227596102332;7662.425318101054;7678;7321.158066822383;7376.37300829414;7377.889331659922;7382.741604043833;7398.556086634819;7361.631918403951;7362;7363.226861179499;7366.079240094989;7385.9630701846145;6958.930410695828;7137.750178743719;7173.6054516999975;7180.7845764627145;7215.098112735908;5979.252593425822;6970.407515361251;7299.635018249172;7334.669939852826;7338.486305958531;7169.964150179216;7195.13658361;7195.8560828784175;7198.920161975536;7227.8554428912175 05:25:35 INFO - PROCESS | 2000 | |5;yui.html;707.1549498349472;763.8014116329756;775.4261846233788;777.9416543759218;798.6086817459443;15313.77029344558;15315.234238288096;15384.923075384635;15618.609534761637;15659.843401565995;14299.213543255117;14310.28448577572;14324.427022919097;14354.784678229835;14403.63990900228;796.0288448093316;953.0707560128853;973.2894986659743;975.5902520941186;998.2962011781676;975.8341082016038;983.4738414948005;988.658912675126;990.8612794208816;995.2187532786763;1032.8760548734124;1045.5399624165343;1047.3977462958828;1047.993925831203;1049.758555532228;1024.129489933558;1029.7168278723411;1032.5353590884133;1034.4930983817876;1038.1020417339023;650.9869802603921;709.8402859356655;758.1546575568257;764.2281295891135;770.8612449759041;14995.700085998218;15102.773458398024;15104.924475377662;15214.08715477064;15229.466968656045;12814.231146131262;12984.480620775157;13077.869221307856;13092.279924604143;13162.210267383893;10000.549975251059;10221.540030698636;10266.6406675766;10529.105026072793;10574.947125264325;3127.3276245607303;3494.4408894576745;3552.6980206682206;3571.8571257149943;3767.453719210699;58540;81272.59363703203;82375.5881220596;83312.16687833166;83480.16519834785;9736.561854716554;9758.46328451942;9767.609295628237;9773.267004974656;9775.462349570842;21615.35153945384;21973.560528789654;22046.8976551175;22709.20517781903;22777.202797901995;7521.887171692429;7774.611269436506;7920.722774702857;7996.280334769898;8052.718154864551;4028.576999415019;4106.938395924063;4201.68487363449;4225.746455212697;4278.507971583245;3699.038250055005;3733.8506459741848;3742.4573436852047;3755.6244375562223;3756.952460908811;657.763205246111;664.3954001858382;666.2105405094978;677.9728810847511;692.5498426023024;521.8251885618361;525.2908573425921;569.6667449541982;574.8045664474015;621.8352136683783;8137.267645911897;8195.42632015765;8282.378821588405;8466.703665371682;8634.438761480484;593.827789940921;608.178958406157;617.8239201827547;624.3194917539903;638.7732355013997;3553.466979953028;3816.065064059323;3848.172642881738;3851.30676478231;3895.3962135868987;95123.52438237764;95415;96937.0306296928;97717.04565908642;97917;78635;79172.20827791764;79351.60324198342;80076.59961700154;80539;28524.714752852622;28638.713612864023;28732.994345197818;63468.73062538723;70886.99999999897;7509.249075092447;7675.731349402744;7779.338756205786;7897.407694422826;8024.719134830253;37603.81198093992;50142.74928625333;50579;50588.74705626448;50615.49384506255;63063.6846815763;68351;69779.30220697729;70061.29938700752;71285.64357178389;9141.908580914373;9676.516174191403;10227.130693890806;10399;10444.2166837489;10779.407132607781;10930.890691092987;10999.120070394189;11080.168987325822;11631.709207269885;9631.566579503798;10016.549255283384;10217.693469195936;10554.736131596464;10590.205734570092;10270.537825798006;10381.480925953521;10477.1094456972;10717.785644286914;10745.086667633339;10147.49262536885;10161.237907156845;10190.490475476048;10426.530806113895;10506.632267870587;8513.36149788756;8711.738647840575;8789.033206347169;8804.955975220082;8833.779155521164;8915.866262006204;8953.731388058368;8960.103989600988;9047.366684332033;9078.818423631623 05:25:35 INFO - PROCESS | 2000 | __end_tp_report 05:25:35 INFO - PROCESS | 2000 | __start_cc_report 05:25:35 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,359 05:25:35 INFO - PROCESS | 2000 | __end_cc_report 05:25:35 INFO - PROCESS | 2000 | __startTimestamp1460031935007__endTimestamp 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - PROCESS | 2000 | ------- Summary: start ------- 05:25:35 INFO - PROCESS | 2000 | Number of tests: 6 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - PROCESS | 2000 | [#0] dojo.html Cycles:165 Average:5712.03 Median:5955.52 stddev:698.28 (11.7%) stddev-sans-first:667.10 05:25:35 INFO - PROCESS | 2000 | Values: 2995.2 3497.5 3516.1 3530.8 3556.4 5143.3 5147.7 5704.2 5709.1 5726.6 5651.2 5662.2 5718.2 5720.4 5748.0 5127.5 5165.6 5197.6 5213.1 5224.1 4656.2 5001.0 5088.8 5177.4 5228.6 4486.9 4572.3 5224.6 5230.4 5275.4 5174.5 5185.0 5186.9 5238.0 5252.2 4846.4 4975.4 5041.7 5068.3 5135.4 4904.3 5423.2 5597.2 5619.4 5623.2 6040.1 6179.4 6231.8 6269.3 6270.4 6198.8 6249.7 6277.4 6294.8 6310.8 5794.5 5844.8 5861.7 5883.1 5887.2 6188.7 6291.1 6295.9 6371.9 6372.1 6131.4 6182.4 6191.8 6219.7 6245.0 6289.6 6298.2 6306.3 6309.6 6325.5 6107.5 6113.1 6183.4 6241.8 6257.2 6202.5 6205.2 6244.0 6279.4 6296.7 4168.0 4859.4 4897.6 4903.1 4910.6 4312.0 4314.5 4358.2 4418.3 4475.5 5676.1 5680.7 5799.3 5838.6 5871.1 6279.8 6284.3 6311.4 6322.4 6328.3 5632.4 5694.7 5779.0 5816.9 5823.7 5322.8 5330.7 5349.6 5356.3 5358.3 6373.3 6394.0 6396.6 6407.9 6409.5 6156.6 6218.8 6255.5 6293.0 6308.9 6384.0 6405.2 6405.2 6407.9 6434.2 6259.6 6263.5 6273.9 6278.9 6281.0 6110.3 6168.6 6249.1 6262.5 6315.9 5911.6 6058.9 6129.9 6135.8 6137.2 4876.5 6076.7 6098.9 6120.8 6152.4 4757.2 5086.5 5858.7 5935.8 5959.4 6159.3 6183.4 6185.4 6190.2 6197.4 5949.7 5955.5 6044.3 6112.1 6112.2 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - PROCESS | 2000 | [#1] ext.html Cycles:180 Average:61503.96 Median:41246.09 stddev:121747.25 (295.2%) stddev-sans-first:122002.47 05:25:35 INFO - PROCESS | 2000 | Values: 444.8 508.5 555.3 651.6 670.0 39245.0 39598.8 40000.6 40131.4 40212.4 41372.8 41450.0 41652.4 41786.0 41850.6 9463.7 9657.0 9657.2 9661.6 9708.5 9570.7 9825.8 9890.7 9915.0 9917.0 9686.7 9701.1 9725.9 9728.7 9764.0 9762.0 9880.8 9896.3 9923.4 9935.6 9583.2 9721.9 9726.4 9727.0 9756.8 34992.0 41177.6 41707.6 41742.0 41865.8 3043.4 3304.4 3352.8 3518.2 3929.2 28077.7 28545.9 28550.9 28570.9 28896.9 2758.5 2784.2 2806.6 2832.4 2874.8 402804.0 403493.0 404340.0 406184.0 408863.0 49292.5 58667.0 71237.6 71683.6 71789.0 48003.5 48253.0 48291.0 48311.8 48374.8 16728.9 17014.6 17054.7 17071.0 17136.0 11951.5 13475.0 13485.9 13556.1 13596.9 12692.1 13340.9 15354.8 15880.2 15965.4 6594.2 6744.4 6747.7 6751.2 6775.4 1003.2 1012.7 1017.6 1028.1 1104.9 30693.0 31058.5 31145.7 31167.5 31177.7 1111.4 1184.5 1198.6 1252.0 1287.3 15940.3 16006.0 16069.8 16075.0 16365.8 499540.0 501987.0 502906.0 507971.0 509473.0 63843.7 63972.7 64650.7 64886.4 64993.7 1536.0 1553.9 1576.3 1588.7 1590.3 30562.5 31252.5 31322.2 31471.2 31669.7 50737.7 50829.7 51059.0 51096.7 51216.7 460126.0 462386.0 464006.0 464278.0 466071.0 33725.0 35771.0 36147.8 36323.8 36378.8 47366.0 47638.5 48476.0 49531.0 54769.0 40367.8 41218.8 42491.9 43157.4 43292.8 41273.4 41837.9 42150.6 42236.2 42376.4 33938.7 37360.4 43029.6 44620.6 45100.3 28675.0 35763.5 39234.4 39254.8 40103.0 24243.3 24656.1 27834.7 28127.1 28434.6 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - PROCESS | 2000 | [#2] jquery.html Cycles:180 Average:33859.13 Median:11754.62 stddev:99830.73 (849.3%) stddev-sans-first:100079.05 05:25:35 INFO - PROCESS | 2000 | Values: 338.2 360.4 365.2 373.6 378.8 19838.9 20004.9 20547.0 20552.2 20570.6 17074.2 20395.3 20631.7 20857.9 21247.9 5746.9 6025.7 6056.5 6058.0 6079.4 4359.5 5324.8 6315.8 6584.4 6852.7 5468.1 6517.4 6520.0 6529.1 6531.1 5692.6 5699.9 5713.0 5743.5 5771.0 5348.6 5478.6 5599.8 5602.3 5609.8 13488.1 13534.5 13678.2 13745.3 13770.9 2103.6 2125.7 2135.9 2146.0 2729.9 8755.4 9122.8 9349.8 9461.1 9931.2 1612.0 1653.7 1673.6 1722.8 1748.9 78595.0 91066.6 96883.5 98759.5 99463.5 9357.4 11623.9 11629.8 11672.9 11750.8 14366.9 14416.7 14418.1 14470.3 14494.4 8814.4 8926.9 8978.6 9010.0 9035.6 9124.9 9168.7 9171.4 9250.2 9259.5 4412.4 4529.8 4532.1 4582.4 4636.0 1775.7 1843.5 1858.2 1933.0 1958.4 883.9 999.2 1013.3 1052.7 1070.8 20657.8 21272.5 21309.6 21363.3 21604.9 942.4 1011.9 1064.2 1077.8 1093.6 9408.0 11131.4 11138.4 11810.0 11823.7 580053.0 584676.0 605309.0 612447.0 630021.0 98977.0 119459.0 120797.0 120895.0 123433.0 1091.5 1101.1 1113.0 1126.6 1128.3 18577.2 18726.8 18956.3 19017.7 19138.7 47693.3 50844.5 50853.7 51874.5 53485.7 78153.6 78224.6 78351.0 78361.6 78722.6 8165.6 8228.7 8285.8 8422.0 8446.7 11136.7 12336.3 13368.1 13555.6 13829.9 11218.9 11342.9 11365.8 11669.9 11770.8 11031.1 11290.2 11409.2 11621.9 11725.5 11486.9 11703.7 11765.6 11824.5 11852.4 8016.4 8219.3 8251.0 8302.9 8523.1 11318.6 11760.6 11960.0 11973.8 12099.7 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - PROCESS | 2000 | [#3] mootools.html Cycles:180 Average:6201.41 Median:5090.79 stddev:3247.25 (63.8%) stddev-sans-first:3238.34 05:25:35 INFO - PROCESS | 2000 | Values: 1650.5 1672.8 1989.2 2014.3 2075.0 8097.5 8784.8 8905.4 9121.6 9127.4 8796.0 8849.6 8870.4 8876.5 8940.6 2492.9 2514.0 2516.6 2517.5 2526.6 2432.0 2435.8 2444.2 2449.5 2467.2 1947.3 2095.5 2469.8 2510.6 2515.0 2484.2 2497.5 2498.3 2514.1 2524.5 2111.7 2494.9 2496.5 2504.5 2509.1 9018.3 9068.6 9120.5 9124.2 9133.8 5587.9 5675.3 5691.9 5708.3 5746.7 3610.9 3670.8 3732.6 3739.3 3764.3 945.2 1056.5 1099.7 1102.3 1106.3 11110.3 12373.6 12413.0 12460.3 12483.3 4917.8 4983.3 5004.2 5051.0 5103.4 10400.1 10429.4 10451.0 10496.9 10506.0 5597.5 5608.7 5615.7 5625.3 5631.8 4489.4 4898.5 4989.6 5005.6 5078.2 3974.2 4046.6 4049.9 4085.2 4129.0 1325.2 1332.0 1336.5 1347.8 1348.0 1186.1 1189.4 1400.3 1433.2 1449.0 8442.7 8445.5 8457.6 8504.9 8672.3 1157.7 1205.1 1229.4 1278.6 1285.8 6258.8 6413.6 6444.7 6448.3 6502.3 10631.9 10752.6 10804.1 10835.7 10930.9 10484.5 10656.5 10998.8 11011.1 11076.9 8501.0 8531.6 8571.0 8589.4 8592.0 7871.3 8038.4 8072.8 8153.1 8174.7 9596.0 9635.3 9787.9 9927.2 9948.2 8682.2 9950.9 10121.9 10341.2 10375.9 6991.7 6993.2 7402.5 7506.0 7860.7 7379.9 8461.6 8461.9 8502.1 8521.4 7298.8 7332.8 7452.5 7473.4 7562.5 7335.3 7478.3 7500.2 7516.8 7539.5 7872.5 7948.6 7970.4 8007.4 8025.5 6994.7 7176.5 7191.4 7197.8 7223.8 7303.7 7359.8 7403.6 7404.7 7409.4 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - PROCESS | 2000 | [#4] prototype.html Cycles:180 Average:5963.61 Median:6832.88 stddev:1920.87 (28.1%) stddev-sans-first:1879.10 05:25:35 INFO - PROCESS | 2000 | Values: 327.5 328.4 331.4 334.2 335.5 6464.7 6864.5 6918.6 6919.2 6953.5 6809.4 6821.9 6843.9 6869.6 6882.9 4776.9 4872.0 4989.3 5008.8 5036.2 4933.3 4975.4 4991.5 5002.0 5012.7 4910.2 4916.5 4946.5 4951.7 4953.1 4938.7 4959.4 4968.0 4970.7 4987.7 4299.9 4304.2 4310.2 4320.3 4334.4 6372.7 6579.5 6604.0 6612.3 6652.9 4997.4 6004.9 6037.4 6039.7 6073.1 7418.1 7426.2 7426.4 7430.6 7468.1 4305.5 4653.1 4883.5 4891.5 4908.8 7213.4 7260.3 7403.7 7752.5 7816.9 3982.6 4800.3 4916.8 4945.8 4955.3 5016.1 5025.8 5029.2 5041.1 5046.5 5702.7 5952.2 5974.4 5977.4 5995.3 5574.3 6494.9 6789.3 7434.9 7461.6 1474.7 1743.9 1757.8 1768.0 1774.8 968.3 1104.4 1146.6 1154.5 1155.8 6858.8 6870.9 6895.4 6902.2 6920.1 6115.4 7588.6 7619.5 7622.8 7628.2 6854.3 6874.5 6890.4 6899.7 6909.2 3816.6 3994.2 4018.3 4032.7 4048.6 7576.1 8008.2 8045.7 8049.0 8122.4 7966.3 8010.5 8013.2 8014.9 8035.2 6740.6 7891.7 8099.3 8107.1 8129.2 5626.3 6404.3 7394.7 7640.2 7652.7 7562.2 7568.4 7588.6 7590.2 7620.6 7054.1 8096.6 8106.8 8131.3 8157.9 4398.2 4411.5 4672.4 4802.8 4824.5 6582.6 7351.6 7356.2 7662.4 7678.0 7321.2 7376.4 7377.9 7382.7 7398.6 7361.6 7362.0 7363.2 7366.1 7386.0 6958.9 7137.8 7173.6 7180.8 7215.1 5979.3 6970.4 7299.6 7334.7 7338.5 7170.0 7195.1 7195.9 7198.9 7227.9 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - PROCESS | 2000 | [#5] yui.html Cycles:180 Average:17528.07 Median:523.56 stddev:25110.57 (4796.1%) stddev-sans-first:25149.25 05:25:35 INFO - PROCESS | 2000 | Values: 707.2 763.8 775.4 777.9 798.6 15313.8 15315.2 15384.9 15618.6 15659.8 14299.2 14310.3 14324.4 14354.8 14403.6 796.0 953.1 973.3 975.6 998.3 975.8 983.5 988.7 990.9 995.2 1032.9 1045.5 1047.4 1048.0 1049.8 1024.1 1029.7 1032.5 1034.5 1038.1 651.0 709.8 758.2 764.2 770.9 14995.7 15102.8 15104.9 15214.1 15229.5 12814.2 12984.5 13077.9 13092.3 13162.2 10000.5 10221.5 10266.6 10529.1 10574.9 3127.3 3494.4 3552.7 3571.9 3767.5 58540.0 81272.6 82375.6 83312.2 83480.2 9736.6 9758.5 9767.6 9773.3 9775.5 21615.4 21973.6 22046.9 22709.2 22777.2 7521.9 7774.6 7920.7 7996.3 8052.7 4028.6 4106.9 4201.7 4225.7 4278.5 3699.0 3733.9 3742.5 3755.6 3757.0 657.8 664.4 666.2 678.0 692.5 521.8 525.3 569.7 574.8 621.8 8137.3 8195.4 8282.4 8466.7 8634.4 593.8 608.2 617.8 624.3 638.8 3553.5 3816.1 3848.2 3851.3 3895.4 95123.5 95415.0 96937.0 97717.0 97917.0 78635.0 79172.2 79351.6 80076.6 80539.0 28524.7 28638.7 28733.0 63468.7 70887.0 7509.2 7675.7 7779.3 7897.4 8024.7 37603.8 50142.7 50579.0 50588.7 50615.5 63063.7 68351.0 69779.3 70061.3 71285.6 9141.9 9676.5 10227.1 10399.0 10444.2 10779.4 10930.9 10999.1 11080.2 11631.7 9631.6 10016.5 10217.7 10554.7 10590.2 10270.5 10381.5 10477.1 10717.8 10745.1 10147.5 10161.2 10190.5 10426.5 10506.6 8513.4 8711.7 8789.0 8805.0 8833.8 8915.9 8953.7 8960.1 9047.4 9078.8 05:25:35 INFO - PROCESS | 2000 | -------- Summary: end -------- 05:25:35 INFO - PROCESS | 2000 | 05:25:35 INFO - TEST-INFO | 2000: exit 0 05:25:35 INFO - TEST-OK | dromaeo_css | took 1109994ms 05:25:35 INFO - TEST-START | kraken 05:25:35 INFO - operating with platform_type : mac_ 05:25:35 INFO - Initialising browser for kraken test... 05:25:35 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpImW2Y4/profile http://localhost:50943/getInfo.html) 05:25:38 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 05:25:38 INFO - PROCESS | 2004 | colorDepth:24 05:25:38 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 05:25:38 INFO - PROCESS | 2004 | __metrics 05:25:38 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:25:38 INFO - TEST-INFO | 2004: exit 0 05:25:38 INFO - Browser initialized. 05:25:38 INFO - Running cycle 1/1 for kraken test... 05:25:38 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpImW2Y4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:50 INFO - PROCESS | 2007 | RSS: Main: 217513984 05:25:50 INFO - PROCESS | 2007 | 05:25:53 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:54 INFO - PROCESS | 2007 | RSS: Main: 230354944 05:25:54 INFO - PROCESS | 2007 | 05:25:56 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-dft) 05:25:57 INFO - PROCESS | 2007 | RSS: Main: 239104000 05:25:57 INFO - PROCESS | 2007 | 05:26:00 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-fft) 05:26:01 INFO - PROCESS | 2007 | RSS: Main: 241995776 05:26:01 INFO - PROCESS | 2007 | 05:26:03 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50943/tests/kraken/driver.html?testName=audio-oscillator) 05:26:03 INFO - PROCESS | 2007 | RSS: Main: 242647040 05:26:03 INFO - PROCESS | 2007 | 05:26:05 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:06 INFO - PROCESS | 2007 | RSS: Main: 244756480 05:26:06 INFO - PROCESS | 2007 | 05:26:09 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:10 INFO - PROCESS | 2007 | RSS: Main: 244572160 05:26:10 INFO - PROCESS | 2007 | 05:26:13 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50943/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:13 INFO - PROCESS | 2007 | RSS: Main: 244895744 05:26:13 INFO - PROCESS | 2007 | 05:26:16 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50943/tests/kraken/driver.html?testName=json-parse-financial) 05:26:17 INFO - PROCESS | 2007 | RSS: Main: 245276672 05:26:17 INFO - PROCESS | 2007 | 05:26:19 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:19 INFO - PROCESS | 2007 | RSS: Main: 244158464 05:26:19 INFO - PROCESS | 2007 | 05:26:21 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:22 INFO - PROCESS | 2007 | RSS: Main: 244371456 05:26:22 INFO - PROCESS | 2007 | 05:26:24 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:24 INFO - PROCESS | 2007 | RSS: Main: 245276672 05:26:24 INFO - PROCESS | 2007 | 05:26:27 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:28 INFO - PROCESS | 2007 | RSS: Main: 244887552 05:26:28 INFO - PROCESS | 2007 | 05:26:31 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:31 INFO - PROCESS | 2007 | RSS: Main: 244711424 05:26:31 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:50943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50943/tests/kraken/driver.html?testName=ai-astar) 05:26:33 INFO - PROCESS | 2007 | RSS: Main: 246390784 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | __start_tp_report 05:26:33 INFO - PROCESS | 2007 | _x_x_mozilla_page_load 05:26:33 INFO - PROCESS | 2007 | _x_x_mozilla_page_load_details 05:26:33 INFO - PROCESS | 2007 | |i|pagename|runs| 05:26:33 INFO - PROCESS | 2007 | |0;ai-astar;117;112;115;115;116;130;152;163;133;118 05:26:33 INFO - PROCESS | 2007 | |1;audio-beat-detection;153;123;145;182;155;171;121;152;150;120 05:26:33 INFO - PROCESS | 2007 | |2;audio-dft;193;199;198;201;198;195;204;199;200;201 05:26:33 INFO - PROCESS | 2007 | |3;audio-fft;65;81;73;114;56;57;69;68;131;55 05:26:33 INFO - PROCESS | 2007 | |4;audio-oscillator;87;84;113;80;78;82;114;79;79;114 05:26:33 INFO - PROCESS | 2007 | |5;imaging-gaussian-blur;90;88;99;131;121;87;78;129;127;86 05:26:33 INFO - PROCESS | 2007 | |6;imaging-darkroom;140;89;147;148;94;120;118;95;95;95 05:26:33 INFO - PROCESS | 2007 | |7;imaging-desaturate;99;146;146;121;101;144;99;143;145;92 05:26:33 INFO - PROCESS | 2007 | |8;json-parse-financial;54;59;60;62;60;61;57;67;56;55 05:26:33 INFO - PROCESS | 2007 | |9;json-stringify-tinderbox;65;67;73;97;103;83;71;68;68;69 05:26:33 INFO - PROCESS | 2007 | |10;stanford-crypto-aes;81;85;81;83;85;82;83;82;85;84 05:26:33 INFO - PROCESS | 2007 | |11;stanford-crypto-ccm;136;134;149;124;141;139;137;131;123;123 05:26:33 INFO - PROCESS | 2007 | |12;stanford-crypto-pbkdf2;140;165;156;174;175;176;137;150;169;173 05:26:33 INFO - PROCESS | 2007 | |13;stanford-crypto-sha256-iterative;68;63;61;64;62;71;98;55;58;58 05:26:33 INFO - PROCESS | 2007 | __end_tp_report 05:26:33 INFO - PROCESS | 2007 | __start_cc_report 05:26:33 INFO - PROCESS | 2007 | _x_x_mozilla_cycle_collect,943 05:26:33 INFO - PROCESS | 2007 | __end_cc_report 05:26:33 INFO - PROCESS | 2007 | __startTimestamp1460031993570__endTimestamp 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | ------- Summary: start ------- 05:26:33 INFO - PROCESS | 2007 | Number of tests: 14 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#0] ai-astar Cycles:10 Average:127.10 Median:124.00 stddev:17.58 (14.2%) stddev-sans-first:18.26 05:26:33 INFO - PROCESS | 2007 | Values: 117.0 112.0 115.0 115.0 116.0 130.0 152.0 163.0 133.0 118.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:152.50 stddev:20.87 (13.7%) stddev-sans-first:22.03 05:26:33 INFO - PROCESS | 2007 | Values: 153.0 123.0 145.0 182.0 155.0 171.0 121.0 152.0 150.0 120.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#2] audio-dft Cycles:10 Average:198.80 Median:199.50 stddev:3.12 (1.6%) stddev-sans-first:2.51 05:26:33 INFO - PROCESS | 2007 | Values: 193.0 199.0 198.0 201.0 198.0 195.0 204.0 199.0 200.0 201.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#3] audio-fft Cycles:10 Average:76.90 Median:66.50 stddev:25.67 (38.6%) stddev-sans-first:26.86 05:26:33 INFO - PROCESS | 2007 | Values: 65.0 81.0 73.0 114.0 56.0 57.0 69.0 68.0 131.0 55.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:79.50 stddev:15.87 (20.0%) stddev-sans-first:16.76 05:26:33 INFO - PROCESS | 2007 | Values: 87.0 84.0 113.0 80.0 78.0 82.0 114.0 79.0 79.0 114.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#5] imaging-gaussian-blur Cycles:10 Average:103.60 Median:86.50 stddev:20.91 (24.2%) stddev-sans-first:21.60 05:26:33 INFO - PROCESS | 2007 | Values: 90.0 88.0 99.0 131.0 121.0 87.0 78.0 129.0 127.0 86.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#6] imaging-darkroom Cycles:10 Average:114.10 Median:91.50 stddev:23.76 (26.0%) stddev-sans-first:23.28 05:26:33 INFO - PROCESS | 2007 | Values: 140.0 89.0 147.0 148.0 94.0 120.0 118.0 95.0 95.0 95.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#7] imaging-desaturate Cycles:10 Average:123.60 Median:146.00 stddev:23.52 (16.1%) stddev-sans-first:23.21 05:26:33 INFO - PROCESS | 2007 | Values: 99.0 146.0 146.0 121.0 101.0 144.0 99.0 143.0 145.0 92.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:60.00 stddev:3.84 (6.4%) stddev-sans-first:3.61 05:26:33 INFO - PROCESS | 2007 | Values: 54.0 59.0 60.0 62.0 60.0 61.0 57.0 67.0 56.0 55.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:70.00 stddev:13.46 (19.2%) stddev-sans-first:13.63 05:26:33 INFO - PROCESS | 2007 | Values: 65.0 67.0 73.0 97.0 103.0 83.0 71.0 68.0 68.0 69.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.50 stddev:1.60 (1.9%) stddev-sans-first:1.50 05:26:33 INFO - PROCESS | 2007 | Values: 81.0 85.0 81.0 83.0 85.0 82.0 83.0 82.0 85.0 84.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:136.50 stddev:8.58 (6.3%) stddev-sans-first:9.06 05:26:33 INFO - PROCESS | 2007 | Values: 136.0 134.0 149.0 124.0 141.0 139.0 137.0 131.0 123.0 123.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:171.00 stddev:14.81 (8.7%) stddev-sans-first:13.51 05:26:33 INFO - PROCESS | 2007 | Values: 140.0 165.0 156.0 174.0 175.0 176.0 137.0 150.0 169.0 173.0 05:26:33 INFO - PROCESS | 2007 | 05:26:33 INFO - PROCESS | 2007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:63.50 stddev:12.27 (19.3%) stddev-sans-first:12.99 05:26:33 INFO - PROCESS | 2007 | Values: 68.0 63.0 61.0 64.0 62.0 71.0 98.0 55.0 58.0 58.0 05:26:33 INFO - PROCESS | 2007 | -------- Summary: end -------- 05:26:33 INFO - PROCESS | 2007 | 05:26:34 INFO - TEST-INFO | 2007: exit 0 05:26:34 INFO - TEST-OK | kraken | took 58758ms 05:26:34 INFO - SUITE-END | took 1168s 05:26:34 INFO - Completed test suite (00:19:29) 05:26:34 INFO - javascript benchmark 05:26:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2995.1912983494453, 3497.545319108517, 3516.068241915891, 3530.841112149954, 3556.430971044633, 5143.305653736745, 5147.665401748884, 5704.229928959589, 5709.115087161486, 5726.599138060337, 5651.1523271509295, 5662.207290979266, 5718.228039214715, 5720.427957204278, 5747.971260143693, 5127.461616530267, 5165.560927321163, 5197.610179236553, 5213.087709650796, 5224.138017227153, 4656.185167595674, 5001.049800537904, 5088.821891233808, 5177.430482646906, 5228.633995620308, 4486.932696009562, 4572.337011133383, 5224.555912747421, 5230.398504172012, 5275.36695596529, 5174.4825517448335, 5185.0, 5186.948130518685, 5238.030964271603, 5252.212168174766, 4846.39420072491, 4975.4029516457895, 5041.72270525121, 5068.341115654941, 5135.3837539495125, 4904.337914381548, 5423.2136340230445, 5597.216389705444, 5619.353774315965, 5623.212750214932, 6040.124181993587, 6179.412955769195, 6231.781887633911, 6269.341719119518, 6270.435660790505, 6198.783042593533, 6249.6875156242, 6277.372262773732, 6294.8111556653375, 6310.842228944267, 5794.536437085023, 5844.795432159896, 5861.677607731531, 5883.117532370093, 5887.175795388606, 6188.721507532172, 6291.087792270096, 6295.905561416583, 6371.936280637227, 6372.076048972873, 6131.3766666500715, 6182.381761823872, 6191.752329906843, 6219.720112594944, 6244.968775156095, 6289.591176573508, 6298.1812364392335, 6306.306306306395, 6309.589876658002, 6325.462335701425, 6107.522607572277, 6113.083037544404, 6183.443490085824, 6241.78153764616, 6257.249130104326, 6202.534809889276, 6205.193324867829, 6243.968780156161, 6279.434850863353, 6296.6851657417865, 4168.0205151789305, 4859.441164266154, 4897.632677549198, 4903.141950158708, 4910.582600479, 4312.0, 4314.503832059353, 4358.171947329997, 4418.293073108287, 4475.462944446622, 5676.148577713294, 5680.68756218412, 5799.33307669615, 5838.562107841929, 5871.060630299217, 6279.843003924939, 6284.308726040132, 6311.431971122621, 6322.36776322364, 6328.303886572473, 5632.352279487911, 5694.743736531866, 5778.971105144447, 5816.854578635568, 5823.650580965155, 5322.813701520428, 5330.733463326818, 5349.598780091431, 5356.276902618175, 5358.33020872391, 6373.267074286517, 6394.0, 6396.584222025646, 6407.8718425630295, 6409.487241020801, 6156.569040167145, 6218.751249950133, 6255.46828519581, 6292.968535157295, 6308.873822523616, 6384.042393640991, 6405.19935008124, 6405.231372235362, 6407.8718425630295, 6434.195725534309, 6259.624422534663, 6263.467605253604, 6273.905891411724, 6278.905816412849, 6281.0, 6110.315755985069, 6168.599041062316, 6249.0626406039455, 6262.499000079892, 6315.936840631535, 5911.599735227167, 6058.909116363347, 6129.877402452015, 6135.815925522242, 6137.202163718866, 4876.536729010738, 6076.696165191811, 6098.908516372347, 6120.846978825565, 6152.446279834837, 4757.215059515142, 5086.54221120101, 5858.7070646468355, 5935.762569497172, 5959.374265702038, 6159.260888693386, 6183.350748171557, 6185.381461853779, 6190.1952746142715, 6197.411245931629, 5949.732262048305, 5955.523558115254, 6044.304904935989, 6112.113743507255, 6112.235970503687], "unit": "score", "name": "dojo.html", "value": 5666.129788963674}, {"lowerIsBetter": false, "replicates": [444.83025596508935, 508.45595213121953, 555.3419198250076, 651.5862427358626, 669.9649042229755, 39245.0, 39598.80200599, 40000.599994000055, 40131.39802902959, 40212.396814047774, 41372.75881723546, 41450.0, 41652.37521437181, 41786.0, 41850.58149418505, 9463.716088517356, 9657.034296570322, 9657.22742180624, 9661.565229564687, 9708.466034368106, 9570.665026724066, 9825.803483930316, 9890.703278901645, 9915.0, 9916.950415247913, 9686.709398718014, 9701.07839755222, 9725.902740972571, 9728.65949691761, 9764.0, 9762.0, 9880.802383952318, 9896.257780666407, 9923.40459572428, 9935.552900119512, 9583.185429238523, 9721.902780972241, 9726.416415015121, 9727.0, 9756.756081097958, 34992.0, 41177.58822411767, 41707.582924170674, 41742.0, 41865.79067104645, 3043.3913217356394, 3304.3556506481245, 3352.8323583820957, 3518.1732292911147, 3929.155231625214, 28077.71922280792, 28545.85727071372, 28550.857245713847, 28570.857145714348, 28896.8555157225, 2758.462099890522, 2784.2065011471836, 2806.579013148024, 2832.4476727038236, 2874.8131371460995, 402804.0, 403493.0, 404340.0, 406183.96908015566, 408863.0, 49292.50707492951, 58667.0, 71237.57524849474, 71683.64158179176, 71789.0, 48003.5199647999, 48253.0, 48291.0, 48311.75844120757, 48374.79063023453, 16728.916355418143, 17014.574635633962, 17054.74417883733, 17070.975741455553, 17136.0, 11951.462184201559, 13475.0, 13485.853702435206, 13556.051076424752, 13596.86403135956, 12692.111552191443, 13340.866591333963, 15354.771618270512, 15880.20598970047, 15965.44120955761, 6594.241662208908, 6744.359285867835, 6747.730090796314, 6751.189857217068, 6775.4240889524945, 1003.1573478278282, 1012.6810054832852, 1017.6387382479113, 1028.095276156977, 1104.9447527623586, 30693.0, 31058.53412198819, 31145.68854311428, 31167.53248701271, 31177.688223117933, 1111.4165063341811, 1184.5439505790162, 1198.574506050357, 1251.9624411267675, 1287.3434548380205, 15940.282687279101, 16006.0, 16069.839301607068, 16075.035497870165, 16365.83634163667, 499540.0, 501987.0, 502906.0, 507971.0, 509473.0, 63843.680781596726, 63972.68013659902, 64650.70698586002, 64886.35113648898, 64993.67503162454, 1535.9769603455957, 1553.930073146711, 1576.2749135397617, 1588.7140314743226, 1590.3400088963183, 30562.541561877035, 31252.531212031383, 31322.21694457657, 31471.21321966969, 31669.683303167596, 50737.73155671138, 50829.74585127199, 51059.0, 51096.74451627867, 51216.74391628018, 460126.0, 462386.0, 464006.03990940837, 464278.0, 466071.0, 33725.0, 35771.0, 36147.819260903525, 36323.81838090793, 36378.818105909304, 47366.0, 47638.523614764796, 48476.0, 49531.0, 54769.0, 40367.79816100901, 41218.793906031475, 42491.937701556475, 43157.3526397098, 43292.78353608212, 41273.380899285934, 41837.908104595255, 42150.578494214664, 42236.155276893674, 42376.364354535326, 33938.66061339454, 37360.43959340666, 43029.56970430381, 44620.55379446294, 45100.32349514694, 28675.0, 35763.46354804732, 39234.41148382719, 39254.80372598119, 40103.0, 24243.272701818973, 24656.124309875915, 27834.721652784025, 28127.071134919646, 28434.57348139821], "unit": "score", "name": "ext.html", "value": 20049.076081741183}, {"lowerIsBetter": false, "replicates": [338.15124038662947, 360.3711523391682, 365.18017051718897, 373.60584583264654, 378.8295267129792, 19838.90080549597, 20004.89997550012, 20547.0, 20552.177912883486, 20570.588588228227, 17074.20720824314, 20395.286164984227, 20631.69052464214, 20857.852818094998, 21247.893760531177, 5746.942530574693, 6025.728842202111, 6056.545759068065, 6058.0, 6079.422454866781, 4359.498657654379, 5324.840254792343, 6315.778947736831, 6584.407403333699, 6852.691628876688, 5468.125099984003, 6517.446017088553, 6520.0, 6529.085927970064, 6531.05299731541, 5692.601517893749, 5699.914501282484, 5712.971435142839, 5743.54051675865, 5770.971145144268, 5348.572114230852, 5478.58910581708, 5599.776008959637, 5602.2717046783655, 5609.775608975677, 13488.055836091478, 13534.458621655122, 13678.247696376695, 13745.312734363242, 13770.862291377158, 2103.5582527669208, 2125.7449106107365, 2135.8718476891436, 2145.9785402145935, 2729.945401091967, 8755.3871229014, 9122.81403417558, 9349.766255843659, 9461.148496635267, 9931.205503559699, 1611.9516414507466, 1653.6940665976713, 1673.5523771937308, 1722.7932648082185, 1748.9038102904335, 78595.0, 91066.63400049004, 96883.51558242235, 98759.50620246853, 99463.50268248685, 9357.39176953496, 11623.941880290544, 11629.76740465203, 11672.88327116735, 11750.823737643943, 14366.928165359106, 14416.711665766627, 14418.13491190532, 14470.27648617565, 14494.420223190955, 8814.382993190415, 8926.86609700855, 8978.551072446351, 9010.0, 9035.593398297093, 9124.863127053099, 9168.724938251864, 9171.358004939724, 9250.213731832735, 9259.537023148816, 4412.42638457005, 4529.841455549106, 4532.138893610204, 4582.427196600425, 4636.049609829976, 1775.6537475192472, 1843.4746097362188, 1858.1823997441084, 1933.0334832583708, 1958.4222654317011, 883.9381243312906, 999.1773240595347, 1013.3261381181579, 1052.6736711619421, 1070.7870632250656, 20657.793422065886, 21272.468188295417, 21309.573808523743, 21363.25228617022, 21604.89197554002, 942.3733217410482, 1011.9291649584459, 1064.2071656615872, 1077.7952189084049, 1093.6336327330275, 9408.0, 11131.387773672526, 11138.3873886937, 11809.996150327146, 11823.704407389883, 580053.0, 584676.0, 605309.0, 612447.0, 630021.0, 98977.0, 119459.0, 120797.0, 120895.0, 123433.0, 1091.5033659684825, 1101.0860985382114, 1112.9610463633735, 1126.622581435212, 1128.2891778179694, 18577.16402761906, 18726.782759120615, 18956.336528221447, 19017.71473427872, 19138.712919305945, 47693.28460073032, 50844.49155508397, 50853.745731271105, 51874.48125518696, 53485.73257133689, 78153.60923195348, 78224.60887695524, 78351.0, 78361.60819195867, 78722.6063869677, 8165.550894700611, 8228.670853165806, 8285.751427457186, 8422.0, 8446.66213351459, 11136.721581960192, 12336.259824410565, 13368.06423550381, 13555.59333220005, 13829.930850345683, 11218.887811121784, 11342.886571134513, 11365.772684546097, 11669.88330116722, 11770.82343764827, 11031.117510598971, 11290.209685321948, 11409.201355905006, 11621.941890290494, 11725.530978760755, 11486.851314868447, 11703.707407314885, 11765.647030589096, 11824.527018919147, 11852.407379631157, 8016.4388492807275, 8219.260266576037, 8251.0, 8302.916970830214, 8523.147685231428, 11318.60384886525, 11760.58837940668, 11960.0, 11973.76052478963, 12099.697507562381], "unit": "score", "name": "jquery.html", "value": 9433.908734752244}, {"lowerIsBetter": false, "replicates": [1650.5460998225487, 1672.7909011373579, 1989.1844343819027, 2014.2949967511381, 2075.0, 8097.514149151055, 8784.824303513926, 8905.421147625408, 9121.589528471219, 9127.406718563305, 8796.032436431988, 8849.601767920443, 8870.379073464845, 8876.511791851446, 8940.59767310471, 2492.875356232186, 2513.987430062856, 2516.5721827289403, 2517.5216708825355, 2526.557852375836, 2432.0, 2435.7686019828175, 2444.2056331692183, 2449.510097980402, 2467.2104926423553, 1947.269773834812, 2095.465656257652, 2469.8271121021535, 2510.623406489023, 2515.0317127905796, 2484.1802205272215, 2497.5254701606636, 2498.3129639349145, 2514.1326242446416, 2524.4572416930264, 2111.6621340585584, 2494.8503089814667, 2496.463260399023, 2504.524140413334, 2509.1092662105057, 9018.323625728097, 9068.591913363849, 9120.45277283365, 9124.22444092253, 9133.77165570866, 5587.944120558783, 5675.262215911946, 5691.857703557403, 5708.286464191976, 5746.712664366807, 3610.945835812465, 3670.7797532148156, 3732.64539868712, 3739.2895349883433, 3764.3412402829667, 945.2201933404968, 1056.5298442193227, 1099.6810924831789, 1102.2835157147838, 1106.3251416635926, 11110.277831940979, 12373.566925157666, 12413.006959443133, 12460.252384856938, 12483.251004939642, 4917.754112294371, 4983.302337672656, 5004.199328107486, 5051.0, 5103.362079740033, 10400.115990140772, 10429.426381549089, 10450.954904509488, 10496.947515262375, 10506.001929816655, 5597.496225339658, 5608.66348019112, 5615.6630602164005, 5625.324961004706, 5631.802886898939, 4489.371487991683, 4898.53463920927, 4989.550940415307, 5005.5745261653165, 5078.21287700407, 3974.2250261198787, 4046.59534046593, 4049.91900162001, 4085.20338533983, 4129.0, 1325.1850112181132, 1331.9933400332936, 1336.4587342126454, 1347.8315210598676, 1347.9932600336936, 1186.0807873897627, 1189.3934093612147, 1400.3348409505606, 1433.168762117969, 1448.9782653260208, 8442.704505342284, 8445.451045682012, 8457.577121143919, 8504.872426913602, 8672.349573781992, 1157.7279339355246, 1205.0720944872573, 1229.3668760588305, 1278.5525066226746, 1285.807128930668, 6258.843528911722, 6413.615183089029, 6444.709988050549, 6448.290688024314, 6502.252240992252, 10631.94684026575, 10752.623658171926, 10804.13566914645, 10835.67492975212, 10930.945345273223, 10484.528196231187, 10656.520456579472, 10998.835017474745, 11011.064059554867, 11076.944615277032, 8500.957495212608, 8531.573421329032, 8570.957145214234, 8589.355798315151, 8591.957040214758, 7871.291583757489, 8038.356931445587, 8072.83854322922, 8153.062397824327, 8174.67301307941, 9596.0, 9635.277354198322, 9787.902120978699, 9927.156191723496, 9948.154406875497, 8682.175193356874, 9950.900490994998, 10121.89878101239, 10341.172706183637, 10375.896241037493, 6991.720331186695, 6993.160820701549, 7402.519496100909, 7506.0, 7860.724874629361, 7379.926200737924, 8461.619227134917, 8461.857649217276, 8502.14978502145, 8521.403501755065, 7298.817529561803, 7332.816679583053, 7452.515586486861, 7473.439492038227, 7562.546247225184, 7335.266473352622, 7478.326950574475, 7500.212477689764, 7516.774496765106, 7539.547627142389, 7872.527648341118, 7948.6423110961305, 7970.442069055111, 8007.439479236397, 8025.518468891885, 6994.685239164148, 7176.533525320838, 7191.352778249773, 7197.784066478014, 7223.783286501413, 7303.671334790053, 7359.8160045999275, 7403.629818509161, 7404.6667899945705, 7409.370203532544], "unit": "score", "name": "mootools.html", "value": 5071.40927805304}, {"lowerIsBetter": false, "replicates": [327.48421236552423, 328.4006687794774, 331.4018197154136, 334.1779223111146, 335.5470115344286, 6464.741410343587, 6864.450843932486, 6918.5848849069025, 6919.204291506466, 6953.513254072204, 6809.421199198074, 6821.897671534931, 6843.863122737543, 6869.55347902386, 6882.9311706883045, 4776.94907120433, 4872.0, 4989.301497790294, 5008.84973450797, 5036.194208926572, 4933.33399991002, 4975.427825800025, 4991.500849915015, 5002.0, 5012.69923804571, 4910.165271903785, 4916.483769204236, 4946.505349465061, 4951.678140920829, 4953.1332016896895, 4938.654294199426, 4959.380077490314, 4968.0, 4970.6520543561965, 4987.650864439491, 4299.914001719948, 4304.160688665712, 4310.224159651261, 4320.265554855682, 4334.371516130143, 6372.7132279047555, 6579.539432239745, 6604.0, 6612.305707900698, 6652.900206496906, 4997.400311962551, 6004.909926351108, 6037.366076561985, 6039.698015099228, 6073.089036644538, 7418.146913105008, 7426.220246874054, 7426.368758655521, 7430.554166750012, 7468.141163766182, 4305.547917468652, 4653.139169253699, 4883.536064073907, 4891.5353041461, 4908.77910494025, 7213.386862116727, 7260.34656880878, 7403.74086906961, 7752.457327987043, 7816.8827467588035, 3982.561918188997, 4800.3279540864305, 4916.754162291871, 4945.8021679132435, 4955.2567114933045, 5016.072026675077, 5025.82409615669, 5029.245613158056, 5041.143005689041, 5046.520580544842, 5702.688381672238, 5952.196453478811, 5974.40255974399, 5977.432143946318, 5995.2805663319805, 5574.303212098488, 6494.870102597922, 6789.32106789327, 7434.925650743531, 7461.552306861606, 1474.7492926202572, 1743.9302427902742, 1757.8417942385247, 1767.9558011049826, 1774.8225177482407, 968.2544440780559, 1104.4091411095187, 1146.5986904583328, 1154.549725607014, 1155.8439610652454, 6858.759943402057, 6870.896936545956, 6895.448364130857, 6902.206246281742, 6920.134983127109, 6115.449609535163, 7588.582627955516, 7619.542827430372, 7622.847543049108, 7628.160902300742, 6854.314568543105, 6874.484413668994, 6890.414314783199, 6899.689513971884, 6909.170899491993, 3816.561095474056, 3994.201159768058, 4018.2767101921936, 4032.7177097602885, 4048.554658987509, 7576.128745194374, 8008.159143289987, 8045.718399855977, 8048.953636027279, 8122.431429799975, 7966.28303452692, 8010.519368837889, 8013.158618345106, 8014.919850801534, 8035.156308587631, 6740.561863478858, 7891.684332626745, 8099.311558517474, 8107.148749381466, 8129.227723366271, 5626.2967129108865, 6404.327545607644, 7394.704211831467, 7640.159582445815, 7652.73215437457, 7562.2059683734615, 7568.4323675723435, 7588.620568971419, 7590.1650818408825, 7620.5808680523105, 7054.08296921397, 8096.5546894921345, 8106.83786324282, 8131.2681858633005, 8157.918420815716, 4398.230309695854, 4411.4926783420315, 4672.369230153886, 4802.831900883452, 4824.49342819013, 6582.605043697394, 7351.595662238628, 7356.227596102332, 7662.425318101054, 7678.0, 7321.158066822383, 7376.37300829414, 7377.889331659922, 7382.741604043833, 7398.556086634819, 7361.631918403951, 7362.0, 7363.226861179499, 7366.079240094989, 7385.9630701846145, 6958.930410695828, 7137.750178743719, 7173.6054516999975, 7180.7845764627145, 7215.098112735908, 5979.252593425822, 6970.407515361251, 7299.635018249172, 7334.669939852826, 7338.486305958531, 7169.964150179216, 7195.13658361, 7195.8560828784175, 7198.920161975536, 7227.8554428912175], "unit": "score", "name": "prototype.html", "value": 5321.621352209919}, {"lowerIsBetter": false, "replicates": [707.1549498349472, 763.8014116329756, 775.4261846233788, 777.9416543759218, 798.6086817459443, 15313.77029344558, 15315.234238288096, 15384.923075384635, 15618.609534761637, 15659.843401565995, 14299.213543255117, 14310.28448577572, 14324.427022919097, 14354.784678229835, 14403.63990900228, 796.0288448093316, 953.0707560128853, 973.2894986659743, 975.5902520941186, 998.2962011781676, 975.8341082016038, 983.4738414948005, 988.658912675126, 990.8612794208816, 995.2187532786763, 1032.8760548734124, 1045.5399624165343, 1047.3977462958828, 1047.993925831203, 1049.758555532228, 1024.129489933558, 1029.7168278723411, 1032.5353590884133, 1034.4930983817876, 1038.1020417339023, 650.9869802603921, 709.8402859356655, 758.1546575568257, 764.2281295891135, 770.8612449759041, 14995.700085998218, 15102.773458398024, 15104.924475377662, 15214.08715477064, 15229.466968656045, 12814.231146131262, 12984.480620775157, 13077.869221307856, 13092.279924604143, 13162.210267383893, 10000.549975251059, 10221.540030698636, 10266.6406675766, 10529.105026072793, 10574.947125264325, 3127.3276245607303, 3494.4408894576745, 3552.6980206682206, 3571.8571257149943, 3767.453719210699, 58540.0, 81272.59363703203, 82375.5881220596, 83312.16687833166, 83480.16519834785, 9736.561854716554, 9758.46328451942, 9767.609295628237, 9773.267004974656, 9775.462349570842, 21615.35153945384, 21973.560528789654, 22046.8976551175, 22709.20517781903, 22777.202797901995, 7521.887171692429, 7774.611269436506, 7920.722774702857, 7996.280334769898, 8052.718154864551, 4028.576999415019, 4106.938395924063, 4201.68487363449, 4225.746455212697, 4278.507971583245, 3699.038250055005, 3733.8506459741848, 3742.4573436852047, 3755.6244375562223, 3756.952460908811, 657.763205246111, 664.3954001858382, 666.2105405094978, 677.9728810847511, 692.5498426023024, 521.8251885618361, 525.2908573425921, 569.6667449541982, 574.8045664474015, 621.8352136683783, 8137.267645911897, 8195.42632015765, 8282.378821588405, 8466.703665371682, 8634.438761480484, 593.827789940921, 608.178958406157, 617.8239201827547, 624.3194917539903, 638.7732355013997, 3553.466979953028, 3816.065064059323, 3848.172642881738, 3851.30676478231, 3895.3962135868987, 95123.52438237764, 95415.0, 96937.0306296928, 97717.04565908642, 97917.0, 78635.0, 79172.20827791764, 79351.60324198342, 80076.59961700154, 80539.0, 28524.714752852622, 28638.713612864023, 28732.994345197818, 63468.73062538723, 70886.99999999897, 7509.249075092447, 7675.731349402744, 7779.338756205786, 7897.407694422826, 8024.719134830253, 37603.81198093992, 50142.74928625333, 50579.0, 50588.74705626448, 50615.49384506255, 63063.6846815763, 68351.0, 69779.30220697729, 70061.29938700752, 71285.64357178389, 9141.908580914373, 9676.516174191403, 10227.130693890806, 10399.0, 10444.2166837489, 10779.407132607781, 10930.890691092987, 10999.120070394189, 11080.168987325822, 11631.709207269885, 9631.566579503798, 10016.549255283384, 10217.693469195936, 10554.736131596464, 10590.205734570092, 10270.537825798006, 10381.480925953521, 10477.1094456972, 10717.785644286914, 10745.086667633339, 10147.49262536885, 10161.237907156845, 10190.490475476048, 10426.530806113895, 10506.632267870587, 8513.36149788756, 8711.738647840575, 8789.033206347169, 8804.955975220082, 8833.779155521164, 8915.866262006204, 8953.731388058368, 8960.103989600988, 9047.366684332033, 9078.818423631623], "unit": "score", "name": "yui.html", "value": 6834.740932604717}], "name": "dromaeo_css", "value": 7632.500243244985}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 112.0, 115.0, 115.0, 116.0, 130.0, 152.0, 163.0, 133.0, 118.0], "unit": "score", "name": "ai-astar", "value": 127.1}, {"lowerIsBetter": true, "replicates": [153.0, 123.0, 145.0, 182.0, 155.0, 171.0, 121.0, 152.0, 150.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 147.2}, {"lowerIsBetter": true, "replicates": [193.0, 199.0, 198.0, 201.0, 198.0, 195.0, 204.0, 199.0, 200.0, 201.0], "unit": "score", "name": "audio-dft", "value": 198.8}, {"lowerIsBetter": true, "replicates": [65.0, 81.0, 73.0, 114.0, 56.0, 57.0, 69.0, 68.0, 131.0, 55.0], "unit": "score", "name": "audio-fft", "value": 76.9}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 113.0, 80.0, 78.0, 82.0, 114.0, 79.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 91.0}, {"lowerIsBetter": true, "replicates": [90.0, 88.0, 99.0, 131.0, 121.0, 87.0, 78.0, 129.0, 127.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 103.6}, {"lowerIsBetter": true, "replicates": [140.0, 89.0, 147.0, 148.0, 94.0, 120.0, 118.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 114.1}, {"lowerIsBetter": true, "replicates": [99.0, 146.0, 146.0, 121.0, 101.0, 144.0, 99.0, 143.0, 145.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 123.6}, {"lowerIsBetter": true, "replicates": [54.0, 59.0, 60.0, 62.0, 60.0, 61.0, 57.0, 67.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 73.0, 97.0, 103.0, 83.0, 71.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.4}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 81.0, 83.0, 85.0, 82.0, 83.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [136.0, 134.0, 149.0, 124.0, 141.0, 139.0, 137.0, 131.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.7}, {"lowerIsBetter": true, "replicates": [140.0, 165.0, 156.0, 174.0, 175.0, 176.0, 137.0, 150.0, 169.0, 173.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 161.5}, {"lowerIsBetter": true, "replicates": [68.0, 63.0, 61.0, 64.0, 62.0, 71.0, 98.0, 55.0, 58.0, 58.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1561.9}]} 05:26:34 INFO - Return code: 0 05:26:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:26:34 ERROR - # TBPL SUCCESS # 05:26:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:34 INFO - 2016-04-07 05:26:34.882 screenresolution[2012:66932] starting screenresolution argv=screenresolution get 05:26:34 INFO - 2016-04-07 05:26:34.885 screenresolution[2012:66932] Display 0: 1600x1200x32@60 05:26:34 INFO - 2016-04-07 05:26:34.891 screenresolution[2013:66935] starting screenresolution argv=screenresolution list 05:26:34 INFO - Available Modes on Display 0 05:26:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:35 INFO - Intel Iris: 05:26:35 INFO - Chipset Model: Intel Iris 05:26:35 INFO - Type: GPU 05:26:35 INFO - Bus: Built-In 05:26:35 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:35 INFO - Vendor: Intel (0x8086) 05:26:35 INFO - Device ID: 0x0a2e 05:26:35 INFO - Revision ID: 0x0009 05:26:35 INFO - Displays: 05:26:35 INFO - Display: 05:26:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:35 INFO - Display Serial Number: 1600x1200 60 05:26:35 INFO - Main Display: Yes 05:26:35 INFO - Mirror: Off 05:26:35 INFO - Online: Yes 05:26:35 INFO - Rotation: Supported 05:26:35 INFO - Return code: 0 05:26:35 INFO - Running post-action listener: _resource_record_post_action 05:26:35 INFO - Running post-run listener: _resource_record_post_run 05:26:36 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 131072; Write bytes: 663570944; Read time: 2; Write time: 1892 05:26:36 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 358222336; Write bytes: 353392128; Read time: 27869; Write time: 631 05:26:36 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 131072; Write bytes: 299004928; Read time: 2; Write time: 1226 05:26:36 INFO - Running post-run listener: _upload_blobber_files 05:26:36 INFO - Blob upload gear active. 05:26:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:26:36 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:26:36 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:26:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:26:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:26:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:37 INFO - (blobuploader) - INFO - Done attempting. 05:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:38 INFO - (blobuploader) - INFO - Done attempting. 05:26:38 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:38 INFO - Return code: 0 05:26:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4be8cc07a1c5998b0aa8f5afe8dc0815580c1c796cf4df03a1fbe2e21f6e9c7e32e09a4daeb8073594dd718c24d350a1ca7fd5c88584de01fdf97b3531f0431", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/065a4085c84bb1ff14b33a134e0a02684dc400f97168749f1432113a6dd203598cfcd892d80ee9ab4ca7a288751e99f125d6e50d2dd3ac298c7a5c2c1abca241"} 05:26:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:38 INFO - Contents: 05:26:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4be8cc07a1c5998b0aa8f5afe8dc0815580c1c796cf4df03a1fbe2e21f6e9c7e32e09a4daeb8073594dd718c24d350a1ca7fd5c88584de01fdf97b3531f0431", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/065a4085c84bb1ff14b33a134e0a02684dc400f97168749f1432113a6dd203598cfcd892d80ee9ab4ca7a288751e99f125d6e50d2dd3ac298c7a5c2c1abca241"} 05:26:38 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:38 INFO - Copying logs to upload dir... 05:26:38 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.780142 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-04-07 05:26:38.512549) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:26:38.516265) ========= 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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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/Mozilla-Aurora/sha512/a4be8cc07a1c5998b0aa8f5afe8dc0815580c1c796cf4df03a1fbe2e21f6e9c7e32e09a4daeb8073594dd718c24d350a1ca7fd5c88584de01fdf97b3531f0431", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/065a4085c84bb1ff14b33a134e0a02684dc400f97168749f1432113a6dd203598cfcd892d80ee9ab4ca7a288751e99f125d6e50d2dd3ac298c7a5c2c1abca241"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011262 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-aurora-macosx64/1460001592/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a4be8cc07a1c5998b0aa8f5afe8dc0815580c1c796cf4df03a1fbe2e21f6e9c7e32e09a4daeb8073594dd718c24d350a1ca7fd5c88584de01fdf97b3531f0431", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/065a4085c84bb1ff14b33a134e0a02684dc400f97168749f1432113a6dd203598cfcd892d80ee9ab4ca7a288751e99f125d6e50d2dd3ac298c7a5c2c1abca241"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-07 05:26:38.567517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:26:38.567886) ========= 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.nKGiwGwjlk/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.p0uFfu7ERr/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-07 05:26:38.649179) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:26:38.649540) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-07 05:26:38.650023) ========= ========= Total master_lag: 0.33 =========