builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0136 starttime: 1455884902.09 results: success (0) buildid: 20160219025900 builduid: 518dd73602454b9a9bb82000d81db3c2 revision: 3e9b07b743d66f85008867f64ab914377794b46c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.086071) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.086460) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.086747) ========= 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.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005717 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.129403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.129704) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.155369) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.155670) ========= 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.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005200 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.226999) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.227271) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.227619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.227888) ========= 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.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-02-19 04:28:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 145M=0s 2016-02-19 04:28:22 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.591131 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.846110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.846446) ========= 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.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.019459 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.894759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:22.895117) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e9b07b743d66f85008867f64ab914377794b46c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3e9b07b743d66f85008867f64ab914377794b46c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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-02-19 04:28:23,012 truncating revision to first 12 chars 2016-02-19 04:28:23,013 Setting DEBUG logging. 2016-02-19 04:28:23,013 attempt 1/10 2016-02-19 04:28:23,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e9b07b743d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-19 04:28:23,743 unpacking tar archive at: fx-team-3e9b07b743d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.976145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:23.891731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:23.892389) ========= echo 3e9b07b743d66f85008867f64ab914377794b46c in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3e9b07b743d66f85008867f64ab914377794b46c'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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 3e9b07b743d66f85008867f64ab914377794b46c program finished with exit code 0 elapsedTime=0.005127 script_repo_revision: '3e9b07b743d66f85008867f64ab914377794b46c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:23.943791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:23.944135) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-19 04:28:23.958260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-02-19 04:28:23.958819) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:28:24 INFO - MultiFileLogger online at 20160219 04:28:24 in /builds/slave/test 04:28:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:28:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:28:24 INFO - {'append_to_log': False, 04:28:24 INFO - 'base_work_dir': '/builds/slave/test', 04:28:24 INFO - 'blob_upload_branch': 'Fx-Team', 04:28:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:28:24 INFO - 'branch': 'Fx-Team', 04:28:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:28:24 INFO - 'config_files': ('talos/mac_config.py',), 04:28:24 INFO - 'default_actions': ('clobber', 04:28:24 INFO - 'read-buildbot-config', 04:28:24 INFO - 'download-and-extract', 04:28:24 INFO - 'populate-webroot', 04:28:24 INFO - 'create-virtualenv', 04:28:24 INFO - 'install', 04:28:24 INFO - 'run-tests'), 04:28:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:28:24 INFO - 'download_minidump_stackwalk': True, 04:28:24 INFO - 'download_symbols': 'ondemand', 04:28:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:28:24 INFO - 'tooltool.py': '/tools/tooltool.py', 04:28:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:28:24 INFO - '/tools/misc-python/virtualenv.py')}, 04:28:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:28:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:28:24 INFO - 'installer_path': 'installer.exe', 04:28:24 INFO - 'log_level': 'info', 04:28:24 INFO - 'log_name': 'talos', 04:28:24 INFO - 'log_to_console': True, 04:28:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:28:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:28:24 INFO - 'opt_config_files': (), 04:28:24 INFO - 'pip_index': False, 04:28:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:28:24 INFO - 'cmd': ('bash', 04:28:24 INFO - '-c', 04:28:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:28:24 INFO - 'enabled': True, 04:28:24 INFO - 'halt_on_failure': False, 04:28:24 INFO - 'name': 'check_screen_resolution'},), 04:28:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:28:24 INFO - 'cmd': ('bash', 04:28:24 INFO - '-c', 04:28:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:28:24 INFO - 'enabled': True, 04:28:24 INFO - 'halt_on_failure': False, 04:28:24 INFO - 'name': 'check_screen_resolution'},), 04:28:24 INFO - 'run_cmd_checks_enabled': True, 04:28:24 INFO - 'sps_profile': False, 04:28:24 INFO - 'sps_profile_interval': 0, 04:28:24 INFO - 'suite': 'dromaeojs', 04:28:24 INFO - 'system_bits': '32', 04:28:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:28:24 INFO - 'title': 't-yosemite-r7-0136', 04:28:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:28:24 INFO - 'use_talos_json': True, 04:28:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:28:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:28:24 INFO - 'work_dir': 'build'} 04:28:24 INFO - ##### 04:28:24 INFO - ##### Running clobber step. 04:28:24 INFO - ##### 04:28:24 INFO - Running pre-action listener: _resource_record_pre_action 04:28:24 INFO - Running main action method: clobber 04:28:24 INFO - rmtree: /builds/slave/test/build 04:28:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:28:24 INFO - Running post-action listener: _resource_record_post_action 04:28:24 INFO - ##### 04:28:24 INFO - ##### Running read-buildbot-config step. 04:28:24 INFO - ##### 04:28:24 INFO - Running pre-action listener: _resource_record_pre_action 04:28:24 INFO - Running main action method: read_buildbot_config 04:28:24 INFO - Using buildbot properties: 04:28:24 INFO - { 04:28:24 INFO - "project": "", 04:28:24 INFO - "product": "firefox", 04:28:24 INFO - "script_repo_revision": "production", 04:28:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:28:24 INFO - "repository": "", 04:28:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:28:24 INFO - "buildid": "20160219025900", 04:28:24 INFO - "pgo_build": "False", 04:28:24 INFO - "basedir": "/builds/slave/test", 04:28:24 INFO - "buildnumber": 465, 04:28:24 INFO - "slavename": "t-yosemite-r7-0136", 04:28:24 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:28:24 INFO - "platform": "yosemite_r7", 04:28:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:28:24 INFO - "branch": "fx-team", 04:28:24 INFO - "repo_path": "integration/fx-team", 04:28:24 INFO - "revision": "3e9b07b743d66f85008867f64ab914377794b46c", 04:28:24 INFO - "stage_platform": "macosx64", 04:28:24 INFO - "builduid": "518dd73602454b9a9bb82000d81db3c2", 04:28:24 INFO - "slavebuilddir": "test" 04:28:24 INFO - } 04:28:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:28:24 INFO - Running post-action listener: _resource_record_post_action 04:28:24 INFO - ##### 04:28:24 INFO - ##### Running download-and-extract step. 04:28:24 INFO - ##### 04:28:24 INFO - Running pre-action listener: _resource_record_pre_action 04:28:24 INFO - Running main action method: download_and_extract 04:28:24 INFO - mkdir: /builds/slave/test/build/tests 04:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:24 INFO - https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:28:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/test_packages.json 04:28:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/test_packages.json 04:28:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:28:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:28:26 INFO - Downloaded 1277 bytes. 04:28:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:28:26 INFO - Using the following test package requirements: 04:28:26 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:28:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:28:26 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:28:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:28:26 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:28:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:28:26 INFO - u'jsshell-mac.zip'], 04:28:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:28:26 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:28:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:28:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:28:26 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:28:26 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:28:26 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:28:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:28:26 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:28:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:28:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:28:26 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:28:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:26 INFO - https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:28:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:28:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:28:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:28:28 INFO - Downloaded 17807197 bytes. 04:28:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:28:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:28:31 INFO - Return code: 0 04:28:31 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:31 INFO - https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:28:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:28:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:28:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:28:42 INFO - Downloaded 17807197 bytes. 04:28:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:28:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:28:46 INFO - Return code: 0 04:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:46 INFO - https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:28:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:28:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:28:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:28:47 INFO - Downloaded 10707015 bytes. 04:28:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:28:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:28:47 INFO - Return code: 0 04:28: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')]} 04:28:47 INFO - https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:28:51 INFO - Downloaded 111324952 bytes. 04:28:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:28:51 INFO - mkdir: /builds/slave/test/properties 04:28:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:28:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:28:51 INFO - Contents: 04:28:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:28:51 INFO - Running post-action listener: _resource_record_post_action 04:28:51 INFO - Running post-action listener: set_extra_try_arguments 04:28:51 INFO - ##### 04:28:51 INFO - ##### Running populate-webroot step. 04:28:51 INFO - ##### 04:28:51 INFO - Running pre-action listener: _resource_record_pre_action 04:28:51 INFO - Running main action method: populate_webroot 04:28:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:28:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:28:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:28:51 INFO - '--tppagecycles', 04:28:51 INFO - '7'], 04:28:51 INFO - 'tests': ['tsvgm']}}, 04:28:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:28:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:28:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:28:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:28:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:28:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:51 INFO - 'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:28:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:51 INFO - 'tests': ['damp', 'tps']}, 04:28:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:51 INFO - 'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['damp', 'tps']}, 04:28:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:28:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:28:51 INFO - 'other': {'tests': ['a11yr', 04:28:51 INFO - 'ts_paint', 04:28:51 INFO - 'tpaint', 04:28:51 INFO - 'sessionrestore', 04:28:51 INFO - 'sessionrestore_no_auto_restore']}, 04:28:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['a11yr', 04:28:51 INFO - 'ts_paint', 04:28:51 INFO - 'tpaint', 04:28:51 INFO - 'sessionrestore', 04:28:51 INFO - 'sessionrestore_no_auto_restore']}, 04:28:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['a11yr', 04:28:51 INFO - 'ts_paint', 04:28:51 INFO - 'tpaint', 04:28:51 INFO - 'sessionrestore', 04:28:51 INFO - 'sessionrestore_no_auto_restore']}, 04:28:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['a11yr', 04:28:51 INFO - 'ts_paint', 04:28:51 INFO - 'tpaint', 04:28:51 INFO - 'sessionrestore', 04:28:51 INFO - 'sessionrestore_no_auto_restore']}, 04:28:51 INFO - 'other_l64': {'tests': ['a11yr', 04:28:51 INFO - 'ts_paint', 04:28:51 INFO - 'tpaint', 04:28:51 INFO - 'sessionrestore', 04:28:51 INFO - 'sessionrestore_no_auto_restore']}, 04:28:51 INFO - 'other_nol64': {'tests': ['a11yr', 04:28:51 INFO - 'ts_paint', 04:28:51 INFO - 'tpaint', 04:28:51 INFO - 'sessionrestore', 04:28:51 INFO - 'sessionrestore_no_auto_restore']}, 04:28:51 INFO - 'svgr': {'tests': ['tsvgx', 04:28:51 INFO - 'tsvgr_opacity', 04:28:51 INFO - 'tart', 04:28:51 INFO - 'tscrollx', 04:28:51 INFO - 'cart']}, 04:28:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['tsvgx', 04:28:51 INFO - 'tsvgr_opacity', 04:28:51 INFO - 'tart', 04:28:51 INFO - 'tscrollx', 04:28:51 INFO - 'cart']}, 04:28:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:51 INFO - 'tests': ['tp5o']}, 04:28:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:51 INFO - 'talos_options': ['--e10s'], 04:28:51 INFO - 'tests': ['tp5o']}, 04:28:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:51 INFO - 'talos_options': ['--xperf_path', 04:28:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:28:51 INFO - 'tests': ['tp5n']}, 04:28:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:28:51 INFO - 'talos_options': ['--e10s', 04:28:51 INFO - '--xperf_path', 04:28:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:28:51 INFO - 'tests': ['tp5n']}}, 04:28:51 INFO - 'talos.zip': {'path': '', 04:28:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:28:51 INFO - Running post-action listener: _resource_record_post_action 04:28:51 INFO - ##### 04:28:51 INFO - ##### Running create-virtualenv step. 04:28:51 INFO - ##### 04:28:51 INFO - Running pre-action listener: _resource_record_pre_action 04:28:51 INFO - Running main action method: create_virtualenv 04:28:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:28:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:28:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:28:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:28:51 INFO - Using real prefix '/tools/python27' 04:28:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:28:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:28:55 INFO - Installing pip.................done. 04:28:55 INFO - Return code: 0 04:28:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:55 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 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:55 INFO - 'HOME': '/Users/cltbld', 04:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:55 INFO - 'LOGNAME': 'cltbld', 04:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:55 INFO - 'MOZ_NO_REMOTE': '1', 04:28:55 INFO - 'NO_EM_RESTART': '1', 04:28:55 INFO - 'PAGER': '/bin/cat', 04:28:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:55 INFO - 'PWD': '/builds/slave/test', 04:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:55 INFO - 'SHELL': '/bin/bash', 04:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:28:55 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:55 INFO - 'USER': 'cltbld', 04:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:55 INFO - 'XPC_FLAGS': '0x0', 04:28:55 INFO - 'XPC_SERVICE_NAME': '0', 04:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:28:55 INFO - Cleaning up... 04:28:55 INFO - Return code: 0 04:28:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:28:55 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 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:28:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:28:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:28:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:28:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:28:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:28:55 INFO - 'HOME': '/Users/cltbld', 04:28:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:28:55 INFO - 'LOGNAME': 'cltbld', 04:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:55 INFO - 'MOZ_NO_REMOTE': '1', 04:28:55 INFO - 'NO_EM_RESTART': '1', 04:28:55 INFO - 'PAGER': '/bin/cat', 04:28:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:55 INFO - 'PWD': '/builds/slave/test', 04:28:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:28:55 INFO - 'SHELL': '/bin/bash', 04:28:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:28:55 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:28:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:28:55 INFO - 'USER': 'cltbld', 04:28:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:28:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:55 INFO - 'XPC_FLAGS': '0x0', 04:28:55 INFO - 'XPC_SERVICE_NAME': '0', 04:28:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:28:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:56 INFO - Downloading/unpacking psutil>=0.7.1 04:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:28:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:28:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:28:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:28:59 INFO - Installing collected packages: psutil 04:28:59 INFO - Running setup.py install for psutil 04:28:59 INFO - building 'psutil._psutil_osx' extension 04:28:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:28:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:28:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:29:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:29:00 INFO - building 'psutil._psutil_posix' extension 04:29:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:29:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:29:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:29:00 INFO - ^ 04:29:00 INFO - 1 warning generated. 04:29:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:29:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:00 INFO - Successfully installed psutil 04:29:00 INFO - Cleaning up... 04:29:00 INFO - Return code: 0 04:29:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:29:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:29:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:29:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:29:00 INFO - 'HOME': '/Users/cltbld', 04:29:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:29:00 INFO - 'LOGNAME': 'cltbld', 04:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:00 INFO - 'MOZ_NO_REMOTE': '1', 04:29:00 INFO - 'NO_EM_RESTART': '1', 04:29:00 INFO - 'PAGER': '/bin/cat', 04:29:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:00 INFO - 'PWD': '/builds/slave/test', 04:29:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:29:00 INFO - 'SHELL': '/bin/bash', 04:29:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:29:00 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:29:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:29:00 INFO - 'USER': 'cltbld', 04:29:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:29:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:00 INFO - 'XPC_FLAGS': '0x0', 04:29:00 INFO - 'XPC_SERVICE_NAME': '0', 04:29:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:29:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:29:03 INFO - Installing collected packages: mozsystemmonitor 04:29:03 INFO - Running setup.py install for mozsystemmonitor 04:29:03 INFO - Successfully installed mozsystemmonitor 04:29:03 INFO - Cleaning up... 04:29:03 INFO - Return code: 0 04:29:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:03 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 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:29:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:29:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:29:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:29:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:29:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:29:03 INFO - 'HOME': '/Users/cltbld', 04:29:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:29:03 INFO - 'LOGNAME': 'cltbld', 04:29:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:03 INFO - 'MOZ_NO_REMOTE': '1', 04:29:03 INFO - 'NO_EM_RESTART': '1', 04:29:03 INFO - 'PAGER': '/bin/cat', 04:29:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:29:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:03 INFO - 'PWD': '/builds/slave/test', 04:29:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:29:03 INFO - 'SHELL': '/bin/bash', 04:29:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:29:03 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:29:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:29:03 INFO - 'USER': 'cltbld', 04:29:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:29:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:29:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:03 INFO - 'XPC_FLAGS': '0x0', 04:29:03 INFO - 'XPC_SERVICE_NAME': '0', 04:29:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:03 INFO - Downloading/unpacking blobuploader==1.2.4 04:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:29:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:29:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:06 INFO - Downloading docopt-0.6.1.tar.gz 04:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:29:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:29:07 INFO - Running setup.py install for blobuploader 04:29:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:29:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:29:07 INFO - Running setup.py install for requests 04:29:07 INFO - Running setup.py install for docopt 04:29:07 INFO - Successfully installed blobuploader requests docopt 04:29:07 INFO - Cleaning up... 04:29:07 INFO - Return code: 0 04:29:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:07 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 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:29:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:29:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:29:07 INFO - 'HOME': '/Users/cltbld', 04:29:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:29:07 INFO - 'LOGNAME': 'cltbld', 04:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:07 INFO - 'MOZ_NO_REMOTE': '1', 04:29:07 INFO - 'NO_EM_RESTART': '1', 04:29:07 INFO - 'PAGER': '/bin/cat', 04:29:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:07 INFO - 'PWD': '/builds/slave/test', 04:29:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:29:07 INFO - 'SHELL': '/bin/bash', 04:29:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:29:07 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:29:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:29:07 INFO - 'USER': 'cltbld', 04:29:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:29:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:07 INFO - 'XPC_FLAGS': '0x0', 04:29:07 INFO - 'XPC_SERVICE_NAME': '0', 04:29:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-i7kbvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-hHcugd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-F7CPwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-weO0zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-443sU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-jSdfyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-BVioDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-DLiOBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:08 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-JtrPyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:09 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-kHcCfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:09 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-VG6DGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:09 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-QOcj35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:09 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-7bPuc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:09 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-XvLPGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:09 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-jwd7bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:09 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-WOBqVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:09 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-cqsTGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:29:09 INFO - Running setup.py install for manifestparser 04:29:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:29:10 INFO - Running setup.py install for mozcrash 04:29:10 INFO - Running setup.py install for mozdebug 04:29:10 INFO - Running setup.py install for mozdevice 04:29:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:29:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:29:10 INFO - Running setup.py install for mozfile 04:29:10 INFO - Running setup.py install for mozhttpd 04:29:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:29:10 INFO - Running setup.py install for mozinfo 04:29:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:29:10 INFO - Running setup.py install for mozInstall 04:29:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Running setup.py install for mozleak 04:29:11 INFO - Running setup.py install for mozlog 04:29:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Running setup.py install for moznetwork 04:29:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Running setup.py install for mozprocess 04:29:11 INFO - Running setup.py install for mozprofile 04:29:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:29:11 INFO - Running setup.py install for mozrunner 04:29:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:29:12 INFO - Running setup.py install for mozscreenshot 04:29:12 INFO - Running setup.py install for moztest 04:29:12 INFO - Running setup.py install for mozversion 04:29:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:29:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:29:12 INFO - Cleaning up... 04:29:12 INFO - Return code: 0 04:29:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:12 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 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:29:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:29:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:29:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:29:12 INFO - 'HOME': '/Users/cltbld', 04:29:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:29:12 INFO - 'LOGNAME': 'cltbld', 04:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:12 INFO - 'MOZ_NO_REMOTE': '1', 04:29:12 INFO - 'NO_EM_RESTART': '1', 04:29:12 INFO - 'PAGER': '/bin/cat', 04:29:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:12 INFO - 'PWD': '/builds/slave/test', 04:29:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:29:12 INFO - 'SHELL': '/bin/bash', 04:29:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:29:12 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:29:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:29:12 INFO - 'USER': 'cltbld', 04:29:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:29:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:12 INFO - 'XPC_FLAGS': '0x0', 04:29:12 INFO - 'XPC_SERVICE_NAME': '0', 04:29:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:12 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-6PdHv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:12 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-nyiCGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:12 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-KwQaCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-EW8V9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-0uHX1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-WWBWq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-y1IxWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-lFUGYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-x8AtZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-mr28GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-RawWf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:13 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-q4_F6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-Pgphcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-BWuhn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-1vb7lH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-bgJxub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:14 INFO - Running setup.py (path:/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/pip-jThRLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:29:14 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:14 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:16 INFO - Downloading blessings-1.6.tar.gz 04:29:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:29:16 INFO - Installing collected packages: blessings 04:29:16 INFO - Running setup.py install for blessings 04:29:17 INFO - Successfully installed blessings 04:29:17 INFO - Cleaning up... 04:29:17 INFO - Return code: 0 04:29:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:17 INFO - Reading from file tmpfile_stdout 04:29:17 INFO - Current package versions: 04:29:17 INFO - blessings == 1.6 04:29:17 INFO - blobuploader == 1.2.4 04:29:17 INFO - docopt == 0.6.1 04:29:17 INFO - manifestparser == 1.1 04:29:17 INFO - mozInstall == 1.12 04:29:17 INFO - mozcrash == 0.16 04:29:17 INFO - mozdebug == 0.1 04:29:17 INFO - mozdevice == 0.48 04:29:17 INFO - mozfile == 1.2 04:29:17 INFO - mozhttpd == 0.7 04:29:17 INFO - mozinfo == 0.9 04:29:17 INFO - mozleak == 0.1 04:29:17 INFO - mozlog == 3.1 04:29:17 INFO - moznetwork == 0.27 04:29:17 INFO - mozprocess == 0.22 04:29:17 INFO - mozprofile == 0.28 04:29:17 INFO - mozrunner == 6.11 04:29:17 INFO - mozscreenshot == 0.1 04:29:17 INFO - mozsystemmonitor == 0.0 04:29:17 INFO - moztest == 0.7 04:29:17 INFO - mozversion == 1.4 04:29:17 INFO - psutil == 3.1.1 04:29:17 INFO - requests == 1.2.3 04:29:17 INFO - wsgiref == 0.1.2 04:29:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:17 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 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:29:17 INFO - 'HOME': '/Users/cltbld', 04:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:29:17 INFO - 'LOGNAME': 'cltbld', 04:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:17 INFO - 'MOZ_NO_REMOTE': '1', 04:29:17 INFO - 'NO_EM_RESTART': '1', 04:29:17 INFO - 'PAGER': '/bin/cat', 04:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:17 INFO - 'PWD': '/builds/slave/test', 04:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:29:17 INFO - 'SHELL': '/bin/bash', 04:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:29:17 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:29:17 INFO - 'USER': 'cltbld', 04:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:17 INFO - 'XPC_FLAGS': '0x0', 04:29:17 INFO - 'XPC_SERVICE_NAME': '0', 04:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:29:17 INFO - Cleaning up... 04:29:17 INFO - Return code: 0 04:29:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:29:17 INFO - 'HOME': '/Users/cltbld', 04:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:29:17 INFO - 'LOGNAME': 'cltbld', 04:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:17 INFO - 'MOZ_NO_REMOTE': '1', 04:29:17 INFO - 'NO_EM_RESTART': '1', 04:29:17 INFO - 'PAGER': '/bin/cat', 04:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:17 INFO - 'PWD': '/builds/slave/test', 04:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:29:17 INFO - 'SHELL': '/bin/bash', 04:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:29:17 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:29:17 INFO - 'USER': 'cltbld', 04:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:17 INFO - 'XPC_FLAGS': '0x0', 04:29:17 INFO - 'XPC_SERVICE_NAME': '0', 04:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:18 INFO - Downloading/unpacking jsonschema 04:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:29:20 INFO - Downloading/unpacking functools32 (from jsonschema) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:20 INFO - Downloading functools32-3.2.3-2.tar.gz 04:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:29:20 INFO - warning: no files found matching '*.txt' 04:29:20 INFO - no previously-included directories found matching 'build' 04:29:20 INFO - no previously-included directories found matching 'dist' 04:29:20 INFO - no previously-included directories found matching '.git*' 04:29:20 INFO - Installing collected packages: jsonschema, functools32 04:29:20 INFO - Running setup.py install for functools32 04:29:21 INFO - warning: no files found matching '*.txt' 04:29:21 INFO - no previously-included directories found matching 'build' 04:29:21 INFO - no previously-included directories found matching 'dist' 04:29:21 INFO - no previously-included directories found matching '.git*' 04:29:21 INFO - Successfully installed jsonschema functools32 04:29:21 INFO - Cleaning up... 04:29:21 INFO - Return code: 0 04:29:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:21 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 0x10c36da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c3754c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca90c79af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, '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.adx5kaS1wA/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.8wrCPTflHP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:29:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:29:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:29:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:29:21 INFO - 'HOME': '/Users/cltbld', 04:29:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:29:21 INFO - 'LOGNAME': 'cltbld', 04:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:21 INFO - 'MOZ_NO_REMOTE': '1', 04:29:21 INFO - 'NO_EM_RESTART': '1', 04:29:21 INFO - 'PAGER': '/bin/cat', 04:29:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:21 INFO - 'PWD': '/builds/slave/test', 04:29:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:29:21 INFO - 'SHELL': '/bin/bash', 04:29:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:29:21 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:29:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:29:21 INFO - 'USER': 'cltbld', 04:29:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:29:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:21 INFO - 'XPC_FLAGS': '0x0', 04:29:21 INFO - 'XPC_SERVICE_NAME': '0', 04:29:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:21 INFO - Downloading/unpacking flake8 04:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:29:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:29:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:29:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:29:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:29:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:29:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:29:25 INFO - no previously-included directories found matching 'docs/_build' 04:29:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:29:25 INFO - Running setup.py install for pep8 04:29:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:29:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:29:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:29:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:29:25 INFO - no previously-included directories found matching 'docs/_build' 04:29:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:29:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:29:25 INFO - Cleaning up... 04:29:25 INFO - Return code: 0 04:29:25 INFO - Running post-action listener: _resource_record_post_action 04:29:25 INFO - Running post-action listener: _start_resource_monitoring 04:29:25 INFO - Starting resource monitoring. 04:29:25 INFO - ##### 04:29:25 INFO - ##### Running install step. 04:29:25 INFO - ##### 04:29:25 INFO - Running pre-action listener: _resource_record_pre_action 04:29:25 INFO - Running main action method: install 04:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:25 INFO - Reading from file tmpfile_stdout 04:29:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:29:25 INFO - Reading from file tmpfile_stdout 04:29:25 INFO - Output received: 04:29:25 INFO - Usage: mozinstall [options] installer 04:29:25 INFO - Options: 04:29:25 INFO - -h, --help show this help message and exit 04:29:25 INFO - -d DEST, --destination=DEST 04:29:25 INFO - Directory to install application into. [default: 04:29:25 INFO - "/builds/slave/test"] 04:29:25 INFO - --app=APP Application being installed. [default: firefox] 04:29:25 INFO - mkdir: /builds/slave/test/build/application 04:29:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:29:59 INFO - Reading from file tmpfile_stdout 04:29:59 INFO - Output received: 04:29:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:29:59 INFO - Running post-action listener: _resource_record_post_action 04:29:59 INFO - ##### 04:29:59 INFO - ##### Running run-tests step. 04:29:59 INFO - ##### 04:29:59 INFO - Running pre-action listener: _resource_record_pre_action 04:29:59 INFO - Running main action method: run_tests 04:30:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:30:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:30:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:30:00 INFO - 2016-02-19 04:30:00.011 screenresolution[6229:100476] starting screenresolution argv=screenresolution get 04:30:00 INFO - 2016-02-19 04:30:00.014 screenresolution[6229:100476] Display 0: 1600x1200x32@60 04:30:00 INFO - 2016-02-19 04:30:00.020 screenresolution[6230:100478] starting screenresolution argv=screenresolution list 04:30:00 INFO - Available Modes on Display 0 04:30:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:30:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:30:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:30:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:30:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:30:00 INFO - Intel Iris: 04:30:00 INFO - Chipset Model: Intel Iris 04:30:00 INFO - Type: GPU 04:30:00 INFO - Bus: Built-In 04:30:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:30:00 INFO - Vendor: Intel (0x8086) 04:30:00 INFO - Device ID: 0x0a2e 04:30:00 INFO - Revision ID: 0x0009 04:30:00 INFO - Displays: 04:30:00 INFO - Display: 04:30:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:30:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:30:00 INFO - Display Serial Number: 1600x1200 60 04:30:00 INFO - Main Display: Yes 04:30:00 INFO - Mirror: Off 04:30:00 INFO - Online: Yes 04:30:00 INFO - Rotation: Supported 04:30:00 INFO - Return code: 0 04:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:30:00 INFO - Python 2.7.3 04:30:00 INFO - Return code: 0 04:30:00 INFO - grabbing minidump binary from tooltool 04:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:00 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 0x10c211d30>, '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 0x10c035db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c208b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:30:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:30:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:30:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:30:00 INFO - Return code: 0 04:30:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:30:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:30:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:30:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:30:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:30:01 INFO - Return code: 0 04:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0136 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:30:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.adx5kaS1wA/Render', 04:30:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:01 INFO - 'HOME': '/Users/cltbld', 04:30:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:01 INFO - 'LOGNAME': 'cltbld', 04:30:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:30:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:01 INFO - 'MOZ_NO_REMOTE': '1', 04:30:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:30:01 INFO - 'NO_EM_RESTART': '1', 04:30:01 INFO - 'PAGER': '/bin/cat', 04:30:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:01 INFO - 'PWD': '/builds/slave/test', 04:30:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:30:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:01 INFO - 'SHELL': '/bin/bash', 04:30:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8wrCPTflHP/Listeners', 04:30:01 INFO - 'TMPDIR': '/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/', 04:30:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:01 INFO - 'USER': 'cltbld', 04:30:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:01 INFO - 'XPC_FLAGS': '0x0', 04:30:01 INFO - 'XPC_SERVICE_NAME': '0', 04:30:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0136', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:30:01 INFO - mozversion application_buildid: 20160219025900 04:30:01 INFO - mozversion application_changeset: 3e9b07b743d66f85008867f64ab914377794b46c 04:30:01 INFO - mozversion application_display_name: Nightly 04:30:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:30:01 INFO - mozversion application_name: Firefox 04:30:01 INFO - mozversion application_remotingname: firefox 04:30:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:30:01 INFO - mozversion application_vendor: Mozilla 04:30:01 INFO - mozversion application_version: 47.0a1 04:30:01 INFO - mozversion platform_buildid: 20160219025900 04:30:01 INFO - mozversion platform_changeset: 3e9b07b743d66f85008867f64ab914377794b46c 04:30:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:30:01 INFO - mozversion platform_version: 47.0a1 04:30:01 INFO - using testdate: 1455885001 04:30:01 INFO - actual date: 1455885001 04:30:01 INFO - starting webserver on 'localhost:57190' 04:30:01 INFO - SUITE-START | Running 2 tests 04:30:01 INFO - TEST-START | dromaeo_css 04:30:01 INFO - operating with platform_type : mac_ 04:30:01 INFO - Initialising browser for dromaeo_css test... 04:30:01 INFO - TEST-INFO | started process 6248 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp6Xvnjm/profile http://localhost:57190/getInfo.html) 04:30:04 INFO - PROCESS | 6248 | __metrics Screen width/height:1600/1200 04:30:04 INFO - PROCESS | 6248 | colorDepth:24 04:30:04 INFO - PROCESS | 6248 | Browser inner width/height: 1024/689 04:30:04 INFO - PROCESS | 6248 | __metrics 04:30:04 INFO - PROCESS | 6248 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:30:04 INFO - PROCESS | 6248 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:30:04 INFO - TEST-INFO | 6248: exit 0 04:30:04 INFO - Browser initialized. 04:30:04 INFO - Running cycle 1/1 for dromaeo_css test... 04:30:04 INFO - TEST-INFO | started process 6252 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmp6Xvnjm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:16 INFO - PROCESS | 6252 | RSS: Main: 244658176 04:30:16 INFO - PROCESS | 6252 | 04:31:07 INFO - PROCESS | 6252 | 1455885067743 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:33:18 INFO - PROCESS | 6252 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57190/tests/dromaeo/cssquery-ext.html) 04:33:19 INFO - PROCESS | 6252 | RSS: Main: 383516672 04:33:19 INFO - PROCESS | 6252 | 04:36:22 INFO - PROCESS | 6252 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-ext.html (next: http://localhost:57190/tests/dromaeo/cssquery-jquery.html) 04:36:23 INFO - PROCESS | 6252 | RSS: Main: 373329920 04:36:23 INFO - PROCESS | 6252 | 04:39:25 INFO - PROCESS | 6252 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57190/tests/dromaeo/cssquery-mootools.html) 04:39:25 INFO - PROCESS | 6252 | RSS: Main: 377663488 04:39:25 INFO - PROCESS | 6252 | 04:42:28 INFO - PROCESS | 6252 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57190/tests/dromaeo/cssquery-prototype.html) 04:42:28 INFO - PROCESS | 6252 | RSS: Main: 335892480 04:42:28 INFO - PROCESS | 6252 | 04:45:31 INFO - PROCESS | 6252 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57190/tests/dromaeo/cssquery-yui.html) 04:45:32 INFO - PROCESS | 6252 | RSS: Main: 337879040 04:45:32 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | Cycle 1(1): loaded http://localhost:57190/tests/dromaeo/cssquery-yui.html (next: http://localhost:57190/tests/dromaeo/cssquery-dojo.html) 04:48:35 INFO - PROCESS | 6252 | RSS: Main: 383643648 04:48:35 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | __start_tp_report 04:48:35 INFO - PROCESS | 6252 | _x_x_mozilla_page_load 04:48:35 INFO - PROCESS | 6252 | _x_x_mozilla_page_load_details 04:48:35 INFO - PROCESS | 6252 | |i|pagename|runs| 04:48:35 INFO - PROCESS | 6252 | |0;dojo.html;3388.796672199668;3411.3518431498014;3449.7757645753018;3456.948145777812;3492.8952131436067;5598.552115830734;5629.071203251464;5630.239917611127;5668.121441176619;5694.316681998155;5276.472352764722;5323.787048518055;5707.486326230638;5717.485426311631;5730.169125476803;5145.151050076733;5166.948330516694;5196.818111366103;5202.375714914216;5289.947100528984;5268.868278293035;5285.180796976456;5318.574514038867;5337.599680023995;5379.408265090837;5076.010178015288;5124.103281925648;5174.43081261061;5177;5257.474252574751;5201.661891977047;5204.9479505204845;5221.556167725748;5223.608229382811;5232.2413250078525;5139.897202055975;5188.766505507224;5191.351081114861;5199.116150254428;5202.557782588447;5461.781528738846;5527.309086364205;5569.136783798477;5617.606767526275;5642.943570564283;6186.443220110212;6201.16284301618;6205.844853878689;6211.689415529206;6223.7821676241565;5158.380994280673;6119.755209791603;6253.280872699653;6253.499720022387;6286.057091436275;5712.171735098387;5743.0811070228565;5746.109353050284;5811.535077193899;5851.970740146315;6281.120643109968;6290.24517057956;6302.684865756693;6320.5891617044745;6321.905171422432;5963.522918166536;6013.909791353133;6088.512918966472;6100.786472473531;6101.023836186189;6151.015837465984;6220.440160385587;6263.248410190807;6263.467605253604;6269.498440124779;5636.464535869086;6077.513798896078;6148.385161483905;6177.7837775677635;6199.28708198563;6053.092036194518;6100.914243738774;6132.171952247653;6180.949238629444;6184.312258386332;4851.248056551241;4851.708897466164;4858.246971719389;4882.511748825089;4891.951080489221;4347.195768782785;4349.3041113421705;4355.3684715716045;4391.802368893407;4426.75652839097;4996;5401.406585057418;5521.503064724194;5548.833534993957;5657.066584013592;6160.784372546939;6177.2587289524645;6177.876442471125;6178;6199.380061993765;5598.916016259759;5604.495595396434;5615.326160860723;5619.438056194348;5630.6058575900115;5320.813771517978;5324.520793128637;5337.01265265927;5337.6797392156595;5367.812126575551;5820.923129221108;6222.968885155546;6243.125962365272;6276.9372306276355;6283.277423096311;6284.622922624657;6302.873942521215;6305.684715764285;6316.084167795736;6320.747170113328;6237.781677641261;6282.528810339334;6297.433231009231;6326.525510586816;6351.650659213788;6120.357362476876;6160.045192995093;6183.505319574333;6213.378662133931;6215.06773983906;6242.625442473284;6253.499720022478;6269.279032911274;6270.811875643738;6274.215723034621;5898.616589921641;5922.851928701817;6034.487068599218;6041.728122234598;6094.177286066501;5098.2352647103235;6050.122732203894;6123.510119190365;6133.426475724657;6139.338817383189;5896.321922978741;5923.318818335774;5946.73239704223;5953.374895636069;5966.970165149147;5862.970685146547;6022.759089636365;6066.484348830222;6095.1771510845465;6105.236845394325;4871.658983871095;5899.852503687443;5933.673647949404;5939.168516407793;5944.078667806497 04:48:35 INFO - PROCESS | 6252 | |1;ext.html;487.73418486924623;565.8161097643265;578.3060327606871;607.4290167242791;611.2329027071025;29754;38086.809565952164;38342;38383;38420;41841.58158418415;42144.73565793031;42445;42537.36193957093;42617.573824261744;9538.236941044734;9780.462074585896;9787.217022638171;9793.510324483746;9811.067948544913;9572.569234384435;9722.756931076745;9729.124378805906;9738.610455581767;9804.362716423446;9791.167750741195;9858.90141098587;9881.308308418413;9883.604655813759;9886.961869003759;9772.511374431286;9845.360051596623;9871.703848884508;9873.703788886345;9882.308238423313;9734.318597698164;9873.506324683736;9874.012598740068;9876.35803672759;9881.418972964362;40215.597844021475;40627.390589141185;40685.79657101695;40717.185656287;40719.38920916188;3158.921026974344;3182.8885988990273;3318.3197444523817;3519.4720791881423;3712.1462063725494;26613.46773064528;26931.73068269312;27781.722182778114;27979.300517487023;27997.300067498272;2769.9584506232422;2799.174243598143;2845.4593627210766;2860.5280128778727;2884.927876803076;380331;380673.09663451783;380732;380914;383406.9999999972;57798.8440231193;59338.51653708692;67343.66328168327;67821;69037.65481172562;63955;64591.677041614494;64848;64852.35147648557;64955.67522162359;16373.91813040927;16568;16593.917030415014;16596.58508537296;16625.00249985005;11698.122640801974;11880.40597970098;12729.236245825095;12861.228326300452;12936.223826570436;20354.982250887395;20680.069396877177;20797.688034679493;20805;20856.374308770763;7915.287624113857;8069.959650201711;8106.594670266463;8115.594220288962;8186.099529051799;990.8810942686923;1019.2406657040405;1024.8923862994427;1028.747956750586;1122.6528166200592;30425.087247382613;30496.54255186174;30565.69434305673;31212.68787312143;31231;1025.7692019295748;1070.55571937645;1086.093112251279;1109;1113.6269349767756;14777.113373197642;14855.628609284855;14918.328675209641;15071.307529655305;15126.697466050617;539970;543823;544919;545407.2729636326;545739;58143.70928145417;58483.70758146182;58538.70730646405;58604.70697646485;58652.4134758647;1415.971680566383;1418.6169734171715;1446.9638259043609;1452.4480697335157;1452.832924213729;29358.119256422342;29452.410951781272;29568.704312956594;29585.798816567636;29925.700742992292;51734.70663233449;52239.73880130575;52286;52307.21539176839;52314.738426309144;427684;428741.856290729;430913;431281;431443;27969;32391.190220244684;32581.34837303288;33023;33193.00420987374;39487.407688884115;40199.59800401959;40553.59446405498;40574.59425405826;43130.56869431391;35620.28759424745;35930.64069359273;36790.63209367872;36991.445128323634;36994.26011479701;28151.71848281573;31370.372592547566;31684;35688.643113568534;36508;34631.13422164466;34805.65194348024;34844.477332840535;34849.65150348566;34874;29181.314676437796;31662.05013849588;33061.03790272861;33250.33499330048;33437;24214.636780448658;24940.251792446255;24997.750022499542;25037.998480060593;25500.744992549837 04:48:35 INFO - PROCESS | 6252 | |2;jquery.html;353.9876104336348;360.7150351222534;362.3495824994137;365.242122595614;371.32789650732195;14703;14967.25163741814;19548.706769398454;19942;20408.693869591967;19066.33267835626;19265.133069011892;19500.317488887893;20220.09009594568;20265;5623.606347555673;5830.562707796911;5830.883382332351;5843.065109582468;5845.8830823383505;4186.141840922619;4292.1630282095;4344.196323680129;5752.734398432338;5767.971160144193;4336.588024137718;4337.457817772778;4343.283358245885;4345.739255644671;4351.934720979188;4323.697341186118;6181.783637572708;6250.218722659668;6309.810705678837;6353.30113687494;5501.5323697485765;5505.476979686923;5506.862328441781;5513.7794488220425;5514.200440936042;12773.105882588223;13228.470861165542;13238.139520931109;13250.602481925558;13255.337233138305;2076.3874656976227;2088.8642238254465;2137.925172618951;2209.4807720185904;2251.819854411643;9302.047466951044;9466;9476.336656434052;9846.803063938682;9979;1741.0511271357013;1742.4551691177173;1776.67131580658;1800.9549761255942;1844.1332573690345;71287.96962430036;81478.77781833218;84333;97131;98447.50776246072;10767.730806729895;10853.945730271298;10897.67306980792;10917.017468427879;11257.324560526395;13206.669833254246;13316.201027938161;13320.533781317801;13344.933275333562;13368.33158342079;8291.668333266722;8330.500169989698;8387.664493420318;8552.914470855212;8574.056853746082;8506.65973361071;8523.872141917876;8550.914490855137;8638.395312328203;8690.348223883235;4246.002189485468;4410.360497727812;4500.909981800346;4529.547045295444;4542.227821270392;1566.490890460582;1817.7818661760673;1875.4279944617024;1881.2192939929776;1894.7821000584834;782.7886470652892;873.76845136039;886.4858382138344;906.5331354352513;955.7849483866074;19069.713954290695;20087.799122008884;20270.797292027186;21079.313654907877;21088.789112108683;940.9200217981411;963.1620490173594;963.2919803944095;966.9129778319844;973.3040875773855;9080.727578172666;10650.254482186172;10729;10981.670549883516;11421;507302;519565;524658;525178;638543;114246;115026.1845077071;121821.39089304674;123023;126564;992.513668302541;998.8064263205545;1047.4343854318583;1048;1050.968470945873;14958.626034349229;17240.051797151278;18163.909180454542;18261.08694565293;18453.169607367432;38119.04702382463;48904.75547622239;49238.261426079356;50048.24927626162;50150.24774628311;66262;66286.00570991535;70978;74337.51324973578;75701.48597028138;7503.9249607503225;7762.7671169865;7928.563928983961;7971.681132754625;7996.60016999136;10286.897131028893;10461.372317660966;12429.005679545795;12429.627111186317;12512.249265044127;8649.437786543855;10284.434356110485;10877.075448586958;10947.288426252268;11111.277766945122;10632.734181645521;10679.199060070681;10731.946340268249;10780.568777248822;10840.186985975926;10979.39613321275;11008.889911100787;11091.889081109086;11236;11361.829572556584;7493.550386976799;7582.241775822374;7784.9610751945875;7819.452638315263;7829.29536341732;9630.32587718853;10705.250632455965;10794.56821727122;10958.671239862817;10974.615888443866 04:48:35 INFO - PROCESS | 6252 | |3;mootools.html;1388.9652758681025;1537.231384307846;1541.4142625802194;1769.6106856491576;1919.1555715485194;7923.683052677893;8558.015828179761;8697.434666746656;8711.0417854036;8717.564121793901;8439.11389304122;8722.60748266328;8733.563321833899;8733.91266087339;8736.301095912328;2184.8907554622206;2236.6421372580307;2406.205952035824;2462.3967128053605;2485.8632775197357;2441.438469152096;2477.938051548717;2478.5910324796387;2479.2438306316567;2481.950360992779;2452.1294940296207;2479.293401380607;2480.491499242651;2484.291976786616;2486.1298545509107;2418.2382549496942;2445.1441995301593;2464.938376540583;2469.4937537804885;2472.344828620417;2439.2194497760725;2440.389902524369;2457.0908763757348;2457.1400009996537;2458.840175388594;8743.650253989832;8815.691450799255;8816.20654141124;8823.426477279021;8834.160754728291;4485.730856148642;5476.890462190734;5509.063459211943;5543.584231182677;5552.666839989613;3621.492990981265;3659.634036596319;3696.1129328961124;3699.038250055005;3716.4796928429773;1037.823569993103;1040.9375437473775;1050.4800123938699;1083.4691001409253;1088.7332603512111;12085.637430877088;12100.092493063055;12115.212511186834;12115.575954841539;12131.332776697278;4778.474367819537;4915.459299477055;4917.0903382874285;4956.628252880976;4997.075541024922;9285;10307.226957978031;10321.63874264397;10324.43215623148;10337.638182663572;5502.504774570308;5524.171374293888;5539.14143307788;5541.778328866801;5551.694656793915;4954.984228233204;4971.4282857471135;4975.502449754996;5021.748912554431;5029.371328583927;3946.8026598670526;3953.6244056814558;3956.1098752780395;3994.6404823565435;4030.879073627796;1273.1088238233274;1274.9235045897276;1281.090425797694;1284.2037936479442;1287.5557932513268;1280.6990357266036;1297.2929753284482;1324.5165514587106;1366.132505858767;1368.8494265630773;8126.796830079295;8158.306543943712;8376.49741015541;8389.454685445426;8389.916100839035;1168.7253495428567;1179.4574495731888;1183.6094088950626;1183.650823007215;1200.7298357869583;6290.937090629035;6327.588706734047;6353.0152826312;6363.872722545616;6371.713272902731;10281.897181028244;10613.0448259657;10620.734481638021;10633.680989570325;10744.247902646895;10039.598416063276;10636.946815265874;10639.255252132276;10672.719273687208;10767;8102.797430064177;8213.301869341172;8322.375821813388;8337.83324333522;8347.081820999685;8032;8032.518048917083;8140.267375936194;8158.755237342889;8181.468204566684;9437.150656440954;9473.763155921157;9676.080772326617;9692.030796920251;9767.902320976984;9635.084666956627;9836.016398360392;9844.261680374144;9946.850797238192;10002.799944001225;6772.55978361405;6997.160340759141;7241.927580724336;7431.851362972819;7449.962750186214;8232.34141268709;8242.010958684996;8264.586770661323;8265.140343422681;8276.627551760064;6333.8733225336155;7135.464840136907;7381.852362952818;7435.144958329645;7443.255674432514;6374.139491168633;7206.855862882818;7248.693636536247;7260.745873894389;7393.667284972296;7637.274458926393;7690.2694244046725;7719.343855772097;7737.961310193413;7800.141984381827;6935.861282774417;6938.993845892418;7014.508984371045;7023.122109736283;7072.398846098139;7109.644517773987;7134;7159.606221657858;7176.246494118252;7178 04:48:35 INFO - PROCESS | 6252 | |4;prototype.html;278.81737461962416;325.99837000815006;327.7623722800969;328.9210589458531;334.6185348702481;6510.967445162773;6633.303503132162;6713.462922966163;6735.797926062214;6743.9662801686045;5410.594205434599;6623.668816559165;6720.966395168018;6729.629870357128;6753.898691519631;4663.300504924255;4752.12085764133;4770.379850619414;4928.1868491698915;4938.604911607063;4634.791434385444;4772.236442169254;4843.491433399495;4849.272609108627;4875.195592727196;4166.9791651041705;4501.302298143776;4776.164171270031;4788.162071637467;4801.951980480203;4592;4779.689320194194;4783.928241076386;4789.760511974388;4813.302071199656;3997.5402828674783;4086;4096.610821971908;4098.856540021085;4103.158852435244;6315.74737010519;6343.936560634381;6412.5190610704385;6417.8395540111405;6441.291457939623;4836.41962964443;5581.386047534768;5597.888042239173;5606.187102870102;5610.859728506779;7042.330978557029;7058.964705176441;7061.9293807062295;7085.50401471892;7093.92906070943;3650.5619325680823;4115.765270418862;4415.955840441587;4423.447069116361;4430.756308403036;7169.928300717031;7220.530665506778;7225.385842203419;7348.742794002238;7412.740554080581;4538.795754191069;4554.453465584085;4558.475775285819;4561.407017087758;4566.977165114153;4521.982553925341;4630.930536041962;4658.883527911829;4679.953200467951;4686.437627484724;4904.43598986114;5176.482351764868;5534.640248383923;5544.7782088716;5553.1670249462095;7114.50198486101;7123.786286411416;7128.287171282934;7134.750283740148;7137.964310178416;1630.1441743084974;1648.2170968789728;1648.7939007624047;1650.026484374225;1651.8348165183627;841.6927821345288;1039.095986491742;1052.2634156090767;1059.3590877519143;1065.8827528971963;6744.393004629607;6772.5936443813525;6780.016897549827;6801.727930882808;6823.624700641512;7599;7604.657790399335;7606.923930760732;7617.200193979663;7621.771346859603;6453.161089058486;6653.767118150841;6746.055552222692;6752.054712340277;6761.053452516651;4005.319095753729;4048.777317247521;4056.9594304057173;4057.229126466021;4059.4316795648633;8039.5176289422825;8042.879356809653;8055.355571554262;8061.87907181381;8065.475744076616;7697.499662521918;7995.200479952075;7998.200179982072;8001.1198768135455;8014.998125234346;8001.959745233083;8011.959940200261;8045.678172873019;8046.919530804851;8064.153263907323;7224.674889629874;7683.846323073395;7692.19231980634;7693.115291741521;7702.691892324468;7200.243974382824;7240.674169662483;7246.565206087652;7257.891131633135;7260.96369518149;6431.646259455588;7775.922240777746;7802.258785415376;7814.492058016211;7824.1002284735705;4104.035551645301;4283.164782867436;4613.638976501873;4673.532646735299;4700.55344742249;7411.888821667571;7437.107547094383;7452.701891924479;7454.030975973305;7466.925330746841;7116.893246601202;7126;7141.750038748619;7145.285471453021;7183.604901730246;5926.814637072689;6227.439530442282;6541.313162118099;7116.644167791694;7154.213036566078;6538.83652908662;6991.40573051276;7012.6844292008;7018.438524917892;7035.12060992376;7132;7163.707613563818;7179.533330333512;7179.964100179465;7204.603746793767;6755.695993680198;7024.26245244242;7033.156021277479;7036.788896333118;7039.120109986252 04:48:35 INFO - PROCESS | 6252 | |5;yui.html;662.1425254295688;674.4368452342294;698.786870004649;709.3580309819612;728.6356821589205;14830;15055.247237638116;15062.77405838912;15064.548063558083;15069.547913562583;13644.113132646371;13738.931305343483;15580.84419155808;16013.759793603105;16060.03639781611;858.995705021474;876.0757400942003;876.3733930239878;876.8640860666607;880.067128843428;704.6124631452706;713.932176443237;714.4641518860855;715.3275920634587;718.1633397092381;747.1631772414876;904.4347282948157;924.3483344242293;925.2782829393051;926.7544100813257;898.7753061734567;914.7530166854946;915.0757734687979;918.6187732091174;918.8392031394479;544.0859356281445;550.7191332420495;667.8029981155571;672.0222076878131;673.6598018000878;15202.46791362297;15213.239338033054;15229.771553426708;15243.16162611056;15287.312070956723;12121.33332666703;12207.328596927166;12272.202306850115;12313.75372492554;12614.936925315315;9981.850272245922;10070.496475176285;10101.292909496338;10106.545205465773;10111.646092386805;3400.931981360384;3471.444568868994;3475.2701932594186;3477.0611934777467;3479.704225140866;83626.16373836245;85126.57436712839;85290;85579;85763.57118214431;9265.95367023174;9302.95348523253;9497.335186536877;9560.235181185488;9656.32405731592;15834.445794397141;16938.576535586708;20689.58620827575;20708.79291207099;20721.27475538349;7304.671289791972;7343.1555371131935;7480.775576732598;7697.461177717506;7781.688732450752;4181.372794080851;4206.537280899099;4213.346931225604;4229.661627069827;4234.174336004449;3543.8936831895085;3591.1560783215923;3594.892153235407;3600.6579374959338;3602.657747513982;624.3756243756244;639.338284875152;649.6849028221309;655.0109334904329;658.318640207383;550.3176061683483;585.6017907822636;587.9382664820217;595.7944509144338;636.3572791480545;6798.796036118924;7537.434692398092;8413.831723365498;8631.611577479029;8703.564821758886;492.15840912040096;504.60892808073305;529.8701818054524;532.1884126706803;630.5397060146119;3901.8439262429183;4014.437978682987;4316.740995540277;4345.435093437833;4368.257396242647;86501;87830.68253976195;88202;88256.558717206;102330.48834755778;83459.74810377849;83579.58210209031;83907;85554.57222713971;87046;75960;76816.23183768202;76987.84518232231;77895.61052194703;78482.6075869617;8754.649814007369;8805.408266179425;8922.063183365914;8992.550372481219;9115;50505.49494505008;51192;51359.486405136966;52205.47794522006;52821;49771;67685;70958.93561596477;72464.27535724787;73463.26536734564;11412.885871141183;11443.25618834773;11598.88401115978;11626.88373116258;11983.520659173535;12086.15396922207;12094.092943029133;12097.153199275966;12114.878851211375;12117.939410302892;11554;11574.247673901169;11589.130815188726;11589.478473468882;11597.304161750322;11520.769584608428;11571.19001669875;11582.305061696325;11582.594609188638;11598.362090085126;11372.772544548898;11414.771704566028;11426.485808138488;11438.084953203557;11442.485088170886;7917.327027202752;8906.910930890608;9094.136057074567;9645.662401815904;10443.321184123008;10109.34289271195;10145.695629131138;10193.949030254802;10248.948755256177;10337.84493232587 04:48:35 INFO - PROCESS | 6252 | __end_tp_report 04:48:35 INFO - PROCESS | 6252 | __start_cc_report 04:48:35 INFO - PROCESS | 6252 | _x_x_mozilla_cycle_collect,1228 04:48:35 INFO - PROCESS | 6252 | __end_cc_report 04:48:35 INFO - PROCESS | 6252 | __startTimestamp1455886115441__endTimestamp 04:48:35 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | ------- Summary: start ------- 04:48:35 INFO - PROCESS | 6252 | Number of tests: 6 04:48:35 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | [#0] dojo.html Cycles:165 Average:5686.23 Median:5898.62 stddev:634.39 (10.8%) stddev-sans-first:610.19 04:48:35 INFO - PROCESS | 6252 | Values: 3388.8 3411.4 3449.8 3456.9 3492.9 5598.6 5629.1 5630.2 5668.1 5694.3 5276.5 5323.8 5707.5 5717.5 5730.2 5145.2 5166.9 5196.8 5202.4 5289.9 5268.9 5285.2 5318.6 5337.6 5379.4 5076.0 5124.1 5174.4 5177.0 5257.5 5201.7 5204.9 5221.6 5223.6 5232.2 5139.9 5188.8 5191.4 5199.1 5202.6 5461.8 5527.3 5569.1 5617.6 5642.9 6186.4 6201.2 6205.8 6211.7 6223.8 5158.4 6119.8 6253.3 6253.5 6286.1 5712.2 5743.1 5746.1 5811.5 5852.0 6281.1 6290.2 6302.7 6320.6 6321.9 5963.5 6013.9 6088.5 6100.8 6101.0 6151.0 6220.4 6263.2 6263.5 6269.5 5636.5 6077.5 6148.4 6177.8 6199.3 6053.1 6100.9 6132.2 6180.9 6184.3 4851.2 4851.7 4858.2 4882.5 4892.0 4347.2 4349.3 4355.4 4391.8 4426.8 4996.0 5401.4 5521.5 5548.8 5657.1 6160.8 6177.3 6177.9 6178.0 6199.4 5598.9 5604.5 5615.3 5619.4 5630.6 5320.8 5324.5 5337.0 5337.7 5367.8 5820.9 6223.0 6243.1 6276.9 6283.3 6284.6 6302.9 6305.7 6316.1 6320.7 6237.8 6282.5 6297.4 6326.5 6351.7 6120.4 6160.0 6183.5 6213.4 6215.1 6242.6 6253.5 6269.3 6270.8 6274.2 5898.6 5922.9 6034.5 6041.7 6094.2 5098.2 6050.1 6123.5 6133.4 6139.3 5896.3 5923.3 5946.7 5953.4 5967.0 5863.0 6022.8 6066.5 6095.2 6105.2 4871.7 5899.9 5933.7 5939.2 5944.1 04:48:35 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | [#1] ext.html Cycles:180 Average:60215.86 Median:380502.05 stddev:121335.72 (31.9%) stddev-sans-first:121593.23 04:48:35 INFO - PROCESS | 6252 | Values: 487.7 565.8 578.3 607.4 611.2 29754.0 38086.8 38342.0 38383.0 38420.0 41841.6 42144.7 42445.0 42537.4 42617.6 9538.2 9780.5 9787.2 9793.5 9811.1 9572.6 9722.8 9729.1 9738.6 9804.4 9791.2 9858.9 9881.3 9883.6 9887.0 9772.5 9845.4 9871.7 9873.7 9882.3 9734.3 9873.5 9874.0 9876.4 9881.4 40215.6 40627.4 40685.8 40717.2 40719.4 3158.9 3182.9 3318.3 3519.5 3712.1 26613.5 26931.7 27781.7 27979.3 27997.3 2770.0 2799.2 2845.5 2860.5 2884.9 380331.0 380673.1 380732.0 380914.0 383407.0 57798.8 59338.5 67343.7 67821.0 69037.7 63955.0 64591.7 64848.0 64852.4 64955.7 16373.9 16568.0 16593.9 16596.6 16625.0 11698.1 11880.4 12729.2 12861.2 12936.2 20355.0 20680.1 20797.7 20805.0 20856.4 7915.3 8070.0 8106.6 8115.6 8186.1 990.9 1019.2 1024.9 1028.7 1122.7 30425.1 30496.5 30565.7 31212.7 31231.0 1025.8 1070.6 1086.1 1109.0 1113.6 14777.1 14855.6 14918.3 15071.3 15126.7 539970.0 543823.0 544919.0 545407.3 545739.0 58143.7 58483.7 58538.7 58604.7 58652.4 1416.0 1418.6 1447.0 1452.4 1452.8 29358.1 29452.4 29568.7 29585.8 29925.7 51734.7 52239.7 52286.0 52307.2 52314.7 427684.0 428741.9 430913.0 431281.0 431443.0 27969.0 32391.2 32581.3 33023.0 33193.0 39487.4 40199.6 40553.6 40574.6 43130.6 35620.3 35930.6 36790.6 36991.4 36994.3 28151.7 31370.4 31684.0 35688.6 36508.0 34631.1 34805.7 34844.5 34849.7 34874.0 29181.3 31662.1 33061.0 33250.3 33437.0 24214.6 24940.3 24997.8 25038.0 25500.7 04:48:35 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | [#2] jquery.html Cycles:180 Average:31318.47 Median:21152.59 stddev:90680.15 (428.7%) stddev-sans-first:90904.72 04:48:35 INFO - PROCESS | 6252 | Values: 354.0 360.7 362.3 365.2 371.3 14703.0 14967.3 19548.7 19942.0 20408.7 19066.3 19265.1 19500.3 20220.1 20265.0 5623.6 5830.6 5830.9 5843.1 5845.9 4186.1 4292.2 4344.2 5752.7 5768.0 4336.6 4337.5 4343.3 4345.7 4351.9 4323.7 6181.8 6250.2 6309.8 6353.3 5501.5 5505.5 5506.9 5513.8 5514.2 12773.1 13228.5 13238.1 13250.6 13255.3 2076.4 2088.9 2137.9 2209.5 2251.8 9302.0 9466.0 9476.3 9846.8 9979.0 1741.1 1742.5 1776.7 1801.0 1844.1 71288.0 81478.8 84333.0 97131.0 98447.5 10767.7 10853.9 10897.7 10917.0 11257.3 13206.7 13316.2 13320.5 13344.9 13368.3 8291.7 8330.5 8387.7 8552.9 8574.1 8506.7 8523.9 8550.9 8638.4 8690.3 4246.0 4410.4 4500.9 4529.5 4542.2 1566.5 1817.8 1875.4 1881.2 1894.8 782.8 873.8 886.5 906.5 955.8 19069.7 20087.8 20270.8 21079.3 21088.8 940.9 963.2 963.3 966.9 973.3 9080.7 10650.3 10729.0 10981.7 11421.0 507302.0 519565.0 524658.0 525178.0 638543.0 114246.0 115026.2 121821.4 123023.0 126564.0 992.5 998.8 1047.4 1048.0 1051.0 14958.6 17240.1 18163.9 18261.1 18453.2 38119.0 48904.8 49238.3 50048.2 50150.2 66262.0 66286.0 70978.0 74337.5 75701.5 7503.9 7762.8 7928.6 7971.7 7996.6 10286.9 10461.4 12429.0 12429.6 12512.2 8649.4 10284.4 10877.1 10947.3 11111.3 10632.7 10679.2 10731.9 10780.6 10840.2 10979.4 11008.9 11091.9 11236.0 11361.8 7493.6 7582.2 7785.0 7819.5 7829.3 9630.3 10705.3 10794.6 10958.7 10974.6 04:48:35 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | [#3] mootools.html Cycles:180 Average:6068.31 Median:5253.13 stddev:3178.85 (60.5%) stddev-sans-first:3168.31 04:48:35 INFO - PROCESS | 6252 | Values: 1389.0 1537.2 1541.4 1769.6 1919.2 7923.7 8558.0 8697.4 8711.0 8717.6 8439.1 8722.6 8733.6 8733.9 8736.3 2184.9 2236.6 2406.2 2462.4 2485.9 2441.4 2477.9 2478.6 2479.2 2482.0 2452.1 2479.3 2480.5 2484.3 2486.1 2418.2 2445.1 2464.9 2469.5 2472.3 2439.2 2440.4 2457.1 2457.1 2458.8 8743.7 8815.7 8816.2 8823.4 8834.2 4485.7 5476.9 5509.1 5543.6 5552.7 3621.5 3659.6 3696.1 3699.0 3716.5 1037.8 1040.9 1050.5 1083.5 1088.7 12085.6 12100.1 12115.2 12115.6 12131.3 4778.5 4915.5 4917.1 4956.6 4997.1 9285.0 10307.2 10321.6 10324.4 10337.6 5502.5 5524.2 5539.1 5541.8 5551.7 4955.0 4971.4 4975.5 5021.7 5029.4 3946.8 3953.6 3956.1 3994.6 4030.9 1273.1 1274.9 1281.1 1284.2 1287.6 1280.7 1297.3 1324.5 1366.1 1368.8 8126.8 8158.3 8376.5 8389.5 8389.9 1168.7 1179.5 1183.6 1183.7 1200.7 6290.9 6327.6 6353.0 6363.9 6371.7 10281.9 10613.0 10620.7 10633.7 10744.2 10039.6 10636.9 10639.3 10672.7 10767.0 8102.8 8213.3 8322.4 8337.8 8347.1 8032.0 8032.5 8140.3 8158.8 8181.5 9437.2 9473.8 9676.1 9692.0 9767.9 9635.1 9836.0 9844.3 9946.9 10002.8 6772.6 6997.2 7241.9 7431.9 7450.0 8232.3 8242.0 8264.6 8265.1 8276.6 6333.9 7135.5 7381.9 7435.1 7443.3 6374.1 7206.9 7248.7 7260.7 7393.7 7637.3 7690.3 7719.3 7738.0 7800.1 6935.9 6939.0 7014.5 7023.1 7072.4 7109.6 7134.0 7159.6 7176.2 7178.0 04:48:35 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | [#4] prototype.html Cycles:180 Average:5817.09 Median:6717.21 stddev:1937.18 (28.8%) stddev-sans-first:1897.49 04:48:35 INFO - PROCESS | 6252 | Values: 278.8 326.0 327.8 328.9 334.6 6511.0 6633.3 6713.5 6735.8 6744.0 5410.6 6623.7 6721.0 6729.6 6753.9 4663.3 4752.1 4770.4 4928.2 4938.6 4634.8 4772.2 4843.5 4849.3 4875.2 4167.0 4501.3 4776.2 4788.2 4802.0 4592.0 4779.7 4783.9 4789.8 4813.3 3997.5 4086.0 4096.6 4098.9 4103.2 6315.7 6343.9 6412.5 6417.8 6441.3 4836.4 5581.4 5597.9 5606.2 5610.9 7042.3 7059.0 7061.9 7085.5 7093.9 3650.6 4115.8 4416.0 4423.4 4430.8 7169.9 7220.5 7225.4 7348.7 7412.7 4538.8 4554.5 4558.5 4561.4 4567.0 4522.0 4630.9 4658.9 4680.0 4686.4 4904.4 5176.5 5534.6 5544.8 5553.2 7114.5 7123.8 7128.3 7134.8 7138.0 1630.1 1648.2 1648.8 1650.0 1651.8 841.7 1039.1 1052.3 1059.4 1065.9 6744.4 6772.6 6780.0 6801.7 6823.6 7599.0 7604.7 7606.9 7617.2 7621.8 6453.2 6653.8 6746.1 6752.1 6761.1 4005.3 4048.8 4057.0 4057.2 4059.4 8039.5 8042.9 8055.4 8061.9 8065.5 7697.5 7995.2 7998.2 8001.1 8015.0 8002.0 8012.0 8045.7 8046.9 8064.2 7224.7 7683.8 7692.2 7693.1 7702.7 7200.2 7240.7 7246.6 7257.9 7261.0 6431.6 7775.9 7802.3 7814.5 7824.1 4104.0 4283.2 4613.6 4673.5 4700.6 7411.9 7437.1 7452.7 7454.0 7466.9 7116.9 7126.0 7141.8 7145.3 7183.6 5926.8 6227.4 6541.3 7116.6 7154.2 6538.8 6991.4 7012.7 7018.4 7035.1 7132.0 7163.7 7179.5 7180.0 7204.6 6755.7 7024.3 7033.2 7036.8 7039.1 04:48:35 INFO - PROCESS | 6252 | 04:48:35 INFO - PROCESS | 6252 | [#5] yui.html Cycles:180 Average:18785.45 Median:538.14 stddev:26774.61 (4975.4%) stddev-sans-first:26815.14 04:48:35 INFO - PROCESS | 6252 | Values: 662.1 674.4 698.8 709.4 728.6 14830.0 15055.2 15062.8 15064.5 15069.5 13644.1 13738.9 15580.8 16013.8 16060.0 859.0 876.1 876.4 876.9 880.1 704.6 713.9 714.5 715.3 718.2 747.2 904.4 924.3 925.3 926.8 898.8 914.8 915.1 918.6 918.8 544.1 550.7 667.8 672.0 673.7 15202.5 15213.2 15229.8 15243.2 15287.3 12121.3 12207.3 12272.2 12313.8 12614.9 9981.9 10070.5 10101.3 10106.5 10111.6 3400.9 3471.4 3475.3 3477.1 3479.7 83626.2 85126.6 85290.0 85579.0 85763.6 9266.0 9303.0 9497.3 9560.2 9656.3 15834.4 16938.6 20689.6 20708.8 20721.3 7304.7 7343.2 7480.8 7697.5 7781.7 4181.4 4206.5 4213.3 4229.7 4234.2 3543.9 3591.2 3594.9 3600.7 3602.7 624.4 639.3 649.7 655.0 658.3 550.3 585.6 587.9 595.8 636.4 6798.8 7537.4 8413.8 8631.6 8703.6 492.2 504.6 529.9 532.2 630.5 3901.8 4014.4 4316.7 4345.4 4368.3 86501.0 87830.7 88202.0 88256.6 102330.5 83459.7 83579.6 83907.0 85554.6 87046.0 75960.0 76816.2 76987.8 77895.6 78482.6 8754.6 8805.4 8922.1 8992.6 9115.0 50505.5 51192.0 51359.5 52205.5 52821.0 49771.0 67685.0 70958.9 72464.3 73463.3 11412.9 11443.3 11598.9 11626.9 11983.5 12086.2 12094.1 12097.2 12114.9 12117.9 11554.0 11574.2 11589.1 11589.5 11597.3 11520.8 11571.2 11582.3 11582.6 11598.4 11372.8 11414.8 11426.5 11438.1 11442.5 7917.3 8906.9 9094.1 9645.7 10443.3 10109.3 10145.7 10193.9 10248.9 10337.8 04:48:35 INFO - PROCESS | 6252 | -------- Summary: end -------- 04:48:35 INFO - PROCESS | 6252 | 04:48:36 INFO - TEST-INFO | 6252: exit 0 04:48:36 INFO - TEST-OK | dromaeo_css | took 1114253ms 04:48:36 INFO - TEST-START | kraken 04:48:36 INFO - operating with platform_type : mac_ 04:48:36 INFO - Initialising browser for kraken test... 04:48:36 INFO - TEST-INFO | started process 6254 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpmlXtMe/profile http://localhost:57190/getInfo.html) 04:48:38 INFO - PROCESS | 6254 | __metrics Screen width/height:1600/1200 04:48:38 INFO - PROCESS | 6254 | colorDepth:24 04:48:38 INFO - PROCESS | 6254 | Browser inner width/height: 1024/689 04:48:38 INFO - PROCESS | 6254 | __metrics 04:48:38 INFO - PROCESS | 6254 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:48:38 INFO - PROCESS | 6254 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:48:38 INFO - TEST-INFO | 6254: exit 0 04:48:38 INFO - Browser initialized. 04:48:38 INFO - Running cycle 1/1 for kraken test... 04:48:38 INFO - TEST-INFO | started process 6256 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/tmpmlXtMe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:50 INFO - PROCESS | 6256 | RSS: Main: 244531200 04:48:50 INFO - PROCESS | 6256 | 04:48:53 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-beat-detection) 04:48:53 INFO - PROCESS | 6256 | RSS: Main: 290385920 04:48:53 INFO - PROCESS | 6256 | 04:48:56 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-dft) 04:48:57 INFO - PROCESS | 6256 | RSS: Main: 300756992 04:48:57 INFO - PROCESS | 6256 | 04:49:00 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-fft) 04:49:00 INFO - PROCESS | 6256 | RSS: Main: 284811264 04:49:00 INFO - PROCESS | 6256 | 04:49:02 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57190/tests/kraken/driver.html?testName=audio-oscillator) 04:49:03 INFO - PROCESS | 6256 | RSS: Main: 287162368 04:49:03 INFO - PROCESS | 6256 | 04:49:05 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:49:06 INFO - PROCESS | 6256 | RSS: Main: 287698944 04:49:06 INFO - PROCESS | 6256 | 04:49:08 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-darkroom) 04:49:09 INFO - PROCESS | 6256 | RSS: Main: 288276480 04:49:09 INFO - PROCESS | 6256 | 04:49:12 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57190/tests/kraken/driver.html?testName=imaging-desaturate) 04:49:13 INFO - PROCESS | 6256 | RSS: Main: 289665024 04:49:13 INFO - PROCESS | 6256 | 04:49:15 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57190/tests/kraken/driver.html?testName=json-parse-financial) 04:49:16 INFO - PROCESS | 6256 | RSS: Main: 290983936 04:49:16 INFO - PROCESS | 6256 | 04:49:18 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57190/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:18 INFO - PROCESS | 6256 | RSS: Main: 322428928 04:49:18 INFO - PROCESS | 6256 | 04:49:20 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:49:21 INFO - PROCESS | 6256 | RSS: Main: 323448832 04:49:21 INFO - PROCESS | 6256 | 04:49:23 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:49:23 INFO - PROCESS | 6256 | RSS: Main: 331931648 04:49:23 INFO - PROCESS | 6256 | 04:49:26 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:49:26 INFO - PROCESS | 6256 | RSS: Main: 333393920 04:49:26 INFO - PROCESS | 6256 | 04:49:29 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:49:29 INFO - PROCESS | 6256 | RSS: Main: 333934592 04:49:29 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | Cycle 1(1): loaded http://localhost:57190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57190/tests/kraken/driver.html?testName=ai-astar) 04:49:31 INFO - PROCESS | 6256 | RSS: Main: 394010624 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | __start_tp_report 04:49:31 INFO - PROCESS | 6256 | _x_x_mozilla_page_load 04:49:31 INFO - PROCESS | 6256 | _x_x_mozilla_page_load_details 04:49:31 INFO - PROCESS | 6256 | |i|pagename|runs| 04:49:31 INFO - PROCESS | 6256 | |0;ai-astar;111;107;110;112;111;113;115;109;111;111 04:49:31 INFO - PROCESS | 6256 | |1;audio-beat-detection;156;122;164;193;146;143;142;123;161;121 04:49:31 INFO - PROCESS | 6256 | |2;audio-dft;186;183;188;185;185;185;185;187;183;177 04:49:31 INFO - PROCESS | 6256 | |3;audio-fft;88;87;85;80;58;57;57;85;77;55 04:49:31 INFO - PROCESS | 6256 | |4;audio-oscillator;91;93;129;79;110;125;153;94;78;116 04:49:31 INFO - PROCESS | 6256 | |5;imaging-gaussian-blur;85;91;85;91;85;91;84;91;84;92 04:49:31 INFO - PROCESS | 6256 | |6;imaging-darkroom;94;94;95;93;104;149;94;94;94;94 04:49:31 INFO - PROCESS | 6256 | |7;imaging-desaturate;85;100;133;142;85;85;88;85;91;85 04:49:31 INFO - PROCESS | 6256 | |8;json-parse-financial;56;52;53;52;53;55;53;63;52;52 04:49:31 INFO - PROCESS | 6256 | |9;json-stringify-tinderbox;64;65;79;76;71;66;66;68;66;68 04:49:31 INFO - PROCESS | 6256 | |10;stanford-crypto-aes;83;83;83;84;83;79;82;82;97;107 04:49:31 INFO - PROCESS | 6256 | |11;stanford-crypto-ccm;121;123;127;123;126;126;124;125;121;122 04:49:31 INFO - PROCESS | 6256 | |12;stanford-crypto-pbkdf2;134;128;140;137;138;126;137;139;140;137 04:49:31 INFO - PROCESS | 6256 | |13;stanford-crypto-sha256-iterative;66;66;65;67;67;66;67;68;66;67 04:49:31 INFO - PROCESS | 6256 | __end_tp_report 04:49:31 INFO - PROCESS | 6256 | __start_cc_report 04:49:31 INFO - PROCESS | 6256 | _x_x_mozilla_cycle_collect,1135 04:49:31 INFO - PROCESS | 6256 | __end_cc_report 04:49:31 INFO - PROCESS | 6256 | __startTimestamp1455886171856__endTimestamp 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | ------- Summary: start ------- 04:49:31 INFO - PROCESS | 6256 | Number of tests: 14 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:2.16 (1.9%) stddev-sans-first:2.29 04:49:31 INFO - PROCESS | 6256 | Values: 111.0 107.0 110.0 112.0 111.0 113.0 115.0 109.0 111.0 111.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:151.00 stddev:22.61 (15.0%) stddev-sans-first:23.75 04:49:31 INFO - PROCESS | 6256 | Values: 156.0 122.0 164.0 193.0 146.0 143.0 142.0 123.0 161.0 121.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:3.03 (1.6%) stddev-sans-first:3.15 04:49:31 INFO - PROCESS | 6256 | Values: 186.0 183.0 188.0 185.0 185.0 185.0 185.0 187.0 183.0 177.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#3] audio-fft Cycles:10 Average:72.90 Median:82.50 stddev:14.28 (17.3%) stddev-sans-first:14.06 04:49:31 INFO - PROCESS | 6256 | Values: 88.0 87.0 85.0 80.0 58.0 57.0 57.0 85.0 77.0 55.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:78.50 stddev:24.17 (30.8%) stddev-sans-first:24.96 04:49:31 INFO - PROCESS | 6256 | Values: 91.0 93.0 129.0 79.0 110.0 125.0 153.0 94.0 78.0 116.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:91.00 stddev:3.51 (3.9%) stddev-sans-first:3.56 04:49:31 INFO - PROCESS | 6256 | Values: 85.0 91.0 85.0 91.0 85.0 91.0 84.0 91.0 84.0 92.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#6] imaging-darkroom Cycles:10 Average:100.50 Median:94.00 stddev:17.33 (18.4%) stddev-sans-first:18.23 04:49:31 INFO - PROCESS | 6256 | Values: 94.0 94.0 95.0 93.0 104.0 149.0 94.0 94.0 94.0 94.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:85.00 stddev:21.50 (25.3%) stddev-sans-first:22.29 04:49:31 INFO - PROCESS | 6256 | Values: 85.0 100.0 133.0 142.0 85.0 85.0 88.0 85.0 91.0 85.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.00 stddev:3.41 (6.4%) stddev-sans-first:3.55 04:49:31 INFO - PROCESS | 6256 | Values: 56.0 52.0 53.0 52.0 53.0 55.0 53.0 63.0 52.0 52.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:68.00 stddev:4.98 (7.3%) stddev-sans-first:4.95 04:49:31 INFO - PROCESS | 6256 | Values: 64.0 65.0 79.0 76.0 71.0 66.0 66.0 68.0 66.0 68.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:83.00 stddev:8.71 (10.5%) stddev-sans-first:9.15 04:49:31 INFO - PROCESS | 6256 | Values: 83.0 83.0 83.0 84.0 83.0 79.0 82.0 82.0 97.0 107.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:124.50 stddev:2.15 (1.7%) stddev-sans-first:2.03 04:49:31 INFO - PROCESS | 6256 | Values: 121.0 123.0 127.0 123.0 126.0 126.0 124.0 125.0 121.0 122.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.60 Median:137.50 stddev:4.88 (3.5%) stddev-sans-first:5.14 04:49:31 INFO - PROCESS | 6256 | Values: 134.0 128.0 140.0 137.0 138.0 126.0 137.0 139.0 140.0 137.0 04:49:31 INFO - PROCESS | 6256 | 04:49:31 INFO - PROCESS | 6256 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 04:49:31 INFO - PROCESS | 6256 | Values: 66.0 66.0 65.0 67.0 67.0 66.0 67.0 68.0 66.0 67.0 04:49:31 INFO - PROCESS | 6256 | -------- Summary: end -------- 04:49:31 INFO - PROCESS | 6256 | 04:49:32 INFO - TEST-INFO | 6256: exit 0 04:49:32 INFO - TEST-OK | kraken | took 56535ms 04:49:32 INFO - SUITE-END | took 1170s 04:49:33 INFO - Completed test suite (00:19:31) 04:49:33 INFO - Working with test: dromaeo_css 04:49:33 INFO - Generating results file: dromaeo_css 04:49:33 INFO - Working with test: kraken 04:49:33 INFO - Generating results file: kraken 04:49:33 INFO - javascript benchmark 04:49:33 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:49:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 04:49:33 INFO - process_Request line: dromaeo_css 7459.00 graph.html#tests=[[72,64,59]] 04:49:33 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:49:33 INFO - process_Request line: kraken 1443.70 graph.html#tests=[[232,64,59]] 04:49:33 INFO - RETURN: dromaeo_css: 7459.00 04:49:33 INFO - RETURN: kraken: 1443.70 04:49:33 INFO - javascript benchmark 04:49:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3388.796672199668, 3411.3518431498014, 3449.7757645753018, 3456.948145777812, 3492.8952131436067, 5598.552115830734, 5629.071203251464, 5630.239917611127, 5668.121441176619, 5694.316681998155, 5276.472352764722, 5323.787048518055, 5707.486326230638, 5717.485426311631, 5730.169125476803, 5145.151050076733, 5166.948330516694, 5196.818111366103, 5202.375714914216, 5289.947100528984, 5268.868278293035, 5285.180796976456, 5318.574514038867, 5337.599680023995, 5379.408265090837, 5076.010178015288, 5124.103281925648, 5174.43081261061, 5177.0, 5257.474252574751, 5201.661891977047, 5204.9479505204845, 5221.556167725748, 5223.608229382811, 5232.2413250078525, 5139.897202055975, 5188.766505507224, 5191.351081114861, 5199.116150254428, 5202.557782588447, 5461.781528738846, 5527.309086364205, 5569.136783798477, 5617.606767526275, 5642.943570564283, 6186.443220110212, 6201.16284301618, 6205.844853878689, 6211.689415529206, 6223.7821676241565, 5158.380994280673, 6119.755209791603, 6253.280872699653, 6253.499720022387, 6286.057091436275, 5712.171735098387, 5743.0811070228565, 5746.109353050284, 5811.535077193899, 5851.970740146315, 6281.120643109968, 6290.24517057956, 6302.684865756693, 6320.5891617044745, 6321.905171422432, 5963.522918166536, 6013.909791353133, 6088.512918966472, 6100.786472473531, 6101.023836186189, 6151.015837465984, 6220.440160385587, 6263.248410190807, 6263.467605253604, 6269.498440124779, 5636.464535869086, 6077.513798896078, 6148.385161483905, 6177.7837775677635, 6199.28708198563, 6053.092036194518, 6100.914243738774, 6132.171952247653, 6180.949238629444, 6184.312258386332, 4851.248056551241, 4851.708897466164, 4858.246971719389, 4882.511748825089, 4891.951080489221, 4347.195768782785, 4349.3041113421705, 4355.3684715716045, 4391.802368893407, 4426.75652839097, 4996.0, 5401.406585057418, 5521.503064724194, 5548.833534993957, 5657.066584013592, 6160.784372546939, 6177.2587289524645, 6177.876442471125, 6178.0, 6199.380061993765, 5598.916016259759, 5604.495595396434, 5615.326160860723, 5619.438056194348, 5630.6058575900115, 5320.813771517978, 5324.520793128637, 5337.01265265927, 5337.6797392156595, 5367.812126575551, 5820.923129221108, 6222.968885155546, 6243.125962365272, 6276.9372306276355, 6283.277423096311, 6284.622922624657, 6302.873942521215, 6305.684715764285, 6316.084167795736, 6320.747170113328, 6237.781677641261, 6282.528810339334, 6297.433231009231, 6326.525510586816, 6351.650659213788, 6120.357362476876, 6160.045192995093, 6183.505319574333, 6213.378662133931, 6215.06773983906, 6242.625442473284, 6253.499720022478, 6269.279032911274, 6270.811875643738, 6274.215723034621, 5898.616589921641, 5922.851928701817, 6034.487068599218, 6041.728122234598, 6094.177286066501, 5098.2352647103235, 6050.122732203894, 6123.510119190365, 6133.426475724657, 6139.338817383189, 5896.321922978741, 5923.318818335774, 5946.73239704223, 5953.374895636069, 5966.970165149147, 5862.970685146547, 6022.759089636365, 6066.484348830222, 6095.1771510845465, 6105.236845394325, 4871.658983871095, 5899.852503687443, 5933.673647949404, 5939.168516407793, 5944.078667806497], "unit": "score", "name": "dojo.html", "value": 5647.395437421849}, {"lowerIsBetter": false, "replicates": [487.73418486924623, 565.8161097643265, 578.3060327606871, 607.4290167242791, 611.2329027071025, 29754.0, 38086.809565952164, 38342.0, 38383.0, 38420.0, 41841.58158418415, 42144.73565793031, 42445.0, 42537.36193957093, 42617.573824261744, 9538.236941044734, 9780.462074585896, 9787.217022638171, 9793.510324483746, 9811.067948544913, 9572.569234384435, 9722.756931076745, 9729.124378805906, 9738.610455581767, 9804.362716423446, 9791.167750741195, 9858.90141098587, 9881.308308418413, 9883.604655813759, 9886.961869003759, 9772.511374431286, 9845.360051596623, 9871.703848884508, 9873.703788886345, 9882.308238423313, 9734.318597698164, 9873.506324683736, 9874.012598740068, 9876.35803672759, 9881.418972964362, 40215.597844021475, 40627.390589141185, 40685.79657101695, 40717.185656287, 40719.38920916188, 3158.921026974344, 3182.8885988990273, 3318.3197444523817, 3519.4720791881423, 3712.1462063725494, 26613.46773064528, 26931.73068269312, 27781.722182778114, 27979.300517487023, 27997.300067498272, 2769.9584506232422, 2799.174243598143, 2845.4593627210766, 2860.5280128778727, 2884.927876803076, 380331.0, 380673.09663451783, 380732.0, 380914.0, 383406.9999999972, 57798.8440231193, 59338.51653708692, 67343.66328168327, 67821.0, 69037.65481172562, 63955.0, 64591.677041614494, 64848.0, 64852.35147648557, 64955.67522162359, 16373.91813040927, 16568.0, 16593.917030415014, 16596.58508537296, 16625.00249985005, 11698.122640801974, 11880.40597970098, 12729.236245825095, 12861.228326300452, 12936.223826570436, 20354.982250887395, 20680.069396877177, 20797.688034679493, 20805.0, 20856.374308770763, 7915.287624113857, 8069.959650201711, 8106.594670266463, 8115.594220288962, 8186.099529051799, 990.8810942686923, 1019.2406657040405, 1024.8923862994427, 1028.747956750586, 1122.6528166200592, 30425.087247382613, 30496.54255186174, 30565.69434305673, 31212.68787312143, 31231.0, 1025.7692019295748, 1070.55571937645, 1086.093112251279, 1109.0, 1113.6269349767756, 14777.113373197642, 14855.628609284855, 14918.328675209641, 15071.307529655305, 15126.697466050617, 539970.0, 543823.0, 544919.0, 545407.2729636326, 545739.0, 58143.70928145417, 58483.70758146182, 58538.70730646405, 58604.70697646485, 58652.4134758647, 1415.971680566383, 1418.6169734171715, 1446.9638259043609, 1452.4480697335157, 1452.832924213729, 29358.119256422342, 29452.410951781272, 29568.704312956594, 29585.798816567636, 29925.700742992292, 51734.70663233449, 52239.73880130575, 52286.0, 52307.21539176839, 52314.738426309144, 427684.0, 428741.856290729, 430913.0, 431281.0, 431443.0, 27969.0, 32391.190220244684, 32581.34837303288, 33023.0, 33193.00420987374, 39487.407688884115, 40199.59800401959, 40553.59446405498, 40574.59425405826, 43130.56869431391, 35620.28759424745, 35930.64069359273, 36790.63209367872, 36991.445128323634, 36994.26011479701, 28151.71848281573, 31370.372592547566, 31684.0, 35688.643113568534, 36508.0, 34631.13422164466, 34805.65194348024, 34844.477332840535, 34849.65150348566, 34874.0, 29181.314676437796, 31662.05013849588, 33061.03790272861, 33250.33499330048, 33437.0, 24214.636780448658, 24940.251792446255, 24997.750022499542, 25037.998480060593, 25500.744992549837], "unit": "score", "name": "ext.html", "value": 19570.993297445308}, {"lowerIsBetter": false, "replicates": [353.9876104336348, 360.7150351222534, 362.3495824994137, 365.242122595614, 371.32789650732195, 14703.0, 14967.25163741814, 19548.706769398454, 19942.0, 20408.693869591967, 19066.33267835626, 19265.133069011892, 19500.317488887893, 20220.09009594568, 20265.0, 5623.606347555673, 5830.562707796911, 5830.883382332351, 5843.065109582468, 5845.8830823383505, 4186.141840922619, 4292.1630282095, 4344.196323680129, 5752.734398432338, 5767.971160144193, 4336.588024137718, 4337.457817772778, 4343.283358245885, 4345.739255644671, 4351.934720979188, 4323.697341186118, 6181.783637572708, 6250.218722659668, 6309.810705678837, 6353.30113687494, 5501.5323697485765, 5505.476979686923, 5506.862328441781, 5513.7794488220425, 5514.200440936042, 12773.105882588223, 13228.470861165542, 13238.139520931109, 13250.602481925558, 13255.337233138305, 2076.3874656976227, 2088.8642238254465, 2137.925172618951, 2209.4807720185904, 2251.819854411643, 9302.047466951044, 9466.0, 9476.336656434052, 9846.803063938682, 9979.0, 1741.0511271357013, 1742.4551691177173, 1776.67131580658, 1800.9549761255942, 1844.1332573690345, 71287.96962430036, 81478.77781833218, 84333.0, 97131.0, 98447.50776246072, 10767.730806729895, 10853.945730271298, 10897.67306980792, 10917.017468427879, 11257.324560526395, 13206.669833254246, 13316.201027938161, 13320.533781317801, 13344.933275333562, 13368.33158342079, 8291.668333266722, 8330.500169989698, 8387.664493420318, 8552.914470855212, 8574.056853746082, 8506.65973361071, 8523.872141917876, 8550.914490855137, 8638.395312328203, 8690.348223883235, 4246.002189485468, 4410.360497727812, 4500.909981800346, 4529.547045295444, 4542.227821270392, 1566.490890460582, 1817.7818661760673, 1875.4279944617024, 1881.2192939929776, 1894.7821000584834, 782.7886470652892, 873.76845136039, 886.4858382138344, 906.5331354352513, 955.7849483866074, 19069.713954290695, 20087.799122008884, 20270.797292027186, 21079.313654907877, 21088.789112108683, 940.9200217981411, 963.1620490173594, 963.2919803944095, 966.9129778319844, 973.3040875773855, 9080.727578172666, 10650.254482186172, 10729.0, 10981.670549883516, 11421.0, 507302.0, 519565.0, 524658.0, 525178.0, 638543.0, 114246.0, 115026.1845077071, 121821.39089304674, 123023.0, 126564.0, 992.513668302541, 998.8064263205545, 1047.4343854318583, 1048.0, 1050.968470945873, 14958.626034349229, 17240.051797151278, 18163.909180454542, 18261.08694565293, 18453.169607367432, 38119.04702382463, 48904.75547622239, 49238.261426079356, 50048.24927626162, 50150.24774628311, 66262.0, 66286.00570991535, 70978.0, 74337.51324973578, 75701.48597028138, 7503.9249607503225, 7762.7671169865, 7928.563928983961, 7971.681132754625, 7996.60016999136, 10286.897131028893, 10461.372317660966, 12429.005679545795, 12429.627111186317, 12512.249265044127, 8649.437786543855, 10284.434356110485, 10877.075448586958, 10947.288426252268, 11111.277766945122, 10632.734181645521, 10679.199060070681, 10731.946340268249, 10780.568777248822, 10840.186985975926, 10979.39613321275, 11008.889911100787, 11091.889081109086, 11236.0, 11361.829572556584, 7493.550386976799, 7582.241775822374, 7784.9610751945875, 7819.452638315263, 7829.29536341732, 9630.32587718853, 10705.250632455965, 10794.56821727122, 10958.671239862817, 10974.615888443866], "unit": "score", "name": "jquery.html", "value": 8841.433693893401}, {"lowerIsBetter": false, "replicates": [1388.9652758681025, 1537.231384307846, 1541.4142625802194, 1769.6106856491576, 1919.1555715485194, 7923.683052677893, 8558.015828179761, 8697.434666746656, 8711.0417854036, 8717.564121793901, 8439.11389304122, 8722.60748266328, 8733.563321833899, 8733.91266087339, 8736.301095912328, 2184.8907554622206, 2236.6421372580307, 2406.205952035824, 2462.3967128053605, 2485.8632775197357, 2441.438469152096, 2477.938051548717, 2478.5910324796387, 2479.2438306316567, 2481.950360992779, 2452.1294940296207, 2479.293401380607, 2480.491499242651, 2484.291976786616, 2486.1298545509107, 2418.2382549496942, 2445.1441995301593, 2464.938376540583, 2469.4937537804885, 2472.344828620417, 2439.2194497760725, 2440.389902524369, 2457.0908763757348, 2457.1400009996537, 2458.840175388594, 8743.650253989832, 8815.691450799255, 8816.20654141124, 8823.426477279021, 8834.160754728291, 4485.730856148642, 5476.890462190734, 5509.063459211943, 5543.584231182677, 5552.666839989613, 3621.492990981265, 3659.634036596319, 3696.1129328961124, 3699.038250055005, 3716.4796928429773, 1037.823569993103, 1040.9375437473775, 1050.4800123938699, 1083.4691001409253, 1088.7332603512111, 12085.637430877088, 12100.092493063055, 12115.212511186834, 12115.575954841539, 12131.332776697278, 4778.474367819537, 4915.459299477055, 4917.0903382874285, 4956.628252880976, 4997.075541024922, 9285.0, 10307.226957978031, 10321.63874264397, 10324.43215623148, 10337.638182663572, 5502.504774570308, 5524.171374293888, 5539.14143307788, 5541.778328866801, 5551.694656793915, 4954.984228233204, 4971.4282857471135, 4975.502449754996, 5021.748912554431, 5029.371328583927, 3946.8026598670526, 3953.6244056814558, 3956.1098752780395, 3994.6404823565435, 4030.879073627796, 1273.1088238233274, 1274.9235045897276, 1281.090425797694, 1284.2037936479442, 1287.5557932513268, 1280.6990357266036, 1297.2929753284482, 1324.5165514587106, 1366.132505858767, 1368.8494265630773, 8126.796830079295, 8158.306543943712, 8376.49741015541, 8389.454685445426, 8389.916100839035, 1168.7253495428567, 1179.4574495731888, 1183.6094088950626, 1183.650823007215, 1200.7298357869583, 6290.937090629035, 6327.588706734047, 6353.0152826312, 6363.872722545616, 6371.713272902731, 10281.897181028244, 10613.0448259657, 10620.734481638021, 10633.680989570325, 10744.247902646895, 10039.598416063276, 10636.946815265874, 10639.255252132276, 10672.719273687208, 10767.0, 8102.797430064177, 8213.301869341172, 8322.375821813388, 8337.83324333522, 8347.081820999685, 8032.0, 8032.518048917083, 8140.267375936194, 8158.755237342889, 8181.468204566684, 9437.150656440954, 9473.763155921157, 9676.080772326617, 9692.030796920251, 9767.902320976984, 9635.084666956627, 9836.016398360392, 9844.261680374144, 9946.850797238192, 10002.799944001225, 6772.55978361405, 6997.160340759141, 7241.927580724336, 7431.851362972819, 7449.962750186214, 8232.34141268709, 8242.010958684996, 8264.586770661323, 8265.140343422681, 8276.627551760064, 6333.8733225336155, 7135.464840136907, 7381.852362952818, 7435.144958329645, 7443.255674432514, 6374.139491168633, 7206.855862882818, 7248.693636536247, 7260.745873894389, 7393.667284972296, 7637.274458926393, 7690.2694244046725, 7719.343855772097, 7737.961310193413, 7800.141984381827, 6935.861282774417, 6938.993845892418, 7014.508984371045, 7023.122109736283, 7072.398846098139, 7109.644517773987, 7134.0, 7159.606221657858, 7176.246494118252, 7178.0], "unit": "score", "name": "mootools.html", "value": 4960.990191118845}, {"lowerIsBetter": false, "replicates": [278.81737461962416, 325.99837000815006, 327.7623722800969, 328.9210589458531, 334.6185348702481, 6510.967445162773, 6633.303503132162, 6713.462922966163, 6735.797926062214, 6743.9662801686045, 5410.594205434599, 6623.668816559165, 6720.966395168018, 6729.629870357128, 6753.898691519631, 4663.300504924255, 4752.12085764133, 4770.379850619414, 4928.1868491698915, 4938.604911607063, 4634.791434385444, 4772.236442169254, 4843.491433399495, 4849.272609108627, 4875.195592727196, 4166.9791651041705, 4501.302298143776, 4776.164171270031, 4788.162071637467, 4801.951980480203, 4592.0, 4779.689320194194, 4783.928241076386, 4789.760511974388, 4813.302071199656, 3997.5402828674783, 4086.0, 4096.610821971908, 4098.856540021085, 4103.158852435244, 6315.74737010519, 6343.936560634381, 6412.5190610704385, 6417.8395540111405, 6441.291457939623, 4836.41962964443, 5581.386047534768, 5597.888042239173, 5606.187102870102, 5610.859728506779, 7042.330978557029, 7058.964705176441, 7061.9293807062295, 7085.50401471892, 7093.92906070943, 3650.5619325680823, 4115.765270418862, 4415.955840441587, 4423.447069116361, 4430.756308403036, 7169.928300717031, 7220.530665506778, 7225.385842203419, 7348.742794002238, 7412.740554080581, 4538.795754191069, 4554.453465584085, 4558.475775285819, 4561.407017087758, 4566.977165114153, 4521.982553925341, 4630.930536041962, 4658.883527911829, 4679.953200467951, 4686.437627484724, 4904.43598986114, 5176.482351764868, 5534.640248383923, 5544.7782088716, 5553.1670249462095, 7114.50198486101, 7123.786286411416, 7128.287171282934, 7134.750283740148, 7137.964310178416, 1630.1441743084974, 1648.2170968789728, 1648.7939007624047, 1650.026484374225, 1651.8348165183627, 841.6927821345288, 1039.095986491742, 1052.2634156090767, 1059.3590877519143, 1065.8827528971963, 6744.393004629607, 6772.5936443813525, 6780.016897549827, 6801.727930882808, 6823.624700641512, 7599.0, 7604.657790399335, 7606.923930760732, 7617.200193979663, 7621.771346859603, 6453.161089058486, 6653.767118150841, 6746.055552222692, 6752.054712340277, 6761.053452516651, 4005.319095753729, 4048.777317247521, 4056.9594304057173, 4057.229126466021, 4059.4316795648633, 8039.5176289422825, 8042.879356809653, 8055.355571554262, 8061.87907181381, 8065.475744076616, 7697.499662521918, 7995.200479952075, 7998.200179982072, 8001.1198768135455, 8014.998125234346, 8001.959745233083, 8011.959940200261, 8045.678172873019, 8046.919530804851, 8064.153263907323, 7224.674889629874, 7683.846323073395, 7692.19231980634, 7693.115291741521, 7702.691892324468, 7200.243974382824, 7240.674169662483, 7246.565206087652, 7257.891131633135, 7260.96369518149, 6431.646259455588, 7775.922240777746, 7802.258785415376, 7814.492058016211, 7824.1002284735705, 4104.035551645301, 4283.164782867436, 4613.638976501873, 4673.532646735299, 4700.55344742249, 7411.888821667571, 7437.107547094383, 7452.701891924479, 7454.030975973305, 7466.925330746841, 7116.893246601202, 7126.0, 7141.750038748619, 7145.285471453021, 7183.604901730246, 5926.814637072689, 6227.439530442282, 6541.313162118099, 7116.644167791694, 7154.213036566078, 6538.83652908662, 6991.40573051276, 7012.6844292008, 7018.438524917892, 7035.12060992376, 7132.0, 7163.707613563818, 7179.533330333512, 7179.964100179465, 7204.603746793767, 6755.695993680198, 7024.26245244242, 7033.156021277479, 7036.788896333118, 7039.120109986252], "unit": "score", "name": "prototype.html", "value": 5162.574720533636}, {"lowerIsBetter": false, "replicates": [662.1425254295688, 674.4368452342294, 698.786870004649, 709.3580309819612, 728.6356821589205, 14830.0, 15055.247237638116, 15062.77405838912, 15064.548063558083, 15069.547913562583, 13644.113132646371, 13738.931305343483, 15580.84419155808, 16013.759793603105, 16060.03639781611, 858.995705021474, 876.0757400942003, 876.3733930239878, 876.8640860666607, 880.067128843428, 704.6124631452706, 713.932176443237, 714.4641518860855, 715.3275920634587, 718.1633397092381, 747.1631772414876, 904.4347282948157, 924.3483344242293, 925.2782829393051, 926.7544100813257, 898.7753061734567, 914.7530166854946, 915.0757734687979, 918.6187732091174, 918.8392031394479, 544.0859356281445, 550.7191332420495, 667.8029981155571, 672.0222076878131, 673.6598018000878, 15202.46791362297, 15213.239338033054, 15229.771553426708, 15243.16162611056, 15287.312070956723, 12121.33332666703, 12207.328596927166, 12272.202306850115, 12313.75372492554, 12614.936925315315, 9981.850272245922, 10070.496475176285, 10101.292909496338, 10106.545205465773, 10111.646092386805, 3400.931981360384, 3471.444568868994, 3475.2701932594186, 3477.0611934777467, 3479.704225140866, 83626.16373836245, 85126.57436712839, 85290.0, 85579.0, 85763.57118214431, 9265.95367023174, 9302.95348523253, 9497.335186536877, 9560.235181185488, 9656.32405731592, 15834.445794397141, 16938.576535586708, 20689.58620827575, 20708.79291207099, 20721.27475538349, 7304.671289791972, 7343.1555371131935, 7480.775576732598, 7697.461177717506, 7781.688732450752, 4181.372794080851, 4206.537280899099, 4213.346931225604, 4229.661627069827, 4234.174336004449, 3543.8936831895085, 3591.1560783215923, 3594.892153235407, 3600.6579374959338, 3602.657747513982, 624.3756243756244, 639.338284875152, 649.6849028221309, 655.0109334904329, 658.318640207383, 550.3176061683483, 585.6017907822636, 587.9382664820217, 595.7944509144338, 636.3572791480545, 6798.796036118924, 7537.434692398092, 8413.831723365498, 8631.611577479029, 8703.564821758886, 492.15840912040096, 504.60892808073305, 529.8701818054524, 532.1884126706803, 630.5397060146119, 3901.8439262429183, 4014.437978682987, 4316.740995540277, 4345.435093437833, 4368.257396242647, 86501.0, 87830.68253976195, 88202.0, 88256.558717206, 102330.48834755778, 83459.74810377849, 83579.58210209031, 83907.0, 85554.57222713971, 87046.0, 75960.0, 76816.23183768202, 76987.84518232231, 77895.61052194703, 78482.6075869617, 8754.649814007369, 8805.408266179425, 8922.063183365914, 8992.550372481219, 9115.0, 50505.49494505008, 51192.0, 51359.486405136966, 52205.47794522006, 52821.0, 49771.0, 67685.0, 70958.93561596477, 72464.27535724787, 73463.26536734564, 11412.885871141183, 11443.25618834773, 11598.88401115978, 11626.88373116258, 11983.520659173535, 12086.15396922207, 12094.092943029133, 12097.153199275966, 12114.878851211375, 12117.939410302892, 11554.0, 11574.247673901169, 11589.130815188726, 11589.478473468882, 11597.304161750322, 11520.769584608428, 11571.19001669875, 11582.305061696325, 11582.594609188638, 11598.362090085126, 11372.772544548898, 11414.771704566028, 11426.485808138488, 11438.084953203557, 11442.485088170886, 7917.327027202752, 8906.910930890608, 9094.136057074567, 9645.662401815904, 10443.321184123008, 10109.34289271195, 10145.695629131138, 10193.949030254802, 10248.948755256177, 10337.84493232587], "unit": "score", "name": "yui.html", "value": 6880.710326565447}], "name": "dromaeo_css", "value": 7459.005021890284}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 112.0, 111.0, 113.0, 115.0, 109.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 164.0, 193.0, 146.0, 143.0, 142.0, 123.0, 161.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 188.0, 185.0, 185.0, 185.0, 185.0, 187.0, 183.0, 177.0], "unit": "score", "name": "audio-dft", "value": 184.4}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 85.0, 80.0, 58.0, 57.0, 57.0, 85.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 72.9}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 129.0, 79.0, 110.0, 125.0, 153.0, 94.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 106.8}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 85.0, 91.0, 85.0, 91.0, 84.0, 91.0, 84.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.9}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 93.0, 104.0, 149.0, 94.0, 94.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 100.5}, {"lowerIsBetter": true, "replicates": [85.0, 100.0, 133.0, 142.0, 85.0, 85.0, 88.0, 85.0, 91.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 97.9}, {"lowerIsBetter": true, "replicates": [56.0, 52.0, 53.0, 52.0, 53.0, 55.0, 53.0, 63.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.1}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 79.0, 76.0, 71.0, 66.0, 66.0, 68.0, 66.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 84.0, 83.0, 79.0, 82.0, 82.0, 97.0, 107.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 127.0, 123.0, 126.0, 126.0, 124.0, 125.0, 121.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.8}, {"lowerIsBetter": true, "replicates": [134.0, 128.0, 140.0, 137.0, 138.0, 126.0, 137.0, 139.0, 140.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 67.0, 67.0, 66.0, 67.0, 68.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1443.6999999999998}]} 04:49:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1443.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7459.00"}}} 04:49:33 INFO - Return code: 0 04:49:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:49:33 INFO - # TBPL SUCCESS # 04:49:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:49:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:49:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:49:33 INFO - 2016-02-19 04:49:33.742 screenresolution[6260:102360] starting screenresolution argv=screenresolution get 04:49:33 INFO - 2016-02-19 04:49:33.745 screenresolution[6260:102360] Display 0: 1600x1200x32@60 04:49:33 INFO - 2016-02-19 04:49:33.750 screenresolution[6261:102363] starting screenresolution argv=screenresolution list 04:49:33 INFO - Available Modes on Display 0 04:49:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:49:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:49:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:49:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:49:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:49:33 INFO - Intel Iris: 04:49:33 INFO - Chipset Model: Intel Iris 04:49:33 INFO - Type: GPU 04:49:33 INFO - Bus: Built-In 04:49:33 INFO - VRAM (Dynamic, Max): 1536 MB 04:49:33 INFO - Vendor: Intel (0x8086) 04:49:33 INFO - Device ID: 0x0a2e 04:49:33 INFO - Revision ID: 0x0009 04:49:33 INFO - Displays: 04:49:33 INFO - Display: 04:49:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:49:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:49:33 INFO - Display Serial Number: 1600x1200 60 04:49:33 INFO - Main Display: Yes 04:49:33 INFO - Mirror: Off 04:49:33 INFO - Online: Yes 04:49:33 INFO - Rotation: Supported 04:49:33 INFO - Return code: 0 04:49:33 INFO - Running post-action listener: _resource_record_post_action 04:49:33 INFO - Running post-run listener: _resource_record_post_run 04:49:35 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 3563008; Write bytes: 707048960; Read time: 53; Write time: 1812 04:49:35 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393439744; Write bytes: 388134912; Read time: 30086; Write time: 636 04:49:35 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 3534336; Write bytes: 298958336; Read time: 53; Write time: 1130 04:49:35 INFO - Running post-run listener: _upload_blobber_files 04:49:35 INFO - Blob upload gear active. 04:49:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:49:35 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 04:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:49:35 INFO - (blobuploader) - INFO - Open directory for files ... 04:49:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:49:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:49:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:36 INFO - (blobuploader) - INFO - Done attempting. 04:49:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:49:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:49:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:37 INFO - (blobuploader) - INFO - Done attempting. 04:49:37 INFO - (blobuploader) - INFO - Iteration through files over. 04:49:37 INFO - Return code: 0 04:49:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:49:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:49:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48add98d2531d86b02198fe0f1bf485017d647eca1f48af9f7dc5678a78a3065d42034660ca7a4f9c7e1d76c702c82001500b4d6ba91d4f0b0f61ebad080ff4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d09ba6a49b7040cb62e396cbe357fed3beffffcc7db3afc196c3cfa5b358946e903db01ecea626a469f63ed0ae4a25dc7c3f1438cd1f6e87925b6dcd03be193"} 04:49:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:49:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:49:37 INFO - Contents: 04:49:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48add98d2531d86b02198fe0f1bf485017d647eca1f48af9f7dc5678a78a3065d42034660ca7a4f9c7e1d76c702c82001500b4d6ba91d4f0b0f61ebad080ff4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d09ba6a49b7040cb62e396cbe357fed3beffffcc7db3afc196c3cfa5b358946e903db01ecea626a469f63ed0ae4a25dc7c3f1438cd1f6e87925b6dcd03be193"} 04:49:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:49:37 INFO - Copying logs to upload dir... 04:49:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:49:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.154323 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-02-19 04:49:37.215725) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 04:49:37.219691) ========= 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.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48add98d2531d86b02198fe0f1bf485017d647eca1f48af9f7dc5678a78a3065d42034660ca7a4f9c7e1d76c702c82001500b4d6ba91d4f0b0f61ebad080ff4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d09ba6a49b7040cb62e396cbe357fed3beffffcc7db3afc196c3cfa5b358946e903db01ecea626a469f63ed0ae4a25dc7c3f1438cd1f6e87925b6dcd03be193"} build_url:https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/Be4aLFXkRRKoyOH_mpE4mQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/48add98d2531d86b02198fe0f1bf485017d647eca1f48af9f7dc5678a78a3065d42034660ca7a4f9c7e1d76c702c82001500b4d6ba91d4f0b0f61ebad080ff4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d09ba6a49b7040cb62e396cbe357fed3beffffcc7db3afc196c3cfa5b358946e903db01ecea626a469f63ed0ae4a25dc7c3f1438cd1f6e87925b6dcd03be193"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-19 04:49:37.246836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:49:37.247148) ========= 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.adx5kaS1wA/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.8wrCPTflHP/Listeners TMPDIR=/var/folders/xw/1xk600bn7yzb_vgtx1q14h5000000w/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.005050 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-19 04:49:37.296486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 04:49:37.296796) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-19 04:49:37.297139) ========= ========= Total master_lag: 0.39 =========