builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0167 starttime: 1456411435.52 results: success (0) buildid: 20160225051426 builduid: 23f7fe9d09a0428db17d56012652bf84 revision: b34dbc48da45cb1c06e9088835513837bf0ff6ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.518979) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.519448) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.519742) ========= 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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005712 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.594784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.595127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.723683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.723945) ========= 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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005649 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.785214) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.785474) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.785862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:55.786150) ========= 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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-25 06:43:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.5M=0.001s 2016-02-25 06:43:56 (10.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.492554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:56.300076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:56.300356) ========= 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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.025844 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:56.347685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 06:43:56.348008) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b34dbc48da45cb1c06e9088835513837bf0ff6ca --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 b34dbc48da45cb1c06e9088835513837bf0ff6ca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-25 06:43:56,425 truncating revision to first 12 chars 2016-02-25 06:43:56,425 Setting DEBUG logging. 2016-02-25 06:43:56,425 attempt 1/10 2016-02-25 06:43:56,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b34dbc48da45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 06:43:57,444 unpacking tar archive at: fx-team-b34dbc48da45/testing/mozharness/ program finished with exit code 0 elapsedTime=1.260660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 06:43:57.624383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:57.624694) ========= echo b34dbc48da45cb1c06e9088835513837bf0ff6ca in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b34dbc48da45cb1c06e9088835513837bf0ff6ca'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 b34dbc48da45cb1c06e9088835513837bf0ff6ca program finished with exit code 0 elapsedTime=0.005454 script_repo_revision: 'b34dbc48da45cb1c06e9088835513837bf0ff6ca' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:57.673592) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:57.673882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 06:43:57.686802) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2016-02-25 06:43:57.687099) ========= /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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:43:57 INFO - MultiFileLogger online at 20160225 06:43:57 in /builds/slave/test 06:43:57 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 06:43:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:43:57 INFO - {'append_to_log': False, 06:43:57 INFO - 'base_work_dir': '/builds/slave/test', 06:43:57 INFO - 'blob_upload_branch': 'Fx-Team', 06:43:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:43:57 INFO - 'branch': 'Fx-Team', 06:43:57 INFO - 'buildbot_json_path': 'buildprops.json', 06:43:57 INFO - 'config_files': ('talos/mac_config.py',), 06:43:57 INFO - 'default_actions': ('clobber', 06:43:57 INFO - 'read-buildbot-config', 06:43:57 INFO - 'download-and-extract', 06:43:57 INFO - 'populate-webroot', 06:43:57 INFO - 'create-virtualenv', 06:43:57 INFO - 'install', 06:43:57 INFO - 'run-tests'), 06:43:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:43:57 INFO - 'download_minidump_stackwalk': True, 06:43:57 INFO - 'download_symbols': 'ondemand', 06:43:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:43:57 INFO - 'tooltool.py': '/tools/tooltool.py', 06:43:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:43:57 INFO - '/tools/misc-python/virtualenv.py')}, 06:43:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:43:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:43:57 INFO - 'installer_path': 'installer.exe', 06:43:57 INFO - 'log_level': 'info', 06:43:57 INFO - 'log_name': 'talos', 06:43:57 INFO - 'log_to_console': True, 06:43:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:43:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:43:57 INFO - 'opt_config_files': (), 06:43:57 INFO - 'pip_index': False, 06:43:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:43:57 INFO - 'cmd': ('bash', 06:43:57 INFO - '-c', 06:43:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:43:57 INFO - 'enabled': True, 06:43:57 INFO - 'halt_on_failure': False, 06:43:57 INFO - 'name': 'check_screen_resolution'},), 06:43:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:43:57 INFO - 'cmd': ('bash', 06:43:57 INFO - '-c', 06:43:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:43:57 INFO - 'enabled': True, 06:43:57 INFO - 'halt_on_failure': False, 06:43:57 INFO - 'name': 'check_screen_resolution'},), 06:43:57 INFO - 'run_cmd_checks_enabled': True, 06:43:57 INFO - 'sps_profile': False, 06:43:57 INFO - 'sps_profile_interval': 0, 06:43:57 INFO - 'suite': 'dromaeojs', 06:43:57 INFO - 'system_bits': '32', 06:43:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:43:57 INFO - 'title': 't-yosemite-r7-0167', 06:43:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:43:57 INFO - 'use_talos_json': True, 06:43:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:43:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:43:57 INFO - 'work_dir': 'build'} 06:43:57 INFO - ##### 06:43:57 INFO - ##### Running clobber step. 06:43:57 INFO - ##### 06:43:57 INFO - Running pre-action listener: _resource_record_pre_action 06:43:57 INFO - Running main action method: clobber 06:43:57 INFO - rmtree: /builds/slave/test/build 06:43:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:43:59 INFO - Running post-action listener: _resource_record_post_action 06:43:59 INFO - ##### 06:43:59 INFO - ##### Running read-buildbot-config step. 06:43:59 INFO - ##### 06:43:59 INFO - Running pre-action listener: _resource_record_pre_action 06:43:59 INFO - Running main action method: read_buildbot_config 06:43:59 INFO - Using buildbot properties: 06:43:59 INFO - { 06:43:59 INFO - "project": "", 06:43:59 INFO - "product": "firefox", 06:43:59 INFO - "script_repo_revision": "production", 06:43:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:43:59 INFO - "repository": "", 06:43:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:43:59 INFO - "buildid": "20160225051426", 06:43:59 INFO - "pgo_build": "False", 06:43:59 INFO - "basedir": "/builds/slave/test", 06:43:59 INFO - "buildnumber": 498, 06:43:59 INFO - "slavename": "t-yosemite-r7-0167", 06:43:59 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:43:59 INFO - "platform": "yosemite_r7", 06:43:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:43:59 INFO - "branch": "fx-team", 06:43:59 INFO - "repo_path": "integration/fx-team", 06:43:59 INFO - "revision": "b34dbc48da45cb1c06e9088835513837bf0ff6ca", 06:43:59 INFO - "stage_platform": "macosx64", 06:43:59 INFO - "builduid": "23f7fe9d09a0428db17d56012652bf84", 06:43:59 INFO - "slavebuilddir": "test" 06:43:59 INFO - } 06:43:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:43:59 INFO - Running post-action listener: _resource_record_post_action 06:43:59 INFO - ##### 06:43:59 INFO - ##### Running download-and-extract step. 06:43:59 INFO - ##### 06:43:59 INFO - Running pre-action listener: _resource_record_pre_action 06:43:59 INFO - Running main action method: download_and_extract 06:43:59 INFO - mkdir: /builds/slave/test/build/tests 06:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:43:59 INFO - https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:43:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/test_packages.json 06:43:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/test_packages.json 06:43:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:43:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:44:00 INFO - Downloaded 1277 bytes. 06:44:00 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:44:00 INFO - Using the following test package requirements: 06:44:00 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:44:00 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:44:00 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:44:00 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:44:00 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:44:00 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:44:00 INFO - u'jsshell-mac.zip'], 06:44:00 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:44:00 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:44:00 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:44:00 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:44:00 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:44:00 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:44:00 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:44:00 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:44:00 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:44:00 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:44:00 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:44:00 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:44:00 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:44: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')]} 06:44:00 INFO - https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:44:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:44:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:44:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/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 06:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/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 06:44:02 INFO - Downloaded 17829665 bytes. 06:44:02 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'] 06:44:02 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 06:44:05 INFO - Return code: 0 06:44:05 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 06:44:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:05 INFO - https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:44:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:44:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:44:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/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 06:44:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/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 06:44:07 INFO - Downloaded 17829665 bytes. 06:44:07 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'] 06:44:07 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 06:44:11 INFO - Return code: 0 06:44:11 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')]} 06:44:11 INFO - https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/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 06:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/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 06:44:12 INFO - Downloaded 10707015 bytes. 06:44:12 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'] 06:44:12 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 06:44:12 INFO - Return code: 0 06:44: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')]} 06:44:12 INFO - https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:44:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:44:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:44:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:44:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AT6xGU3hS3iLAxq_ckybIA/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 06:44:19 INFO - Downloaded 111446023 bytes. 06:44:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:44:19 INFO - mkdir: /builds/slave/test/properties 06:44:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:19 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:19 INFO - Contents: 06:44:19 INFO - build_url:https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:44:20 INFO - Running post-action listener: _resource_record_post_action 06:44:20 INFO - Running post-action listener: set_extra_try_arguments 06:44:20 INFO - ##### 06:44:20 INFO - ##### Running populate-webroot step. 06:44:20 INFO - ##### 06:44:20 INFO - Running pre-action listener: _resource_record_pre_action 06:44:20 INFO - Running main action method: populate_webroot 06:44:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:44:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:44:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:44:20 INFO - '--tppagecycles', 06:44:20 INFO - '7'], 06:44:20 INFO - 'tests': ['tsvgm']}}, 06:44:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:44:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:44:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:44:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:44:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:20 INFO - 'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:20 INFO - 'tests': ['damp', 'tps']}, 06:44:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:20 INFO - 'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['damp', 'tps']}, 06:44:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:44:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:20 INFO - 'other': {'tests': ['a11yr', 06:44:20 INFO - 'ts_paint', 06:44:20 INFO - 'tpaint', 06:44:20 INFO - 'sessionrestore', 06:44:20 INFO - 'sessionrestore_no_auto_restore']}, 06:44:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['a11yr', 06:44:20 INFO - 'ts_paint', 06:44:20 INFO - 'tpaint', 06:44:20 INFO - 'sessionrestore', 06:44:20 INFO - 'sessionrestore_no_auto_restore']}, 06:44:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['a11yr', 06:44:20 INFO - 'ts_paint', 06:44:20 INFO - 'tpaint', 06:44:20 INFO - 'sessionrestore', 06:44:20 INFO - 'sessionrestore_no_auto_restore']}, 06:44:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['a11yr', 06:44:20 INFO - 'ts_paint', 06:44:20 INFO - 'tpaint', 06:44:20 INFO - 'sessionrestore', 06:44:20 INFO - 'sessionrestore_no_auto_restore']}, 06:44:20 INFO - 'other_l64': {'tests': ['a11yr', 06:44:20 INFO - 'ts_paint', 06:44:20 INFO - 'tpaint', 06:44:20 INFO - 'sessionrestore', 06:44:20 INFO - 'sessionrestore_no_auto_restore']}, 06:44:20 INFO - 'other_nol64': {'tests': ['a11yr', 06:44:20 INFO - 'ts_paint', 06:44:20 INFO - 'tpaint', 06:44:20 INFO - 'sessionrestore', 06:44:20 INFO - 'sessionrestore_no_auto_restore']}, 06:44:20 INFO - 'svgr': {'tests': ['tsvgx', 06:44:20 INFO - 'tsvgr_opacity', 06:44:20 INFO - 'tart', 06:44:20 INFO - 'tscrollx', 06:44:20 INFO - 'cart']}, 06:44:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['tsvgx', 06:44:20 INFO - 'tsvgr_opacity', 06:44:20 INFO - 'tart', 06:44:20 INFO - 'tscrollx', 06:44:20 INFO - 'cart']}, 06:44:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:20 INFO - 'tests': ['tp5o']}, 06:44:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:20 INFO - 'talos_options': ['--e10s'], 06:44:20 INFO - 'tests': ['tp5o']}, 06:44:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:20 INFO - 'talos_options': ['--xperf_path', 06:44:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:20 INFO - 'tests': ['tp5n']}, 06:44:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:44:20 INFO - 'talos_options': ['--e10s', 06:44:20 INFO - '--xperf_path', 06:44:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:20 INFO - 'tests': ['tp5n']}}, 06:44:20 INFO - 'talos.zip': {'path': '', 06:44:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:44:20 INFO - Running post-action listener: _resource_record_post_action 06:44:20 INFO - ##### 06:44:20 INFO - ##### Running create-virtualenv step. 06:44:20 INFO - ##### 06:44:20 INFO - Running pre-action listener: _resource_record_pre_action 06:44:20 INFO - Running main action method: create_virtualenv 06:44:20 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:20 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 06:44:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:44:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:20 INFO - Using real prefix '/tools/python27' 06:44:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:21 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:24 INFO - Installing pip.................done. 06:44:24 INFO - Return code: 0 06:44:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:24 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:24 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 06:44:24 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 06:44:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:24 INFO - 'HOME': '/Users/cltbld', 06:44:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:24 INFO - 'LOGNAME': 'cltbld', 06:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:24 INFO - 'MOZ_NO_REMOTE': '1', 06:44:24 INFO - 'NO_EM_RESTART': '1', 06:44:24 INFO - 'PAGER': '/bin/cat', 06:44:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:24 INFO - 'PWD': '/builds/slave/test', 06:44:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:24 INFO - 'SHELL': '/bin/bash', 06:44:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:24 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:24 INFO - 'USER': 'cltbld', 06:44:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:24 INFO - 'XPC_FLAGS': '0x0', 06:44:24 INFO - 'XPC_SERVICE_NAME': '0', 06:44:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:24 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 06:44:24 INFO - Cleaning up... 06:44:24 INFO - Return code: 0 06:44:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:24 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:24 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 06:44:24 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 06:44:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:24 INFO - 'HOME': '/Users/cltbld', 06:44:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:24 INFO - 'LOGNAME': 'cltbld', 06:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:24 INFO - 'MOZ_NO_REMOTE': '1', 06:44:24 INFO - 'NO_EM_RESTART': '1', 06:44:24 INFO - 'PAGER': '/bin/cat', 06:44:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:24 INFO - 'PWD': '/builds/slave/test', 06:44:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:24 INFO - 'SHELL': '/bin/bash', 06:44:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:24 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:24 INFO - 'USER': 'cltbld', 06:44:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:24 INFO - 'XPC_FLAGS': '0x0', 06:44:24 INFO - 'XPC_SERVICE_NAME': '0', 06:44:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:25 INFO - Downloading/unpacking psutil>=0.7.1 06:44:25 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 06:44:25 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 06:44:25 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 06:44:25 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 06:44:25 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 06:44:25 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 06:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:27 INFO - Installing collected packages: psutil 06:44:27 INFO - Running setup.py install for psutil 06:44:27 INFO - building 'psutil._psutil_osx' extension 06:44:28 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 06:44:28 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 06:44:28 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 06:44:28 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 06:44:28 INFO - building 'psutil._psutil_posix' extension 06:44:28 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 06:44:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:44:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:44:28 INFO - ^ 06:44:28 INFO - 1 warning generated. 06:44:28 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 06:44:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:29 INFO - Successfully installed psutil 06:44:29 INFO - Cleaning up... 06:44:29 INFO - Return code: 0 06:44:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:44:29 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')]} 06:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:29 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')]} 06:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:29 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:29 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 06:44:29 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 06:44:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:29 INFO - 'HOME': '/Users/cltbld', 06:44:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:29 INFO - 'LOGNAME': 'cltbld', 06:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:29 INFO - 'MOZ_NO_REMOTE': '1', 06:44:29 INFO - 'NO_EM_RESTART': '1', 06:44:29 INFO - 'PAGER': '/bin/cat', 06:44:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:29 INFO - 'PWD': '/builds/slave/test', 06:44:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:29 INFO - 'SHELL': '/bin/bash', 06:44:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:29 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:29 INFO - 'USER': 'cltbld', 06:44:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:29 INFO - 'XPC_FLAGS': '0x0', 06:44:29 INFO - 'XPC_SERVICE_NAME': '0', 06:44:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:44:31 INFO - Installing collected packages: mozsystemmonitor 06:44:31 INFO - Running setup.py install for mozsystemmonitor 06:44:31 INFO - Successfully installed mozsystemmonitor 06:44:31 INFO - Cleaning up... 06:44:32 INFO - Return code: 0 06:44:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:32 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:32 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 06:44:32 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 06:44:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:32 INFO - 'HOME': '/Users/cltbld', 06:44:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:32 INFO - 'LOGNAME': 'cltbld', 06:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:32 INFO - 'MOZ_NO_REMOTE': '1', 06:44:32 INFO - 'NO_EM_RESTART': '1', 06:44:32 INFO - 'PAGER': '/bin/cat', 06:44:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:32 INFO - 'PWD': '/builds/slave/test', 06:44:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:32 INFO - 'SHELL': '/bin/bash', 06:44:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:32 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:32 INFO - 'USER': 'cltbld', 06:44:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:32 INFO - 'XPC_FLAGS': '0x0', 06:44:32 INFO - 'XPC_SERVICE_NAME': '0', 06:44:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:32 INFO - Downloading/unpacking blobuploader==1.2.4 06:44:32 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 06:44:32 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 06:44:32 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 06:44:32 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 06:44:32 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 06:44:32 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 06:44:34 INFO - Downloading blobuploader-1.2.4.tar.gz 06:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:44:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:44:34 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 06:44:34 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 06:44:34 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 06:44:34 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 06:44:34 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 06:44:34 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 06:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:44:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:44:35 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 06:44:35 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 06:44:35 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 06:44:35 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 06:44:35 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 06:44:35 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 06:44:35 INFO - Downloading docopt-0.6.1.tar.gz 06:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:44:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:44:35 INFO - Running setup.py install for blobuploader 06:44:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:44:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:44:35 INFO - Running setup.py install for requests 06:44:36 INFO - Running setup.py install for docopt 06:44:36 INFO - Successfully installed blobuploader requests docopt 06:44:36 INFO - Cleaning up... 06:44:36 INFO - Return code: 0 06:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:36 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:36 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 06:44:36 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 06:44:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:36 INFO - 'HOME': '/Users/cltbld', 06:44:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:36 INFO - 'LOGNAME': 'cltbld', 06:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:36 INFO - 'MOZ_NO_REMOTE': '1', 06:44:36 INFO - 'NO_EM_RESTART': '1', 06:44:36 INFO - 'PAGER': '/bin/cat', 06:44:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:36 INFO - 'PWD': '/builds/slave/test', 06:44:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:36 INFO - 'SHELL': '/bin/bash', 06:44:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:36 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:36 INFO - 'USER': 'cltbld', 06:44:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:36 INFO - 'XPC_FLAGS': '0x0', 06:44:36 INFO - 'XPC_SERVICE_NAME': '0', 06:44:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:36 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-gZtTW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-yRn5b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-k_rf6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-rg7MGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0OKQIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-aPKM_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-dmqusX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-4scI5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-98taZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-8_KLHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:37 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-rIXsHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-mURhf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-6a3luV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-5429Bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Gxe5xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-DVIUIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:38 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9lrQnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:44:38 INFO - Running setup.py install for manifestparser 06:44:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:44:38 INFO - Running setup.py install for mozcrash 06:44:39 INFO - Running setup.py install for mozdebug 06:44:39 INFO - Running setup.py install for mozdevice 06:44:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:44:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:44:39 INFO - Running setup.py install for mozfile 06:44:39 INFO - Running setup.py install for mozhttpd 06:44:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:44:39 INFO - Running setup.py install for mozinfo 06:44:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:44:39 INFO - Running setup.py install for mozInstall 06:44:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:44:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:44:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:44:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:44:39 INFO - Running setup.py install for mozleak 06:44:40 INFO - Running setup.py install for mozlog 06:44:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:44:40 INFO - Running setup.py install for moznetwork 06:44:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:44:40 INFO - Running setup.py install for mozprocess 06:44:40 INFO - Running setup.py install for mozprofile 06:44:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:44:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:44:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:44:40 INFO - Running setup.py install for mozrunner 06:44:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:44:40 INFO - Running setup.py install for mozscreenshot 06:44:40 INFO - Running setup.py install for moztest 06:44:41 INFO - Running setup.py install for mozversion 06:44:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:44:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:44:41 INFO - Cleaning up... 06:44:41 INFO - Return code: 0 06:44:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:41 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:41 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 06:44:41 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 06:44:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:41 INFO - 'HOME': '/Users/cltbld', 06:44:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:41 INFO - 'LOGNAME': 'cltbld', 06:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:41 INFO - 'MOZ_NO_REMOTE': '1', 06:44:41 INFO - 'NO_EM_RESTART': '1', 06:44:41 INFO - 'PAGER': '/bin/cat', 06:44:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:41 INFO - 'PWD': '/builds/slave/test', 06:44:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:41 INFO - 'SHELL': '/bin/bash', 06:44:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:41 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:41 INFO - 'USER': 'cltbld', 06:44:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:41 INFO - 'XPC_FLAGS': '0x0', 06:44:41 INFO - 'XPC_SERVICE_NAME': '0', 06:44:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:44:41 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-zuO1mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:44:41 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)) 06:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:44:41 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-_vwEI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:44:41 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)) 06:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:44:41 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-GQRiXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:44:41 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)) 06:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:44:41 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-62X5zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:44:41 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)) 06:44:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:44:41 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-fTKZYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-pHe6MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-IOMe3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-rRPW9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-PvYWQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-yPKhSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-6Zngi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-bMUdwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ihkjwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:44:42 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)) 06:44:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:44:42 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-LWNFoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:44:43 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)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:43 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-N3zpfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:44:43 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)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:44:43 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-I5j_gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:44:43 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)) 06:44:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:44:43 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-BoH7sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:44:43 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)) 06:44:43 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)) 06:44:43 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)) 06:44:43 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)) 06:44:43 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)) 06:44:43 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)) 06:44:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:44:43 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 06:44:43 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 06:44:43 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 06:44:43 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 06:44:43 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 06:44:43 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 06:44:45 INFO - Downloading blessings-1.6.tar.gz 06:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:44:45 INFO - Installing collected packages: blessings 06:44:45 INFO - Running setup.py install for blessings 06:44:45 INFO - Successfully installed blessings 06:44:45 INFO - Cleaning up... 06:44:46 INFO - Return code: 0 06:44:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:44:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:46 INFO - Reading from file tmpfile_stdout 06:44:46 INFO - Current package versions: 06:44:46 INFO - blessings == 1.6 06:44:46 INFO - blobuploader == 1.2.4 06:44:46 INFO - docopt == 0.6.1 06:44:46 INFO - manifestparser == 1.1 06:44:46 INFO - mozInstall == 1.12 06:44:46 INFO - mozcrash == 0.16 06:44:46 INFO - mozdebug == 0.1 06:44:46 INFO - mozdevice == 0.48 06:44:46 INFO - mozfile == 1.2 06:44:46 INFO - mozhttpd == 0.7 06:44:46 INFO - mozinfo == 0.9 06:44:46 INFO - mozleak == 0.1 06:44:46 INFO - mozlog == 3.1 06:44:46 INFO - moznetwork == 0.27 06:44:46 INFO - mozprocess == 0.22 06:44:46 INFO - mozprofile == 0.28 06:44:46 INFO - mozrunner == 6.11 06:44:46 INFO - mozscreenshot == 0.1 06:44:46 INFO - mozsystemmonitor == 0.0 06:44:46 INFO - moztest == 0.7 06:44:46 INFO - mozversion == 1.4 06:44:46 INFO - psutil == 3.1.1 06:44:46 INFO - requests == 1.2.3 06:44:46 INFO - wsgiref == 0.1.2 06:44:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:46 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:46 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 06:44:46 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 06:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:46 INFO - 'HOME': '/Users/cltbld', 06:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:46 INFO - 'LOGNAME': 'cltbld', 06:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:46 INFO - 'MOZ_NO_REMOTE': '1', 06:44:46 INFO - 'NO_EM_RESTART': '1', 06:44:46 INFO - 'PAGER': '/bin/cat', 06:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:46 INFO - 'PWD': '/builds/slave/test', 06:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:46 INFO - 'SHELL': '/bin/bash', 06:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:46 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:46 INFO - 'USER': 'cltbld', 06:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:46 INFO - 'XPC_FLAGS': '0x0', 06:44:46 INFO - 'XPC_SERVICE_NAME': '0', 06:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 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)) 06:44:46 INFO - Cleaning up... 06:44:46 INFO - Return code: 0 06:44:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44: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')]} 06:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:46 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:46 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 06:44:46 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 06:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:46 INFO - 'HOME': '/Users/cltbld', 06:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:46 INFO - 'LOGNAME': 'cltbld', 06:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:46 INFO - 'MOZ_NO_REMOTE': '1', 06:44:46 INFO - 'NO_EM_RESTART': '1', 06:44:46 INFO - 'PAGER': '/bin/cat', 06:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:46 INFO - 'PWD': '/builds/slave/test', 06:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:46 INFO - 'SHELL': '/bin/bash', 06:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:46 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:46 INFO - 'USER': 'cltbld', 06:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:46 INFO - 'XPC_FLAGS': '0x0', 06:44:46 INFO - 'XPC_SERVICE_NAME': '0', 06:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:46 INFO - Downloading/unpacking jsonschema 06:44:46 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 06:44:46 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 06:44:46 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 06:44:46 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 06:44:46 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 06:44:46 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 06:44:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:49 INFO - Downloading/unpacking functools32 (from jsonschema) 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 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 06:44:49 INFO - Downloading functools32-3.2.3-2.tar.gz 06:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:44:49 INFO - warning: no files found matching '*.txt' 06:44:49 INFO - no previously-included directories found matching 'build' 06:44:49 INFO - no previously-included directories found matching 'dist' 06:44:49 INFO - no previously-included directories found matching '.git*' 06:44:49 INFO - Installing collected packages: jsonschema, functools32 06:44:49 INFO - Running setup.py install for functools32 06:44:49 INFO - warning: no files found matching '*.txt' 06:44:49 INFO - no previously-included directories found matching 'build' 06:44:49 INFO - no previously-included directories found matching 'dist' 06:44:49 INFO - no previously-included directories found matching '.git*' 06:44:49 INFO - Successfully installed jsonschema functools32 06:44:49 INFO - Cleaning up... 06:44:49 INFO - Return code: 0 06:44:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:44:49 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')]} 06:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:49 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')]} 06:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:44:49 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 0x10e087a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e08f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d134d8720>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, '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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 06:44:49 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 06:44:49 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 06:44:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:44:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:49 INFO - 'HOME': '/Users/cltbld', 06:44:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:49 INFO - 'LOGNAME': 'cltbld', 06:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:49 INFO - 'MOZ_NO_REMOTE': '1', 06:44:49 INFO - 'NO_EM_RESTART': '1', 06:44:49 INFO - 'PAGER': '/bin/cat', 06:44:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:49 INFO - 'PWD': '/builds/slave/test', 06:44:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:49 INFO - 'SHELL': '/bin/bash', 06:44:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:44:49 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:44:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:49 INFO - 'USER': 'cltbld', 06:44:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:49 INFO - 'XPC_FLAGS': '0x0', 06:44:49 INFO - 'XPC_SERVICE_NAME': '0', 06:44:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:50 INFO - Downloading/unpacking flake8 06:44:50 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 06:44:50 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 06:44:50 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 06:44:50 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 06:44:50 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 06:44:50 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 06:44:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:44:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:44:52 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 06:44:52 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 06:44:52 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 06:44:52 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 06:44:52 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 06:44:52 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 06:44:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:44:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:44:52 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 06:44:52 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 06:44:52 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 06:44:52 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 06:44:52 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 06:44:52 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 06:44:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:44:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:44:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:44:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:44:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:44:53 INFO - no previously-included directories found matching 'docs/_build' 06:44:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:44:53 INFO - Running setup.py install for pep8 06:44:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:44:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:44:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:44:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:44:53 INFO - no previously-included directories found matching 'docs/_build' 06:44:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:44:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:44:53 INFO - Cleaning up... 06:44:54 INFO - Return code: 0 06:44:54 INFO - Running post-action listener: _resource_record_post_action 06:44:54 INFO - Running post-action listener: _start_resource_monitoring 06:44:54 INFO - Starting resource monitoring. 06:44:54 INFO - ##### 06:44:54 INFO - ##### Running install step. 06:44:54 INFO - ##### 06:44:54 INFO - Running pre-action listener: _resource_record_pre_action 06:44:54 INFO - Running main action method: install 06:44:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:44:54 INFO - Reading from file tmpfile_stdout 06:44:54 INFO - Detecting whether we're running mozinstall >=1.0... 06:44:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:44:54 INFO - Reading from file tmpfile_stdout 06:44:54 INFO - Output received: 06:44:54 INFO - Usage: mozinstall [options] installer 06:44:54 INFO - Options: 06:44:54 INFO - -h, --help show this help message and exit 06:44:54 INFO - -d DEST, --destination=DEST 06:44:54 INFO - Directory to install application into. [default: 06:44:54 INFO - "/builds/slave/test"] 06:44:54 INFO - --app=APP Application being installed. [default: firefox] 06:44:54 INFO - mkdir: /builds/slave/test/build/application 06:44:54 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'] 06:44:54 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 06:45:28 INFO - Reading from file tmpfile_stdout 06:45:28 INFO - Output received: 06:45:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:45:28 INFO - Running post-action listener: _resource_record_post_action 06:45:28 INFO - ##### 06:45:28 INFO - ##### Running run-tests step. 06:45:28 INFO - ##### 06:45:28 INFO - Running pre-action listener: _resource_record_pre_action 06:45:28 INFO - Running main action method: run_tests 06:45:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:45:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:45:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:45:28 INFO - 2016-02-25 06:45:28.419 screenresolution[1649:8407] starting screenresolution argv=screenresolution get 06:45:28 INFO - 2016-02-25 06:45:28.422 screenresolution[1649:8407] Display 0: 1600x1200x32@60 06:45:28 INFO - 2016-02-25 06:45:28.428 screenresolution[1650:8409] starting screenresolution argv=screenresolution list 06:45:28 INFO - Available Modes on Display 0 06:45:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:45:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:45:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:45:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:45:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:45:28 INFO - Intel Iris: 06:45:28 INFO - Chipset Model: Intel Iris 06:45:28 INFO - Type: GPU 06:45:28 INFO - Bus: Built-In 06:45:28 INFO - VRAM (Dynamic, Max): 1536 MB 06:45:28 INFO - Vendor: Intel (0x8086) 06:45:28 INFO - Device ID: 0x0a2e 06:45:28 INFO - Revision ID: 0x0009 06:45:28 INFO - Displays: 06:45:28 INFO - Display: 06:45:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:45:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:45:28 INFO - Display Serial Number: 1600x1200 60 06:45:28 INFO - Main Display: Yes 06:45:28 INFO - Mirror: Off 06:45:28 INFO - Online: Yes 06:45:28 INFO - Rotation: Supported 06:45:28 INFO - Return code: 0 06:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:28 INFO - Python 2.7.3 06:45:28 INFO - Return code: 0 06:45:28 INFO - grabbing minidump binary from tooltool 06:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:45:28 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 0x10df2bd30>, '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 0x10dd4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df22b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:28 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 06:45:28 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 06:45:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:28 INFO - Return code: 0 06:45:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:45:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:45:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:45:30 INFO - Return code: 0 06:45:30 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/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 06:45:30 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/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 06:45:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oO09sTP9Ku/Render', 06:45:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:45:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:45:30 INFO - 'HOME': '/Users/cltbld', 06:45:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:45:30 INFO - 'LOGNAME': 'cltbld', 06:45:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:30 INFO - 'MOZ_NO_REMOTE': '1', 06:45:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:30 INFO - 'NO_EM_RESTART': '1', 06:45:30 INFO - 'PAGER': '/bin/cat', 06:45:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:30 INFO - 'PWD': '/builds/slave/test', 06:45:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:45:30 INFO - 'SHELL': '/bin/bash', 06:45:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HEXYcdvIXZ/Listeners', 06:45:30 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 06:45:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:45:30 INFO - 'USER': 'cltbld', 06:45:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:45:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:30 INFO - 'XPC_FLAGS': '0x0', 06:45:30 INFO - 'XPC_SERVICE_NAME': '0', 06:45:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:45:30 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/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 06:45:30 INFO - mozversion application_buildid: 20160225051426 06:45:30 INFO - mozversion application_changeset: b34dbc48da45cb1c06e9088835513837bf0ff6ca 06:45:30 INFO - mozversion application_display_name: Nightly 06:45:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:30 INFO - mozversion application_name: Firefox 06:45:30 INFO - mozversion application_remotingname: firefox 06:45:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:45:30 INFO - mozversion application_vendor: Mozilla 06:45:30 INFO - mozversion application_version: 47.0a1 06:45:30 INFO - mozversion platform_buildid: 20160225051426 06:45:30 INFO - mozversion platform_changeset: b34dbc48da45cb1c06e9088835513837bf0ff6ca 06:45:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:45:30 INFO - mozversion platform_version: 47.0a1 06:45:30 INFO - using testdate: 1456411530 06:45:30 INFO - actual date: 1456411530 06:45:30 INFO - starting webserver on 'localhost:49276' 06:45:30 INFO - SUITE-START | Running 2 tests 06:45:30 INFO - TEST-START | dromaeo_css 06:45:30 INFO - operating with platform_type : mac_ 06:45:30 INFO - Initialising browser for dromaeo_css test... 06:45:30 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpBq0JHQ/profile http://localhost:49276/getInfo.html) 06:45:33 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 06:45:33 INFO - PROCESS | 1668 | colorDepth:24 06:45:33 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 06:45:33 INFO - PROCESS | 1668 | __metrics 06:45:33 INFO - PROCESS | 1668 | 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" 06:45:33 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:45:33 INFO - TEST-INFO | 1668: exit 0 06:45:33 INFO - Browser initialized. 06:45:33 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:33 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpBq0JHQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:45 INFO - PROCESS | 1672 | RSS: Main: 244473856 06:45:45 INFO - PROCESS | 1672 | 06:46:36 INFO - PROCESS | 1672 | 1456411596576 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] 06:48:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 06:48:47 INFO - PROCESS | 1672 | RSS: Main: 376315904 06:48:47 INFO - PROCESS | 1672 | 06:51:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 06:51:51 INFO - PROCESS | 1672 | RSS: Main: 377556992 06:51:51 INFO - PROCESS | 1672 | 06:54:53 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 06:54:53 INFO - PROCESS | 1672 | RSS: Main: 376602624 06:54:53 INFO - PROCESS | 1672 | 06:57:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 06:57:56 INFO - PROCESS | 1672 | RSS: Main: 335060992 06:57:56 INFO - PROCESS | 1672 | 07:00:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 07:01:00 INFO - PROCESS | 1672 | RSS: Main: 337055744 07:01:00 INFO - PROCESS | 1672 | 07:04:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 07:04:03 INFO - PROCESS | 1672 | RSS: Main: 390602752 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - PROCESS | 1672 | __start_tp_report 07:04:03 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 07:04:03 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 07:04:03 INFO - PROCESS | 1672 | |i|pagename|runs| 07:04:03 INFO - PROCESS | 1672 | |0;dojo.html;2910.708929107089;3488.250026244357;3491.9999999999986;3499.9475007874903;3557.8576856925724;5662.801801936933;5700.287464066992;5703.800366987156;5731.340895796985;5742.253507044078;5676.772929082842;5699.629524080932;5737.913931291034;5816;5844.152597873306;5136.409312929024;5146.228065790143;5180.197069454241;5198.116320225552;5205.687658740488;5166.974165129169;5169.224616307546;5195.922061169085;5232.16285394337;5280.392754833186;5117.513836185556;5122.641415100926;5231.503007214327;5238.240455133984;5250.238715386286;5218.191180367049;5219.556337711299;5225.137852254374;5230.973845130788;5254.710990895499;5163.225516172567;5186.0665080285535;5197.896042079137;5228.215767634847;5248;5515.834524964217;5613.7193140342815;5624;5654.6041777075625;5730.140478928152;6216.378362163793;6227.470664993481;6231.376862313778;6254.3745625437095;6302.747890084437;5440.483154100354;6307.684615769193;6322.304546499881;6347.079673447371;6355.142055822451;5542.334919809608;5648.774049038034;5753.108268218475;5841.532677385799;5861;6373.5857169283845;6387.904181437282;6393.520485963571;6402.263739669997;6408.58344207625;6070.544709146743;6081.209442772411;6137.386261373917;6150.231221097363;6164.845878852975;6126.059675755388;6228.22147231596;6339.334369891188;6356.936430635635;6358.713857876407;6206.72069756862;6210.596311239755;6217.067439884054;6227.657478838617;6228.5017198624;6091.51267898567;6231.626102433868;6238.594491358047;6252.5935814171935;6265.780697675559;4833.661643684979;4837.22604383304;4878.170710979071;4901.730404827768;4917.754112294371;4364.974231055699;4380.299152135643;4382.649388048949;4395.988922547768;4401.911961760811;5473.534749546254;5583.469570390806;5651.576131790132;5666.263385759908;5709.286339207599;6190.41191086846;6231.813045608639;6270.655113968775;6311.779087731999;6314.55798094129;5657.830265092054;5662.631928924607;5667.716614169275;5668.178114173422;5692.8861422771315;5245.160774276097;5339.733013349394;5347.117725575236;5349.331333583302;5360.490753378423;6298.307186209513;6344.111824344688;6347.143135676717;6365.267994180728;6377.8724425512155;6263.467605253604;6273.62358258506;6274.717637706405;6275.278342990615;6312.400321969406;6254.3745625437095;6329.430351268408;6352.809415717351;6353.078803573549;6376.075469057054;6129.877402451837;6153.507719382528;6181.1655426516845;6200.7519699211525;6212.968935155295;6280.775248826435;6286.182796236643;6321.747130114744;6321.810345689637;6326.43062124411;5898.764049438146;6062.6665533394325;6118.510519158545;6134.325224225421;6135.53983451234;6091.177691011657;6115.422885572139;6120.477608373006;6122.703114648804;6124.350421260821;5924.200232968667;5963.403659634002;5966.105084237399;5971.910421343597;6000.459958603747;5899.292084949833;6046.848828779316;6055.212822333068;6060.212172417734;6122.908156377569;5957.463828255304;5984.910226346696;5995.160677505066;5996.970015149896;6002.279726432856 07:04:03 INFO - PROCESS | 1672 | |1;ext.html;428.27621319969256;455.7903364452352;465.69264285571506;525.8816766227602;563.3099453169867;30026.549601755964;38331.23337533248;38929.221415571745;39032.41451378224;39036.024099397495;40494.78515644535;40940.38589421161;41049.38425923613;41100.794496027556;41120;9429.905700942989;9631.181349585258;9672.371295865782;9676.661316853912;9686.66096686616;9458;9573.856392154123;9607.4715890626;9623.182029527463;9628.988956159608;9679.08048735369;9785.266105042114;9788.755281117958;9810.950945245264;9817.460039697813;8270.917290827076;9305.069493050709;9598.232141428669;9666.371685840433;9763.26775491841;9659.130678238993;9798.873129590118;9805.950970245174;9816.95091524545;9819.018098190123;40437.98905027368;40905.59094409047;40961;41178;41254.79372603118;3035.362573859492;3045.390921815646;3049.832259225742;3214.6624604416666;3535.257595904863;28703.42593148125;28748.712512874812;29212.561811572843;29423.558646620317;29683.554746678816;2474.9628755568683;2755.1872197701728;2799.272189230794;2820.8025438219333;2902.1873875314946;360467;361529;362543;363988;364031;58009;65960.67019664872;66169;66306.33693663098;67909.66045169742;51682.22476662853;64821.351786482475;65328.67335663291;65600;65667;15901;16205.946613470087;16209.189540522926;16222.269997850126;16232;11364.374959377148;12226.327551984548;12327.93836030814;12333.260004399765;12510.81233781494;20409.795902041085;20683.4829129273;20685.58628827445;20735.792642073688;20749;7630.7329243476215;7836.451448398671;7869.409794265339;7898.60506974649;7921.881171782428;877.6050777150181;941.4304345870787;950.5247376311844;1034.1778286262288;1078.412265315405;29015.12954611365;29140.708592914223;29223.85388073046;29827.254318642208;29981.950631727785;1089.6131873185063;1091.345192884279;1107.684309971654;1116.0346300450215;1175.7883580955338;14751.557453276419;14925.552233433014;14974.550763476895;15239.466618668293;15322.233888305764;532190;535305;535800;536945;540122.2993885005;52332.47667523352;54054;54118.7294063535;54139.72930135324;54244;1295.1257900917033;1315.6447759104797;1316.565533373965;1405.5361730628867;1432.6275168456277;23655;29132.143906971578;29292.707072929;29555;30082.24794380158;50610.74694626503;51080;51113;51139;51203;496856;498412;498754;499189;499358;26285.21144365672;28648;28677.85661071681;28692.856535717186;28715;33983.4902476468;40466.59533404628;40603.79698101491;41466.792666036476;41820.79089604533;32545;32869.50695739614;34397.484037738956;34495.13762155966;35241.295174096886;34076;34792.82603586966;35384.82307588446;35585.46621800727;36328;35281.64718352886;35570.75502357405;35625.46561801523;35825.954793842815;35864.924052278475;30812.69187308098;31469.05592832219;31513.52729709102;31633.683663163993;31819.04542863718;24052.873126493443;24162.75837241605;24374.87812560926;24562.754372456046;24584.139555115486 07:04:03 INFO - PROCESS | 1672 | |2;jquery.html;357.32287315537053;363.88355726167623;366.02271933936396;368.80269056055016;373.86540845295707;19784.60430791385;20100.8994955025;20187.39437816866;20411.591768164628;20466.89766551169;18799;19671.704924426143;19941.601167976667;19961;20379;5074.568661663763;5697.572682048843;5881.823545293648;5911.142884281798;5921.348651648315;4066.857659981901;4311.094670119263;6204.565680402374;6492.772752953648;6499.2850786413455;6335.176427064498;6396.2324521057535;6407.679616019203;6414.61512309263;6429.3570642935565;6203.441690247854;6349.809505714836;6380.968095159517;6392.137061496708;6397.0724244984685;3683.2633473305177;3862;3872.3029854626157;5245.895082098375;5501.229827824108;24665.753342466523;24709.5058098837;24944.12695555647;25667.35831604206;25710.843012064503;1944.8930308833008;2016.5462770876582;2032.8280953865474;2042.5608494173675;2083.6457802173513;7506.587137707424;7806.258405451473;9287.792586963718;9353.672621458216;9594.9520252399;1669.7996240451102;1673.5314112048645;1697.6010637500178;1732.9133543322782;1774;108831.45584272107;110194;111119.44440277827;112016.4399178007;112644;11180.27328223679;11188.384638844942;11228.214025018171;11273.661790146309;11364.374959377314;13580.253086080163;13619.319034048258;13633.863661363457;13652.931735341459;13670.658233544242;8287.461315014625;8356.289715374262;8371.665133394596;8451.830963380698;8464.111268316861;6872;8418.452800567944;8439;8450.788730281793;8518.190771876662;4375.453068366454;4456.688031837805;4461.397711308997;4504.842330518416;4519.932201016987;1736.3662263273814;1805.647898659775;1807.7107662773892;1809.4933418642802;1809.5476130967259;903.5301643145527;918.7229750646607;963.6675347005272;977.3842479238034;998.3959704378747;16112.919435402982;20042.39872803789;20212.29256976028;20586.897065514877;20764.961751912342;803.6704950970075;901.3904745760985;962.7881865989472;969.7284760267137;972.9173020293355;10139.2902496826;11159.832602510969;11164.939330763564;11255.943720281346;11291.717707057389;522786;641162;643948;661218;665313;118158.40920795342;118352.40823795825;120211;121168.39415802865;125364;998.1116806042628;1007.4761124215366;1016.3698506925606;1038.9064984151462;1041.4584416103585;14930.925345373204;17742.29030838752;18193.181306840957;18216.544586384916;18321.267149313877;49695.75152124361;49850.25224621561;50120;50385.244221337445;50413.747931260106;77177;77566.44867102739;79902.6004869972;80124;80389.19610803817;7783.143854176149;7868.331191848528;7968.561729104955;8138.633761480629;8349.248567628943;9328.580213890256;10673.626423075155;12030.27818330903;12097.939510302393;12801.487940482277;10975.50610222526;11249.212555121063;11495.425228738362;11523.481443335239;11911.702207444883;10030.899691002996;10703.090237329914;11288.774224515299;11491.712707182387;11814.763704726029;9761.56072976732;10490.108340790814;11690;11956.163068585116;11988.820167697666;7533.472656913963;8066.745507801901;8091.312238459797;8188.385871059575;8206.179382061984;9294.72115836526;10593.36439813583;10722.03501684852;10790.082842958436;10806.837897431702 07:04:03 INFO - PROCESS | 1672 | |3;mootools.html;1400.082945670586;1526.1529850932734;1535.7849901013856;1743.6512697460503;1902.3056584346718;7792.45452818303;8414.032386275572;8572.528510931896;8576.0995095515;8580.39937204396;8282;8482.575871206445;8494.193051660099;8497.872531912026;8518.829623407528;2146.785321467856;2373.2287006722886;2424.1273141668985;2441.5116976604663;2452.3256104571296;2464.0143942422997;2466.1615050882697;2469.802415806731;2473.084958565333;2473.5300292944285;2386.0813586769045;2441.170002199252;2463.15021317646;2467.3091534370405;2472.159465781634;2407.263397213312;2413.951720965571;2416.3113512648897;2441.816863735227;2447.106806015809;2418.431668557905;2452.350127216289;2460.286516910112;2462.5936720441105;2470.4564995700916;8547.145285471403;8605.827883442358;8623.82752344956;8626.698065567674;8628.09405012471;5222.3472065991755;5342.5993050521365;5354.14333706609;5390.838274851761;5402.135658294694;3522.0490467573613;3616.4032934565766;3691.630836916314;3691.8154092295545;3697.8890633281044;1020.9897901020969;1057.148995058977;1067.386252904583;1077.2136340471422;1082.9079528240109;11714.062874969983;11735.061195104456;11736.471858766376;11747.882521174764;11759.35323557204;4721.7403042832975;4829.823489376069;4830.951690483121;4843.128236917389;4887.877803054881;9854.408735475894;9889.109980101824;9894.950525247472;9897.554610042565;9913.752156196153;4460.710053846555;4520.61574766142;5341.572674186055;5366.946330536644;5371.979323928441;4327.826886924488;4453.55464453552;4462.196804575207;4467.798949047301;4668.743219122981;3809.238152369537;3883;3925.823337949799;3931.941020884689;3934.15415685629;1275.1647670775658;1289.774289499334;1289.8645642207432;1296.6563860576955;1305.3147097773744;1313.1792629606496;1332.2872263339068;1334.3328335832084;1338.4110991163857;1359.3814814259488;6891.896621550681;7999.600019998977;8082.838343233102;8192.057913339922;8204.548749818818;1001.7796084861319;1179.8761130081389;1180.816973369129;1181.5805389086922;1198.8621308549455;6254.2807577129215;6310.179676642099;6313.463355614732;6321.956877115316;6340.619562826245;9881.851772223423;10436.739081523023;10459.849416564171;10592.15262778976;10618.36289822613;10228.693139205687;10569.365838049742;10602.681919542427;10612.893871061346;10628.574857005633;8086.555239461886;8240;8276.006879174418;8339.916600834036;8391.790205244917;7631.732889348847;7778.883316750366;7819.296263336327;7826.139124696393;7830.765077047698;8036.4776289541;9156.816863662556;9526.380785248937;9544.33189676716;9633.807323853343;9502.524873756423;9795.951020244853;9808.460534670376;9944.900550994398;9964.701058968243;6323.841903952438;6483.189601299838;6927.134108236471;7011.4390848733;7056.765066113512;7824.334931530883;8059.274665280153;8067.515949043076;8075;8080.595970201584;7081.964590177016;7193.244709305448;7213.783586492414;7340.009098771598;7351.595662238628;7054.435645148478;7091;7104.3961263293195;7231.349178573953;7257.310555497219;7361.521501102411;7515.511491753018;7531.510451820614;7586.3930885527925;7623.123340815877;6826.112605361272;6841.418479429105;6877.931220687929;6879.243283238739;6879.793606191622;6927.792166235021;6952.165740111219;6971.5468494547695;6976.4767642426;6984.126984126984 07:04:03 INFO - PROCESS | 1672 | |4;prototype.html;318.45226210917224;324.14264271003196;329.231245042825;329.99835000824993;334.1495892952436;6720.46236301096;6739.494537909652;6742.898856517156;6759.526833121683;6773.187217533897;6644.568103073297;6682.097916781233;6685.398314151726;6689.230738465078;6695.765648202314;3943.5859234780364;4714.764261786914;4841.055994081155;4846.248831431134;4934.481879402665;4913.434954980169;4917.188663870457;4940.2342636891335;4952.603791696673;4956.876078098058;4888.755562221892;4902.142125128088;4907.1412502812045;4911.386076740408;4930.679505832128;4704.6001089907395;4770;4880.731559764212;4883.19427294496;4883.4628190898975;4148.688848336386;4149.190907772985;4154.667626589896;4157.10622216225;4166.708330416872;6323.241211054657;6330.87338253237;6337.873242535124;6342.302346741854;6349.333320001379;4653.511381304948;5670.631408958405;5672.205891175238;5677.772889084432;5688.544916406678;6692.93307066928;6988.510804243705;6994.965025174893;6996.510244282902;7001.82495437613;4580.748058856761;4646.53534646536;4650.116477869194;4657.790399432034;4660.673752837302;7269.3094156055095;7333.303336183;7337.0828646419195;7343.339099481019;7347;4709.27006314015;4714.3871296731895;4725.64557658177;4726.456457507431;4734.360861283682;3919.6472317490993;4780.689255198401;4787.664863459524;4791.904161916742;4792.496787837296;4652.930206046912;4827.61379089672;5593.440655934455;5653.321601407857;5656.095024796013;5460.34475862899;7045.013698082273;7119.430445564342;7143.642817859086;7150.7497237596435;1617.4500669772099;1619.3117924881878;1629.4785668586176;1630.3071194742424;1634.5014770495113;978.6183388478499;1010.1817527802503;1032.2258306270298;1038.5274700011478;1058.1217589400778;6546.24718157418;6625;6625.86748265032;6642.86714265712;6670.799876003728;7383.2985866342615;7390.9260907390235;7395.482316237812;7398.852022959511;7405.740799072007;6657.933420665829;6680.766173184013;6681.866362672719;6705.597664140069;6712.463002959751;3765.1528406108405;3907.374820028782;3944.4280579315837;3944.980275098606;3950.486436763202;7767.2232776723;7782.64978075988;7791.6883324667515;7798.844023119505;7805.2194780521495;7637.389008879276;7660.923390766133;7681.347085497683;7684.923150768421;7690.577018264049;7733.883991740128;7740.729074482366;7748.7675369739;7751.612419379121;7764.495307804975;6476.6114033158165;6662.733490660319;7416.7404140854815;7444.330010298882;7454.068241469817;7247.891281630675;7317.524360916524;7331.156916954618;7342.3758980487255;7342.816429589303;7758.7672369829;7759.573223472763;7763.0684317882215;7769.067711874612;7773.222677732181;3840.8669442515084;4633.397658304533;4647.838754978951;4659.5573420525;4660.394148760775;6013.879722405615;6471.514636402195;7415.555066696015;7416.96291518539;7431.925680743339;7197.784066478014;7203.747868824776;7216.170140433707;7230.023946767329;7243.167035790952;6136.938630613637;7170.928290717235;7186.281371862981;7190.532615379983;7210.819729506804;7063.752768653072;7064.258252883579;7066.399356054793;7067.116610423697;7067.434605231672;6905.75829845953;7192.244814294633;7200.063991681048;7225.855482890418;7231.602261875647;6752.122224110834;6923.065386172802;6929.272426395156;7010.334018268256;7058.470614704021 07:04:03 INFO - PROCESS | 1672 | |5;yui.html;640.8333833203367;664.3423011218889;738.8300690841106;752.6274494125408;787.8503084413961;14293.14241145532;14453.349599268033;14463.710725785479;14464.71070578589;14509.347079381427;15047.924760376183;15523.223838808071;15534.61163470911;15572.532824015268;15605.375784968588;711.2780527764323;717.3543810570502;867.3104881619112;883.1389395339556;886.3485338276362;864.0754392799707;886.7428445750725;888.9155530224618;889.5596679643586;889.5774507109136;927.6057675487924;936.6955739384728;939.9436033837958;942.2979879989417;942.9339946203769;740.2893222506427;930.6696122876349;931.5575101826646;939.0609390609391;948.9810203795954;689.837888096297;692.4183685703982;692.4875592061888;692.5636848785283;693.7606525748608;14986.250687465583;15051.021683590532;15056.698866022618;15069;15081.849181508154;12617.747645047139;12651.177673451197;12949.741005179843;12971.481140754358;13030.804537931845;9918.518962315029;10096.990300969917;10135.341202821794;10163.4918254087;10171.89828101717;3505;3545.2909418116224;3554.3779838528153;3557.3774589446743;3733.7946412947276;69522;70118.29881701169;70793;70804;71216.99999999948;9069.54652267384;9391;9417.011213822587;9612.134907858326;9712.077352651488;21570.81360525186;21596.352109436742;21604.027818748193;21642.89178554097;22591.20930767415;7372.520786148883;7436.66535005926;7531.246875312535;7601.961990190013;7684.500507466997;3913.980430097888;3972.980135099364;3975.1453437511072;3992.5608183099835;4001.519817621846;3510.297940411877;3537;3556.822158892045;3556.822158892097;3556.87550935716;649.5063751548762;651.2478087808589;678.7454704485817;692.1417442371524;721.3147509865648;483.76779146010114;590.8375196820908;604.3442864492075;619.9380061993854;624.4348864277745;8017.559034253055;8040.316573091236;8181.754547363588;8240.464369815943;8261.504309741315;577.6995962099685;600.447588218831;603.2278683285401;606.7633622886989;613.1018058544254;3591.533100696945;3739.2334571412794;3795.0322667719556;3957.920841583152;3998.1603863188475;91002;91611.54194228986;93138.67153321221;93191.0680893196;93276.6680832971;63523;76239.47521049548;76686;77654.22345776582;78370.77106903693;67889.3027674312;70326.59346813035;70403.2959670407;70624;71268;7652.426068044808;7730.11103723079;7756.379489640703;7847.372210223282;7957.340037611791;49658;50290.49709502858;51049.46851594458;51464.22803658023;52852;65068;66881.99677004751;69103.83346026862;69227;69684;10231.84652230232;10234.385936843813;10367.32612380193;10887.78224435491;10942.343459392461;12319.137660363689;12349.32078735678;12351.320677362832;12420.06849486274;12796;11270.718232044264;11302.265352752045;11460.140489463156;11781.116416268986;11910.404479775803;10741.087007604128;10876.619318324138;10950;11462.312261264351;11503.252288601214;11325.868127940954;11330.858881301025;11516.366599836754;11559.537618495166;11700.590479333183;9339;9539.76150596213;9609.90390096118;9615.663451779154;9785.97247289053;9338.587053615662;9592.328537002342;9645.565949532429;9782.168515675963;9811.607535698493 07:04:03 INFO - PROCESS | 1672 | __end_tp_report 07:04:03 INFO - PROCESS | 1672 | __start_cc_report 07:04:03 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1290 07:04:03 INFO - PROCESS | 1672 | __end_cc_report 07:04:03 INFO - PROCESS | 1672 | __startTimestamp1456412643073__endTimestamp 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - PROCESS | 1672 | ------- Summary: start ------- 07:04:03 INFO - PROCESS | 1672 | Number of tests: 6 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5745.58 Median:5971.91 stddev:653.81 (10.9%) stddev-sans-first:616.84 07:04:03 INFO - PROCESS | 1672 | Values: 2910.7 3488.3 3492.0 3499.9 3557.9 5662.8 5700.3 5703.8 5731.3 5742.3 5676.8 5699.6 5737.9 5816.0 5844.2 5136.4 5146.2 5180.2 5198.1 5205.7 5167.0 5169.2 5195.9 5232.2 5280.4 5117.5 5122.6 5231.5 5238.2 5250.2 5218.2 5219.6 5225.1 5231.0 5254.7 5163.2 5186.1 5197.9 5228.2 5248.0 5515.8 5613.7 5624.0 5654.6 5730.1 6216.4 6227.5 6231.4 6254.4 6302.7 5440.5 6307.7 6322.3 6347.1 6355.1 5542.3 5648.8 5753.1 5841.5 5861.0 6373.6 6387.9 6393.5 6402.3 6408.6 6070.5 6081.2 6137.4 6150.2 6164.8 6126.1 6228.2 6339.3 6356.9 6358.7 6206.7 6210.6 6217.1 6227.7 6228.5 6091.5 6231.6 6238.6 6252.6 6265.8 4833.7 4837.2 4878.2 4901.7 4917.8 4365.0 4380.3 4382.6 4396.0 4401.9 5473.5 5583.5 5651.6 5666.3 5709.3 6190.4 6231.8 6270.7 6311.8 6314.6 5657.8 5662.6 5667.7 5668.2 5692.9 5245.2 5339.7 5347.1 5349.3 5360.5 6298.3 6344.1 6347.1 6365.3 6377.9 6263.5 6273.6 6274.7 6275.3 6312.4 6254.4 6329.4 6352.8 6353.1 6376.1 6129.9 6153.5 6181.2 6200.8 6213.0 6280.8 6286.2 6321.7 6321.8 6326.4 5898.8 6062.7 6118.5 6134.3 6135.5 6091.2 6115.4 6120.5 6122.7 6124.4 5924.2 5963.4 5966.1 5971.9 6000.5 5899.3 6046.8 6055.2 6060.2 6122.9 5957.5 5984.9 5995.2 5997.0 6002.3 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:60930.69 Median:199435.50 stddev:125496.39 (62.9%) stddev-sans-first:125766.23 07:04:03 INFO - PROCESS | 1672 | Values: 428.3 455.8 465.7 525.9 563.3 30026.5 38331.2 38929.2 39032.4 39036.0 40494.8 40940.4 41049.4 41100.8 41120.0 9429.9 9631.2 9672.4 9676.7 9686.7 9458.0 9573.9 9607.5 9623.2 9629.0 9679.1 9785.3 9788.8 9811.0 9817.5 8270.9 9305.1 9598.2 9666.4 9763.3 9659.1 9798.9 9806.0 9817.0 9819.0 40438.0 40905.6 40961.0 41178.0 41254.8 3035.4 3045.4 3049.8 3214.7 3535.3 28703.4 28748.7 29212.6 29423.6 29683.6 2475.0 2755.2 2799.3 2820.8 2902.2 360467.0 361529.0 362543.0 363988.0 364031.0 58009.0 65960.7 66169.0 66306.3 67909.7 51682.2 64821.4 65328.7 65600.0 65667.0 15901.0 16205.9 16209.2 16222.3 16232.0 11364.4 12226.3 12327.9 12333.3 12510.8 20409.8 20683.5 20685.6 20735.8 20749.0 7630.7 7836.5 7869.4 7898.6 7921.9 877.6 941.4 950.5 1034.2 1078.4 29015.1 29140.7 29223.9 29827.3 29982.0 1089.6 1091.3 1107.7 1116.0 1175.8 14751.6 14925.6 14974.6 15239.5 15322.2 532190.0 535305.0 535800.0 536945.0 540122.3 52332.5 54054.0 54118.7 54139.7 54244.0 1295.1 1315.6 1316.6 1405.5 1432.6 23655.0 29132.1 29292.7 29555.0 30082.2 50610.7 51080.0 51113.0 51139.0 51203.0 496856.0 498412.0 498754.0 499189.0 499358.0 26285.2 28648.0 28677.9 28692.9 28715.0 33983.5 40466.6 40603.8 41466.8 41820.8 32545.0 32869.5 34397.5 34495.1 35241.3 34076.0 34792.8 35384.8 35585.5 36328.0 35281.6 35570.8 35625.5 35826.0 35864.9 30812.7 31469.1 31513.5 31633.7 31819.0 24052.9 24162.8 24374.9 24562.8 24584.1 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:35111.75 Median:13034.08 stddev:104474.29 (801.5%) stddev-sans-first:104734.77 07:04:03 INFO - PROCESS | 1672 | Values: 357.3 363.9 366.0 368.8 373.9 19784.6 20100.9 20187.4 20411.6 20466.9 18799.0 19671.7 19941.6 19961.0 20379.0 5074.6 5697.6 5881.8 5911.1 5921.3 4066.9 4311.1 6204.6 6492.8 6499.3 6335.2 6396.2 6407.7 6414.6 6429.4 6203.4 6349.8 6381.0 6392.1 6397.1 3683.3 3862.0 3872.3 5245.9 5501.2 24665.8 24709.5 24944.1 25667.4 25710.8 1944.9 2016.5 2032.8 2042.6 2083.6 7506.6 7806.3 9287.8 9353.7 9595.0 1669.8 1673.5 1697.6 1732.9 1774.0 108831.5 110194.0 111119.4 112016.4 112644.0 11180.3 11188.4 11228.2 11273.7 11364.4 13580.3 13619.3 13633.9 13652.9 13670.7 8287.5 8356.3 8371.7 8451.8 8464.1 6872.0 8418.5 8439.0 8450.8 8518.2 4375.5 4456.7 4461.4 4504.8 4519.9 1736.4 1805.6 1807.7 1809.5 1809.5 903.5 918.7 963.7 977.4 998.4 16112.9 20042.4 20212.3 20586.9 20765.0 803.7 901.4 962.8 969.7 972.9 10139.3 11159.8 11164.9 11255.9 11291.7 522786.0 641162.0 643948.0 661218.0 665313.0 118158.4 118352.4 120211.0 121168.4 125364.0 998.1 1007.5 1016.4 1038.9 1041.5 14930.9 17742.3 18193.2 18216.5 18321.3 49695.8 49850.3 50120.0 50385.2 50413.7 77177.0 77566.4 79902.6 80124.0 80389.2 7783.1 7868.3 7968.6 8138.6 8349.2 9328.6 10673.6 12030.3 12097.9 12801.5 10975.5 11249.2 11495.4 11523.5 11911.7 10030.9 10703.1 11288.8 11491.7 11814.8 9761.6 10490.1 11690.0 11956.2 11988.8 7533.5 8066.7 8091.3 8188.4 8206.2 9294.7 10593.4 10722.0 10790.1 10806.8 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5931.63 Median:5369.46 stddev:3105.39 (57.8%) stddev-sans-first:3095.42 07:04:03 INFO - PROCESS | 1672 | Values: 1400.1 1526.2 1535.8 1743.7 1902.3 7792.5 8414.0 8572.5 8576.1 8580.4 8282.0 8482.6 8494.2 8497.9 8518.8 2146.8 2373.2 2424.1 2441.5 2452.3 2464.0 2466.2 2469.8 2473.1 2473.5 2386.1 2441.2 2463.2 2467.3 2472.2 2407.3 2414.0 2416.3 2441.8 2447.1 2418.4 2452.4 2460.3 2462.6 2470.5 8547.1 8605.8 8623.8 8626.7 8628.1 5222.3 5342.6 5354.1 5390.8 5402.1 3522.0 3616.4 3691.6 3691.8 3697.9 1021.0 1057.1 1067.4 1077.2 1082.9 11714.1 11735.1 11736.5 11747.9 11759.4 4721.7 4829.8 4831.0 4843.1 4887.9 9854.4 9889.1 9895.0 9897.6 9913.8 4460.7 4520.6 5341.6 5366.9 5372.0 4327.8 4453.6 4462.2 4467.8 4668.7 3809.2 3883.0 3925.8 3931.9 3934.2 1275.2 1289.8 1289.9 1296.7 1305.3 1313.2 1332.3 1334.3 1338.4 1359.4 6891.9 7999.6 8082.8 8192.1 8204.5 1001.8 1179.9 1180.8 1181.6 1198.9 6254.3 6310.2 6313.5 6322.0 6340.6 9881.9 10436.7 10459.8 10592.2 10618.4 10228.7 10569.4 10602.7 10612.9 10628.6 8086.6 8240.0 8276.0 8339.9 8391.8 7631.7 7778.9 7819.3 7826.1 7830.8 8036.5 9156.8 9526.4 9544.3 9633.8 9502.5 9796.0 9808.5 9944.9 9964.7 6323.8 6483.2 6927.1 7011.4 7056.8 7824.3 8059.3 8067.5 8075.0 8080.6 7082.0 7193.2 7213.8 7340.0 7351.6 7054.4 7091.0 7104.4 7231.3 7257.3 7361.5 7515.5 7531.5 7586.4 7623.1 6826.1 6841.4 6877.9 6879.2 6879.8 6927.8 6952.2 6971.5 6976.5 6984.1 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5799.00 Median:6666.77 stddev:1885.81 (28.3%) stddev-sans-first:1845.69 07:04:03 INFO - PROCESS | 1672 | Values: 318.5 324.1 329.2 330.0 334.1 6720.5 6739.5 6742.9 6759.5 6773.2 6644.6 6682.1 6685.4 6689.2 6695.8 3943.6 4714.8 4841.1 4846.2 4934.5 4913.4 4917.2 4940.2 4952.6 4956.9 4888.8 4902.1 4907.1 4911.4 4930.7 4704.6 4770.0 4880.7 4883.2 4883.5 4148.7 4149.2 4154.7 4157.1 4166.7 6323.2 6330.9 6337.9 6342.3 6349.3 4653.5 5670.6 5672.2 5677.8 5688.5 6692.9 6988.5 6995.0 6996.5 7001.8 4580.7 4646.5 4650.1 4657.8 4660.7 7269.3 7333.3 7337.1 7343.3 7347.0 4709.3 4714.4 4725.6 4726.5 4734.4 3919.6 4780.7 4787.7 4791.9 4792.5 4652.9 4827.6 5593.4 5653.3 5656.1 5460.3 7045.0 7119.4 7143.6 7150.7 1617.5 1619.3 1629.5 1630.3 1634.5 978.6 1010.2 1032.2 1038.5 1058.1 6546.2 6625.0 6625.9 6642.9 6670.8 7383.3 7390.9 7395.5 7398.9 7405.7 6657.9 6680.8 6681.9 6705.6 6712.5 3765.2 3907.4 3944.4 3945.0 3950.5 7767.2 7782.6 7791.7 7798.8 7805.2 7637.4 7660.9 7681.3 7684.9 7690.6 7733.9 7740.7 7748.8 7751.6 7764.5 6476.6 6662.7 7416.7 7444.3 7454.1 7247.9 7317.5 7331.2 7342.4 7342.8 7758.8 7759.6 7763.1 7769.1 7773.2 3840.9 4633.4 4647.8 4659.6 4660.4 6013.9 6471.5 7415.6 7417.0 7431.9 7197.8 7203.7 7216.2 7230.0 7243.2 6136.9 7170.9 7186.3 7190.5 7210.8 7063.8 7064.3 7066.4 7067.1 7067.4 6905.8 7192.2 7200.1 7225.9 7231.6 6752.1 6923.1 6929.3 7010.3 7058.5 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:17978.37 Median:645.17 stddev:24902.14 (3859.8%) stddev-sans-first:24937.97 07:04:03 INFO - PROCESS | 1672 | Values: 640.8 664.3 738.8 752.6 787.9 14293.1 14453.3 14463.7 14464.7 14509.3 15047.9 15523.2 15534.6 15572.5 15605.4 711.3 717.4 867.3 883.1 886.3 864.1 886.7 888.9 889.6 889.6 927.6 936.7 939.9 942.3 942.9 740.3 930.7 931.6 939.1 949.0 689.8 692.4 692.5 692.6 693.8 14986.3 15051.0 15056.7 15069.0 15081.8 12617.7 12651.2 12949.7 12971.5 13030.8 9918.5 10097.0 10135.3 10163.5 10171.9 3505.0 3545.3 3554.4 3557.4 3733.8 69522.0 70118.3 70793.0 70804.0 71217.0 9069.5 9391.0 9417.0 9612.1 9712.1 21570.8 21596.4 21604.0 21642.9 22591.2 7372.5 7436.7 7531.2 7602.0 7684.5 3914.0 3973.0 3975.1 3992.6 4001.5 3510.3 3537.0 3556.8 3556.8 3556.9 649.5 651.2 678.7 692.1 721.3 483.8 590.8 604.3 619.9 624.4 8017.6 8040.3 8181.8 8240.5 8261.5 577.7 600.4 603.2 606.8 613.1 3591.5 3739.2 3795.0 3957.9 3998.2 91002.0 91611.5 93138.7 93191.1 93276.7 63523.0 76239.5 76686.0 77654.2 78370.8 67889.3 70326.6 70403.3 70624.0 71268.0 7652.4 7730.1 7756.4 7847.4 7957.3 49658.0 50290.5 51049.5 51464.2 52852.0 65068.0 66882.0 69103.8 69227.0 69684.0 10231.8 10234.4 10367.3 10887.8 10942.3 12319.1 12349.3 12351.3 12420.1 12796.0 11270.7 11302.3 11460.1 11781.1 11910.4 10741.1 10876.6 10950.0 11462.3 11503.3 11325.9 11330.9 11516.4 11559.5 11700.6 9339.0 9539.8 9609.9 9615.7 9786.0 9338.6 9592.3 9645.6 9782.2 9811.6 07:04:03 INFO - PROCESS | 1672 | -------- Summary: end -------- 07:04:03 INFO - PROCESS | 1672 | 07:04:03 INFO - TEST-INFO | 1672: exit 0 07:04:03 INFO - TEST-OK | dromaeo_css | took 1112963ms 07:04:03 INFO - TEST-START | kraken 07:04:03 INFO - operating with platform_type : mac_ 07:04:03 INFO - Initialising browser for kraken test... 07:04:03 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmplM85u4/profile http://localhost:49276/getInfo.html) 07:04:05 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 07:04:05 INFO - PROCESS | 1679 | colorDepth:24 07:04:05 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 07:04:05 INFO - PROCESS | 1679 | __metrics 07:04:06 INFO - PROCESS | 1679 | 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" 07:04:06 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:04:06 INFO - TEST-INFO | 1679: exit 0 07:04:06 INFO - Browser initialized. 07:04:06 INFO - Running cycle 1/1 for kraken test... 07:04:06 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmplM85u4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:18 INFO - PROCESS | 1681 | RSS: Main: 244350976 07:04:18 INFO - PROCESS | 1681 | 07:04:21 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:21 INFO - PROCESS | 1681 | RSS: Main: 289509376 07:04:21 INFO - PROCESS | 1681 | 07:04:24 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 07:04:25 INFO - PROCESS | 1681 | RSS: Main: 301432832 07:04:25 INFO - PROCESS | 1681 | 07:04:28 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 07:04:29 INFO - PROCESS | 1681 | RSS: Main: 285474816 07:04:29 INFO - PROCESS | 1681 | 07:04:31 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 07:04:31 INFO - PROCESS | 1681 | RSS: Main: 288452608 07:04:31 INFO - PROCESS | 1681 | 07:04:33 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:34 INFO - PROCESS | 1681 | RSS: Main: 289177600 07:04:34 INFO - PROCESS | 1681 | 07:04:37 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:37 INFO - PROCESS | 1681 | RSS: Main: 290127872 07:04:37 INFO - PROCESS | 1681 | 07:04:40 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 07:04:41 INFO - PROCESS | 1681 | RSS: Main: 290463744 07:04:41 INFO - PROCESS | 1681 | 07:04:44 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 07:04:44 INFO - PROCESS | 1681 | RSS: Main: 290328576 07:04:44 INFO - PROCESS | 1681 | 07:04:46 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:46 INFO - PROCESS | 1681 | RSS: Main: 325435392 07:04:46 INFO - PROCESS | 1681 | 07:04:48 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:49 INFO - PROCESS | 1681 | RSS: Main: 324792320 07:04:49 INFO - PROCESS | 1681 | 07:04:51 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:52 INFO - PROCESS | 1681 | RSS: Main: 331706368 07:04:52 INFO - PROCESS | 1681 | 07:04:54 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:55 INFO - PROCESS | 1681 | RSS: Main: 333479936 07:04:55 INFO - PROCESS | 1681 | 07:04:57 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:04:58 INFO - PROCESS | 1681 | RSS: Main: 333430784 07:04:58 INFO - PROCESS | 1681 | 07:04:59 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 07:05:00 INFO - PROCESS | 1681 | RSS: Main: 393580544 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | __start_tp_report 07:05:00 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 07:05:00 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 07:05:00 INFO - PROCESS | 1681 | |i|pagename|runs| 07:05:00 INFO - PROCESS | 1681 | |0;ai-astar;111;108;110;112;111;111;114;111;111;111 07:05:00 INFO - PROCESS | 1681 | |1;audio-beat-detection;156;115;145;145;147;170;165;118;163;119 07:05:00 INFO - PROCESS | 1681 | |2;audio-dft;185;184;187;184;182;184;186;181;183;184 07:05:00 INFO - PROCESS | 1681 | |3;audio-fft;74;77;88;78;62;82;87;107;107;55 07:05:00 INFO - PROCESS | 1681 | |4;audio-oscillator;90;81;127;106;80;78;117;78;78;123 07:05:00 INFO - PROCESS | 1681 | |5;imaging-gaussian-blur;84;90;85;92;87;91;84;90;84;90 07:05:00 INFO - PROCESS | 1681 | |6;imaging-darkroom;94;94;94;94;94;95;113;148;102;94 07:05:00 INFO - PROCESS | 1681 | |7;imaging-desaturate;90;91;89;91;97;129;91;89;91;90 07:05:00 INFO - PROCESS | 1681 | |8;json-parse-financial;44;43;74;84;85;83;84;66;54;53 07:05:00 INFO - PROCESS | 1681 | |9;json-stringify-tinderbox;63;65;74;75;68;65;66;66;67;66 07:05:00 INFO - PROCESS | 1681 | |10;stanford-crypto-aes;84;81;83;84;82;82;79;82;82;84 07:05:00 INFO - PROCESS | 1681 | |11;stanford-crypto-ccm;128;123;124;130;128;118;120;116;120;119 07:05:00 INFO - PROCESS | 1681 | |12;stanford-crypto-pbkdf2;140;127;135;136;138;127;139;137;138;135 07:05:00 INFO - PROCESS | 1681 | |13;stanford-crypto-sha256-iterative;65;66;66;67;66;67;66;68;67;66 07:05:00 INFO - PROCESS | 1681 | __end_tp_report 07:05:00 INFO - PROCESS | 1681 | __start_cc_report 07:05:00 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1269 07:05:00 INFO - PROCESS | 1681 | __end_cc_report 07:05:00 INFO - PROCESS | 1681 | __startTimestamp1456412700129__endTimestamp 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | ------- Summary: start ------- 07:05:00 INFO - PROCESS | 1681 | Number of tests: 14 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.49 (1.3%) stddev-sans-first:1.58 07:05:00 INFO - PROCESS | 1681 | Values: 111.0 108.0 110.0 112.0 111.0 111.0 114.0 111.0 111.0 111.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:151.50 stddev:20.48 (13.5%) stddev-sans-first:21.28 07:05:00 INFO - PROCESS | 1681 | Values: 156.0 115.0 145.0 145.0 147.0 170.0 165.0 118.0 163.0 119.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:1.76 (1.0%) stddev-sans-first:1.83 07:05:00 INFO - PROCESS | 1681 | Values: 185.0 184.0 187.0 184.0 182.0 184.0 186.0 181.0 183.0 184.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.50 stddev:16.81 (21.7%) stddev-sans-first:17.60 07:05:00 INFO - PROCESS | 1681 | Values: 74.0 77.0 88.0 78.0 62.0 82.0 87.0 107.0 107.0 55.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:78.00 stddev:20.33 (26.1%) stddev-sans-first:21.45 07:05:00 INFO - PROCESS | 1681 | Values: 90.0 81.0 127.0 106.0 80.0 78.0 117.0 78.0 78.0 123.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:90.00 stddev:3.23 (3.6%) stddev-sans-first:3.14 07:05:00 INFO - PROCESS | 1681 | Values: 84.0 90.0 85.0 92.0 87.0 91.0 84.0 90.0 84.0 90.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#6] imaging-darkroom Cycles:10 Average:102.20 Median:94.00 stddev:17.22 (18.3%) stddev-sans-first:18.01 07:05:00 INFO - PROCESS | 1681 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 113.0 148.0 102.0 94.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:91.00 stddev:12.23 (13.4%) stddev-sans-first:12.85 07:05:00 INFO - PROCESS | 1681 | Values: 90.0 91.0 89.0 91.0 97.0 129.0 91.0 89.0 91.0 90.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:78.50 stddev:17.25 (22.0%) stddev-sans-first:16.16 07:05:00 INFO - PROCESS | 1681 | Values: 44.0 43.0 74.0 84.0 85.0 83.0 84.0 66.0 54.0 53.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:66.50 stddev:3.92 (5.9%) stddev-sans-first:3.81 07:05:00 INFO - PROCESS | 1681 | Values: 63.0 65.0 74.0 75.0 68.0 65.0 66.0 66.0 67.0 66.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:1.57 (1.9%) stddev-sans-first:1.54 07:05:00 INFO - PROCESS | 1681 | Values: 84.0 81.0 83.0 84.0 82.0 82.0 79.0 82.0 82.0 84.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:123.50 stddev:4.79 (3.9%) stddev-sans-first:4.66 07:05:00 INFO - PROCESS | 1681 | Values: 128.0 123.0 124.0 130.0 128.0 118.0 120.0 116.0 120.0 119.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.20 Median:137.50 stddev:4.61 (3.4%) stddev-sans-first:4.56 07:05:00 INFO - PROCESS | 1681 | Values: 140.0 127.0 135.0 136.0 138.0 127.0 139.0 137.0 138.0 135.0 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - PROCESS | 1681 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 07:05:00 INFO - PROCESS | 1681 | Values: 65.0 66.0 66.0 67.0 66.0 67.0 66.0 68.0 67.0 66.0 07:05:00 INFO - PROCESS | 1681 | -------- Summary: end -------- 07:05:00 INFO - PROCESS | 1681 | 07:05:00 INFO - TEST-INFO | 1681: exit 0 07:05:00 INFO - TEST-OK | kraken | took 57250ms 07:05:00 INFO - SUITE-END | took 1170s 07:05:01 INFO - Completed test suite (00:19:30) 07:05:01 INFO - Working with test: dromaeo_css 07:05:01 INFO - Generating results file: dromaeo_css 07:05:01 INFO - Working with test: kraken 07:05:01 INFO - Generating results file: kraken 07:05:01 INFO - javascript benchmark 07:05:01 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:05:01 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 07:05:01 INFO - process_Request line: dromaeo_css 7474.07 graph.html#tests=[[72,64,59]] 07:05:01 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:05:01 INFO - process_Request line: kraken 1442.50 graph.html#tests=[[232,64,59]] 07:05:01 INFO - RETURN: dromaeo_css: 7474.07 07:05:01 INFO - RETURN: kraken: 1442.50 07:05:01 INFO - javascript benchmark 07:05:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2910.708929107089, 3488.250026244357, 3491.9999999999986, 3499.9475007874903, 3557.8576856925724, 5662.801801936933, 5700.287464066992, 5703.800366987156, 5731.340895796985, 5742.253507044078, 5676.772929082842, 5699.629524080932, 5737.913931291034, 5816.0, 5844.152597873306, 5136.409312929024, 5146.228065790143, 5180.197069454241, 5198.116320225552, 5205.687658740488, 5166.974165129169, 5169.224616307546, 5195.922061169085, 5232.16285394337, 5280.392754833186, 5117.513836185556, 5122.641415100926, 5231.503007214327, 5238.240455133984, 5250.238715386286, 5218.191180367049, 5219.556337711299, 5225.137852254374, 5230.973845130788, 5254.710990895499, 5163.225516172567, 5186.0665080285535, 5197.896042079137, 5228.215767634847, 5248.0, 5515.834524964217, 5613.7193140342815, 5624.0, 5654.6041777075625, 5730.140478928152, 6216.378362163793, 6227.470664993481, 6231.376862313778, 6254.3745625437095, 6302.747890084437, 5440.483154100354, 6307.684615769193, 6322.304546499881, 6347.079673447371, 6355.142055822451, 5542.334919809608, 5648.774049038034, 5753.108268218475, 5841.532677385799, 5861.0, 6373.5857169283845, 6387.904181437282, 6393.520485963571, 6402.263739669997, 6408.58344207625, 6070.544709146743, 6081.209442772411, 6137.386261373917, 6150.231221097363, 6164.845878852975, 6126.059675755388, 6228.22147231596, 6339.334369891188, 6356.936430635635, 6358.713857876407, 6206.72069756862, 6210.596311239755, 6217.067439884054, 6227.657478838617, 6228.5017198624, 6091.51267898567, 6231.626102433868, 6238.594491358047, 6252.5935814171935, 6265.780697675559, 4833.661643684979, 4837.22604383304, 4878.170710979071, 4901.730404827768, 4917.754112294371, 4364.974231055699, 4380.299152135643, 4382.649388048949, 4395.988922547768, 4401.911961760811, 5473.534749546254, 5583.469570390806, 5651.576131790132, 5666.263385759908, 5709.286339207599, 6190.41191086846, 6231.813045608639, 6270.655113968775, 6311.779087731999, 6314.55798094129, 5657.830265092054, 5662.631928924607, 5667.716614169275, 5668.178114173422, 5692.8861422771315, 5245.160774276097, 5339.733013349394, 5347.117725575236, 5349.331333583302, 5360.490753378423, 6298.307186209513, 6344.111824344688, 6347.143135676717, 6365.267994180728, 6377.8724425512155, 6263.467605253604, 6273.62358258506, 6274.717637706405, 6275.278342990615, 6312.400321969406, 6254.3745625437095, 6329.430351268408, 6352.809415717351, 6353.078803573549, 6376.075469057054, 6129.877402451837, 6153.507719382528, 6181.1655426516845, 6200.7519699211525, 6212.968935155295, 6280.775248826435, 6286.182796236643, 6321.747130114744, 6321.810345689637, 6326.43062124411, 5898.764049438146, 6062.6665533394325, 6118.510519158545, 6134.325224225421, 6135.53983451234, 6091.177691011657, 6115.422885572139, 6120.477608373006, 6122.703114648804, 6124.350421260821, 5924.200232968667, 5963.403659634002, 5966.105084237399, 5971.910421343597, 6000.459958603747, 5899.292084949833, 6046.848828779316, 6055.212822333068, 6060.212172417734, 6122.908156377569, 5957.463828255304, 5984.910226346696, 5995.160677505066, 5996.970015149896, 6002.279726432856], "unit": "score", "name": "dojo.html", "value": 5702.727801095917}, {"lowerIsBetter": false, "replicates": [428.27621319969256, 455.7903364452352, 465.69264285571506, 525.8816766227602, 563.3099453169867, 30026.549601755964, 38331.23337533248, 38929.221415571745, 39032.41451378224, 39036.024099397495, 40494.78515644535, 40940.38589421161, 41049.38425923613, 41100.794496027556, 41120.0, 9429.905700942989, 9631.181349585258, 9672.371295865782, 9676.661316853912, 9686.66096686616, 9458.0, 9573.856392154123, 9607.4715890626, 9623.182029527463, 9628.988956159608, 9679.08048735369, 9785.266105042114, 9788.755281117958, 9810.950945245264, 9817.460039697813, 8270.917290827076, 9305.069493050709, 9598.232141428669, 9666.371685840433, 9763.26775491841, 9659.130678238993, 9798.873129590118, 9805.950970245174, 9816.95091524545, 9819.018098190123, 40437.98905027368, 40905.59094409047, 40961.0, 41178.0, 41254.79372603118, 3035.362573859492, 3045.390921815646, 3049.832259225742, 3214.6624604416666, 3535.257595904863, 28703.42593148125, 28748.712512874812, 29212.561811572843, 29423.558646620317, 29683.554746678816, 2474.9628755568683, 2755.1872197701728, 2799.272189230794, 2820.8025438219333, 2902.1873875314946, 360467.0, 361529.0, 362543.0, 363988.0, 364031.0, 58009.0, 65960.67019664872, 66169.0, 66306.33693663098, 67909.66045169742, 51682.22476662853, 64821.351786482475, 65328.67335663291, 65600.0, 65667.0, 15901.0, 16205.946613470087, 16209.189540522926, 16222.269997850126, 16232.0, 11364.374959377148, 12226.327551984548, 12327.93836030814, 12333.260004399765, 12510.81233781494, 20409.795902041085, 20683.4829129273, 20685.58628827445, 20735.792642073688, 20749.0, 7630.7329243476215, 7836.451448398671, 7869.409794265339, 7898.60506974649, 7921.881171782428, 877.6050777150181, 941.4304345870787, 950.5247376311844, 1034.1778286262288, 1078.412265315405, 29015.12954611365, 29140.708592914223, 29223.85388073046, 29827.254318642208, 29981.950631727785, 1089.6131873185063, 1091.345192884279, 1107.684309971654, 1116.0346300450215, 1175.7883580955338, 14751.557453276419, 14925.552233433014, 14974.550763476895, 15239.466618668293, 15322.233888305764, 532190.0, 535305.0, 535800.0, 536945.0, 540122.2993885005, 52332.47667523352, 54054.0, 54118.7294063535, 54139.72930135324, 54244.0, 1295.1257900917033, 1315.6447759104797, 1316.565533373965, 1405.5361730628867, 1432.6275168456277, 23655.0, 29132.143906971578, 29292.707072929, 29555.0, 30082.24794380158, 50610.74694626503, 51080.0, 51113.0, 51139.0, 51203.0, 496856.0, 498412.0, 498754.0, 499189.0, 499358.0, 26285.21144365672, 28648.0, 28677.85661071681, 28692.856535717186, 28715.0, 33983.4902476468, 40466.59533404628, 40603.79698101491, 41466.792666036476, 41820.79089604533, 32545.0, 32869.50695739614, 34397.484037738956, 34495.13762155966, 35241.295174096886, 34076.0, 34792.82603586966, 35384.82307588446, 35585.46621800727, 36328.0, 35281.64718352886, 35570.75502357405, 35625.46561801523, 35825.954793842815, 35864.924052278475, 30812.69187308098, 31469.05592832219, 31513.52729709102, 31633.683663163993, 31819.04542863718, 24052.873126493443, 24162.75837241605, 24374.87812560926, 24562.754372456046, 24584.139555115486], "unit": "score", "name": "ext.html", "value": 19162.980892544852}, {"lowerIsBetter": false, "replicates": [357.32287315537053, 363.88355726167623, 366.02271933936396, 368.80269056055016, 373.86540845295707, 19784.60430791385, 20100.8994955025, 20187.39437816866, 20411.591768164628, 20466.89766551169, 18799.0, 19671.704924426143, 19941.601167976667, 19961.0, 20379.0, 5074.568661663763, 5697.572682048843, 5881.823545293648, 5911.142884281798, 5921.348651648315, 4066.857659981901, 4311.094670119263, 6204.565680402374, 6492.772752953648, 6499.2850786413455, 6335.176427064498, 6396.2324521057535, 6407.679616019203, 6414.61512309263, 6429.3570642935565, 6203.441690247854, 6349.809505714836, 6380.968095159517, 6392.137061496708, 6397.0724244984685, 3683.2633473305177, 3862.0, 3872.3029854626157, 5245.895082098375, 5501.229827824108, 24665.753342466523, 24709.5058098837, 24944.12695555647, 25667.35831604206, 25710.843012064503, 1944.8930308833008, 2016.5462770876582, 2032.8280953865474, 2042.5608494173675, 2083.6457802173513, 7506.587137707424, 7806.258405451473, 9287.792586963718, 9353.672621458216, 9594.9520252399, 1669.7996240451102, 1673.5314112048645, 1697.6010637500178, 1732.9133543322782, 1774.0, 108831.45584272107, 110194.0, 111119.44440277827, 112016.4399178007, 112644.0, 11180.27328223679, 11188.384638844942, 11228.214025018171, 11273.661790146309, 11364.374959377314, 13580.253086080163, 13619.319034048258, 13633.863661363457, 13652.931735341459, 13670.658233544242, 8287.461315014625, 8356.289715374262, 8371.665133394596, 8451.830963380698, 8464.111268316861, 6872.0, 8418.452800567944, 8439.0, 8450.788730281793, 8518.190771876662, 4375.453068366454, 4456.688031837805, 4461.397711308997, 4504.842330518416, 4519.932201016987, 1736.3662263273814, 1805.647898659775, 1807.7107662773892, 1809.4933418642802, 1809.5476130967259, 903.5301643145527, 918.7229750646607, 963.6675347005272, 977.3842479238034, 998.3959704378747, 16112.919435402982, 20042.39872803789, 20212.29256976028, 20586.897065514877, 20764.961751912342, 803.6704950970075, 901.3904745760985, 962.7881865989472, 969.7284760267137, 972.9173020293355, 10139.2902496826, 11159.832602510969, 11164.939330763564, 11255.943720281346, 11291.717707057389, 522786.0, 641162.0, 643948.0, 661218.0, 665313.0, 118158.40920795342, 118352.40823795825, 120211.0, 121168.39415802865, 125364.0, 998.1116806042628, 1007.4761124215366, 1016.3698506925606, 1038.9064984151462, 1041.4584416103585, 14930.925345373204, 17742.29030838752, 18193.181306840957, 18216.544586384916, 18321.267149313877, 49695.75152124361, 49850.25224621561, 50120.0, 50385.244221337445, 50413.747931260106, 77177.0, 77566.44867102739, 79902.6004869972, 80124.0, 80389.19610803817, 7783.143854176149, 7868.331191848528, 7968.561729104955, 8138.633761480629, 8349.248567628943, 9328.580213890256, 10673.626423075155, 12030.27818330903, 12097.939510302393, 12801.487940482277, 10975.50610222526, 11249.212555121063, 11495.425228738362, 11523.481443335239, 11911.702207444883, 10030.899691002996, 10703.090237329914, 11288.774224515299, 11491.712707182387, 11814.763704726029, 9761.56072976732, 10490.108340790814, 11690.0, 11956.163068585116, 11988.820167697666, 7533.472656913963, 8066.745507801901, 8091.312238459797, 8188.385871059575, 8206.179382061984, 9294.72115836526, 10593.36439813583, 10722.03501684852, 10790.082842958436, 10806.837897431702], "unit": "score", "name": "jquery.html", "value": 9263.91623252673}, {"lowerIsBetter": false, "replicates": [1400.082945670586, 1526.1529850932734, 1535.7849901013856, 1743.6512697460503, 1902.3056584346718, 7792.45452818303, 8414.032386275572, 8572.528510931896, 8576.0995095515, 8580.39937204396, 8282.0, 8482.575871206445, 8494.193051660099, 8497.872531912026, 8518.829623407528, 2146.785321467856, 2373.2287006722886, 2424.1273141668985, 2441.5116976604663, 2452.3256104571296, 2464.0143942422997, 2466.1615050882697, 2469.802415806731, 2473.084958565333, 2473.5300292944285, 2386.0813586769045, 2441.170002199252, 2463.15021317646, 2467.3091534370405, 2472.159465781634, 2407.263397213312, 2413.951720965571, 2416.3113512648897, 2441.816863735227, 2447.106806015809, 2418.431668557905, 2452.350127216289, 2460.286516910112, 2462.5936720441105, 2470.4564995700916, 8547.145285471403, 8605.827883442358, 8623.82752344956, 8626.698065567674, 8628.09405012471, 5222.3472065991755, 5342.5993050521365, 5354.14333706609, 5390.838274851761, 5402.135658294694, 3522.0490467573613, 3616.4032934565766, 3691.630836916314, 3691.8154092295545, 3697.8890633281044, 1020.9897901020969, 1057.148995058977, 1067.386252904583, 1077.2136340471422, 1082.9079528240109, 11714.062874969983, 11735.061195104456, 11736.471858766376, 11747.882521174764, 11759.35323557204, 4721.7403042832975, 4829.823489376069, 4830.951690483121, 4843.128236917389, 4887.877803054881, 9854.408735475894, 9889.109980101824, 9894.950525247472, 9897.554610042565, 9913.752156196153, 4460.710053846555, 4520.61574766142, 5341.572674186055, 5366.946330536644, 5371.979323928441, 4327.826886924488, 4453.55464453552, 4462.196804575207, 4467.798949047301, 4668.743219122981, 3809.238152369537, 3883.0, 3925.823337949799, 3931.941020884689, 3934.15415685629, 1275.1647670775658, 1289.774289499334, 1289.8645642207432, 1296.6563860576955, 1305.3147097773744, 1313.1792629606496, 1332.2872263339068, 1334.3328335832084, 1338.4110991163857, 1359.3814814259488, 6891.896621550681, 7999.600019998977, 8082.838343233102, 8192.057913339922, 8204.548749818818, 1001.7796084861319, 1179.8761130081389, 1180.816973369129, 1181.5805389086922, 1198.8621308549455, 6254.2807577129215, 6310.179676642099, 6313.463355614732, 6321.956877115316, 6340.619562826245, 9881.851772223423, 10436.739081523023, 10459.849416564171, 10592.15262778976, 10618.36289822613, 10228.693139205687, 10569.365838049742, 10602.681919542427, 10612.893871061346, 10628.574857005633, 8086.555239461886, 8240.0, 8276.006879174418, 8339.916600834036, 8391.790205244917, 7631.732889348847, 7778.883316750366, 7819.296263336327, 7826.139124696393, 7830.765077047698, 8036.4776289541, 9156.816863662556, 9526.380785248937, 9544.33189676716, 9633.807323853343, 9502.524873756423, 9795.951020244853, 9808.460534670376, 9944.900550994398, 9964.701058968243, 6323.841903952438, 6483.189601299838, 6927.134108236471, 7011.4390848733, 7056.765066113512, 7824.334931530883, 8059.274665280153, 8067.515949043076, 8075.0, 8080.595970201584, 7081.964590177016, 7193.244709305448, 7213.783586492414, 7340.009098771598, 7351.595662238628, 7054.435645148478, 7091.0, 7104.3961263293195, 7231.349178573953, 7257.310555497219, 7361.521501102411, 7515.511491753018, 7531.510451820614, 7586.3930885527925, 7623.123340815877, 6826.112605361272, 6841.418479429105, 6877.931220687929, 6879.243283238739, 6879.793606191622, 6927.792166235021, 6952.165740111219, 6971.5468494547695, 6976.4767642426, 6984.126984126984], "unit": "score", "name": "mootools.html", "value": 4863.208922725036}, {"lowerIsBetter": false, "replicates": [318.45226210917224, 324.14264271003196, 329.231245042825, 329.99835000824993, 334.1495892952436, 6720.46236301096, 6739.494537909652, 6742.898856517156, 6759.526833121683, 6773.187217533897, 6644.568103073297, 6682.097916781233, 6685.398314151726, 6689.230738465078, 6695.765648202314, 3943.5859234780364, 4714.764261786914, 4841.055994081155, 4846.248831431134, 4934.481879402665, 4913.434954980169, 4917.188663870457, 4940.2342636891335, 4952.603791696673, 4956.876078098058, 4888.755562221892, 4902.142125128088, 4907.1412502812045, 4911.386076740408, 4930.679505832128, 4704.6001089907395, 4770.0, 4880.731559764212, 4883.19427294496, 4883.4628190898975, 4148.688848336386, 4149.190907772985, 4154.667626589896, 4157.10622216225, 4166.708330416872, 6323.241211054657, 6330.87338253237, 6337.873242535124, 6342.302346741854, 6349.333320001379, 4653.511381304948, 5670.631408958405, 5672.205891175238, 5677.772889084432, 5688.544916406678, 6692.93307066928, 6988.510804243705, 6994.965025174893, 6996.510244282902, 7001.82495437613, 4580.748058856761, 4646.53534646536, 4650.116477869194, 4657.790399432034, 4660.673752837302, 7269.3094156055095, 7333.303336183, 7337.0828646419195, 7343.339099481019, 7347.0, 4709.27006314015, 4714.3871296731895, 4725.64557658177, 4726.456457507431, 4734.360861283682, 3919.6472317490993, 4780.689255198401, 4787.664863459524, 4791.904161916742, 4792.496787837296, 4652.930206046912, 4827.61379089672, 5593.440655934455, 5653.321601407857, 5656.095024796013, 5460.34475862899, 7045.013698082273, 7119.430445564342, 7143.642817859086, 7150.7497237596435, 1617.4500669772099, 1619.3117924881878, 1629.4785668586176, 1630.3071194742424, 1634.5014770495113, 978.6183388478499, 1010.1817527802503, 1032.2258306270298, 1038.5274700011478, 1058.1217589400778, 6546.24718157418, 6625.0, 6625.86748265032, 6642.86714265712, 6670.799876003728, 7383.2985866342615, 7390.9260907390235, 7395.482316237812, 7398.852022959511, 7405.740799072007, 6657.933420665829, 6680.766173184013, 6681.866362672719, 6705.597664140069, 6712.463002959751, 3765.1528406108405, 3907.374820028782, 3944.4280579315837, 3944.980275098606, 3950.486436763202, 7767.2232776723, 7782.64978075988, 7791.6883324667515, 7798.844023119505, 7805.2194780521495, 7637.389008879276, 7660.923390766133, 7681.347085497683, 7684.923150768421, 7690.577018264049, 7733.883991740128, 7740.729074482366, 7748.7675369739, 7751.612419379121, 7764.495307804975, 6476.6114033158165, 6662.733490660319, 7416.7404140854815, 7444.330010298882, 7454.068241469817, 7247.891281630675, 7317.524360916524, 7331.156916954618, 7342.3758980487255, 7342.816429589303, 7758.7672369829, 7759.573223472763, 7763.0684317882215, 7769.067711874612, 7773.222677732181, 3840.8669442515084, 4633.397658304533, 4647.838754978951, 4659.5573420525, 4660.394148760775, 6013.879722405615, 6471.514636402195, 7415.555066696015, 7416.96291518539, 7431.925680743339, 7197.784066478014, 7203.747868824776, 7216.170140433707, 7230.023946767329, 7243.167035790952, 6136.938630613637, 7170.928290717235, 7186.281371862981, 7190.532615379983, 7210.819729506804, 7063.752768653072, 7064.258252883579, 7066.399356054793, 7067.116610423697, 7067.434605231672, 6905.75829845953, 7192.244814294633, 7200.063991681048, 7225.855482890418, 7231.602261875647, 6752.122224110834, 6923.065386172802, 6929.272426395156, 7010.334018268256, 7058.470614704021], "unit": "score", "name": "prototype.html", "value": 5164.239283716887}, {"lowerIsBetter": false, "replicates": [640.8333833203367, 664.3423011218889, 738.8300690841106, 752.6274494125408, 787.8503084413961, 14293.14241145532, 14453.349599268033, 14463.710725785479, 14464.71070578589, 14509.347079381427, 15047.924760376183, 15523.223838808071, 15534.61163470911, 15572.532824015268, 15605.375784968588, 711.2780527764323, 717.3543810570502, 867.3104881619112, 883.1389395339556, 886.3485338276362, 864.0754392799707, 886.7428445750725, 888.9155530224618, 889.5596679643586, 889.5774507109136, 927.6057675487924, 936.6955739384728, 939.9436033837958, 942.2979879989417, 942.9339946203769, 740.2893222506427, 930.6696122876349, 931.5575101826646, 939.0609390609391, 948.9810203795954, 689.837888096297, 692.4183685703982, 692.4875592061888, 692.5636848785283, 693.7606525748608, 14986.250687465583, 15051.021683590532, 15056.698866022618, 15069.0, 15081.849181508154, 12617.747645047139, 12651.177673451197, 12949.741005179843, 12971.481140754358, 13030.804537931845, 9918.518962315029, 10096.990300969917, 10135.341202821794, 10163.4918254087, 10171.89828101717, 3505.0, 3545.2909418116224, 3554.3779838528153, 3557.3774589446743, 3733.7946412947276, 69522.0, 70118.29881701169, 70793.0, 70804.0, 71216.99999999948, 9069.54652267384, 9391.0, 9417.011213822587, 9612.134907858326, 9712.077352651488, 21570.81360525186, 21596.352109436742, 21604.027818748193, 21642.89178554097, 22591.20930767415, 7372.520786148883, 7436.66535005926, 7531.246875312535, 7601.961990190013, 7684.500507466997, 3913.980430097888, 3972.980135099364, 3975.1453437511072, 3992.5608183099835, 4001.519817621846, 3510.297940411877, 3537.0, 3556.822158892045, 3556.822158892097, 3556.87550935716, 649.5063751548762, 651.2478087808589, 678.7454704485817, 692.1417442371524, 721.3147509865648, 483.76779146010114, 590.8375196820908, 604.3442864492075, 619.9380061993854, 624.4348864277745, 8017.559034253055, 8040.316573091236, 8181.754547363588, 8240.464369815943, 8261.504309741315, 577.6995962099685, 600.447588218831, 603.2278683285401, 606.7633622886989, 613.1018058544254, 3591.533100696945, 3739.2334571412794, 3795.0322667719556, 3957.920841583152, 3998.1603863188475, 91002.0, 91611.54194228986, 93138.67153321221, 93191.0680893196, 93276.6680832971, 63523.0, 76239.47521049548, 76686.0, 77654.22345776582, 78370.77106903693, 67889.3027674312, 70326.59346813035, 70403.2959670407, 70624.0, 71268.0, 7652.426068044808, 7730.11103723079, 7756.379489640703, 7847.372210223282, 7957.340037611791, 49658.0, 50290.49709502858, 51049.46851594458, 51464.22803658023, 52852.0, 65068.0, 66881.99677004751, 69103.83346026862, 69227.0, 69684.0, 10231.84652230232, 10234.385936843813, 10367.32612380193, 10887.78224435491, 10942.343459392461, 12319.137660363689, 12349.32078735678, 12351.320677362832, 12420.06849486274, 12796.0, 11270.718232044264, 11302.265352752045, 11460.140489463156, 11781.116416268986, 11910.404479775803, 10741.087007604128, 10876.619318324138, 10950.0, 11462.312261264351, 11503.252288601214, 11325.868127940954, 11330.858881301025, 11516.366599836754, 11559.537618495166, 11700.590479333183, 9339.0, 9539.76150596213, 9609.90390096118, 9615.663451779154, 9785.97247289053, 9338.587053615662, 9592.328537002342, 9645.565949532429, 9782.168515675963, 9811.607535698493], "unit": "score", "name": "yui.html", "value": 6855.4756448217795}], "name": "dromaeo_css", "value": 7474.064369171067}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 112.0, 111.0, 111.0, 114.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [156.0, 115.0, 145.0, 145.0, 147.0, 170.0, 165.0, 118.0, 163.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 187.0, 184.0, 182.0, 184.0, 186.0, 181.0, 183.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [74.0, 77.0, 88.0, 78.0, 62.0, 82.0, 87.0, 107.0, 107.0, 55.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [90.0, 81.0, 127.0, 106.0, 80.0, 78.0, 117.0, 78.0, 78.0, 123.0], "unit": "score", "name": "audio-oscillator", "value": 95.8}, {"lowerIsBetter": true, "replicates": [84.0, 90.0, 85.0, 92.0, 87.0, 91.0, 84.0, 90.0, 84.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.7}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 113.0, 148.0, 102.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 102.2}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 89.0, 91.0, 97.0, 129.0, 91.0, 89.0, 91.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 94.8}, {"lowerIsBetter": true, "replicates": [44.0, 43.0, 74.0, 84.0, 85.0, 83.0, 84.0, 66.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 67.0}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 74.0, 75.0, 68.0, 65.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 83.0, 84.0, 82.0, 82.0, 79.0, 82.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [128.0, 123.0, 124.0, 130.0, 128.0, 118.0, 120.0, 116.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.6}, {"lowerIsBetter": true, "replicates": [140.0, 127.0, 135.0, 136.0, 138.0, 127.0, 139.0, 137.0, 138.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.2}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1442.5}]} 07:05:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1442.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7474.07"}}} 07:05:01 INFO - Return code: 0 07:05:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:05:01 INFO - # TBPL SUCCESS # 07:05:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:05:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:05:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:05:01 INFO - 2016-02-25 07:05:01.868 screenresolution[1685:10568] starting screenresolution argv=screenresolution get 07:05:01 INFO - 2016-02-25 07:05:01.870 screenresolution[1685:10568] Display 0: 1600x1200x32@60 07:05:01 INFO - 2016-02-25 07:05:01.876 screenresolution[1686:10571] starting screenresolution argv=screenresolution list 07:05:01 INFO - Available Modes on Display 0 07:05:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:05:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:05:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:05:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:05:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:05:02 INFO - Intel Iris: 07:05:02 INFO - Chipset Model: Intel Iris 07:05:02 INFO - Type: GPU 07:05:02 INFO - Bus: Built-In 07:05:02 INFO - VRAM (Dynamic, Max): 1536 MB 07:05:02 INFO - Vendor: Intel (0x8086) 07:05:02 INFO - Device ID: 0x0a2e 07:05:02 INFO - Revision ID: 0x0009 07:05:02 INFO - Displays: 07:05:02 INFO - Display: 07:05:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:05:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:05:02 INFO - Display Serial Number: 1600x1200 60 07:05:02 INFO - Main Display: Yes 07:05:02 INFO - Mirror: Off 07:05:02 INFO - Online: Yes 07:05:02 INFO - Rotation: Supported 07:05:02 INFO - Return code: 0 07:05:02 INFO - Running post-action listener: _resource_record_post_action 07:05:02 INFO - Running post-run listener: _resource_record_post_run 07:05:03 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33766912; Write bytes: 709483008; Read time: 355; Write time: 1986 07:05:03 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401801728; Write bytes: 396776960; Read time: 30218; Write time: 697 07:05:03 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 31981056; Write bytes: 301130752; Read time: 336; Write time: 1254 07:05:03 INFO - Running post-run listener: _upload_blobber_files 07:05:03 INFO - Blob upload gear active. 07:05:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:05:03 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 07:05:03 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'] 07:05:03 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 07:05:03 INFO - (blobuploader) - INFO - Open directory for files ... 07:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:05:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:04 INFO - (blobuploader) - INFO - Done attempting. 07:05:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:05:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:05:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:05 INFO - (blobuploader) - INFO - Done attempting. 07:05:05 INFO - (blobuploader) - INFO - Iteration through files over. 07:05:05 INFO - Return code: 0 07:05:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:05:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:05:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7925093317b59a03d824c2cd142ff0b0fb56fe27c09f6380fe6d15096bbb526d43f459741d54ff5a9ceaf69be2338f36855845c861cc023fba8efedba85e4dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0c354c0be10054187a6c3bf2cf731e67b84771126e46c93f8d7b972a8a2ac57c230ee59fc65b9d4d6fae32e4ef46416c23a824d03141b1fa4980932463e8838"} 07:05:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:05:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:05:05 INFO - Contents: 07:05:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7925093317b59a03d824c2cd142ff0b0fb56fe27c09f6380fe6d15096bbb526d43f459741d54ff5a9ceaf69be2338f36855845c861cc023fba8efedba85e4dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0c354c0be10054187a6c3bf2cf731e67b84771126e46c93f8d7b972a8a2ac57c230ee59fc65b9d4d6fae32e4ef46416c23a824d03141b1fa4980932463e8838"} 07:05:05 INFO - Running post-run listener: copy_logs_to_upload_dir 07:05:05 INFO - Copying logs to upload dir... 07:05:05 INFO - mkdir: /builds/slave/test/build/upload/logs 07:05:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.087635 ========= master_lag: 56.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2016-02-25 07:06:02.224707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 07:06:02.225892) ========= 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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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/7925093317b59a03d824c2cd142ff0b0fb56fe27c09f6380fe6d15096bbb526d43f459741d54ff5a9ceaf69be2338f36855845c861cc023fba8efedba85e4dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0c354c0be10054187a6c3bf2cf731e67b84771126e46c93f8d7b972a8a2ac57c230ee59fc65b9d4d6fae32e4ef46416c23a824d03141b1fa4980932463e8838"} build_url:https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/AT6xGU3hS3iLAxq_ckybIA/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/7925093317b59a03d824c2cd142ff0b0fb56fe27c09f6380fe6d15096bbb526d43f459741d54ff5a9ceaf69be2338f36855845c861cc023fba8efedba85e4dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0c354c0be10054187a6c3bf2cf731e67b84771126e46c93f8d7b972a8a2ac57c230ee59fc65b9d4d6fae32e4ef46416c23a824d03141b1fa4980932463e8838"}' ========= master_lag: 0.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 07:06:02.774782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 07:06:02.775116) ========= 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.oO09sTP9Ku/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.HEXYcdvIXZ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005176 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 07:06:02.851248) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-25 07:06:02.851579) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-25 07:06:05.702337) ========= ========= Total master_lag: 57.29 =========