builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0164 starttime: 1459357681.07 results: success (0) buildid: 20160330090109 builduid: 877b50ef34f9412181f476218c0acbc0 revision: b994a14879e1a8e03c6e63ba86edcbdcd832535e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.069367) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.069834) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.070153) ========= 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.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005482 basedir: '/builds/slave/test' ========= master_lag: 0.26 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.340345) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.340665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.377069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.377485) ========= 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.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005519 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.431991) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.432319) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.432684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.432965) ========= 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.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-30 10:08:01-- 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% 19.1M=0.001s 2016-03-30 10:08:01 (19.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.632439) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.633013) ========= 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.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.025947 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:01.690894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 10:08:01.691279) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b994a14879e1a8e03c6e63ba86edcbdcd832535e --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 b994a14879e1a8e03c6e63ba86edcbdcd832535e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-30 10:08:01,770 truncating revision to first 12 chars 2016-03-30 10:08:01,770 Setting DEBUG logging. 2016-03-30 10:08:01,770 attempt 1/10 2016-03-30 10:08:01,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b994a14879e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-30 10:08:02,487 unpacking tar archive at: fx-team-b994a14879e1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949599 ========= master_lag: 0.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-30 10:08:03.017185) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:03.017569) ========= echo b994a14879e1a8e03c6e63ba86edcbdcd832535e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b994a14879e1a8e03c6e63ba86edcbdcd832535e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 b994a14879e1a8e03c6e63ba86edcbdcd832535e program finished with exit code 0 elapsedTime=0.005824 script_repo_revision: 'b994a14879e1a8e03c6e63ba86edcbdcd832535e' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:03.056939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:03.057364) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-30 10:08:03.117198) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-03-30 10:08:03.117615) ========= /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.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:03 INFO - MultiFileLogger online at 20160330 10:08:03 in /builds/slave/test 10:08:03 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 10:08:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:08:03 INFO - {'append_to_log': False, 10:08:03 INFO - 'base_work_dir': '/builds/slave/test', 10:08:03 INFO - 'blob_upload_branch': 'Fx-Team', 10:08:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:08:03 INFO - 'branch': 'Fx-Team', 10:08:03 INFO - 'buildbot_json_path': 'buildprops.json', 10:08:03 INFO - 'config_files': ('talos/mac_config.py',), 10:08:03 INFO - 'default_actions': ('clobber', 10:08:03 INFO - 'read-buildbot-config', 10:08:03 INFO - 'download-and-extract', 10:08:03 INFO - 'populate-webroot', 10:08:03 INFO - 'create-virtualenv', 10:08:03 INFO - 'install', 10:08:03 INFO - 'run-tests'), 10:08:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:08:03 INFO - 'download_minidump_stackwalk': True, 10:08:03 INFO - 'download_symbols': 'ondemand', 10:08:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:08:03 INFO - 'tooltool.py': '/tools/tooltool.py', 10:08:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:08:03 INFO - '/tools/misc-python/virtualenv.py')}, 10:08:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:08:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:08:03 INFO - 'installer_path': 'installer.exe', 10:08:03 INFO - 'log_level': 'info', 10:08:03 INFO - 'log_name': 'talos', 10:08:03 INFO - 'log_to_console': True, 10:08:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:08:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:08:03 INFO - 'opt_config_files': (), 10:08:03 INFO - 'pip_index': False, 10:08:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:08:03 INFO - 'cmd': ('bash', 10:08:03 INFO - '-c', 10:08:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:08:03 INFO - 'enabled': True, 10:08:03 INFO - 'halt_on_failure': False, 10:08:03 INFO - 'name': 'check_screen_resolution'},), 10:08:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:08:03 INFO - 'cmd': ('bash', 10:08:03 INFO - '-c', 10:08:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:08:03 INFO - 'enabled': True, 10:08:03 INFO - 'halt_on_failure': False, 10:08:03 INFO - 'name': 'check_screen_resolution'},), 10:08:03 INFO - 'run_cmd_checks_enabled': True, 10:08:03 INFO - 'sps_profile': False, 10:08:03 INFO - 'sps_profile_interval': 0, 10:08:03 INFO - 'suite': 'dromaeojs', 10:08:03 INFO - 'system_bits': '32', 10:08:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:08:03 INFO - 'title': 't-yosemite-r7-0164', 10:08:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:08:03 INFO - 'use_talos_json': True, 10:08:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:08:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:08:03 INFO - 'work_dir': 'build'} 10:08:03 INFO - ##### 10:08:03 INFO - ##### Running clobber step. 10:08:03 INFO - ##### 10:08:03 INFO - Running pre-action listener: _resource_record_pre_action 10:08:03 INFO - Running main action method: clobber 10:08:03 INFO - rmtree: /builds/slave/test/build 10:08:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:08:04 INFO - Running post-action listener: _resource_record_post_action 10:08:04 INFO - ##### 10:08:04 INFO - ##### Running read-buildbot-config step. 10:08:04 INFO - ##### 10:08:04 INFO - Running pre-action listener: _resource_record_pre_action 10:08:04 INFO - Running main action method: read_buildbot_config 10:08:04 INFO - Using buildbot properties: 10:08:04 INFO - { 10:08:04 INFO - "project": "", 10:08:04 INFO - "product": "firefox", 10:08:04 INFO - "script_repo_revision": "production", 10:08:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 10:08:04 INFO - "repository": "", 10:08:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 10:08:04 INFO - "buildid": "20160330090109", 10:08:04 INFO - "pgo_build": "False", 10:08:04 INFO - "basedir": "/builds/slave/test", 10:08:04 INFO - "buildnumber": 584, 10:08:04 INFO - "slavename": "t-yosemite-r7-0164", 10:08:04 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:08:04 INFO - "platform": "yosemite_r7", 10:08:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 10:08:04 INFO - "branch": "fx-team", 10:08:04 INFO - "repo_path": "integration/fx-team", 10:08:04 INFO - "revision": "b994a14879e1a8e03c6e63ba86edcbdcd832535e", 10:08:04 INFO - "stage_platform": "macosx64", 10:08:04 INFO - "builduid": "877b50ef34f9412181f476218c0acbc0", 10:08:04 INFO - "slavebuilddir": "test" 10:08:04 INFO - } 10:08:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 10:08:04 INFO - Running post-action listener: _resource_record_post_action 10:08:04 INFO - ##### 10:08:04 INFO - ##### Running download-and-extract step. 10:08:04 INFO - ##### 10:08:04 INFO - Running pre-action listener: _resource_record_pre_action 10:08:04 INFO - Running main action method: download_and_extract 10:08:04 INFO - mkdir: /builds/slave/test/build/tests 10:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:04 INFO - https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:08:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:08:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 10:08:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 10:08:05 INFO - Downloaded 1199 bytes. 10:08:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 10:08:05 INFO - Using the following test package requirements: 10:08:05 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:08:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:08:05 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 10:08:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:08:05 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 10:08:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:08:05 INFO - u'jsshell-mac.zip'], 10:08:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:08:05 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 10:08:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 10:08:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:08:05 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 10:08:05 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:08:05 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 10:08:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:08:05 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 10:08:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 10:08:05 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 10:08:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:08: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')]} 10:08:05 INFO - https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:08:07 INFO - Downloaded 17946608 bytes. 10:08:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:08:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:08:11 INFO - Return code: 0 10:08:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:08: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')]} 10:08:11 INFO - https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:08:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:08:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:08:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 10:08:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:08:13 INFO - Downloaded 17946608 bytes. 10:08:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:08:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:08:17 INFO - Return code: 0 10:08:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:17 INFO - https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:08:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:08:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:08:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 10:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:08:20 INFO - Downloaded 10847531 bytes. 10:08:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:08:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:08:20 INFO - Return code: 0 10:08:20 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')]} 10:08:20 INFO - https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 10:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 10:08:25 INFO - Downloaded 111429596 bytes. 10:08:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:08:25 INFO - mkdir: /builds/slave/test/properties 10:08:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:25 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:25 INFO - Contents: 10:08:25 INFO - build_url:https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 10:08:26 INFO - Running post-action listener: _resource_record_post_action 10:08:26 INFO - Running post-action listener: set_extra_try_arguments 10:08:26 INFO - ##### 10:08:26 INFO - ##### Running populate-webroot step. 10:08:26 INFO - ##### 10:08:26 INFO - Running pre-action listener: _resource_record_pre_action 10:08:26 INFO - Running main action method: populate_webroot 10:08:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:26 INFO - '--tppagecycles', 10:08:26 INFO - '7'], 10:08:26 INFO - 'tests': ['tsvgm']}}, 10:08:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:08:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:08:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:26 INFO - 'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:26 INFO - 'tests': ['damp', 'tps']}, 10:08:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:26 INFO - 'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['damp', 'tps']}, 10:08:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:08:26 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['dromaeo_dom']}, 10:08:26 INFO - 'other': {'tests': ['a11yr', 10:08:26 INFO - 'ts_paint', 10:08:26 INFO - 'tpaint', 10:08:26 INFO - 'sessionrestore', 10:08:26 INFO - 'sessionrestore_no_auto_restore', 10:08:26 INFO - 'tabpaint']}, 10:08:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['a11yr', 10:08:26 INFO - 'ts_paint', 10:08:26 INFO - 'tpaint', 10:08:26 INFO - 'sessionrestore', 10:08:26 INFO - 'sessionrestore_no_auto_restore', 10:08:26 INFO - 'tabpaint']}, 10:08:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['a11yr', 10:08:26 INFO - 'ts_paint', 10:08:26 INFO - 'tpaint', 10:08:26 INFO - 'sessionrestore', 10:08:26 INFO - 'sessionrestore_no_auto_restore', 10:08:26 INFO - 'tabpaint']}, 10:08:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['a11yr', 10:08:26 INFO - 'ts_paint', 10:08:26 INFO - 'tpaint', 10:08:26 INFO - 'sessionrestore', 10:08:26 INFO - 'sessionrestore_no_auto_restore', 10:08:26 INFO - 'tabpaint']}, 10:08:26 INFO - 'other_l64': {'tests': ['a11yr', 10:08:26 INFO - 'ts_paint', 10:08:26 INFO - 'tpaint', 10:08:26 INFO - 'sessionrestore', 10:08:26 INFO - 'sessionrestore_no_auto_restore', 10:08:26 INFO - 'tabpaint']}, 10:08:26 INFO - 'other_nol64': {'tests': ['a11yr', 10:08:26 INFO - 'ts_paint', 10:08:26 INFO - 'tpaint', 10:08:26 INFO - 'sessionrestore', 10:08:26 INFO - 'sessionrestore_no_auto_restore', 10:08:26 INFO - 'tabpaint']}, 10:08:26 INFO - 'svgr': {'tests': ['tsvgx', 10:08:26 INFO - 'tsvgr_opacity', 10:08:26 INFO - 'tart', 10:08:26 INFO - 'tscrollx', 10:08:26 INFO - 'cart']}, 10:08:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['tsvgx', 10:08:26 INFO - 'tsvgr_opacity', 10:08:26 INFO - 'tart', 10:08:26 INFO - 'tscrollx', 10:08:26 INFO - 'cart']}, 10:08:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:26 INFO - 'tests': ['tp5o']}, 10:08:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:26 INFO - 'talos_options': ['--e10s'], 10:08:26 INFO - 'tests': ['tp5o']}, 10:08:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:26 INFO - 'talos_options': ['--xperf_path', 10:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:26 INFO - 'tests': ['tp5n']}, 10:08:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:26 INFO - 'talos_options': ['--e10s', 10:08:26 INFO - '--xperf_path', 10:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:26 INFO - 'tests': ['tp5n']}}, 10:08:26 INFO - 'talos.zip': {'path': '', 10:08:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:26 INFO - Running post-action listener: _resource_record_post_action 10:08:26 INFO - ##### 10:08:26 INFO - ##### Running create-virtualenv step. 10:08:26 INFO - ##### 10:08:26 INFO - Running pre-action listener: _resource_record_pre_action 10:08:26 INFO - Running main action method: create_virtualenv 10:08:26 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:26 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 10:08:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:26 INFO - Using real prefix '/tools/python27' 10:08:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:30 INFO - Installing pip.................done. 10:08:30 INFO - Return code: 0 10:08:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08:30 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')]} 10:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:30 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')]} 10:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:30 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 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:30 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 10:08:30 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 10:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:30 INFO - 'HOME': '/Users/cltbld', 10:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:30 INFO - 'LOGNAME': 'cltbld', 10:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:30 INFO - 'MOZ_NO_REMOTE': '1', 10:08:30 INFO - 'NO_EM_RESTART': '1', 10:08:30 INFO - 'PAGER': '/bin/cat', 10:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:30 INFO - 'PWD': '/builds/slave/test', 10:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:30 INFO - 'SHELL': '/bin/bash', 10:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:08:30 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:30 INFO - 'USER': 'cltbld', 10:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:30 INFO - 'XPC_FLAGS': '0x0', 10:08:30 INFO - 'XPC_SERVICE_NAME': '0', 10:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:30 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 10:08:30 INFO - Cleaning up... 10:08:30 INFO - Return code: 0 10:08:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:08:30 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')]} 10:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:30 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')]} 10:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:30 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 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:30 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 10:08:30 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 10:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:30 INFO - 'HOME': '/Users/cltbld', 10:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:30 INFO - 'LOGNAME': 'cltbld', 10:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:30 INFO - 'MOZ_NO_REMOTE': '1', 10:08:30 INFO - 'NO_EM_RESTART': '1', 10:08:30 INFO - 'PAGER': '/bin/cat', 10:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:30 INFO - 'PWD': '/builds/slave/test', 10:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:30 INFO - 'SHELL': '/bin/bash', 10:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:08:30 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:30 INFO - 'USER': 'cltbld', 10:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:30 INFO - 'XPC_FLAGS': '0x0', 10:08:30 INFO - 'XPC_SERVICE_NAME': '0', 10:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:30 INFO - Downloading/unpacking psutil>=0.7.1 10:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:33 INFO - Installing collected packages: psutil 10:08:33 INFO - Running setup.py install for psutil 10:08:33 INFO - building 'psutil._psutil_osx' extension 10:08:33 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 10:08:34 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 10:08:34 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 10:08:34 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 10:08:34 INFO - building 'psutil._psutil_posix' extension 10:08:34 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 10:08:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:08:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:08:34 INFO - ^ 10:08:34 INFO - 1 warning generated. 10:08:34 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 10:08:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:35 INFO - Successfully installed psutil 10:08:35 INFO - Cleaning up... 10:08:35 INFO - Return code: 0 10:08:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:08:35 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')]} 10:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:35 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')]} 10:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:35 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 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:35 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 10:08:35 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 10:08:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:08:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:35 INFO - 'HOME': '/Users/cltbld', 10:08:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:35 INFO - 'LOGNAME': 'cltbld', 10:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:35 INFO - 'MOZ_NO_REMOTE': '1', 10:08:35 INFO - 'NO_EM_RESTART': '1', 10:08:35 INFO - 'PAGER': '/bin/cat', 10:08:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:35 INFO - 'PWD': '/builds/slave/test', 10:08:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:35 INFO - 'SHELL': '/bin/bash', 10:08:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:08:35 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:08:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:35 INFO - 'USER': 'cltbld', 10:08:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:35 INFO - 'XPC_FLAGS': '0x0', 10:08:35 INFO - 'XPC_SERVICE_NAME': '0', 10:08:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:08:38 INFO - Installing collected packages: mozsystemmonitor 10:08:38 INFO - Running setup.py install for mozsystemmonitor 10:08:38 INFO - Successfully installed mozsystemmonitor 10:08:38 INFO - Cleaning up... 10:08:38 INFO - Return code: 0 10:08:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08:38 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')]} 10:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:38 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')]} 10:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:38 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 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:38 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 10:08:38 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 10:08:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:08:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:38 INFO - 'HOME': '/Users/cltbld', 10:08:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:38 INFO - 'LOGNAME': 'cltbld', 10:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:38 INFO - 'MOZ_NO_REMOTE': '1', 10:08:38 INFO - 'NO_EM_RESTART': '1', 10:08:38 INFO - 'PAGER': '/bin/cat', 10:08:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:38 INFO - 'PWD': '/builds/slave/test', 10:08:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:38 INFO - 'SHELL': '/bin/bash', 10:08:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:08:38 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:08:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:38 INFO - 'USER': 'cltbld', 10:08:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:38 INFO - 'XPC_FLAGS': '0x0', 10:08:38 INFO - 'XPC_SERVICE_NAME': '0', 10:08:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08:41 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 10:08:41 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 10:08:41 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 10:08:41 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 10:08:41 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 10:08:41 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 10:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08:42 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 10:08:42 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 10:08:42 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 10:08:42 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 10:08:42 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 10:08:42 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 10:08:43 INFO - Downloading docopt-0.6.1.tar.gz 10:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:43 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:43 INFO - Running setup.py install for blobuploader 10:08:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:43 INFO - Running setup.py install for requests 10:08:44 INFO - Running setup.py install for docopt 10:08:44 INFO - Successfully installed blobuploader requests docopt 10:08:44 INFO - Cleaning up... 10:08:44 INFO - Return code: 0 10:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:44 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 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:44 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 10:08:44 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 10:08:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:08:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:44 INFO - 'HOME': '/Users/cltbld', 10:08:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:44 INFO - 'LOGNAME': 'cltbld', 10:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:44 INFO - 'MOZ_NO_REMOTE': '1', 10:08:44 INFO - 'NO_EM_RESTART': '1', 10:08:44 INFO - 'PAGER': '/bin/cat', 10:08:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:44 INFO - 'PWD': '/builds/slave/test', 10:08:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:44 INFO - 'SHELL': '/bin/bash', 10:08:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:08:44 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:08:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:44 INFO - 'USER': 'cltbld', 10:08:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:44 INFO - 'XPC_FLAGS': '0x0', 10:08:44 INFO - 'XPC_SERVICE_NAME': '0', 10:08:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-mSxoWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-mJiRnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-by2wUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:44 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-yx6URt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-YZizCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-T5cHEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-DaHtj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-TK9Kqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-RsT53o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-yIbz5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-oFDK6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-_JZXkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-UNVmsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:45 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-_KAjco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:46 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-kDHxq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:46 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-D13oTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:46 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-VJyEtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:46 INFO - Running setup.py install for manifestparser 10:08:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:46 INFO - Running setup.py install for mozcrash 10:08:46 INFO - Running setup.py install for mozdebug 10:08:46 INFO - Running setup.py install for mozdevice 10:08:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:46 INFO - Running setup.py install for mozfile 10:08:47 INFO - Running setup.py install for mozhttpd 10:08:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:47 INFO - Running setup.py install for mozinfo 10:08:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:47 INFO - Running setup.py install for mozInstall 10:08:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:47 INFO - Running setup.py install for mozleak 10:08:47 INFO - Running setup.py install for mozlog 10:08:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:47 INFO - Running setup.py install for moznetwork 10:08:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:47 INFO - Running setup.py install for mozprocess 10:08:48 INFO - Running setup.py install for mozprofile 10:08:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:48 INFO - Running setup.py install for mozrunner 10:08:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:48 INFO - Running setup.py install for mozscreenshot 10:08:48 INFO - Running setup.py install for moztest 10:08:48 INFO - Running setup.py install for mozversion 10:08:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:48 INFO - Cleaning up... 10:08:48 INFO - Return code: 0 10:08:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:48 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')]} 10:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:49 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 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:49 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 10:08:49 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 10:08:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:08:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:49 INFO - 'HOME': '/Users/cltbld', 10:08:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:49 INFO - 'LOGNAME': 'cltbld', 10:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:49 INFO - 'MOZ_NO_REMOTE': '1', 10:08:49 INFO - 'NO_EM_RESTART': '1', 10:08:49 INFO - 'PAGER': '/bin/cat', 10:08:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:49 INFO - 'PWD': '/builds/slave/test', 10:08:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:49 INFO - 'SHELL': '/bin/bash', 10:08:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:08:49 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:08:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:49 INFO - 'USER': 'cltbld', 10:08:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:49 INFO - 'XPC_FLAGS': '0x0', 10:08:49 INFO - 'XPC_SERVICE_NAME': '0', 10:08:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:49 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-xwpDI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:49 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)) 10:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:49 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-WCmR1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:49 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-rVo1iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:49 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)) 10:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:49 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-ViMS6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-sxMVva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-dRdRGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-WfMFlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-PA1XRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-5Wv4J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-qWC3KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-mSZdPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-mfr8Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:50 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)) 10:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:50 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-CC78iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:51 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)) 10:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-jc7f_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:51 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)) 10:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-Q0VRc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:51 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)) 10:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-QL4EyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:51 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)) 10:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:51 INFO - Running setup.py (path:/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/pip-93Bq2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:51 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)) 10:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:08:51 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)) 10:08:51 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)) 10:08:51 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)) 10:08:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:55 INFO - Downloading blessings-1.6.tar.gz 10:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:55 INFO - Installing collected packages: blessings 10:08:55 INFO - Running setup.py install for blessings 10:08:56 INFO - Successfully installed blessings 10:08:56 INFO - Cleaning up... 10:08:56 INFO - Return code: 0 10:08:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:56 INFO - Reading from file tmpfile_stdout 10:08:56 INFO - Current package versions: 10:08:56 INFO - blessings == 1.6 10:08:56 INFO - blobuploader == 1.2.4 10:08:56 INFO - docopt == 0.6.1 10:08:56 INFO - manifestparser == 1.1 10:08:56 INFO - mozInstall == 1.12 10:08:56 INFO - mozcrash == 0.17 10:08:56 INFO - mozdebug == 0.1 10:08:56 INFO - mozdevice == 0.48 10:08:56 INFO - mozfile == 1.2 10:08:56 INFO - mozhttpd == 0.7 10:08:56 INFO - mozinfo == 0.9 10:08:56 INFO - mozleak == 0.1 10:08:56 INFO - mozlog == 3.1 10:08:56 INFO - moznetwork == 0.27 10:08:56 INFO - mozprocess == 0.22 10:08:56 INFO - mozprofile == 0.28 10:08:56 INFO - mozrunner == 6.11 10:08:56 INFO - mozscreenshot == 0.1 10:08:56 INFO - mozsystemmonitor == 0.0 10:08:56 INFO - moztest == 0.7 10:08:56 INFO - mozversion == 1.4 10:08:56 INFO - psutil == 3.1.1 10:08:56 INFO - requests == 1.2.3 10:08:56 INFO - wsgiref == 0.1.2 10:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:56 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')]} 10:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:56 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')]} 10:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:56 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 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:56 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 10:08:56 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 10:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:56 INFO - 'HOME': '/Users/cltbld', 10:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:56 INFO - 'LOGNAME': 'cltbld', 10:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:56 INFO - 'MOZ_NO_REMOTE': '1', 10:08:56 INFO - 'NO_EM_RESTART': '1', 10:08:56 INFO - 'PAGER': '/bin/cat', 10:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:56 INFO - 'PWD': '/builds/slave/test', 10:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:56 INFO - 'SHELL': '/bin/bash', 10:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:08:56 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:56 INFO - 'USER': 'cltbld', 10:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:56 INFO - 'XPC_FLAGS': '0x0', 10:08:56 INFO - 'XPC_SERVICE_NAME': '0', 10:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 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)) 10:08:56 INFO - Cleaning up... 10:08:56 INFO - Return code: 0 10:08:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08:56 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')]} 10:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:56 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')]} 10:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:56 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 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:08:56 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 10:08:56 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 10:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:56 INFO - 'HOME': '/Users/cltbld', 10:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:56 INFO - 'LOGNAME': 'cltbld', 10:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:56 INFO - 'MOZ_NO_REMOTE': '1', 10:08:56 INFO - 'NO_EM_RESTART': '1', 10:08:56 INFO - 'PAGER': '/bin/cat', 10:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:56 INFO - 'PWD': '/builds/slave/test', 10:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:56 INFO - 'SHELL': '/bin/bash', 10:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:08:56 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:56 INFO - 'USER': 'cltbld', 10:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:56 INFO - 'XPC_FLAGS': '0x0', 10:08:56 INFO - 'XPC_SERVICE_NAME': '0', 10:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:56 INFO - Downloading/unpacking jsonschema 10:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:09:00 INFO - Downloading/unpacking functools32 (from jsonschema) 10:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:00 INFO - Downloading functools32-3.2.3-2.tar.gz 10:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:09:01 INFO - warning: no files found matching '*.txt' 10:09:01 INFO - no previously-included directories found matching 'build' 10:09:01 INFO - no previously-included directories found matching 'dist' 10:09:01 INFO - no previously-included directories found matching '.git*' 10:09:01 INFO - Installing collected packages: jsonschema, functools32 10:09:01 INFO - Running setup.py install for functools32 10:09:01 INFO - warning: no files found matching '*.txt' 10:09:01 INFO - no previously-included directories found matching 'build' 10:09:01 INFO - no previously-included directories found matching 'dist' 10:09:01 INFO - no previously-included directories found matching '.git*' 10:09:01 INFO - Successfully installed jsonschema functools32 10:09:01 INFO - Cleaning up... 10:09:01 INFO - Return code: 0 10:09:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:09:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa26a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa36420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71048a160>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, '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.NbU4PqFoYt/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.IM3qskUW9F/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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 10:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:01 INFO - 'HOME': '/Users/cltbld', 10:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:01 INFO - 'LOGNAME': 'cltbld', 10:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:01 INFO - 'MOZ_NO_REMOTE': '1', 10:09:01 INFO - 'NO_EM_RESTART': '1', 10:09:01 INFO - 'PAGER': '/bin/cat', 10:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:01 INFO - 'PWD': '/builds/slave/test', 10:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:01 INFO - 'SHELL': '/bin/bash', 10:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:09:01 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:01 INFO - 'USER': 'cltbld', 10:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:01 INFO - 'XPC_FLAGS': '0x0', 10:09:01 INFO - 'XPC_SERVICE_NAME': '0', 10:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:09:01 INFO - Downloading/unpacking flake8 10:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:09:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:09:04 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 10:09:04 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 10:09:04 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 10:09:04 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 10:09:04 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 10:09:04 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 10:09:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:09:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:09:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:06 INFO - no previously-included directories found matching 'docs/_build' 10:09:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:09:06 INFO - Running setup.py install for pep8 10:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:09:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:09:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:09:06 INFO - no previously-included directories found matching 'docs/_build' 10:09:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:09:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:09:06 INFO - Cleaning up... 10:09:06 INFO - Return code: 0 10:09:06 INFO - Running post-action listener: _resource_record_post_action 10:09:06 INFO - Running post-action listener: _start_resource_monitoring 10:09:06 INFO - Starting resource monitoring. 10:09:06 INFO - ##### 10:09:06 INFO - ##### Running install step. 10:09:06 INFO - ##### 10:09:06 INFO - Running pre-action listener: _resource_record_pre_action 10:09:06 INFO - Running main action method: install 10:09:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:09:07 INFO - Reading from file tmpfile_stdout 10:09:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:09:07 INFO - Reading from file tmpfile_stdout 10:09:07 INFO - Output received: 10:09:07 INFO - Usage: mozinstall [options] installer 10:09:07 INFO - Options: 10:09:07 INFO - -h, --help show this help message and exit 10:09:07 INFO - -d DEST, --destination=DEST 10:09:07 INFO - Directory to install application into. [default: 10:09:07 INFO - "/builds/slave/test"] 10:09:07 INFO - --app=APP Application being installed. [default: firefox] 10:09:07 INFO - mkdir: /builds/slave/test/build/application 10:09:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:09:41 INFO - Reading from file tmpfile_stdout 10:09:41 INFO - Output received: 10:09:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:09:41 INFO - Running post-action listener: _resource_record_post_action 10:09:41 INFO - ##### 10:09:41 INFO - ##### Running run-tests step. 10:09:41 INFO - ##### 10:09:41 INFO - Running pre-action listener: _resource_record_pre_action 10:09:41 INFO - Running main action method: run_tests 10:09:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:41 INFO - 2016-03-30 10:09:41.830 screenresolution[1648:7493] starting screenresolution argv=screenresolution get 10:09:41 INFO - 2016-03-30 10:09:41.832 screenresolution[1648:7493] Display 0: 1600x1200x32@60 10:09:41 INFO - 2016-03-30 10:09:41.838 screenresolution[1649:7495] starting screenresolution argv=screenresolution list 10:09:41 INFO - Available Modes on Display 0 10:09:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:42 INFO - Intel Iris: 10:09:42 INFO - Chipset Model: Intel Iris 10:09:42 INFO - Type: GPU 10:09:42 INFO - Bus: Built-In 10:09:42 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:42 INFO - Vendor: Intel (0x8086) 10:09:42 INFO - Device ID: 0x0a2e 10:09:42 INFO - Revision ID: 0x0009 10:09:42 INFO - Displays: 10:09:42 INFO - Display: 10:09:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:42 INFO - Display Serial Number: 1600x1200 60 10:09:42 INFO - Main Display: Yes 10:09:42 INFO - Mirror: Off 10:09:42 INFO - Online: Yes 10:09:42 INFO - Rotation: Supported 10:09:42 INFO - Return code: 0 10:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:42 INFO - Python 2.7.3 10:09:42 INFO - Return code: 0 10:09:42 INFO - grabbing minidump binary from tooltool 10:09:42 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')]} 10:09:42 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 0x10f8c5e00>, '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 0x10f6eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f8c0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:42 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 10:09:42 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 10:09:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:42 INFO - Return code: 0 10:09:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:09:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:09:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:09:43 INFO - Return code: 0 10:09:43 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/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--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 10:09:43 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/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0164 --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 10:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NbU4PqFoYt/Render', 10:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:43 INFO - 'HOME': '/Users/cltbld', 10:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:43 INFO - 'LOGNAME': 'cltbld', 10:09:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:43 INFO - 'MOZ_NO_REMOTE': '1', 10:09:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:43 INFO - 'NO_EM_RESTART': '1', 10:09:43 INFO - 'PAGER': '/bin/cat', 10:09:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:43 INFO - 'PWD': '/builds/slave/test', 10:09:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:43 INFO - 'SHELL': '/bin/bash', 10:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IM3qskUW9F/Listeners', 10:09:43 INFO - 'TMPDIR': '/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/', 10:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:43 INFO - 'USER': 'cltbld', 10:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:43 INFO - 'XPC_FLAGS': '0x0', 10:09:43 INFO - 'XPC_SERVICE_NAME': '0', 10:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:43 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/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0164', '--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 10:09:43 INFO - mozversion application_buildid: 20160330090109 10:09:43 INFO - mozversion application_changeset: b994a14879e1a8e03c6e63ba86edcbdcd832535e 10:09:43 INFO - mozversion application_display_name: Nightly 10:09:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:43 INFO - mozversion application_name: Firefox 10:09:43 INFO - mozversion application_remotingname: firefox 10:09:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:09:43 INFO - mozversion application_vendor: Mozilla 10:09:43 INFO - mozversion application_version: 48.0a1 10:09:43 INFO - mozversion platform_buildid: 20160330090109 10:09:43 INFO - mozversion platform_changeset: b994a14879e1a8e03c6e63ba86edcbdcd832535e 10:09:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:09:43 INFO - mozversion platform_version: 48.0a1 10:09:43 INFO - using testdate: 1459357783 10:09:43 INFO - actual date: 1459357783 10:09:43 INFO - starting webserver on 'localhost:49280' 10:09:43 INFO - SUITE-START | Running 2 tests 10:09:43 INFO - TEST-START | dromaeo_css 10:09:43 INFO - operating with platform_type : mac_ 10:09:43 INFO - Initialising browser for dromaeo_css test... 10:09:43 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmp0Hi3zv/profile http://localhost:49280/getInfo.html) 10:09:45 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 10:09:45 INFO - PROCESS | 1667 | colorDepth:24 10:09:45 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 10:09:45 INFO - PROCESS | 1667 | __metrics 10:09:45 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:09:45 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:09:46 INFO - TEST-INFO | 1667: exit 0 10:09:46 INFO - Browser initialized. 10:09:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:46 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmp0Hi3zv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:58 INFO - PROCESS | 1670 | RSS: Main: 244195328 10:09:58 INFO - PROCESS | 1670 | 10:10:49 INFO - PROCESS | 1670 | 1459357849978 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] 10:12:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 10:13:01 INFO - PROCESS | 1670 | RSS: Main: 333672448 10:13:01 INFO - PROCESS | 1670 | 10:16:03 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 10:16:04 INFO - PROCESS | 1670 | RSS: Main: 377356288 10:16:04 INFO - PROCESS | 1670 | 10:19:06 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 10:19:07 INFO - PROCESS | 1670 | RSS: Main: 376193024 10:19:07 INFO - PROCESS | 1670 | 10:22:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 10:22:09 INFO - PROCESS | 1670 | RSS: Main: 336957440 10:22:09 INFO - PROCESS | 1670 | 10:25:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 10:25:13 INFO - PROCESS | 1670 | RSS: Main: 336166912 10:25:13 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 10:28:16 INFO - PROCESS | 1670 | RSS: Main: 407027712 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | __start_tp_report 10:28:16 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 10:28:16 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 10:28:16 INFO - PROCESS | 1670 | |i|pagename|runs| 10:28:16 INFO - PROCESS | 1670 | |0;dojo.html;3447.3622379859726;3508.666676665719;3513.4202856528673;3565.4117070683333;3587.7309201809853;5609.242752228448;5680.630759000662;5695.8576035599135;5745.971270143648;5803.274590676166;5653.745581448834;5744.770209191627;5746.224259724936;5755.223044888939;5757.539396848252;5084.491550844905;5148.613853960958;5167.431582525919;5183.922241166386;5243.632945693803;5107.591392688576;5158.7936482540845;5225.921611175835;5229.60777941654;5236.162214045753;5150.665206761567;5195.714235717034;5207.583393328525;5210.478952104778;5245.977034478259;5209.765560549784;5253.238280449352;5259.579233661336;5268.841934741964;5323.680579165224;5084.923726144111;5097.770600322994;5135.281060651511;5191.325127733408;5195.220716892459;4598.195315819718;5613.129964855454;5616.382197958222;5634.154876768476;5638.830835074954;6200.348963358828;6216.067589861512;6226.439620434183;6233.065040243954;6235.251769787609;6123.038605230386;6230;6315.810525684236;6336.303006669263;6341.8414539636415;5866.560007999417;5880.294364676266;5888.057910734262;5900.616459930134;5915.112733090071;5812.767489300465;6286.811395658137;6304.590201636879;6312.715927783261;6316.084167795644;5981.252343457068;6030.964179667709;6132.110769107974;6168.784092556739;6180.165677633552;6215.502759779207;6250.062490626442;6273.96863015682;6289;6289.056641503811;6144.262688477412;6188.2883468400805;6206.410391012847;6220.34686357935;6222.688865556795;6112.685862051747;6122.112293717475;6188.783392581238;6238.220222472191;6251.562390632703;4912.508749125131;4941.65408421407;4942.357493525818;4945.530174633404;4973.676711013773;4441.178381999341;4447.288433850568;4479.507254202035;4486.977565112219;4520.660950428731;5601.075822489325;5700;5706.258186435737;5811.128330750421;5832.62087964281;6267.123457956548;6302.086197501429;6314.747410103636;6329.050642403677;6343.777967771198;5647.237622920935;5702.116171993264;5718.7426565804635;5732.799352022659;5765.769369225268;5301.655392399482;5360.463953604686;5418.83743487696;5446.945530544723;5483.341998960151;5658.490735833795;5810.983077961424;6303.46420554258;6344.30212676596;6349.682515874188;6152.446279834837;6222.62664240147;6309.842253943688;6323.905141422974;6344.111824344688;6277.12120303167;6310.873782524232;6336.1446204763615;6336.936630633819;6344.238691356882;6157.384261573807;6181.350958149509;6209.285932117864;6228.34602366745;6234.189555357774;6128.930927367261;6209.720562574786;6328.050792381179;6338.080978258219;6344.365563443804;6131.682521312607;6149.631022138686;6167.198264225622;6172.506199504119;6184.721687523982;5104.106781313181;5992.9811931972545;6128.846778830565;6140;6151.0773383992755;5735.369109398046;5947.167396564398;6013.038043397147;6023.849403764941;6030.969845150747;5987.371326010706;6024.638521688713;6101.338204344158;6110.741024289911;6114.144019837316;5954.374790647093;5997.310309314485;6001;6005.978983572891;6019.187409699634 10:28:16 INFO - PROCESS | 1670 | |1;ext.html;454.5681602477645;520.5263210478465;539.4982666120511;585.8488070940602;630.3035146163489;30434;38385;38859.61140388595;38905.22189556207;38971;43071.92320191997;43695.78152109243;43785.56214437863;43803;43872.78063609685;9547.856782148274;9777.657781977632;9785.853212201822;9796.216302695768;9800.117989380955;9636.22910167185;9788.678528398646;9790.90209097907;9800.166985806214;9801;9742.22062235023;9822.410655360665;9822.459764712938;9823.21414286859;9837.213022958145;9720.07659272368;9800.068993445611;9803.705888823346;9806.411615303105;9812.215022798158;9550.426974381558;9727.805443891153;9729.805403891953;9737.26970477217;9738.9513052435;39546.40680389797;40447.59552404468;40912.79543602293;40936.79531602353;40959.7952010241;3263.167892187477;3279.508073788927;3335.266241426882;3505.842237099311;3829.291581057513;28733.281667958257;29652.258693532618;30034.3844389265;30081.849590752125;30331.241718956982;2770.1551026936777;2820.85895705216;2842.701516340796;2847.4447482740875;2862.069827306134;480526;482779.9999999965;483333.5833320811;483352;484624;45370.54629453729;46043.76978115088;63779.362206377344;64125.35874641194;64498.67750661217;44326.77836610861;44352.556474434845;44436.3334549982;44455;44589;15689.607759806097;15806.92096539533;15808.288627011812;15817.05097694142;15831.89176757639;10770.892291076989;10814;12545.74908501825;12760.979121670243;12836.229826210458;14513.854861451251;14745.557633271019;14755.55733328002;14774.63063423423;14904.254787260594;6233;6330.177076979963;6408.283195746456;6409.583377080475;6411.3909178627955;953.2326477185793;961.778790878102;1004.6082028009082;1104.2442516398964;1176.6764139861607;29008.564871526945;29034.709652903624;29647.55528667072;29742.702572974427;29932;1068.1188019883627;1071.12703146935;1073.7691396349821;1102.5755084292446;1137.2096393006946;12720.745585088247;14929.477468288558;14969.176695281647;15174.317155728018;15549.067055976677;494761;494864;499501.0049899527;500251;500739;58887;59295.703521482115;59422.10866837001;59432.514187145665;59459.51351216168;1339.1496399786206;1471.8160229971254;1477.6084337650532;1496.3640452807513;1511.8941674082928;28297.717022830333;28738.281542961595;28742;29032.274193144494;29155.562666560443;44974.10051799011;45239;45681.771591141835;45923.540764591926;46095;297971;298737.0126298709;299180;299200;299545;28474.43051139007;32280.031599052065;32822;33223.83388083044;33295.66930314855;40324.79837600793;41487.1702565953;41502.792486037375;41975;42044.36933446062;33400.42446767217;34323.4851477233;34966.82516587502;35643.82178089093;35797.28405431825;30169.245768855955;33203.667963320055;34113.31773364569;35033.474497883064;35751.64248357483;35011.59735570332;35176;35781.747638832516;36413.27173456569;36649;30907.690923090482;31626.841865791444;31760;31760.841195793873;31831;20075.79545227291;23333;23928.40178995539;25034.499310013332;25150.874245628656 10:28:16 INFO - PROCESS | 1670 | |2;jquery.html;301.64406000918916;365.97621154624966;368.1422286073448;374.1618773946361;376.2662807525323;19888.105035273413;19965.500862478446;21243.57512849742;21268.468288292763;21315.040823162955;19994.10026548805;20198.192072317128;20369.77781333121;21205.151793928264;21235.256766013194;5808.2449281593335;5983.461488466037;6053.213082299295;6061.545384096188;6066.878662426749;3563.8752643657476;4313.202057619351;5998.460138587527;6365.904511432309;6687.966560167192;5684.971575142139;6528.510361722866;6611.074449577063;6621.6689165541775;6624.834379140512;6268.529860260476;6565.441937435347;6569.310222426624;6580.5393622446445;6590.110335104771;3787.715921305913;5254.264402983586;5640.5487560995025;5667.943320566783;5669.886602267931;25652.61521077185;25705.485890282278;25808.096716615015;26142.86928565364;26465.73534264652;2158.115172779153;2212.5243072739277;2265.728112626495;2275.601769690314;2314.109068008812;14242.430302787876;14462;14698.33857476416;14824.703505929929;15221.771673424908;1731.3680506615121;1772.421830444583;1785.4286628278956;1785.6071664233848;1798.8071173666715;106253;109682.45158774155;111375;111980;113323.86676133216;10405.791884162425;10579.259451838298;10657.62698305571;10872.78254434907;11031.558737650565;11375.03312218454;13552.254625995467;13662.453501859814;13686.452541898412;13710.971677124255;8606.741797746077;8761.43050701715;8810.471371717718;8814.427062240933;8897.911020889838;7121.679524421414;8986.415882967585;8995.730128096167;9059.864102038475;9081.59132839024;6196.566240363221;6333.20834895638;6348.365163483707;6352.6823658816875;6565.310642382577;1706.1554530507478;1796.91015449227;1797.4248240563156;1802.9819701802815;1813.963720725578;910.981780364389;965.7875267441152;997.6458357283205;1064.2071656615872;1107.5126944144552;18374.448766537025;19864.801351986294;22460.775392246196;22504;22568.774312256668;998.2213873178932;1002.7643503776607;1026.825439675257;1043.389617074005;1140.8573928258968;11621.418929053514;11948.283103013848;12033.939830300793;12078.912897839236;12198.878011219951;529086;591314;603463;616760.9603966256;617603;120076.3996180031;120692.39653801675;121240.39379803045;123176.76823231833;127324;1072.3780207479642;1073.2058276875057;1097.3744965369822;1098.6813823991113;1099.1920938110643;15861.365545378056;19775.90112049488;19897;20273;20506.58986820285;50904.49095509146;51837.22244166416;53000.73499632477;53024;53166.4683353177;67061.28203333536;67710.32289677237;70779.58440831052;71538.92691609525;72570.1857453568;7717.961410193137;7939.6030198491;7956.681732730626;8101.432899696964;8307.626156823078;7502.924970750441;11472.31166130035;12343.69140771488;12390.62828115158;13090.541831035867;8838.469691818511;11202.047825934887;11270.83093753578;11287.141566099643;11639.76720465603;8677.696280630147;10928.562857485611;11150;11220.15848811326;11506.94246528762;11373.20387572862;11764.470598822902;11768.94115529417;11770.352630605057;11867.821982670093;7284.781456556312;7374.483786135133;7502.98709674187;7916.445848790529;8341.45780524264;7692.34615057704;9629.374090684363;9812.116909477896;11039.227254092137;11196.94401527987 10:28:16 INFO - PROCESS | 1670 | |3;mootools.html;1416.5042235217668;1604.2460043779424;1632.8938618989762;1922.7212054252134;2050.190174880921;8123.91876081239;8849.867251991225;9084.36409451337;9091;9091.45451272924;8655.567221638925;8916.554172291391;8921.643134274638;8922.91077089229;8937;2201.966970495444;2440.3533063738123;2476.2571228631427;2506.749325067497;2511.485145545168;2535.277445927911;2536.1884197056947;2544.211294498702;2545.847249165047;2546.974530254692;2420.6248031555137;2521.306640673811;2524.3184340228127;2526.5957446808516;2535.911243106492;2461.8030557555444;2515.5975043992967;2529.051605647882;2531.202671158579;2533.442642618621;2475.3192871960173;2514.7233804281514;2521.6091505816626;2522.281149872296;2523.2682522068576;9026.097390260988;9098.044705305914;9106.590203440861;9117.817643647157;9118.95440522793;5520.530754885839;5681.119426488859;5730.713464326809;5734.827955161351;5744;3159.952600710991;3637.781733096023;3741.3639681254253;3806.6003069677563;3824.2160357126722;1056.8256237720766;1068.4283908109203;1078.2129045796612;1088.7931293054373;1090.596479302655;12476.625701228977;12480.75038499234;12491.812622810665;12494.500219991189;12507.06197035226;4941.925871111936;4946.975265123651;5013.724245166478;5029.5221953914315;5040.722760248148;8857.335699822539;10527.631532896312;10542.26204165701;10559.419231942316;10572;4828.203346447796;5643.604947653625;5648.661080335193;5685;5685.090385538294;3794.2790869734663;4695.154872122982;4713.9764301178275;4792.233242681224;4871.756412179377;3904.4924159859606;3988.1824226033596;3999.8000099994883;4028.194361127786;4055.1484188320783;1161.9419029048513;1325.754735373959;1327.6481732340937;1340.2025794652166;1342.5636668082716;1146.5585749486509;1164.3246916788241;1312.9365214176548;1338.7857942729117;1429.0925262458206;7201.243869393638;8366.748997530083;8442.409031367868;8469.788255293544;8483.939507561554;495.15823100728187;516.6538419259106;520.4119345139968;521.1713375732528;523.4948274914725;6304.338044505353;6315.336889626615;6333.714982825784;6356.68216589178;6367.522435817332;10621.5220315086;11004.504797284142;11013.339199648046;11134.220604557766;11134.331940083459;10529.57881684724;10868.728281793019;10870.456477176109;10974.561017559368;10977.341359518454;8402.957985210034;8436.493810371398;8447.873281900776;8544.273736732323;8549.529775862387;7795.337396321376;8012.359011278967;8019.799505012188;8068.838623227385;8070.757877263692;9445.574949127444;9565.665201717906;9775.85336219943;9874.605015799574;9968.352057116264;9848.212143028397;10017.69946901594;10176.949115254376;10194.847077293698;10238.53926573291;6756.594604323756;7273.272672732684;7537.585432801248;7587.393008559412;7661.272179142972;8342.538951009588;8359.791005224675;8405.747827565183;8423.32613390915;8432.662693492437;6832.965835170792;7194.1726701427915;7293.38006269473;7491.063617047869;7504.474686771873;7353.995697554074;7382.5570465772225;7391.519551229153;7402.444816638881;7548.584827834302;6649.46804255668;7836.647350869339;7901.881471777813;7903.012123484565;7903.249191326815;7006.089208402875;7018.894716579153;7072.292770722886;7077.327653872874;7139.535930164523;7199.992001119743;7217.170025446931;7251.637418128967;7267.236940121211;7276.235995220637 10:28:16 INFO - PROCESS | 1670 | |4;prototype.html;315.68904628940487;326.6716949465788;332.0668920333862;332.5493955690038;336.06741292912153;5751.223584816049;5829.854253643651;6655.800325990216;6664.800055998316;6769.39075483207;5331.546818520431;6601.2078550574;6648.002799580066;6668.833279168023;6681.632510211936;3638.326909521747;4598.356230127785;4676.883077923062;4788.257820037882;4941.555260026588;4409.118176364724;4769.427668679763;4804.44748853881;4812.374391329122;4850.8059677612855;4804.471508134103;4805.855824325258;4816.060868130716;4827.372441582589;4827.372441582589;4179.791010449496;4845.612351011928;4849.981503884153;4853.563179313879;4874.073925954058;3944.112574670705;3976.9005774855573;4037.596240375968;4050.4936882889638;4169.687273454503;6368.235811702579;6379.681015949231;6396.392342727433;6400.071989561534;6414.550981431302;5764.308283006066;5777.826665200051;5788.942110578882;5792.594518383715;5798.565107616903;6306.873862522724;6500.252470965852;7001.929980700179;7022.087128673291;7028.121484814398;4097.262492751303;4519.615832654228;4705.3647757552635;4714.434267887841;4722.480527142012;7133.536320139175;7463.029806125223;7463.962680186619;7480.738174163878;7488.5506869588;4789.114013907439;4809.975950120297;4813.95186048135;4820.325154478376;4824.324594556765;4884.291777692215;4894.1679914414635;4897.4857639947295;4902.583280421204;4917.508249175054;5818.592698511148;5821.7380217890295;5827.446392592697;5833.445822646927;5834.299884013945;5413.945860541423;7066.787996360117;7079.681414336367;7079.964600176966;7081.5042946994245;1670.9331626734795;1686.9156542172843;1704.8295170482852;1707.8633709303226;1708.6241026974294;945.5036106044382;1091.497910960967;1095.0910744082391;1098.242212873115;1114.4929057278919;5558.944410555842;5737.852429514114;6006.309274433496;6486.902696459557;6621.86756264872;7158.141023077264;7260.273972602803;7262.745803896838;7268.67290971897;7288.453365997571;6511.674416279167;6666.566673166229;6673.1992160941;6679.599224046476;6704.061431399608;3874.438206460104;3919.392494163409;3921.686265098785;3922.058705910618;3922.5881282465502;7408.703651853865;7704.26809453101;7706.075270967408;7718.768436946788;7793.571353575494;7600.733974310872;7627.313541781266;7664.540127592362;7673.386129109658;7679.542546385103;7769.494982826098;7772.922270777333;7782.338501227233;7787.182345853604;7792.649330780015;7413.481056326005;7426.70293188288;7432.405407567489;7442.516236444614;7445.664945077377;7009.544379615309;7259.963700181465;7264.927350726425;7272;7277.9272207277245;7411.221821708858;7730.884036739566;7756.767296981099;7770.339521140766;7790.493617914817;4037.717359784787;4663.230566956414;4672.859814205579;4676.345311656303;4679.625629949528;7307.2327405621645;7318.560886346836;7321.74373896911;7329.900514922804;7337.889931651136;5748.6838223898085;6834.965825170842;7059.611721355374;7079.327463891128;7092.432605391659;7031.367176954099;7083.433325334064;7093.290670932865;7095.077639906779;7099.432045436456;6906.102206713095;6911.101556797584;6914.377706006484;6914.896276555755;6925.099737034153;7098.148222213161;7102.72151012802;7109.608971506616;7110.786676399716;7114.14630244374;6646.567973081735;6711.563748356341;6873.312668733087;6942.06282151903;6946.895796562954 10:28:16 INFO - PROCESS | 1670 | |5;yui.html;691.4468425259792;751.4138971602149;759.5883071248784;764.0334976255042;780.5433821214591;14859;15252.389904403839;15252.923735381322;15304.081755094701;15325.233738313082;9786.902130978688;11035.337879727222;13330.33348332582;13876.098053626507;13880.652983675413;745.306864615907;757.0272200222687;909.3952521573146;913.3652111782297;926.9351145419823;932.9673461428852;936.3211671538148;938.0385105267087;939.0703203828195;940.0176815228103;983.5770618633984;984.4093543873654;987.1559816357019;987.733312005758;988.8961659025806;774.7365895595497;787.4645241235958;791.8535071011881;958.3818437108026;979.8334283171843;727.323589062172;727.8216836874999;728.5155371677828;728.7995801154672;729.7008226627111;15142.394304227928;15186;15228.086314821147;15257.10943709358;15262.694746105015;12454.937725311405;12647.114701970866;12648.177868438523;12829.920819003371;12852.228866268053;9923.702288931343;10032.799344013152;10039.849402258971;10120.544575494121;10409.167266618653;3462.4460086386057;3499.1602015516346;3526.294741051774;3537.168765340143;3611.061124107751;78018;78039;78146.43707125883;78163.21836781673;78348;9109;9548.61805527785;9548.761280967892;9590.808183836285;9832.262580306506;22025.22911698083;22038;22057.448563785714;22059.779402206095;22075.227367042076;7333.669984850694;7339.302766237199;7343.48595598303;7355.190928997806;7412.258774122544;3440.449528075496;4031.637152656275;4047.91904161921;4069.918601627951;4139.399787030924;3695.796731179811;3733.9439908401396;3736.2901048801186;3738.9439158412647;3739.364308067635;668.9029891290838;688.3082502085372;688.8002479280952;689.162667359161;698.7205117952859;480.2148487223415;543.3751186135976;547.4005963469994;577.1976952036672;596.5615272774508;7396.3343299103335;8124;8156.632951517077;8233.46482478637;8281;588.0913987888722;600.0429315242181;603.8007457539002;605.5882000239791;615.7229246838851;3666.651668091527;3837.366834472281;3925.156091440354;3970.3250447424007;4029.1337362466625;92103.53948230216;92622;92858.53570732103;93198;96612;80521.59739201267;81598.59200703958;82187.5890620543;82721;83037.58481207555;72984.63507682533;74078.88881666672;74171;74278;75171.62414187894;7001.36987671112;7607.4674772765375;7703.537787732754;7716.421268405004;8035.67857285702;49162;51983.740081300864;52069.21896171485;52196.73901630467;52350.73824630852;67800;68614.65692671505;69012.654936725;69437.30562694308;70975.03869201217;9725.6596019139;9826.852597211191;9837.950810245902;10087.546060427152;10380.480975951323;10930;10957.83563246568;11097.889021110008;11147.55409783632;11419.257748246337;8960.79412104178;10618.8938110621;10801.081908037904;11781;12278.938605306916;11127.276727012719;11253.716551040634;11274.379909105079;11297.661070167907;11297.7740445189;11123.388213648326;11523.596674116367;11584.16188033937;11622.82565761531;11654.009409200313;9307.925976257957;9385.436873787594;9434.245260379015;9617.759556011155;9648;9165.587548560465;9769.706908792748;9837.163841073303;9849.507524623883;9892.307538472238 10:28:16 INFO - PROCESS | 1670 | __end_tp_report 10:28:16 INFO - PROCESS | 1670 | __start_cc_report 10:28:16 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1252 10:28:16 INFO - PROCESS | 1670 | __end_cc_report 10:28:16 INFO - PROCESS | 1670 | __startTimestamp1459358896333__endTimestamp 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | ------- Summary: start ------- 10:28:16 INFO - PROCESS | 1670 | Number of tests: 6 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5742.01 Median:5981.25 stddev:628.43 (10.5%) stddev-sans-first:604.03 10:28:16 INFO - PROCESS | 1670 | Values: 3447.4 3508.7 3513.4 3565.4 3587.7 5609.2 5680.6 5695.9 5746.0 5803.3 5653.7 5744.8 5746.2 5755.2 5757.5 5084.5 5148.6 5167.4 5183.9 5243.6 5107.6 5158.8 5225.9 5229.6 5236.2 5150.7 5195.7 5207.6 5210.5 5246.0 5209.8 5253.2 5259.6 5268.8 5323.7 5084.9 5097.8 5135.3 5191.3 5195.2 4598.2 5613.1 5616.4 5634.2 5638.8 6200.3 6216.1 6226.4 6233.1 6235.3 6123.0 6230.0 6315.8 6336.3 6341.8 5866.6 5880.3 5888.1 5900.6 5915.1 5812.8 6286.8 6304.6 6312.7 6316.1 5981.3 6031.0 6132.1 6168.8 6180.2 6215.5 6250.1 6274.0 6289.0 6289.1 6144.3 6188.3 6206.4 6220.3 6222.7 6112.7 6122.1 6188.8 6238.2 6251.6 4912.5 4941.7 4942.4 4945.5 4973.7 4441.2 4447.3 4479.5 4487.0 4520.7 5601.1 5700.0 5706.3 5811.1 5832.6 6267.1 6302.1 6314.7 6329.1 6343.8 5647.2 5702.1 5718.7 5732.8 5765.8 5301.7 5360.5 5418.8 5446.9 5483.3 5658.5 5811.0 6303.5 6344.3 6349.7 6152.4 6222.6 6309.8 6323.9 6344.1 6277.1 6310.9 6336.1 6336.9 6344.2 6157.4 6181.4 6209.3 6228.3 6234.2 6128.9 6209.7 6328.1 6338.1 6344.4 6131.7 6149.6 6167.2 6172.5 6184.7 5104.1 5993.0 6128.8 6140.0 6151.1 5735.4 5947.2 6013.0 6023.8 6031.0 5987.4 6024.6 6101.3 6110.7 6114.1 5954.4 5997.3 6001.0 6006.0 6019.2 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:56968.47 Median:36105.28 stddev:115969.41 (321.2%) stddev-sans-first:116217.11 10:28:16 INFO - PROCESS | 1670 | Values: 454.6 520.5 539.5 585.8 630.3 30434.0 38385.0 38859.6 38905.2 38971.0 43071.9 43695.8 43785.6 43803.0 43872.8 9547.9 9777.7 9785.9 9796.2 9800.1 9636.2 9788.7 9790.9 9800.2 9801.0 9742.2 9822.4 9822.5 9823.2 9837.2 9720.1 9800.1 9803.7 9806.4 9812.2 9550.4 9727.8 9729.8 9737.3 9739.0 39546.4 40447.6 40912.8 40936.8 40959.8 3263.2 3279.5 3335.3 3505.8 3829.3 28733.3 29652.3 30034.4 30081.8 30331.2 2770.2 2820.9 2842.7 2847.4 2862.1 480526.0 482780.0 483333.6 483352.0 484624.0 45370.5 46043.8 63779.4 64125.4 64498.7 44326.8 44352.6 44436.3 44455.0 44589.0 15689.6 15806.9 15808.3 15817.1 15831.9 10770.9 10814.0 12545.7 12761.0 12836.2 14513.9 14745.6 14755.6 14774.6 14904.3 6233.0 6330.2 6408.3 6409.6 6411.4 953.2 961.8 1004.6 1104.2 1176.7 29008.6 29034.7 29647.6 29742.7 29932.0 1068.1 1071.1 1073.8 1102.6 1137.2 12720.7 14929.5 14969.2 15174.3 15549.1 494761.0 494864.0 499501.0 500251.0 500739.0 58887.0 59295.7 59422.1 59432.5 59459.5 1339.1 1471.8 1477.6 1496.4 1511.9 28297.7 28738.3 28742.0 29032.3 29155.6 44974.1 45239.0 45681.8 45923.5 46095.0 297971.0 298737.0 299180.0 299200.0 299545.0 28474.4 32280.0 32822.0 33223.8 33295.7 40324.8 41487.2 41502.8 41975.0 42044.4 33400.4 34323.5 34966.8 35643.8 35797.3 30169.2 33203.7 34113.3 35033.5 35751.6 35011.6 35176.0 35781.7 36413.3 36649.0 30907.7 31626.8 31760.0 31760.8 31831.0 20075.8 23333.0 23928.4 25034.5 25150.9 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:34390.20 Median:22536.39 stddev:98526.72 (437.2%) stddev-sans-first:98769.87 10:28:16 INFO - PROCESS | 1670 | Values: 301.6 366.0 368.1 374.2 376.3 19888.1 19965.5 21243.6 21268.5 21315.0 19994.1 20198.2 20369.8 21205.2 21235.3 5808.2 5983.5 6053.2 6061.5 6066.9 3563.9 4313.2 5998.5 6365.9 6688.0 5685.0 6528.5 6611.1 6621.7 6624.8 6268.5 6565.4 6569.3 6580.5 6590.1 3787.7 5254.3 5640.5 5667.9 5669.9 25652.6 25705.5 25808.1 26142.9 26465.7 2158.1 2212.5 2265.7 2275.6 2314.1 14242.4 14462.0 14698.3 14824.7 15221.8 1731.4 1772.4 1785.4 1785.6 1798.8 106253.0 109682.5 111375.0 111980.0 113323.9 10405.8 10579.3 10657.6 10872.8 11031.6 11375.0 13552.3 13662.5 13686.5 13711.0 8606.7 8761.4 8810.5 8814.4 8897.9 7121.7 8986.4 8995.7 9059.9 9081.6 6196.6 6333.2 6348.4 6352.7 6565.3 1706.2 1796.9 1797.4 1803.0 1814.0 911.0 965.8 997.6 1064.2 1107.5 18374.4 19864.8 22460.8 22504.0 22568.8 998.2 1002.8 1026.8 1043.4 1140.9 11621.4 11948.3 12033.9 12078.9 12198.9 529086.0 591314.0 603463.0 616761.0 617603.0 120076.4 120692.4 121240.4 123176.8 127324.0 1072.4 1073.2 1097.4 1098.7 1099.2 15861.4 19775.9 19897.0 20273.0 20506.6 50904.5 51837.2 53000.7 53024.0 53166.5 67061.3 67710.3 70779.6 71538.9 72570.2 7718.0 7939.6 7956.7 8101.4 8307.6 7502.9 11472.3 12343.7 12390.6 13090.5 8838.5 11202.0 11270.8 11287.1 11639.8 8677.7 10928.6 11150.0 11220.2 11506.9 11373.2 11764.5 11768.9 11770.4 11867.8 7284.8 7374.5 7503.0 7916.4 8341.5 7692.3 9629.4 9812.1 11039.2 11196.9 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6147.55 Median:518.53 stddev:3294.66 (635.4%) stddev-sans-first:3284.71 10:28:16 INFO - PROCESS | 1670 | Values: 1416.5 1604.2 1632.9 1922.7 2050.2 8123.9 8849.9 9084.4 9091.0 9091.5 8655.6 8916.6 8921.6 8922.9 8937.0 2202.0 2440.4 2476.3 2506.7 2511.5 2535.3 2536.2 2544.2 2545.8 2547.0 2420.6 2521.3 2524.3 2526.6 2535.9 2461.8 2515.6 2529.1 2531.2 2533.4 2475.3 2514.7 2521.6 2522.3 2523.3 9026.1 9098.0 9106.6 9117.8 9119.0 5520.5 5681.1 5730.7 5734.8 5744.0 3160.0 3637.8 3741.4 3806.6 3824.2 1056.8 1068.4 1078.2 1088.8 1090.6 12476.6 12480.8 12491.8 12494.5 12507.1 4941.9 4947.0 5013.7 5029.5 5040.7 8857.3 10527.6 10542.3 10559.4 10572.0 4828.2 5643.6 5648.7 5685.0 5685.1 3794.3 4695.2 4714.0 4792.2 4871.8 3904.5 3988.2 3999.8 4028.2 4055.1 1161.9 1325.8 1327.6 1340.2 1342.6 1146.6 1164.3 1312.9 1338.8 1429.1 7201.2 8366.7 8442.4 8469.8 8483.9 495.2 516.7 520.4 521.2 523.5 6304.3 6315.3 6333.7 6356.7 6367.5 10621.5 11004.5 11013.3 11134.2 11134.3 10529.6 10868.7 10870.5 10974.6 10977.3 8403.0 8436.5 8447.9 8544.3 8549.5 7795.3 8012.4 8019.8 8068.8 8070.8 9445.6 9565.7 9775.9 9874.6 9968.4 9848.2 10017.7 10176.9 10194.8 10238.5 6756.6 7273.3 7537.6 7587.4 7661.3 8342.5 8359.8 8405.7 8423.3 8432.7 6833.0 7194.2 7293.4 7491.1 7504.5 7354.0 7382.6 7391.5 7402.4 7548.6 6649.5 7836.6 7901.9 7903.0 7903.2 7006.1 7018.9 7072.3 7077.3 7139.5 7200.0 7217.2 7251.6 7267.2 7276.2 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:5769.91 Median:6556.44 stddev:1860.05 (28.4%) stddev-sans-first:1819.66 10:28:16 INFO - PROCESS | 1670 | Values: 315.7 326.7 332.1 332.5 336.1 5751.2 5829.9 6655.8 6664.8 6769.4 5331.5 6601.2 6648.0 6668.8 6681.6 3638.3 4598.4 4676.9 4788.3 4941.6 4409.1 4769.4 4804.4 4812.4 4850.8 4804.5 4805.9 4816.1 4827.4 4827.4 4179.8 4845.6 4850.0 4853.6 4874.1 3944.1 3976.9 4037.6 4050.5 4169.7 6368.2 6379.7 6396.4 6400.1 6414.6 5764.3 5777.8 5788.9 5792.6 5798.6 6306.9 6500.3 7001.9 7022.1 7028.1 4097.3 4519.6 4705.4 4714.4 4722.5 7133.5 7463.0 7464.0 7480.7 7488.6 4789.1 4810.0 4814.0 4820.3 4824.3 4884.3 4894.2 4897.5 4902.6 4917.5 5818.6 5821.7 5827.4 5833.4 5834.3 5413.9 7066.8 7079.7 7080.0 7081.5 1670.9 1686.9 1704.8 1707.9 1708.6 945.5 1091.5 1095.1 1098.2 1114.5 5558.9 5737.9 6006.3 6486.9 6621.9 7158.1 7260.3 7262.7 7268.7 7288.5 6511.7 6666.6 6673.2 6679.6 6704.1 3874.4 3919.4 3921.7 3922.1 3922.6 7408.7 7704.3 7706.1 7718.8 7793.6 7600.7 7627.3 7664.5 7673.4 7679.5 7769.5 7772.9 7782.3 7787.2 7792.6 7413.5 7426.7 7432.4 7442.5 7445.7 7009.5 7260.0 7264.9 7272.0 7277.9 7411.2 7730.9 7756.8 7770.3 7790.5 4037.7 4663.2 4672.9 4676.3 4679.6 7307.2 7318.6 7321.7 7329.9 7337.9 5748.7 6835.0 7059.6 7079.3 7092.4 7031.4 7083.4 7093.3 7095.1 7099.4 6906.1 6911.1 6914.4 6914.9 6925.1 7098.1 7102.7 7109.6 7110.8 7114.1 6646.6 6711.6 6873.3 6942.1 6946.9 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18461.25 Median:34852.05 stddev:26282.77 (75.4%) stddev-sans-first:26322.63 10:28:16 INFO - PROCESS | 1670 | Values: 691.4 751.4 759.6 764.0 780.5 14859.0 15252.4 15252.9 15304.1 15325.2 9786.9 11035.3 13330.3 13876.1 13880.7 745.3 757.0 909.4 913.4 926.9 933.0 936.3 938.0 939.1 940.0 983.6 984.4 987.2 987.7 988.9 774.7 787.5 791.9 958.4 979.8 727.3 727.8 728.5 728.8 729.7 15142.4 15186.0 15228.1 15257.1 15262.7 12454.9 12647.1 12648.2 12829.9 12852.2 9923.7 10032.8 10039.8 10120.5 10409.2 3462.4 3499.2 3526.3 3537.2 3611.1 78018.0 78039.0 78146.4 78163.2 78348.0 9109.0 9548.6 9548.8 9590.8 9832.3 22025.2 22038.0 22057.4 22059.8 22075.2 7333.7 7339.3 7343.5 7355.2 7412.3 3440.4 4031.6 4047.9 4069.9 4139.4 3695.8 3733.9 3736.3 3738.9 3739.4 668.9 688.3 688.8 689.2 698.7 480.2 543.4 547.4 577.2 596.6 7396.3 8124.0 8156.6 8233.5 8281.0 588.1 600.0 603.8 605.6 615.7 3666.7 3837.4 3925.2 3970.3 4029.1 92103.5 92622.0 92858.5 93198.0 96612.0 80521.6 81598.6 82187.6 82721.0 83037.6 72984.6 74078.9 74171.0 74278.0 75171.6 7001.4 7607.5 7703.5 7716.4 8035.7 49162.0 51983.7 52069.2 52196.7 52350.7 67800.0 68614.7 69012.7 69437.3 70975.0 9725.7 9826.9 9838.0 10087.5 10380.5 10930.0 10957.8 11097.9 11147.6 11419.3 8960.8 10618.9 10801.1 11781.0 12278.9 11127.3 11253.7 11274.4 11297.7 11297.8 11123.4 11523.6 11584.2 11622.8 11654.0 9307.9 9385.4 9434.2 9617.8 9648.0 9165.6 9769.7 9837.2 9849.5 9892.3 10:28:16 INFO - PROCESS | 1670 | -------- Summary: end -------- 10:28:16 INFO - PROCESS | 1670 | 10:28:16 INFO - TEST-INFO | 1670: exit 0 10:28:16 INFO - TEST-OK | dromaeo_css | took 1113334ms 10:28:16 INFO - TEST-START | kraken 10:28:16 INFO - operating with platform_type : mac_ 10:28:16 INFO - Initialising browser for kraken test... 10:28:16 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpk8Ymel/profile http://localhost:49280/getInfo.html) 10:28:18 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 10:28:18 INFO - PROCESS | 1677 | colorDepth:24 10:28:18 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 10:28:18 INFO - PROCESS | 1677 | __metrics 10:28:19 INFO - PROCESS | 1677 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:28:19 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:28:19 INFO - TEST-INFO | 1677: exit 0 10:28:19 INFO - Browser initialized. 10:28:19 INFO - Running cycle 1/1 for kraken test... 10:28:19 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/T/tmpk8Ymel/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:31 INFO - PROCESS | 1679 | RSS: Main: 244432896 10:28:31 INFO - PROCESS | 1679 | 10:28:34 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:34 INFO - PROCESS | 1679 | RSS: Main: 290295808 10:28:34 INFO - PROCESS | 1679 | 10:28:37 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 10:28:37 INFO - PROCESS | 1679 | RSS: Main: 300453888 10:28:37 INFO - PROCESS | 1679 | 10:28:41 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 10:28:41 INFO - PROCESS | 1679 | RSS: Main: 286027776 10:28:41 INFO - PROCESS | 1679 | 10:28:43 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 10:28:44 INFO - PROCESS | 1679 | RSS: Main: 288628736 10:28:44 INFO - PROCESS | 1679 | 10:28:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:46 INFO - PROCESS | 1679 | RSS: Main: 288055296 10:28:46 INFO - PROCESS | 1679 | 10:28:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:50 INFO - PROCESS | 1679 | RSS: Main: 288161792 10:28:50 INFO - PROCESS | 1679 | 10:28:53 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:53 INFO - PROCESS | 1679 | RSS: Main: 288407552 10:28:53 INFO - PROCESS | 1679 | 10:28:56 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 10:28:57 INFO - PROCESS | 1679 | RSS: Main: 288587776 10:28:57 INFO - PROCESS | 1679 | 10:28:58 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:59 INFO - PROCESS | 1679 | RSS: Main: 324005888 10:28:59 INFO - PROCESS | 1679 | 10:29:01 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:29:01 INFO - PROCESS | 1679 | RSS: Main: 324063232 10:29:01 INFO - PROCESS | 1679 | 10:29:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:29:04 INFO - PROCESS | 1679 | RSS: Main: 332021760 10:29:04 INFO - PROCESS | 1679 | 10:29:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:29:07 INFO - PROCESS | 1679 | RSS: Main: 332226560 10:29:07 INFO - PROCESS | 1679 | 10:29:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:29:10 INFO - PROCESS | 1679 | RSS: Main: 332550144 10:29:10 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 10:29:12 INFO - PROCESS | 1679 | RSS: Main: 394952704 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | __start_tp_report 10:29:12 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 10:29:12 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 10:29:12 INFO - PROCESS | 1679 | |i|pagename|runs| 10:29:12 INFO - PROCESS | 1679 | |0;ai-astar;111;107;111;110;112;112;116;109;118;162 10:29:12 INFO - PROCESS | 1679 | |1;audio-beat-detection;155;121;144;161;124;143;143;117;164;119 10:29:12 INFO - PROCESS | 1679 | |2;audio-dft;183;183;184;187;183;184;186;184;183;181 10:29:12 INFO - PROCESS | 1679 | |3;audio-fft;79;69;80;79;57;57;57;77;75;47 10:29:12 INFO - PROCESS | 1679 | |4;audio-oscillator;91;103;130;81;77;84;118;79;79;119 10:29:12 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;88;85;89;85;89;85;88;85;92;129 10:29:12 INFO - PROCESS | 1679 | |6;imaging-darkroom;93;93;96;95;97;97;95;95;94;94 10:29:12 INFO - PROCESS | 1679 | |7;imaging-desaturate;86;85;84;85;84;116;134;142;86;85 10:29:12 INFO - PROCESS | 1679 | |8;json-parse-financial;56;55;56;54;54;54;54;63;56;53 10:29:12 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;62;64;75;73;70;67;68;68;66;67 10:29:12 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;81;83;83;84;85;82;82;83;84;82 10:29:12 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;133;122;127;134;119;122;132;124;119;134 10:29:12 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;141;129;143;138;142;130;138;138;136;136 10:29:12 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;68;67;67;67;66;69;67;67;68;66 10:29:12 INFO - PROCESS | 1679 | __end_tp_report 10:29:12 INFO - PROCESS | 1679 | __start_cc_report 10:29:12 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1288 10:29:12 INFO - PROCESS | 1679 | __end_cc_report 10:29:12 INFO - PROCESS | 1679 | __startTimestamp1459358952713__endTimestamp 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | ------- Summary: start ------- 10:29:12 INFO - PROCESS | 1679 | Number of tests: 14 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:116.80 Median:112.00 stddev:16.20 (14.5%) stddev-sans-first:17.04 10:29:12 INFO - PROCESS | 1679 | Values: 111.0 107.0 111.0 110.0 112.0 112.0 116.0 109.0 118.0 162.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:143.50 stddev:17.81 (12.4%) stddev-sans-first:17.94 10:29:12 INFO - PROCESS | 1679 | Values: 155.0 121.0 144.0 161.0 124.0 143.0 143.0 117.0 164.0 119.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.69 (0.9%) stddev-sans-first:1.76 10:29:12 INFO - PROCESS | 1679 | Values: 183.0 183.0 184.0 187.0 183.0 184.0 186.0 184.0 183.0 181.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:67.70 Median:76.00 stddev:12.11 (15.9%) stddev-sans-first:12.14 10:29:12 INFO - PROCESS | 1679 | Values: 79.0 69.0 80.0 79.0 57.0 57.0 57.0 77.0 75.0 47.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:79.00 stddev:19.86 (25.1%) stddev-sans-first:20.98 10:29:12 INFO - PROCESS | 1679 | Values: 91.0 103.0 130.0 81.0 77.0 84.0 118.0 79.0 79.0 119.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:88.00 stddev:13.39 (15.2%) stddev-sans-first:14.14 10:29:12 INFO - PROCESS | 1679 | Values: 88.0 85.0 89.0 85.0 89.0 85.0 88.0 85.0 92.0 129.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:1.45 (1.5%) stddev-sans-first:1.36 10:29:12 INFO - PROCESS | 1679 | Values: 93.0 93.0 96.0 95.0 97.0 97.0 95.0 95.0 94.0 94.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:98.70 Median:85.00 stddev:22.94 (27.0%) stddev-sans-first:23.87 10:29:12 INFO - PROCESS | 1679 | Values: 86.0 85.0 84.0 85.0 84.0 116.0 134.0 142.0 86.0 85.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:2.84 (5.1%) stddev-sans-first:3.00 10:29:12 INFO - PROCESS | 1679 | Values: 56.0 55.0 56.0 54.0 54.0 54.0 54.0 63.0 56.0 53.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:3.89 (5.7%) stddev-sans-first:3.46 10:29:12 INFO - PROCESS | 1679 | Values: 62.0 64.0 75.0 73.0 70.0 67.0 68.0 68.0 66.0 67.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.20 (1.4%) stddev-sans-first:1.05 10:29:12 INFO - PROCESS | 1679 | Values: 81.0 83.0 83.0 84.0 85.0 82.0 82.0 83.0 84.0 82.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:129.50 stddev:6.19 (4.8%) stddev-sans-first:6.11 10:29:12 INFO - PROCESS | 1679 | Values: 133.0 122.0 127.0 134.0 119.0 122.0 132.0 124.0 119.0 134.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:138.00 stddev:4.65 (3.4%) stddev-sans-first:4.72 10:29:12 INFO - PROCESS | 1679 | Values: 141.0 129.0 143.0 138.0 142.0 130.0 138.0 138.0 136.0 136.0 10:29:12 INFO - PROCESS | 1679 | 10:29:12 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 10:29:12 INFO - PROCESS | 1679 | Values: 68.0 67.0 67.0 67.0 66.0 69.0 67.0 67.0 68.0 66.0 10:29:12 INFO - PROCESS | 1679 | -------- Summary: end -------- 10:29:12 INFO - PROCESS | 1679 | 10:29:13 INFO - TEST-INFO | 1679: exit 0 10:29:13 INFO - TEST-OK | kraken | took 56581ms 10:29:13 INFO - SUITE-END | took 1169s 10:29:13 INFO - Completed test suite (00:19:30) 10:29:13 INFO - javascript benchmark 10:29:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3447.3622379859726, 3508.666676665719, 3513.4202856528673, 3565.4117070683333, 3587.7309201809853, 5609.242752228448, 5680.630759000662, 5695.8576035599135, 5745.971270143648, 5803.274590676166, 5653.745581448834, 5744.770209191627, 5746.224259724936, 5755.223044888939, 5757.539396848252, 5084.491550844905, 5148.613853960958, 5167.431582525919, 5183.922241166386, 5243.632945693803, 5107.591392688576, 5158.7936482540845, 5225.921611175835, 5229.60777941654, 5236.162214045753, 5150.665206761567, 5195.714235717034, 5207.583393328525, 5210.478952104778, 5245.977034478259, 5209.765560549784, 5253.238280449352, 5259.579233661336, 5268.841934741964, 5323.680579165224, 5084.923726144111, 5097.770600322994, 5135.281060651511, 5191.325127733408, 5195.220716892459, 4598.195315819718, 5613.129964855454, 5616.382197958222, 5634.154876768476, 5638.830835074954, 6200.348963358828, 6216.067589861512, 6226.439620434183, 6233.065040243954, 6235.251769787609, 6123.038605230386, 6230.0, 6315.810525684236, 6336.303006669263, 6341.8414539636415, 5866.560007999417, 5880.294364676266, 5888.057910734262, 5900.616459930134, 5915.112733090071, 5812.767489300465, 6286.811395658137, 6304.590201636879, 6312.715927783261, 6316.084167795644, 5981.252343457068, 6030.964179667709, 6132.110769107974, 6168.784092556739, 6180.165677633552, 6215.502759779207, 6250.062490626442, 6273.96863015682, 6289.0, 6289.056641503811, 6144.262688477412, 6188.2883468400805, 6206.410391012847, 6220.34686357935, 6222.688865556795, 6112.685862051747, 6122.112293717475, 6188.783392581238, 6238.220222472191, 6251.562390632703, 4912.508749125131, 4941.65408421407, 4942.357493525818, 4945.530174633404, 4973.676711013773, 4441.178381999341, 4447.288433850568, 4479.507254202035, 4486.977565112219, 4520.660950428731, 5601.075822489325, 5700.0, 5706.258186435737, 5811.128330750421, 5832.62087964281, 6267.123457956548, 6302.086197501429, 6314.747410103636, 6329.050642403677, 6343.777967771198, 5647.237622920935, 5702.116171993264, 5718.7426565804635, 5732.799352022659, 5765.769369225268, 5301.655392399482, 5360.463953604686, 5418.83743487696, 5446.945530544723, 5483.341998960151, 5658.490735833795, 5810.983077961424, 6303.46420554258, 6344.30212676596, 6349.682515874188, 6152.446279834837, 6222.62664240147, 6309.842253943688, 6323.905141422974, 6344.111824344688, 6277.12120303167, 6310.873782524232, 6336.1446204763615, 6336.936630633819, 6344.238691356882, 6157.384261573807, 6181.350958149509, 6209.285932117864, 6228.34602366745, 6234.189555357774, 6128.930927367261, 6209.720562574786, 6328.050792381179, 6338.080978258219, 6344.365563443804, 6131.682521312607, 6149.631022138686, 6167.198264225622, 6172.506199504119, 6184.721687523982, 5104.106781313181, 5992.9811931972545, 6128.846778830565, 6140.0, 6151.0773383992755, 5735.369109398046, 5947.167396564398, 6013.038043397147, 6023.849403764941, 6030.969845150747, 5987.371326010706, 6024.638521688713, 6101.338204344158, 6110.741024289911, 6114.144019837316, 5954.374790647093, 5997.310309314485, 6001.0, 6005.978983572891, 6019.187409699634], "unit": "score", "name": "dojo.html", "value": 5703.8937802064365}, {"lowerIsBetter": false, "replicates": [454.5681602477645, 520.5263210478465, 539.4982666120511, 585.8488070940602, 630.3035146163489, 30434.0, 38385.0, 38859.61140388595, 38905.22189556207, 38971.0, 43071.92320191997, 43695.78152109243, 43785.56214437863, 43803.0, 43872.78063609685, 9547.856782148274, 9777.657781977632, 9785.853212201822, 9796.216302695768, 9800.117989380955, 9636.22910167185, 9788.678528398646, 9790.90209097907, 9800.166985806214, 9801.0, 9742.22062235023, 9822.410655360665, 9822.459764712938, 9823.21414286859, 9837.213022958145, 9720.07659272368, 9800.068993445611, 9803.705888823346, 9806.411615303105, 9812.215022798158, 9550.426974381558, 9727.805443891153, 9729.805403891953, 9737.26970477217, 9738.9513052435, 39546.40680389797, 40447.59552404468, 40912.79543602293, 40936.79531602353, 40959.7952010241, 3263.167892187477, 3279.508073788927, 3335.266241426882, 3505.842237099311, 3829.291581057513, 28733.281667958257, 29652.258693532618, 30034.3844389265, 30081.849590752125, 30331.241718956982, 2770.1551026936777, 2820.85895705216, 2842.701516340796, 2847.4447482740875, 2862.069827306134, 480526.0, 482779.9999999965, 483333.5833320811, 483352.0, 484624.0, 45370.54629453729, 46043.76978115088, 63779.362206377344, 64125.35874641194, 64498.67750661217, 44326.77836610861, 44352.556474434845, 44436.3334549982, 44455.0, 44589.0, 15689.607759806097, 15806.92096539533, 15808.288627011812, 15817.05097694142, 15831.89176757639, 10770.892291076989, 10814.0, 12545.74908501825, 12760.979121670243, 12836.229826210458, 14513.854861451251, 14745.557633271019, 14755.55733328002, 14774.63063423423, 14904.254787260594, 6233.0, 6330.177076979963, 6408.283195746456, 6409.583377080475, 6411.3909178627955, 953.2326477185793, 961.778790878102, 1004.6082028009082, 1104.2442516398964, 1176.6764139861607, 29008.564871526945, 29034.709652903624, 29647.55528667072, 29742.702572974427, 29932.0, 1068.1188019883627, 1071.12703146935, 1073.7691396349821, 1102.5755084292446, 1137.2096393006946, 12720.745585088247, 14929.477468288558, 14969.176695281647, 15174.317155728018, 15549.067055976677, 494761.0, 494864.0, 499501.0049899527, 500251.0, 500739.0, 58887.0, 59295.703521482115, 59422.10866837001, 59432.514187145665, 59459.51351216168, 1339.1496399786206, 1471.8160229971254, 1477.6084337650532, 1496.3640452807513, 1511.8941674082928, 28297.717022830333, 28738.281542961595, 28742.0, 29032.274193144494, 29155.562666560443, 44974.10051799011, 45239.0, 45681.771591141835, 45923.540764591926, 46095.0, 297971.0, 298737.0126298709, 299180.0, 299200.0, 299545.0, 28474.43051139007, 32280.031599052065, 32822.0, 33223.83388083044, 33295.66930314855, 40324.79837600793, 41487.1702565953, 41502.792486037375, 41975.0, 42044.36933446062, 33400.42446767217, 34323.4851477233, 34966.82516587502, 35643.82178089093, 35797.28405431825, 30169.245768855955, 33203.667963320055, 34113.31773364569, 35033.474497883064, 35751.64248357483, 35011.59735570332, 35176.0, 35781.747638832516, 36413.27173456569, 36649.0, 30907.690923090482, 31626.841865791444, 31760.0, 31760.841195793873, 31831.0, 20075.79545227291, 23333.0, 23928.40178995539, 25034.499310013332, 25150.874245628656], "unit": "score", "name": "ext.html", "value": 18757.774176482188}, {"lowerIsBetter": false, "replicates": [301.64406000918916, 365.97621154624966, 368.1422286073448, 374.1618773946361, 376.2662807525323, 19888.105035273413, 19965.500862478446, 21243.57512849742, 21268.468288292763, 21315.040823162955, 19994.10026548805, 20198.192072317128, 20369.77781333121, 21205.151793928264, 21235.256766013194, 5808.2449281593335, 5983.461488466037, 6053.213082299295, 6061.545384096188, 6066.878662426749, 3563.8752643657476, 4313.202057619351, 5998.460138587527, 6365.904511432309, 6687.966560167192, 5684.971575142139, 6528.510361722866, 6611.074449577063, 6621.6689165541775, 6624.834379140512, 6268.529860260476, 6565.441937435347, 6569.310222426624, 6580.5393622446445, 6590.110335104771, 3787.715921305913, 5254.264402983586, 5640.5487560995025, 5667.943320566783, 5669.886602267931, 25652.61521077185, 25705.485890282278, 25808.096716615015, 26142.86928565364, 26465.73534264652, 2158.115172779153, 2212.5243072739277, 2265.728112626495, 2275.601769690314, 2314.109068008812, 14242.430302787876, 14462.0, 14698.33857476416, 14824.703505929929, 15221.771673424908, 1731.3680506615121, 1772.421830444583, 1785.4286628278956, 1785.6071664233848, 1798.8071173666715, 106253.0, 109682.45158774155, 111375.0, 111980.0, 113323.86676133216, 10405.791884162425, 10579.259451838298, 10657.62698305571, 10872.78254434907, 11031.558737650565, 11375.03312218454, 13552.254625995467, 13662.453501859814, 13686.452541898412, 13710.971677124255, 8606.741797746077, 8761.43050701715, 8810.471371717718, 8814.427062240933, 8897.911020889838, 7121.679524421414, 8986.415882967585, 8995.730128096167, 9059.864102038475, 9081.59132839024, 6196.566240363221, 6333.20834895638, 6348.365163483707, 6352.6823658816875, 6565.310642382577, 1706.1554530507478, 1796.91015449227, 1797.4248240563156, 1802.9819701802815, 1813.963720725578, 910.981780364389, 965.7875267441152, 997.6458357283205, 1064.2071656615872, 1107.5126944144552, 18374.448766537025, 19864.801351986294, 22460.775392246196, 22504.0, 22568.774312256668, 998.2213873178932, 1002.7643503776607, 1026.825439675257, 1043.389617074005, 1140.8573928258968, 11621.418929053514, 11948.283103013848, 12033.939830300793, 12078.912897839236, 12198.878011219951, 529086.0, 591314.0, 603463.0, 616760.9603966256, 617603.0, 120076.3996180031, 120692.39653801675, 121240.39379803045, 123176.76823231833, 127324.0, 1072.3780207479642, 1073.2058276875057, 1097.3744965369822, 1098.6813823991113, 1099.1920938110643, 15861.365545378056, 19775.90112049488, 19897.0, 20273.0, 20506.58986820285, 50904.49095509146, 51837.22244166416, 53000.73499632477, 53024.0, 53166.4683353177, 67061.28203333536, 67710.32289677237, 70779.58440831052, 71538.92691609525, 72570.1857453568, 7717.961410193137, 7939.6030198491, 7956.681732730626, 8101.432899696964, 8307.626156823078, 7502.924970750441, 11472.31166130035, 12343.69140771488, 12390.62828115158, 13090.541831035867, 8838.469691818511, 11202.047825934887, 11270.83093753578, 11287.141566099643, 11639.76720465603, 8677.696280630147, 10928.562857485611, 11150.0, 11220.15848811326, 11506.94246528762, 11373.20387572862, 11764.470598822902, 11768.94115529417, 11770.352630605057, 11867.821982670093, 7284.781456556312, 7374.483786135133, 7502.98709674187, 7916.445848790529, 8341.45780524264, 7692.34615057704, 9629.374090684363, 9812.116909477896, 11039.227254092137, 11196.94401527987], "unit": "score", "name": "jquery.html", "value": 9676.692343754772}, {"lowerIsBetter": false, "replicates": [1416.5042235217668, 1604.2460043779424, 1632.8938618989762, 1922.7212054252134, 2050.190174880921, 8123.91876081239, 8849.867251991225, 9084.36409451337, 9091.0, 9091.45451272924, 8655.567221638925, 8916.554172291391, 8921.643134274638, 8922.91077089229, 8937.0, 2201.966970495444, 2440.3533063738123, 2476.2571228631427, 2506.749325067497, 2511.485145545168, 2535.277445927911, 2536.1884197056947, 2544.211294498702, 2545.847249165047, 2546.974530254692, 2420.6248031555137, 2521.306640673811, 2524.3184340228127, 2526.5957446808516, 2535.911243106492, 2461.8030557555444, 2515.5975043992967, 2529.051605647882, 2531.202671158579, 2533.442642618621, 2475.3192871960173, 2514.7233804281514, 2521.6091505816626, 2522.281149872296, 2523.2682522068576, 9026.097390260988, 9098.044705305914, 9106.590203440861, 9117.817643647157, 9118.95440522793, 5520.530754885839, 5681.119426488859, 5730.713464326809, 5734.827955161351, 5744.0, 3159.952600710991, 3637.781733096023, 3741.3639681254253, 3806.6003069677563, 3824.2160357126722, 1056.8256237720766, 1068.4283908109203, 1078.2129045796612, 1088.7931293054373, 1090.596479302655, 12476.625701228977, 12480.75038499234, 12491.812622810665, 12494.500219991189, 12507.06197035226, 4941.925871111936, 4946.975265123651, 5013.724245166478, 5029.5221953914315, 5040.722760248148, 8857.335699822539, 10527.631532896312, 10542.26204165701, 10559.419231942316, 10572.0, 4828.203346447796, 5643.604947653625, 5648.661080335193, 5685.0, 5685.090385538294, 3794.2790869734663, 4695.154872122982, 4713.9764301178275, 4792.233242681224, 4871.756412179377, 3904.4924159859606, 3988.1824226033596, 3999.8000099994883, 4028.194361127786, 4055.1484188320783, 1161.9419029048513, 1325.754735373959, 1327.6481732340937, 1340.2025794652166, 1342.5636668082716, 1146.5585749486509, 1164.3246916788241, 1312.9365214176548, 1338.7857942729117, 1429.0925262458206, 7201.243869393638, 8366.748997530083, 8442.409031367868, 8469.788255293544, 8483.939507561554, 495.15823100728187, 516.6538419259106, 520.4119345139968, 521.1713375732528, 523.4948274914725, 6304.338044505353, 6315.336889626615, 6333.714982825784, 6356.68216589178, 6367.522435817332, 10621.5220315086, 11004.504797284142, 11013.339199648046, 11134.220604557766, 11134.331940083459, 10529.57881684724, 10868.728281793019, 10870.456477176109, 10974.561017559368, 10977.341359518454, 8402.957985210034, 8436.493810371398, 8447.873281900776, 8544.273736732323, 8549.529775862387, 7795.337396321376, 8012.359011278967, 8019.799505012188, 8068.838623227385, 8070.757877263692, 9445.574949127444, 9565.665201717906, 9775.85336219943, 9874.605015799574, 9968.352057116264, 9848.212143028397, 10017.69946901594, 10176.949115254376, 10194.847077293698, 10238.53926573291, 6756.594604323756, 7273.272672732684, 7537.585432801248, 7587.393008559412, 7661.272179142972, 8342.538951009588, 8359.791005224675, 8405.747827565183, 8423.32613390915, 8432.662693492437, 6832.965835170792, 7194.1726701427915, 7293.38006269473, 7491.063617047869, 7504.474686771873, 7353.995697554074, 7382.5570465772225, 7391.519551229153, 7402.444816638881, 7548.584827834302, 6649.46804255668, 7836.647350869339, 7901.881471777813, 7903.012123484565, 7903.249191326815, 7006.089208402875, 7018.894716579153, 7072.292770722886, 7077.327653872874, 7139.535930164523, 7199.992001119743, 7217.170025446931, 7251.637418128967, 7267.236940121211, 7276.235995220637], "unit": "score", "name": "mootools.html", "value": 4915.140588175487}, {"lowerIsBetter": false, "replicates": [315.68904628940487, 326.6716949465788, 332.0668920333862, 332.5493955690038, 336.06741292912153, 5751.223584816049, 5829.854253643651, 6655.800325990216, 6664.800055998316, 6769.39075483207, 5331.546818520431, 6601.2078550574, 6648.002799580066, 6668.833279168023, 6681.632510211936, 3638.326909521747, 4598.356230127785, 4676.883077923062, 4788.257820037882, 4941.555260026588, 4409.118176364724, 4769.427668679763, 4804.44748853881, 4812.374391329122, 4850.8059677612855, 4804.471508134103, 4805.855824325258, 4816.060868130716, 4827.372441582589, 4827.372441582589, 4179.791010449496, 4845.612351011928, 4849.981503884153, 4853.563179313879, 4874.073925954058, 3944.112574670705, 3976.9005774855573, 4037.596240375968, 4050.4936882889638, 4169.687273454503, 6368.235811702579, 6379.681015949231, 6396.392342727433, 6400.071989561534, 6414.550981431302, 5764.308283006066, 5777.826665200051, 5788.942110578882, 5792.594518383715, 5798.565107616903, 6306.873862522724, 6500.252470965852, 7001.929980700179, 7022.087128673291, 7028.121484814398, 4097.262492751303, 4519.615832654228, 4705.3647757552635, 4714.434267887841, 4722.480527142012, 7133.536320139175, 7463.029806125223, 7463.962680186619, 7480.738174163878, 7488.5506869588, 4789.114013907439, 4809.975950120297, 4813.95186048135, 4820.325154478376, 4824.324594556765, 4884.291777692215, 4894.1679914414635, 4897.4857639947295, 4902.583280421204, 4917.508249175054, 5818.592698511148, 5821.7380217890295, 5827.446392592697, 5833.445822646927, 5834.299884013945, 5413.945860541423, 7066.787996360117, 7079.681414336367, 7079.964600176966, 7081.5042946994245, 1670.9331626734795, 1686.9156542172843, 1704.8295170482852, 1707.8633709303226, 1708.6241026974294, 945.5036106044382, 1091.497910960967, 1095.0910744082391, 1098.242212873115, 1114.4929057278919, 5558.944410555842, 5737.852429514114, 6006.309274433496, 6486.902696459557, 6621.86756264872, 7158.141023077264, 7260.273972602803, 7262.745803896838, 7268.67290971897, 7288.453365997571, 6511.674416279167, 6666.566673166229, 6673.1992160941, 6679.599224046476, 6704.061431399608, 3874.438206460104, 3919.392494163409, 3921.686265098785, 3922.058705910618, 3922.5881282465502, 7408.703651853865, 7704.26809453101, 7706.075270967408, 7718.768436946788, 7793.571353575494, 7600.733974310872, 7627.313541781266, 7664.540127592362, 7673.386129109658, 7679.542546385103, 7769.494982826098, 7772.922270777333, 7782.338501227233, 7787.182345853604, 7792.649330780015, 7413.481056326005, 7426.70293188288, 7432.405407567489, 7442.516236444614, 7445.664945077377, 7009.544379615309, 7259.963700181465, 7264.927350726425, 7272.0, 7277.9272207277245, 7411.221821708858, 7730.884036739566, 7756.767296981099, 7770.339521140766, 7790.493617914817, 4037.717359784787, 4663.230566956414, 4672.859814205579, 4676.345311656303, 4679.625629949528, 7307.2327405621645, 7318.560886346836, 7321.74373896911, 7329.900514922804, 7337.889931651136, 5748.6838223898085, 6834.965825170842, 7059.611721355374, 7079.327463891128, 7092.432605391659, 7031.367176954099, 7083.433325334064, 7093.290670932865, 7095.077639906779, 7099.432045436456, 6906.102206713095, 6911.101556797584, 6914.377706006484, 6914.896276555755, 6925.099737034153, 7098.148222213161, 7102.72151012802, 7109.608971506616, 7110.786676399716, 7114.14630244374, 6646.567973081735, 6711.563748356341, 6873.312668733087, 6942.06282151903, 6946.895796562954], "unit": "score", "name": "prototype.html", "value": 5152.258062732497}, {"lowerIsBetter": false, "replicates": [691.4468425259792, 751.4138971602149, 759.5883071248784, 764.0334976255042, 780.5433821214591, 14859.0, 15252.389904403839, 15252.923735381322, 15304.081755094701, 15325.233738313082, 9786.902130978688, 11035.337879727222, 13330.33348332582, 13876.098053626507, 13880.652983675413, 745.306864615907, 757.0272200222687, 909.3952521573146, 913.3652111782297, 926.9351145419823, 932.9673461428852, 936.3211671538148, 938.0385105267087, 939.0703203828195, 940.0176815228103, 983.5770618633984, 984.4093543873654, 987.1559816357019, 987.733312005758, 988.8961659025806, 774.7365895595497, 787.4645241235958, 791.8535071011881, 958.3818437108026, 979.8334283171843, 727.323589062172, 727.8216836874999, 728.5155371677828, 728.7995801154672, 729.7008226627111, 15142.394304227928, 15186.0, 15228.086314821147, 15257.10943709358, 15262.694746105015, 12454.937725311405, 12647.114701970866, 12648.177868438523, 12829.920819003371, 12852.228866268053, 9923.702288931343, 10032.799344013152, 10039.849402258971, 10120.544575494121, 10409.167266618653, 3462.4460086386057, 3499.1602015516346, 3526.294741051774, 3537.168765340143, 3611.061124107751, 78018.0, 78039.0, 78146.43707125883, 78163.21836781673, 78348.0, 9109.0, 9548.61805527785, 9548.761280967892, 9590.808183836285, 9832.262580306506, 22025.22911698083, 22038.0, 22057.448563785714, 22059.779402206095, 22075.227367042076, 7333.669984850694, 7339.302766237199, 7343.48595598303, 7355.190928997806, 7412.258774122544, 3440.449528075496, 4031.637152656275, 4047.91904161921, 4069.918601627951, 4139.399787030924, 3695.796731179811, 3733.9439908401396, 3736.2901048801186, 3738.9439158412647, 3739.364308067635, 668.9029891290838, 688.3082502085372, 688.8002479280952, 689.162667359161, 698.7205117952859, 480.2148487223415, 543.3751186135976, 547.4005963469994, 577.1976952036672, 596.5615272774508, 7396.3343299103335, 8124.0, 8156.632951517077, 8233.46482478637, 8281.0, 588.0913987888722, 600.0429315242181, 603.8007457539002, 605.5882000239791, 615.7229246838851, 3666.651668091527, 3837.366834472281, 3925.156091440354, 3970.3250447424007, 4029.1337362466625, 92103.53948230216, 92622.0, 92858.53570732103, 93198.0, 96612.0, 80521.59739201267, 81598.59200703958, 82187.5890620543, 82721.0, 83037.58481207555, 72984.63507682533, 74078.88881666672, 74171.0, 74278.0, 75171.62414187894, 7001.36987671112, 7607.4674772765375, 7703.537787732754, 7716.421268405004, 8035.67857285702, 49162.0, 51983.740081300864, 52069.21896171485, 52196.73901630467, 52350.73824630852, 67800.0, 68614.65692671505, 69012.654936725, 69437.30562694308, 70975.03869201217, 9725.6596019139, 9826.852597211191, 9837.950810245902, 10087.546060427152, 10380.480975951323, 10930.0, 10957.83563246568, 11097.889021110008, 11147.55409783632, 11419.257748246337, 8960.79412104178, 10618.8938110621, 10801.081908037904, 11781.0, 12278.938605306916, 11127.276727012719, 11253.716551040634, 11274.379909105079, 11297.661070167907, 11297.7740445189, 11123.388213648326, 11523.596674116367, 11584.16188033937, 11622.82565761531, 11654.009409200313, 9307.925976257957, 9385.436873787594, 9434.245260379015, 9617.759556011155, 9648.0, 9165.587548560465, 9769.706908792748, 9837.163841073303, 9849.507524623883, 9892.307538472238], "unit": "score", "name": "yui.html", "value": 6869.2506802390835}], "name": "dromaeo_css", "value": 7514.9479957632075}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 110.0, 112.0, 112.0, 116.0, 109.0, 118.0, 162.0], "unit": "score", "name": "ai-astar", "value": 116.8}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 144.0, 161.0, 124.0, 143.0, 143.0, 117.0, 164.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 139.1}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 184.0, 187.0, 183.0, 184.0, 186.0, 184.0, 183.0, 181.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [79.0, 69.0, 80.0, 79.0, 57.0, 57.0, 57.0, 77.0, 75.0, 47.0], "unit": "score", "name": "audio-fft", "value": 67.7}, {"lowerIsBetter": true, "replicates": [91.0, 103.0, 130.0, 81.0, 77.0, 84.0, 118.0, 79.0, 79.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 85.0, 89.0, 85.0, 88.0, 85.0, 92.0, 129.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 96.0, 95.0, 97.0, 97.0, 95.0, 95.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 84.0, 85.0, 84.0, 116.0, 134.0, 142.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 98.7}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 54.0, 54.0, 54.0, 54.0, 63.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [62.0, 64.0, 75.0, 73.0, 70.0, 67.0, 68.0, 68.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 84.0, 85.0, 82.0, 82.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [133.0, 122.0, 127.0, 134.0, 119.0, 122.0, 132.0, 124.0, 119.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [141.0, 129.0, 143.0, 138.0, 142.0, 130.0, 138.0, 138.0, 136.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 66.0, 69.0, 67.0, 67.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1425.8999999999999}]} 10:29:13 INFO - Return code: 0 10:29:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:29:13 ERROR - # TBPL SUCCESS # 10:29:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:29:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:29:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:29:14 INFO - 2016-03-30 10:29:14.011 screenresolution[1683:9610] starting screenresolution argv=screenresolution get 10:29:14 INFO - 2016-03-30 10:29:14.014 screenresolution[1683:9610] Display 0: 1600x1200x32@60 10:29:14 INFO - 2016-03-30 10:29:14.019 screenresolution[1684:9613] starting screenresolution argv=screenresolution list 10:29:14 INFO - Available Modes on Display 0 10:29:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:29:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:29:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:29:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:29:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:29:14 INFO - Intel Iris: 10:29:14 INFO - Chipset Model: Intel Iris 10:29:14 INFO - Type: GPU 10:29:14 INFO - Bus: Built-In 10:29:14 INFO - VRAM (Dynamic, Max): 1536 MB 10:29:14 INFO - Vendor: Intel (0x8086) 10:29:14 INFO - Device ID: 0x0a2e 10:29:14 INFO - Revision ID: 0x0009 10:29:14 INFO - Displays: 10:29:14 INFO - Display: 10:29:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:29:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:29:14 INFO - Display Serial Number: 1600x1200 60 10:29:14 INFO - Main Display: Yes 10:29:14 INFO - Mirror: Off 10:29:14 INFO - Online: Yes 10:29:14 INFO - Rotation: Supported 10:29:14 INFO - Return code: 0 10:29:14 INFO - Running post-action listener: _resource_record_post_action 10:29:14 INFO - Running post-run listener: _resource_record_post_run 10:29:15 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39294464; Write bytes: 705861632; Read time: 439; Write time: 2067 10:29:15 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 5556224; Write bytes: 404739584; Read time: 79; Write time: 768 10:29:15 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 32194048; Write bytes: 297413120; Read time: 346; Write time: 1238 10:29:15 INFO - Running post-run listener: _upload_blobber_files 10:29:15 INFO - Blob upload gear active. 10:29:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:29:15 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 10:29:15 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'] 10:29:15 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 10:29:16 INFO - (blobuploader) - INFO - Open directory for files ... 10:29:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:29:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:29:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:18 INFO - (blobuploader) - INFO - Done attempting. 10:29:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:29:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:29:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:20 INFO - (blobuploader) - INFO - Done attempting. 10:29:20 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:20 INFO - Return code: 0 10:29:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fe5b59c930cfdbe1cbc8de2bb681ab5ed2aa2559edb9b5b18a157bec38c60d67a7f3cf07c0bd11e39cebf944c382b585bf5f8419860d071797e05b6ed04d3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e941d74ce222d5882523ceb94af74c225f0f33aec8a74edc1b7d4105535d348b51fa83219b6838ca3e9b59c4d6c4f218aa601b5763b519092489d74a1c5b851"} 10:29:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:20 INFO - Contents: 10:29:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fe5b59c930cfdbe1cbc8de2bb681ab5ed2aa2559edb9b5b18a157bec38c60d67a7f3cf07c0bd11e39cebf944c382b585bf5f8419860d071797e05b6ed04d3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e941d74ce222d5882523ceb94af74c225f0f33aec8a74edc1b7d4105535d348b51fa83219b6838ca3e9b59c4d6c4f218aa601b5763b519092489d74a1c5b851"} 10:29:20 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:20 INFO - Copying logs to upload dir... 10:29:20 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.602307 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-03-30 10:29:20.822148) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 10:29:20.825485) ========= 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.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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/5fe5b59c930cfdbe1cbc8de2bb681ab5ed2aa2559edb9b5b18a157bec38c60d67a7f3cf07c0bd11e39cebf944c382b585bf5f8419860d071797e05b6ed04d3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e941d74ce222d5882523ceb94af74c225f0f33aec8a74edc1b7d4105535d348b51fa83219b6838ca3e9b59c4d6c4f218aa601b5763b519092489d74a1c5b851"} build_url:https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/NpRep9leQyqly5UIESsjVw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5fe5b59c930cfdbe1cbc8de2bb681ab5ed2aa2559edb9b5b18a157bec38c60d67a7f3cf07c0bd11e39cebf944c382b585bf5f8419860d071797e05b6ed04d3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0e941d74ce222d5882523ceb94af74c225f0f33aec8a74edc1b7d4105535d348b51fa83219b6838ca3e9b59c4d6c4f218aa601b5763b519092489d74a1c5b851"}' ========= master_lag: 0.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-30 10:29:20.979163) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 10:29:20.979510) ========= 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.NbU4PqFoYt/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.IM3qskUW9F/Listeners TMPDIR=/var/folders/t3/b01yfz4j3ln01tl7gpfw3l9000000w/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.005301 ========= master_lag: 0.43 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-30 10:29:21.411414) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 10:29:21.411772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-30 10:29:21.412327) ========= ========= Total master_lag: 1.45 =========