builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0066 starttime: 1460630381.85 results: success (0) buildid: 20160414023144 builduid: 1fb7481869d04398a7f109f3da9feab8 revision: f98aad8ef492eb30e2a7e5f38a522b41a6434e8a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.848153) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.848556) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.848836) ========= 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.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005726 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.876095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.876550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.945205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.945469) ========= 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.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005549 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.994765) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.995267) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.996007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:41.996465) ========= 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.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-14 03:39:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 163M=0s 2016-04-14 03:39:42 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.262835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:42.274773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-04-14 03:39:42.275090) ========= 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.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.026932 ========= master_lag: 3.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-04-14 03:39:45.554856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:45.555164) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f98aad8ef492eb30e2a7e5f38a522b41a6434e8a --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 f98aad8ef492eb30e2a7e5f38a522b41a6434e8a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-14 03:39:45,640 truncating revision to first 12 chars 2016-04-14 03:39:45,641 Setting DEBUG logging. 2016-04-14 03:39:45,641 attempt 1/10 2016-04-14 03:39:45,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f98aad8ef492?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 03:39:45,898 unpacking tar archive at: fx-team-f98aad8ef492/testing/mozharness/ program finished with exit code 0 elapsedTime=0.503731 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:46.084222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:46.084976) ========= echo f98aad8ef492eb30e2a7e5f38a522b41a6434e8a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f98aad8ef492eb30e2a7e5f38a522b41a6434e8a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 f98aad8ef492eb30e2a7e5f38a522b41a6434e8a program finished with exit code 0 elapsedTime=0.005567 script_repo_revision: 'f98aad8ef492eb30e2a7e5f38a522b41a6434e8a' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:46.134757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:46.135053) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 03:39:46.149316) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-14 03:39:46.149616) ========= /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.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:39:46 INFO - MultiFileLogger online at 20160414 03:39:46 in /builds/slave/test 03:39:46 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 03:39:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:46 INFO - {'append_to_log': False, 03:39:46 INFO - 'base_work_dir': '/builds/slave/test', 03:39:46 INFO - 'blob_upload_branch': 'Fx-Team', 03:39:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:46 INFO - 'branch': 'Fx-Team', 03:39:46 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:46 INFO - 'config_files': ('talos/mac_config.py',), 03:39:46 INFO - 'default_actions': ('clobber', 03:39:46 INFO - 'read-buildbot-config', 03:39:46 INFO - 'download-and-extract', 03:39:46 INFO - 'populate-webroot', 03:39:46 INFO - 'create-virtualenv', 03:39:46 INFO - 'install', 03:39:46 INFO - 'run-tests'), 03:39:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:46 INFO - 'download_minidump_stackwalk': True, 03:39:46 INFO - 'download_symbols': 'ondemand', 03:39:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:46 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:46 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:46 INFO - 'installer_path': 'installer.exe', 03:39:46 INFO - 'log_level': 'info', 03:39:46 INFO - 'log_name': 'talos', 03:39:46 INFO - 'log_to_console': True, 03:39:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:39:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:39:46 INFO - 'opt_config_files': (), 03:39:46 INFO - 'pip_index': False, 03:39:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:39:46 INFO - 'cmd': ('bash', 03:39:46 INFO - '-c', 03:39:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:39:46 INFO - 'enabled': True, 03:39:46 INFO - 'halt_on_failure': False, 03:39:46 INFO - 'name': 'check_screen_resolution'},), 03:39:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:39:46 INFO - 'cmd': ('bash', 03:39:46 INFO - '-c', 03:39:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:39:46 INFO - 'enabled': True, 03:39:46 INFO - 'halt_on_failure': False, 03:39:46 INFO - 'name': 'check_screen_resolution'},), 03:39:46 INFO - 'run_cmd_checks_enabled': True, 03:39:46 INFO - 'sps_profile': False, 03:39:46 INFO - 'sps_profile_interval': 0, 03:39:46 INFO - 'suite': 'dromaeojs', 03:39:46 INFO - 'system_bits': '32', 03:39:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:46 INFO - 'title': 't-yosemite-r7-0066', 03:39:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:46 INFO - 'use_talos_json': True, 03:39:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:46 INFO - 'work_dir': 'build'} 03:39:46 INFO - ##### 03:39:46 INFO - ##### Running clobber step. 03:39:46 INFO - ##### 03:39:46 INFO - Running pre-action listener: _resource_record_pre_action 03:39:46 INFO - Running main action method: clobber 03:39:46 INFO - rmtree: /builds/slave/test/build 03:39:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:48 INFO - Running post-action listener: _resource_record_post_action 03:39:48 INFO - ##### 03:39:48 INFO - ##### Running read-buildbot-config step. 03:39:48 INFO - ##### 03:39:48 INFO - Running pre-action listener: _resource_record_pre_action 03:39:48 INFO - Running main action method: read_buildbot_config 03:39:48 INFO - Using buildbot properties: 03:39:48 INFO - { 03:39:48 INFO - "project": "", 03:39:48 INFO - "product": "firefox", 03:39:48 INFO - "script_repo_revision": "production", 03:39:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:39:48 INFO - "repository": "", 03:39:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:39:48 INFO - "buildid": "20160414023144", 03:39:48 INFO - "pgo_build": "False", 03:39:48 INFO - "basedir": "/builds/slave/test", 03:39:48 INFO - "buildnumber": 622, 03:39:48 INFO - "slavename": "t-yosemite-r7-0066", 03:39:48 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:39:48 INFO - "platform": "yosemite_r7", 03:39:48 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:39:48 INFO - "branch": "fx-team", 03:39:48 INFO - "repo_path": "integration/fx-team", 03:39:48 INFO - "revision": "f98aad8ef492eb30e2a7e5f38a522b41a6434e8a", 03:39:48 INFO - "stage_platform": "macosx64", 03:39:48 INFO - "builduid": "1fb7481869d04398a7f109f3da9feab8", 03:39:48 INFO - "slavebuilddir": "test" 03:39:48 INFO - } 03:39:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:39:48 INFO - Running post-action listener: _resource_record_post_action 03:39:48 INFO - ##### 03:39:48 INFO - ##### Running download-and-extract step. 03:39:48 INFO - ##### 03:39:48 INFO - Running pre-action listener: _resource_record_pre_action 03:39:48 INFO - Running main action method: download_and_extract 03:39:48 INFO - mkdir: /builds/slave/test/build/tests 03:39: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')]} 03:39:48 INFO - https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:39:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:39:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:39:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:39:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:39:50 INFO - Downloaded 1199 bytes. 03:39:50 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:39:50 INFO - Using the following test package requirements: 03:39:50 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:39:50 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:39:50 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:39:50 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:39:50 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:39:50 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:39:50 INFO - u'jsshell-mac.zip'], 03:39:50 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:39:50 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:39:50 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:39:50 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:39:50 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:39:50 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:39:50 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:39:50 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:39:50 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:39:50 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:39:50 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:39:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:39:50 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')]} 03:39:50 INFO - https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:39:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:39:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:39:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:39:52 INFO - Downloaded 18031137 bytes. 03:39:52 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'] 03:39:52 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 03:39:55 INFO - Return code: 0 03:39:55 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 03:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:39:55 INFO - https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:39:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:39:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:39:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:39:56 INFO - Downloaded 18031137 bytes. 03:39:56 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'] 03:39:56 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 03:40:00 INFO - Return code: 0 03:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:00 INFO - https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:40:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:40:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:40:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:40:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:40:01 INFO - Downloaded 10841076 bytes. 03:40:01 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'] 03:40:01 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 03:40:01 INFO - Return code: 0 03:40: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')]} 03:40:01 INFO - https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:40:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:40:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:40:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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 03:40:04 INFO - Downloaded 109336665 bytes. 03:40:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:40:04 INFO - mkdir: /builds/slave/test/properties 03:40:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:04 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:04 INFO - Contents: 03:40:04 INFO - build_url:https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:40:05 INFO - Running post-action listener: _resource_record_post_action 03:40:05 INFO - Running post-action listener: set_extra_try_arguments 03:40:05 INFO - ##### 03:40:05 INFO - ##### Running populate-webroot step. 03:40:05 INFO - ##### 03:40:05 INFO - Running pre-action listener: _resource_record_pre_action 03:40:05 INFO - Running main action method: populate_webroot 03:40:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:05 INFO - '--tppagecycles', 03:40:05 INFO - '7'], 03:40:05 INFO - 'tests': ['tsvgm']}}, 03:40:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:05 INFO - 'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:05 INFO - 'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['damp', 'tps']}, 03:40:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:05 INFO - 'tests': ['damp', 'tps']}, 03:40:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['dromaeo_dom']}, 03:40:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['a11yr', 03:40:05 INFO - 'ts_paint', 03:40:05 INFO - 'tpaint', 03:40:05 INFO - 'sessionrestore', 03:40:05 INFO - 'sessionrestore_no_auto_restore', 03:40:05 INFO - 'tabpaint']}, 03:40:05 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:05 INFO - 'ts_paint', 03:40:05 INFO - 'tpaint', 03:40:05 INFO - 'sessionrestore', 03:40:05 INFO - 'sessionrestore_no_auto_restore', 03:40:05 INFO - 'tabpaint']}, 03:40:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:05 INFO - 'ts_paint', 03:40:05 INFO - 'tpaint', 03:40:05 INFO - 'sessionrestore', 03:40:05 INFO - 'sessionrestore_no_auto_restore', 03:40:05 INFO - 'tabpaint']}, 03:40:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:05 INFO - 'ts_paint', 03:40:05 INFO - 'tpaint', 03:40:05 INFO - 'sessionrestore', 03:40:05 INFO - 'sessionrestore_no_auto_restore', 03:40:05 INFO - 'tabpaint']}, 03:40:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['a11yr', 03:40:05 INFO - 'ts_paint', 03:40:05 INFO - 'tpaint', 03:40:05 INFO - 'sessionrestore', 03:40:05 INFO - 'sessionrestore_no_auto_restore', 03:40:05 INFO - 'tabpaint']}, 03:40:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['a11yr', 03:40:05 INFO - 'ts_paint', 03:40:05 INFO - 'tpaint', 03:40:05 INFO - 'sessionrestore', 03:40:05 INFO - 'sessionrestore_no_auto_restore', 03:40:05 INFO - 'tabpaint']}, 03:40:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['tsvgx', 03:40:05 INFO - 'tsvgr_opacity', 03:40:05 INFO - 'tart', 03:40:05 INFO - 'tscrollx', 03:40:05 INFO - 'cart']}, 03:40:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:05 INFO - 'tsvgr_opacity', 03:40:05 INFO - 'tart', 03:40:05 INFO - 'tscrollx', 03:40:05 INFO - 'cart']}, 03:40:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:05 INFO - 'talos_options': ['--disable-e10s'], 03:40:05 INFO - 'tests': ['tp5o']}, 03:40:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:05 INFO - 'tests': ['tp5o']}, 03:40:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:05 INFO - 'talos_options': ['--disable-e10s', 03:40:05 INFO - '--xperf_path', 03:40:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:05 INFO - 'tests': ['tp5n']}, 03:40:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:05 INFO - 'talos_options': ['--xperf_path', 03:40:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:05 INFO - 'tests': ['tp5n']}}, 03:40:05 INFO - 'talos.zip': {'path': '', 03:40:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:05 INFO - Running post-action listener: _resource_record_post_action 03:40:05 INFO - ##### 03:40:05 INFO - ##### Running create-virtualenv step. 03:40:05 INFO - ##### 03:40:05 INFO - Running pre-action listener: _resource_record_pre_action 03:40:05 INFO - Running main action method: create_virtualenv 03:40:05 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40:05 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 03:40:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:05 INFO - Using real prefix '/tools/python27' 03:40:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:06 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:09 INFO - Installing pip.................done. 03:40:09 INFO - Return code: 0 03:40:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40:09 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')]} 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:09 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')]} 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:09 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 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40:09 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 03:40:09 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 03:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:09 INFO - 'HOME': '/Users/cltbld', 03:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:09 INFO - 'LOGNAME': 'cltbld', 03:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:09 INFO - 'MOZ_NO_REMOTE': '1', 03:40:09 INFO - 'NO_EM_RESTART': '1', 03:40:09 INFO - 'PAGER': '/bin/cat', 03:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:09 INFO - 'PWD': '/builds/slave/test', 03:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:09 INFO - 'SHELL': '/bin/bash', 03:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:09 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:09 INFO - 'USER': 'cltbld', 03:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:09 INFO - 'XPC_FLAGS': '0x0', 03:40:09 INFO - 'XPC_SERVICE_NAME': '0', 03:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:09 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 03:40:09 INFO - Cleaning up... 03:40:09 INFO - Return code: 0 03:40:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:40:09 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')]} 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:09 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')]} 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:09 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 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40:09 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 03:40:09 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 03:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:09 INFO - 'HOME': '/Users/cltbld', 03:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:09 INFO - 'LOGNAME': 'cltbld', 03:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:09 INFO - 'MOZ_NO_REMOTE': '1', 03:40:09 INFO - 'NO_EM_RESTART': '1', 03:40:09 INFO - 'PAGER': '/bin/cat', 03:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:09 INFO - 'PWD': '/builds/slave/test', 03:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:09 INFO - 'SHELL': '/bin/bash', 03:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:09 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:09 INFO - 'USER': 'cltbld', 03:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:09 INFO - 'XPC_FLAGS': '0x0', 03:40:09 INFO - 'XPC_SERVICE_NAME': '0', 03:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:09 INFO - Downloading/unpacking psutil>=0.7.1 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:12 INFO - Installing collected packages: psutil 03:40:12 INFO - Running setup.py install for psutil 03:40:12 INFO - building 'psutil._psutil_osx' extension 03:40:12 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 03:40:13 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 03:40:13 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 03:40:13 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 03:40:13 INFO - building 'psutil._psutil_posix' extension 03:40:13 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 03:40:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:40:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:40:13 INFO - ^ 03:40:13 INFO - 1 warning generated. 03:40:13 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 03:40:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:14 INFO - Successfully installed psutil 03:40:14 INFO - Cleaning up... 03:40:14 INFO - Return code: 0 03:40:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:40:14 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')]} 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:14 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')]} 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:14 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 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40:14 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 03:40:14 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 03:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:14 INFO - 'HOME': '/Users/cltbld', 03:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:14 INFO - 'LOGNAME': 'cltbld', 03:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:14 INFO - 'MOZ_NO_REMOTE': '1', 03:40:14 INFO - 'NO_EM_RESTART': '1', 03:40:14 INFO - 'PAGER': '/bin/cat', 03:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:14 INFO - 'PWD': '/builds/slave/test', 03:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:14 INFO - 'SHELL': '/bin/bash', 03:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:14 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:14 INFO - 'USER': 'cltbld', 03:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:14 INFO - 'XPC_FLAGS': '0x0', 03:40:14 INFO - 'XPC_SERVICE_NAME': '0', 03:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:40:17 INFO - Installing collected packages: mozsystemmonitor 03:40:17 INFO - Running setup.py install for mozsystemmonitor 03:40:17 INFO - Successfully installed mozsystemmonitor 03:40:17 INFO - Cleaning up... 03:40:17 INFO - Return code: 0 03:40:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:40:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:17 INFO - 'HOME': '/Users/cltbld', 03:40:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:17 INFO - 'LOGNAME': 'cltbld', 03:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:17 INFO - 'MOZ_NO_REMOTE': '1', 03:40:17 INFO - 'NO_EM_RESTART': '1', 03:40:17 INFO - 'PAGER': '/bin/cat', 03:40:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:17 INFO - 'PWD': '/builds/slave/test', 03:40:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:17 INFO - 'SHELL': '/bin/bash', 03:40:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:17 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:17 INFO - 'USER': 'cltbld', 03:40:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:17 INFO - 'XPC_FLAGS': '0x0', 03:40:17 INFO - 'XPC_SERVICE_NAME': '0', 03:40:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:18 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:20 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:21 INFO - Downloading docopt-0.6.1.tar.gz 03:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:21 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:21 INFO - Running setup.py install for blobuploader 03:40:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:21 INFO - Running setup.py install for requests 03:40:22 INFO - Running setup.py install for docopt 03:40:22 INFO - Successfully installed blobuploader requests docopt 03:40:22 INFO - Cleaning up... 03:40:22 INFO - Return code: 0 03:40:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:22 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')]} 03:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:22 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')]} 03:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:22 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 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40:22 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 03:40:22 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 03:40:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:22 INFO - 'HOME': '/Users/cltbld', 03:40:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:22 INFO - 'LOGNAME': 'cltbld', 03:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:22 INFO - 'MOZ_NO_REMOTE': '1', 03:40:22 INFO - 'NO_EM_RESTART': '1', 03:40:22 INFO - 'PAGER': '/bin/cat', 03:40:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:22 INFO - 'PWD': '/builds/slave/test', 03:40:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:22 INFO - 'SHELL': '/bin/bash', 03:40:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:22 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:22 INFO - 'USER': 'cltbld', 03:40:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:22 INFO - 'XPC_FLAGS': '0x0', 03:40:22 INFO - 'XPC_SERVICE_NAME': '0', 03:40:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-0V02Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:22 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-myszJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-QPpLrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-bh3NWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-_ho40r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-g3aNyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-hARMIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-pTYHoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-tLnhRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-lMbhwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-orCwv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:23 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-1ij9up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:24 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-QayNKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:24 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-k5QQ6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:24 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-GVHYOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:24 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-VJQBP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:24 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-zMrNRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:24 INFO - Running setup.py install for manifestparser 03:40:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:24 INFO - Running setup.py install for mozcrash 03:40:24 INFO - Running setup.py install for mozdebug 03:40:24 INFO - Running setup.py install for mozdevice 03:40:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:25 INFO - Running setup.py install for mozfile 03:40:25 INFO - Running setup.py install for mozhttpd 03:40:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:25 INFO - Running setup.py install for mozinfo 03:40:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:25 INFO - Running setup.py install for mozInstall 03:40:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:25 INFO - Running setup.py install for mozleak 03:40:25 INFO - Running setup.py install for mozlog 03:40:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:26 INFO - Running setup.py install for moznetwork 03:40:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:26 INFO - Running setup.py install for mozprocess 03:40:26 INFO - Running setup.py install for mozprofile 03:40:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:26 INFO - Running setup.py install for mozrunner 03:40:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:26 INFO - Running setup.py install for mozscreenshot 03:40:26 INFO - Running setup.py install for moztest 03:40:26 INFO - Running setup.py install for mozversion 03:40:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:27 INFO - Cleaning up... 03:40:27 INFO - Return code: 0 03:40:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:27 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 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40:27 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 03:40:27 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 03:40:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:27 INFO - 'HOME': '/Users/cltbld', 03:40:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:27 INFO - 'LOGNAME': 'cltbld', 03:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:27 INFO - 'MOZ_NO_REMOTE': '1', 03:40:27 INFO - 'NO_EM_RESTART': '1', 03:40:27 INFO - 'PAGER': '/bin/cat', 03:40:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:27 INFO - 'PWD': '/builds/slave/test', 03:40:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:27 INFO - 'SHELL': '/bin/bash', 03:40:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:27 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:27 INFO - 'USER': 'cltbld', 03:40:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:27 INFO - 'XPC_FLAGS': '0x0', 03:40:27 INFO - 'XPC_SERVICE_NAME': '0', 03:40:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-MAknWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:27 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)) 03:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-k3jT6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:27 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)) 03:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-POaScM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:27 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)) 03:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ZEgeeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:27 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)) 03:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-dRVaZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:27 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)) 03:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:27 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-rN4z57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-YOkOJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-YE7uZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-OhYjfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-4C1REH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-OQBkTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-BS211R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-r62wcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-jUvMGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Z28xct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:28 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)) 03:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:28 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-dmkP86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:29 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)) 03:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:29 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-pomHzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:29 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)) 03:40:29 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)) 03:40:29 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)) 03:40:29 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)) 03:40:29 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)) 03:40:29 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)) 03:40:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:31 INFO - Downloading blessings-1.6.tar.gz 03:40:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:31 INFO - Installing collected packages: blessings 03:40:31 INFO - Running setup.py install for blessings 03:40:31 INFO - Successfully installed blessings 03:40:31 INFO - Cleaning up... 03:40:31 INFO - Return code: 0 03:40:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:32 INFO - Reading from file tmpfile_stdout 03:40:32 INFO - Current package versions: 03:40:32 INFO - blessings == 1.6 03:40:32 INFO - blobuploader == 1.2.4 03:40:32 INFO - docopt == 0.6.1 03:40:32 INFO - manifestparser == 1.1 03:40:32 INFO - mozInstall == 1.12 03:40:32 INFO - mozcrash == 0.17 03:40:32 INFO - mozdebug == 0.1 03:40:32 INFO - mozdevice == 0.48 03:40:32 INFO - mozfile == 1.2 03:40:32 INFO - mozhttpd == 0.7 03:40:32 INFO - mozinfo == 0.9 03:40:32 INFO - mozleak == 0.1 03:40:32 INFO - mozlog == 3.1 03:40:32 INFO - moznetwork == 0.27 03:40:32 INFO - mozprocess == 0.22 03:40:32 INFO - mozprofile == 0.28 03:40:32 INFO - mozrunner == 6.11 03:40:32 INFO - mozscreenshot == 0.1 03:40:32 INFO - mozsystemmonitor == 0.0 03:40:32 INFO - moztest == 0.7 03:40:32 INFO - mozversion == 1.4 03:40:32 INFO - psutil == 3.1.1 03:40:32 INFO - requests == 1.2.3 03:40:32 INFO - wsgiref == 0.1.2 03:40:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:32 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 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40:32 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 03:40:32 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 03:40:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:32 INFO - 'HOME': '/Users/cltbld', 03:40:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:32 INFO - 'LOGNAME': 'cltbld', 03:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:32 INFO - 'MOZ_NO_REMOTE': '1', 03:40:32 INFO - 'NO_EM_RESTART': '1', 03:40:32 INFO - 'PAGER': '/bin/cat', 03:40:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:32 INFO - 'PWD': '/builds/slave/test', 03:40:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:32 INFO - 'SHELL': '/bin/bash', 03:40:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:32 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:32 INFO - 'USER': 'cltbld', 03:40:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:32 INFO - 'XPC_FLAGS': '0x0', 03:40:32 INFO - 'XPC_SERVICE_NAME': '0', 03:40:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 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)) 03:40:32 INFO - Cleaning up... 03:40:32 INFO - Return code: 0 03:40:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:40:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:32 INFO - 'HOME': '/Users/cltbld', 03:40:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:32 INFO - 'LOGNAME': 'cltbld', 03:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:32 INFO - 'MOZ_NO_REMOTE': '1', 03:40:32 INFO - 'NO_EM_RESTART': '1', 03:40:32 INFO - 'PAGER': '/bin/cat', 03:40:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:32 INFO - 'PWD': '/builds/slave/test', 03:40:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:32 INFO - 'SHELL': '/bin/bash', 03:40:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:32 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:32 INFO - 'USER': 'cltbld', 03:40:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:32 INFO - 'XPC_FLAGS': '0x0', 03:40:32 INFO - 'XPC_SERVICE_NAME': '0', 03:40:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:32 INFO - Downloading/unpacking jsonschema 03:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:35 INFO - Downloading/unpacking functools32 (from jsonschema) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:35 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:35 INFO - warning: no files found matching '*.txt' 03:40:35 INFO - no previously-included directories found matching 'build' 03:40:35 INFO - no previously-included directories found matching 'dist' 03:40:35 INFO - no previously-included directories found matching '.git*' 03:40:35 INFO - Installing collected packages: jsonschema, functools32 03:40:35 INFO - Running setup.py install for functools32 03:40:35 INFO - warning: no files found matching '*.txt' 03:40:35 INFO - no previously-included directories found matching 'build' 03:40:35 INFO - no previously-included directories found matching 'dist' 03:40:35 INFO - no previously-included directories found matching '.git*' 03:40:35 INFO - Successfully installed jsonschema functools32 03:40:35 INFO - Cleaning up... 03:40:35 INFO - Return code: 0 03:40:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b8fea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b90e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab28d96cb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, '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.oHrUngtSke/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.cSetaXPlQp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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 03:40: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', 'flake8'] in /builds/slave/test/build 03:40: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 flake8 03:40:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:40:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:35 INFO - 'HOME': '/Users/cltbld', 03:40:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:35 INFO - 'LOGNAME': 'cltbld', 03:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:35 INFO - 'MOZ_NO_REMOTE': '1', 03:40:35 INFO - 'NO_EM_RESTART': '1', 03:40:35 INFO - 'PAGER': '/bin/cat', 03:40:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:35 INFO - 'PWD': '/builds/slave/test', 03:40:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:35 INFO - 'SHELL': '/bin/bash', 03:40:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:40:35 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:40:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:35 INFO - 'USER': 'cltbld', 03:40:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:35 INFO - 'XPC_FLAGS': '0x0', 03:40:35 INFO - 'XPC_SERVICE_NAME': '0', 03:40:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:36 INFO - Downloading/unpacking flake8 03:40:36 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 03:40:36 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 03:40:36 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 03:40:36 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 03:40:36 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 03:40:36 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 03:40:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:40:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:40:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:40:39 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 03:40:39 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 03:40:39 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 03:40:39 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 03:40:39 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 03:40:39 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 03:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:40:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:39 INFO - no previously-included directories found matching 'docs/_build' 03:40:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:40:39 INFO - Running setup.py install for pep8 03:40:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:40:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:40:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:40:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:40:40 INFO - no previously-included directories found matching 'docs/_build' 03:40:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:40:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:40:40 INFO - Cleaning up... 03:40:40 INFO - Return code: 0 03:40:40 INFO - Running post-action listener: _resource_record_post_action 03:40:40 INFO - Running post-action listener: _start_resource_monitoring 03:40:40 INFO - Starting resource monitoring. 03:40:40 INFO - ##### 03:40:40 INFO - ##### Running install step. 03:40:40 INFO - ##### 03:40:40 INFO - Running pre-action listener: _resource_record_pre_action 03:40:40 INFO - Running main action method: install 03:40:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:40 INFO - Reading from file tmpfile_stdout 03:40:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:40 INFO - Reading from file tmpfile_stdout 03:40:40 INFO - Output received: 03:40:40 INFO - Usage: mozinstall [options] installer 03:40:40 INFO - Options: 03:40:40 INFO - -h, --help show this help message and exit 03:40:40 INFO - -d DEST, --destination=DEST 03:40:40 INFO - Directory to install application into. [default: 03:40:40 INFO - "/builds/slave/test"] 03:40:40 INFO - --app=APP Application being installed. [default: firefox] 03:40:40 INFO - mkdir: /builds/slave/test/build/application 03:40:40 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'] 03:40:40 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 03:41:14 INFO - Reading from file tmpfile_stdout 03:41:14 INFO - Output received: 03:41:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:41:14 INFO - Running post-action listener: _resource_record_post_action 03:41:14 INFO - ##### 03:41:14 INFO - ##### Running run-tests step. 03:41:14 INFO - ##### 03:41:14 INFO - Running pre-action listener: _resource_record_pre_action 03:41:14 INFO - Running main action method: run_tests 03:41:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:41:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:41:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:41:14 INFO - 2016-04-14 03:41:14.173 screenresolution[1646:7693] starting screenresolution argv=screenresolution get 03:41:14 INFO - 2016-04-14 03:41:14.176 screenresolution[1646:7693] Display 0: 1600x1200x32@60 03:41:14 INFO - 2016-04-14 03:41:14.182 screenresolution[1647:7696] starting screenresolution argv=screenresolution list 03:41:14 INFO - Available Modes on Display 0 03:41:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:41:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:41:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:41:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:41:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:41:14 INFO - Intel Iris: 03:41:14 INFO - Chipset Model: Intel Iris 03:41:14 INFO - Type: GPU 03:41:14 INFO - Bus: Built-In 03:41:14 INFO - VRAM (Dynamic, Max): 1536 MB 03:41:14 INFO - Vendor: Intel (0x8086) 03:41:14 INFO - Device ID: 0x0a2e 03:41:14 INFO - Revision ID: 0x0009 03:41:14 INFO - Displays: 03:41:14 INFO - Display: 03:41:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:41:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:41:14 INFO - Display Serial Number: 1600x1200 60 03:41:14 INFO - Main Display: Yes 03:41:14 INFO - Mirror: Off 03:41:14 INFO - Online: Yes 03:41:14 INFO - Rotation: Supported 03:41:14 INFO - Return code: 0 03:41:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:14 INFO - Python 2.7.3 03:41:14 INFO - Return code: 0 03:41:14 INFO - grabbing minidump binary from tooltool 03:41:14 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')]} 03:41:14 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 0x10b79de00>, '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 0x10b5c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b798b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41:14 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 03:41:14 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 03:41:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:14 INFO - Return code: 0 03:41:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:41:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:41:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:41:15 INFO - Return code: 0 03:41:15 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/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 03:41:15 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/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 03:41:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHrUngtSke/Render', 03:41:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:41:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:41:15 INFO - 'HOME': '/Users/cltbld', 03:41:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:41:15 INFO - 'LOGNAME': 'cltbld', 03:41:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:15 INFO - 'MOZ_NO_REMOTE': '1', 03:41:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:15 INFO - 'NO_EM_RESTART': '1', 03:41:15 INFO - 'PAGER': '/bin/cat', 03:41:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:15 INFO - 'PWD': '/builds/slave/test', 03:41:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:41:15 INFO - 'SHELL': '/bin/bash', 03:41:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cSetaXPlQp/Listeners', 03:41:15 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 03:41:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:41:15 INFO - 'USER': 'cltbld', 03:41:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:41:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:15 INFO - 'XPC_FLAGS': '0x0', 03:41:15 INFO - 'XPC_SERVICE_NAME': '0', 03:41:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:41:15 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/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 03:41:15 INFO - mozversion application_buildid: 20160414023144 03:41:15 INFO - mozversion application_changeset: f98aad8ef492eb30e2a7e5f38a522b41a6434e8a 03:41:15 INFO - mozversion application_display_name: Nightly 03:41:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:15 INFO - mozversion application_name: Firefox 03:41:15 INFO - mozversion application_remotingname: firefox 03:41:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:41:15 INFO - mozversion application_vendor: Mozilla 03:41:15 INFO - mozversion application_version: 48.0a1 03:41:15 INFO - mozversion platform_buildid: 20160414023144 03:41:15 INFO - mozversion platform_changeset: f98aad8ef492eb30e2a7e5f38a522b41a6434e8a 03:41:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:41:15 INFO - mozversion platform_version: 48.0a1 03:41:15 INFO - using testdate: 1460630475 03:41:15 INFO - actual date: 1460630475 03:41:15 INFO - starting webserver on 'localhost:49281' 03:41:15 INFO - SUITE-START | Running 2 tests 03:41:15 INFO - TEST-START | dromaeo_css 03:41:15 INFO - operating with platform_type : mac_ 03:41:15 INFO - Initialising browser for dromaeo_css test... 03:41:15 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpdpsqwE/profile http://localhost:49281/getInfo.html) 03:41:18 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 03:41:18 INFO - PROCESS | 1665 | colorDepth:24 03:41:18 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 03:41:18 INFO - PROCESS | 1665 | __metrics 03:41:18 INFO - PROCESS | 1665 | 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" 03:41:18 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:41:18 INFO - TEST-INFO | 1665: exit 0 03:41:18 INFO - Browser initialized. 03:41:18 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:18 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpdpsqwE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:30 INFO - PROCESS | 1667 | RSS: Main: 237199360 03:41:30 INFO - PROCESS | 1667 | 03:42:22 INFO - PROCESS | 1667 | 1460630542395 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] 03:44:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 03:44:34 INFO - PROCESS | 1667 | RSS: Main: 371961856 03:44:34 INFO - PROCESS | 1667 | 03:47:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 03:47:37 INFO - PROCESS | 1667 | RSS: Main: 373882880 03:47:37 INFO - PROCESS | 1667 | 03:50:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 03:50:40 INFO - PROCESS | 1667 | RSS: Main: 376467456 03:50:40 INFO - PROCESS | 1667 | 03:53:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 03:53:43 INFO - PROCESS | 1667 | RSS: Main: 372842496 03:53:43 INFO - PROCESS | 1667 | 03:56:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 03:56:47 INFO - PROCESS | 1667 | RSS: Main: 345329664 03:56:47 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 03:59:50 INFO - PROCESS | 1667 | RSS: Main: 382652416 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | __start_tp_report 03:59:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 03:59:50 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 03:59:50 INFO - PROCESS | 1667 | |i|pagename|runs| 03:59:50 INFO - PROCESS | 1667 | |0;dojo.html;3393.406153923064;3473.6700013498726;3511.8068506232157;3513.1392808761825;3541.8583256669717;4823.78292976816;5679.886402271952;5693.829185124453;5791.276090488689;5813.418658134185;5747.568932330081;5811.302643682753;5815.38938411467;5818.650880947135;5820.912686309709;5200.08998425276;5205.479452054793;5247.632665713401;5261.289725886994;5308.946910530904;5322.04203243416;5327.760250788724;5331.466853314676;5336.332958380202;5359.598030147735;5229.477052294778;5309.097453432925;5319.893602127955;5323.148296272597;5357.8392648220615;5286.841394758163;5312.203169524563;5362.624616276862;5370.597205209586;5375.354957405098;5162.870928226786;5188.429272779991;5206.114960456694;5290.391604965402;5295.68225906443;4693.319468677023;5668;5682.857928551778;5696.202531645531;5739.942600573982;6314.494840412756;6362.809115726535;6363.140975968277;6373.044043393482;6382.712777925005;6169.722362493699;6200.534959878028;6285.528585356116;6325.936740632626;6332.018537126753;5942;5971.28344598651;5975.372585878507;5977.731002104916;5978.730957106897;6358.268799088071;6359.618422894641;6364.013577895434;6372;6372.107904893319;6138.263408391022;6172.197614310111;6270.968645156745;6280.717367718372;6292.370762923762;6285;6294.968525157345;6311.779087731999;6324.2410910691015;6326.2092238470195;6258.530610204253;6332.968335158387;6335.271443784024;6340.397662222082;6342.39747224013;6153.261608606996;6211.875762484816;6307.526935479766;6319.936800631935;6325.462335701517;4951.282064100686;4996.875078123076;5004.724740139327;5007.624428167902;5010.749462526859;4482.036362182146;4485.775711214426;4498.460184777848;4517.1417430688725;4552.658550608651;5724.885502289931;5808.88382232353;5817.981853175677;5827.125931110282;5835.620684655484;5256.6057545684225;6243.282022567463;6251.093591429309;6266.342034086355;6319.05214217871;5853.853653658607;5859.355470898197;5863.70681465925;5864.32560255576;5883.970580147072;5420.593455490854;5433.646812957145;5438.5377242934;5442.91835622466;5458.50873421386;6296.527760417987;6336.4614007808;6372.55392122547;6458;6474.546781725234;6264.655443950626;6266.592671476339;6276.278228003838;6283.088952101828;6289.245290565162;6329.430351268408;6441.871162576816;6458.580192287486;6459.998700201476;6477.4170324671;6106.612350340411;6157.96921015392;6252.312245652884;6277.686115694289;6297.055441683784;6162.537809664203;6207.131001659862;6257.749690012349;6287.151234583455;6296.905546416716;6085.604435711664;6224.844378890382;6246.3753624637175;6251.68741562911;6271.4669253114;6112.989854784024;6224.844378890564;6228.03465462854;6240.7503699851495;6249.906251406142;6018.157457955977;6045.1234570987845;6082.722648076756;6083.939160608337;6102.938970610237;6077.817665470043;6156.076588511759;6197.81406557804;6224.9377506224355;6246.968765156145;5981.970090149522;6036.577439579363;6044.304904935989;6107.328193898578;6110.205673262448 03:59:50 INFO - PROCESS | 1667 | |1;ext.html;531.5322516185759;534.1000414301901;575.2234483447346;589.9351670235229;592.7273454211063;23842.523149537;30178.84910575444;30202;30280.3943921122;30284.39431211377;30687.079387618352;39207.60792392083;40635.79682101593;40662.593374066324;40722.18555628886;9499.43003419797;9743.366681165702;9759.95120024399;9771.804563908752;9797.06927841854;8662.393632445732;9521.952390238039;9657.806843863118;9662.17871480925;9663.371880827759;8719.04090550039;8783.209511143996;8810.559472026405;8814.427062240966;11749.823752643717;11666.591669291576;11756.706082347924;11761.94119029408;11763.529458821637;11765.647030589096;11591.710207244887;11754.294742315404;11754.647360579196;11755.94122029393;11761.059115270758;31542.36915261682;38481.42277865834;40453.393199102036;41072.58927410717;41117.58882411168;3150;3282.917927051819;3364.8508023760032;3632.4006538921312;3816.503854498925;27273.045443409585;27678.584821227698;27946;28028;28425.57361639577;2642.3526236072285;2687.7273406746804;2696.5955106734145;2737.5209338365707;2799.0343331550584;427338;429232;429638;430274;430671;51103.72240693938;58657.70671146617;60343;60344;60542.09186862112;58485.5378615538;58588;58652;58696.706516467144;58723.41276587265;15223.923880380527;15641.452549160726;15903.52289431319;15905.125218112884;15944.681106377808;12403.13178077544;12507.312097834525;12525.248485090742;12737.93631031839;12870.613881583567;13446.663833404047;13709.931450342685;15533.91262611629;15997.760033599272;16148.83851161497;5775.603124703285;6297.2128483939505;7248.383887369527;7271.709131634675;7290.5625662460425;897.9775505612281;903.8418276801533;980.8915925004842;1034.6844212515255;1075.7418219627389;26077.9568817249;26289.73710262911;28575.14274571766;29151;29310.97411590584;1051.9474026298808;1056.7886422715487;1184.934828584419;1208.3173007250875;1218.5734992752643;13821.239831809347;14963.775543366859;15267.770983435257;15531.145786981599;15630.843691563166;573808;577877;585193;588201;588518;59699.70150149308;60431.18706438814;60537.69731151404;60715.39284607097;60732;1324.344449497505;1454.898157129012;1457.7521821290195;1484.7475929092295;1488.2112480385413;23342.883285583463;28391.00631477971;29376.706232938253;29704.70295297106;30240.546391803702;48053.75973120112;48500.5149948496;48538.5146148534;48616.78458038577;48641.51358486511;380607;394962;397894;397948;399246;32580.185495362806;33147.50278745869;33921.66078339185;33956.49065264072;37802.810985945995;41914;41925.16149676928;42366.152676946906;43681.12637747291;43682.563174367846;33277.50083748794;34446.82776586101;35322.11694707653;36245.91262262136;36578.8171059143;34900.47649285314;34991.125221868635;35730;35775;35803.641963581074;35398.938031859085;36137.277254455286;36326.45510317294;36496.45255321226;37321.2535749278;31300.843495783287;32079.67920320767;32220;33181.17047073746;33554.32891342111;23424.53150937006;23706;24096.27711168668;24156.87921560381;24292.39269018218 03:59:50 INFO - PROCESS | 1667 | |2;jquery.html;374.19174582900934;389.3458988898651;393.61643821965794;399.29874399686145;405.43644334375205;13761.089233428665;19829.900850495746;19845.305414310504;20345.898270508646;20494.590108197826;20454.693179602316;20772.89613551934;20820.895895520538;21723.456913577167;21750;5720.599558030929;5903.4686878180955;5970.701464926737;5973.1040343948325;5982.371850955652;5900.321463031742;5916.497097746696;5992.280926288851;6006.879862402771;6510.869782604345;6416.518761092913;6416.743330266784;6439.517036222279;6448.065030570565;6451.967740161293;5512.5589952803675;5889.734961926723;5899.970500147515;5908.586398952054;6448.097266382711;4576.427946506687;5685.971570142165;5700.3159620845345;5915.615484993505;5924.377940316291;13796.655083622889;14090.506832260822;14155.787663184958;16498.6700265994;25866.741332586622;1869.598036422162;2051.1590247998247;2287.611106111965;2415.6376543518436;2439.243834411338;9807.26445516582;10197.388156710622;10285.434301113435;10399.376037437778;13767.692069253404;1517.271709579397;1602.9118398488079;1685.8651307895339;1764.559109736007;1812.5196822841958;118089;124082.13876791856;125374;127694;128695;11617.88382116185;11627.53489860413;11665.941670291595;11691.356975366436;11801.291922484506;13345.399457024458;14082.450930397648;14108.224047677477;15273.465428710164;15301.923490382476;7689;7710.498817576839;8392.748217553482;8594.65621375138;8694.869576956351;8416.873746893802;8441.957790211132;8448.662053517914;8547.82904341922;8551.700690475804;4470.552944705569;4637.5130611286;4644.303354496785;4646.117237724821;4664.137134630104;1698.88107832453;1898.1837809741944;1975.3086419753258;1975.604879024201;2003.4991252186953;856.7986523167051;862.1163307609625;945.3193700535603;987.8093757164256;1044.1751016696876;19846;20240.696389554167;20305.796942030687;20609.48476288105;20645;953.3612479638658;964.8552717092352;982.3418309732497;984.4290311619244;1007.4761124215366;9234.584443700049;10577.197042783668;10836.862129476449;10852.240343175901;10903.400312982862;549366;560059;578179;578281;583406;113166;124867;127008.36495817646;130459;132899.33550332187;998.3959704378891;1032.5921261101823;1041.7083216699336;1065.0787069185253;1067.4342598422847;18036.458906232834;18144.546386340447;18171.909140454212;18181.99999000015;18227.817721822612;38044.61955380411;48993.83147979954;50839;51161;51727.74136129446;69973.65013174902;73108;73576.63211684121;74735.252647475;75753.62123189348;7944.496941363658;8024.638891250024;8125.674973001013;8317.875231871647;8345.248927596545;9069.229115525255;9996.450195239331;10095.44475053879;10594.629187978384;12694.365281736062;10533.578656853946;10809.405482698212;10811.56753729842;10928.125749939827;11031.724206894893;10454.477276136315;10494.422806745702;10722.517486713272;10892.61875834342;11026.614068507564;11254.268472549258;11311.377874216669;11381.374024428405;11720.88279117232;11777.291223018583;7687.11598166218;8143.389245806469;8243.876341854757;8416.4108512406;8491.490510569385;8144.389170812331;10069.647562335284;10880.347179169275;11172.21794474379;11215.831762523732 03:59:50 INFO - PROCESS | 1667 | |3;mootools.html;1399.5451478269565;1566.7493201087825;1648.0688411047756;1862.9441116766493;1977.5563838397977;7889.368850491961;8531;8763;8766.605502752376;8830;7386.667599958001;8364.163583641634;8625.698100566482;8632.482051076924;8635.438696484724;2078.3349328214977;2093.9685904711405;2148.677698345245;2267.841251112423;2347.049444974788;2090.5191805884656;2465.038634932369;2497.67530221071;2499.0378704198924;2499.787518060967;2439.3779586205583;2447.070113356922;2459.717132529764;2465.9506809863883;2467.6545283660303;2151.924682636108;2394.449276666359;2440.2679196241147;2472.431340791628;2473.0478765675166;2452.766987136219;2463.6550882876413;2484.813638977084;2487.912923047703;2492.1651246832334;8531.530765807878;8665.220130188314;8669.69656062041;8679.826403471958;8686.609102590399;5201.713905735183;5374.758135883894;5411.404745477994;5412.052890744104;5442.727863606843;3624.9456258156147;3663.7618554793853;3668.9082772930624;3715.145516531186;3746.4942232798494;1039.1478987230473;1051.910587600055;1055.1980494823913;1069.5561342043043;1070.903618674323;11644.59243926467;11698.707532311675;11704.414779261087;11712.824307635392;11720;4015.457913181683;4731.981805348592;4754.7147171169845;4912.263160525878;4916.360873086476;9782;9841.753956151153;9863.457509836884;9867.470542065992;9889.011098890054;5395.595330350239;5403.0544654686055;5437.021336159451;5437.401885792559;5451.37309209446;4047.777372244496;4401.471823381215;4580.977095114503;4906.852794416173;4910.312556242129;3942.664873485786;3990.7206495545033;4054.1688953764406;4095.488063992001;4110.301248787713;1355.6610847288177;1364.9931750341184;1367.47352269377;1367.541873472378;1384.3908680180689;818.1695578987333;842.797728545157;874.2918236228675;926.5228407370209;984.4585477987079;5110.616703747234;5172.663776854492;5647;5674.914876276859;5978.940210597925;1014.2291858187683;1040.147079394904;1055.440616473255;1061.273027975839;1077.4612693653173;3764.7176461765475;3918.8432462701744;3967.2263908537557;3974.602539746002;4016.6184212499766;9998.900010999796;10476.63331783384;10571.2600117991;10586.735331616617;10591;10390.58437662485;10536.789264214673;10552.894471055344;10565.577376904992;10697.93020697924;7965.322947549407;8091.83816323682;8102.270795628304;8103.918960810434;8229.300509456643;5466.453354664502;5723.084306510938;5824.15549745293;5870.031444811729;5889.705514724333;9847.704568862946;9849.852252216366;9910.15763660097;9979.401235925578;10026.298159128792;9492.857607136037;9549.427034377959;10137.543810528396;10140.391576505433;10284.382937023802;7493.550386976799;7786.454948153575;7960.721374752087;8069.6772129116525;8280.089190188954;8338.874916876373;8355.164483551596;8419.452735572168;8429.241368276884;8437.620307086074;7219.855602887807;7222.602756848424;7322.524035937647;7457.291557302047;7581.810454738455;7243.311885370881;7247.673854676657;7264.055672762507;7315.670794814353;7377.8155546111775;6843.965780171067;6911.9264220732575;6981.3367730065565;6986.196587392515;6986.371226589428;4754.358161648272;4817.445993710628;4891.926621100757;4960.826371076995;5149.56228720548;4199.790010499524;4738.725059668245;4880.438749543848;5040.445550989315;5114.309568208244 03:59:50 INFO - PROCESS | 1667 | |4;prototype.html;315.60234105027666;318.4745170468726;322.9757768167388;328.1042753283536;334.6603197754278;5923.555733320002;5925.407459254073;5949.762009519625;5963.940360596393;5992.4606785389415;5329.653572517784;5884.734377264752;5889.851478961604;5910.615809972349;5930.6738129402975;3358.6473420290886;4009;4095.3413867383756;4220.641245494129;4323.329883868006;4103.753774773523;4431.689781715281;4451.88870278244;4470.441194850644;4520.389747384094;3729.8321575529167;4444.511103778582;4459.799309031086;4460.420145381096;4469.435697505879;3822.311983842907;4159.771212583307;4193.329067349225;4433.645308375354;4507.346434766941;3830.597787232356;3845.1348446599573;3845.346501004567;3845.576986531479;3866.8066596670337;4952.4057113146655;5712.171735098429;5726;5730.512906402961;5744.482996530291;4366.956330436687;4887.560119589254;5203.635745497817;5204.661696989721;5204.9739751301;5124.436312005676;5171.922421163686;5959.582829201958;6121.724522396503;6223.471004964538;3536.3104194682046;4090.529589097262;4326.805293761757;4350.782460876975;4360.520342762294;5742;6123.663198524079;6154.138420621071;6583.341665833378;6595.571287866322;3797.335466293443;4410.80151393188;4413.095315460323;4413.558644135561;4431.955680443154;3765.585785563586;3788.905277368033;4218.388333691598;4435.090806384684;4471;4743.57692692191;5139.201279552127;5166.43169251382;5170.689758614495;5215.348081489814;6117.357677443804;6227.221597300338;6261.7182226799905;6263.655498947602;6301.204156815285;1475.3066058952274;1539.0457916092093;1550.6511035017256;1554.5724925645538;1571.1594297051022;964.5370222293199;989.4508547756064;1014.9441780702132;1036.7356324137297;1037.4657051618422;5261.5264626183825;5808.186853840466;5936.614120082181;5985.191999080069;5985.880282394415;6596.373344532358;6609;6616.801495955033;6624.238212605515;6631;5117.336865518721;5679.602427830012;5914.792982245687;5949.762009519657;6014.271151885771;3404.7446441516986;3455.4775014239744;3469.2020835208045;3476.1309672581856;3495.8288973194267;5684.971575142181;5697.829065128053;6272.3100458949475;6771.72913083481;6885.862282754317;6692.163479565054;6729.8654026919185;6733.865322693617;6756.628385438848;6767.932320676829;6593.40659340652;6816.897746533707;6818.18181818185;6881.965590172117;6894.551854129466;4976.402831660079;6487.513436492376;6491.058796474579;6543.509236807164;6553.901691474536;5381.48875856793;5902.498287645427;6401.679916004275;6405.583637063576;6443.162388889415;6434.742610295536;6505.902411463737;6865.485088618473;6869.725210991504;6922.7923162305215;4179.89232853288;4233.8518151865765;4237.152569486054;4248.532661407305;4261.637760790368;6300.243970723543;6355.3644635536075;6512.274247324557;6551.49315657392;6585.604863708193;6216.409441103088;6242.5942313749465;6261.78083767066;6280.152179455715;6337.556371053982;5950.9404905952115;6239.500839932885;6268.780592679234;6272.153259310117;6276.403741644536;4946.35697359341;5868.853278668067;6006.909896351471;6048.153258543719;6138.907916381168;5286.81496147633;6320.873582528416;6327.810165695037;6330.493560515056;6331.89191891408;5227.607929405233;6168.19813424252;6189.96905015472;6190.288116866438;6193.659348735682 03:59:50 INFO - PROCESS | 1667 | |5;yui.html;667.592768411269;738.5494848142632;759.7758661194947;761.1475147834426;790.3365657733439;14644.414223431064;14939;14945.701085978288;14963.251837408141;14966.25168741564;13654.249016304098;13791.03462757605;13903.930480347584;13907.235102069382;13940.302984850743;906.9863952040724;929.6560272699077;932.9486878221695;937.2314701944374;937.2689302344182;897.8742975983367;909.245326379107;911.8586619074055;913.9862902056475;915.3866909170838;972.5283237629744;977.0571398600349;977.1742877268697;977.218225419665;979.5249304087512;932.2169377722712;939.9342046056813;966.3139171188465;968.1093394077395;970.1656575345268;722.3643193989255;724.5073350121914;724.8767709489399;724.916634587024;726.8982342472058;13848.961327900348;13878.375473103735;13912.58262252134;13918.234497102756;13924.443022279096;10599.258051936291;10646.414447205401;10766.892331076746;10886.0746836519;10909.1818113641;9336.253099752072;9468.100530449665;9561.808763824685;9587.856182157273;9853.605855765762;3389.694927456516;3429.228423604694;3474.7567670263093;3485.337785820686;3540.929181416383;64498;76787.61606191934;77566.61216693936;77573.61213193898;78454.21545784526;8931.151540603632;9154.176124148726;9676.516174191262;9730.513474326397;10476.895231047592;21950.45123871916;22240.666390004164;22293.7738424385;22312.665310020362;22318;7563.168051514329;7644.0827100748265;7706.845863082707;7772;7979.960100199578;4014.979925100356;4051.372037334218;4103.85636502721;4118.19695159447;4359.019220675386;3471.5139880416764;3583.6416358363954;3592.515010473605;3864.188520410689;4019.7789121598007;694.6908625661532;700.6146619359332;701.0920857489564;703.5532436902502;706.523096909584;530.3794560364383;546.893355795624;559.932808063035;574.9770009199668;605.276694350256;7896.447248692652;7920.6039698014865;7931.56376399292;8011.399145064143;8117.634706438224;544.5153813106339;574.7413663851283;603.5322624965687;611.455804334143;613.5643692978035;3698.1679122197293;3805.9809700951873;3876.4185372194397;3945.349017412152;4014.8897887969893;80827.7875831863;81632.18367816365;83512;83533;83591.5820420894;61584.69207653933;75252;76657.61671191608;76780.23219767731;78460.82308765373;66151;66162.66918665376;66252.00621990675;66982.66508667426;67367.6526469468;8252.092269850431;8293.445053687354;8349.206825351583;8438.324934005142;8507.8723819144;40548.59451405448;40849.38725919173;42155.789221053696;42835.357469638606;42960;56522;56666.433335666115;57185.42814571801;57244.71377643085;60235.69882150561;10845.078168355778;11083.667489975314;11301.15241356885;11326.490307936327;11348;11810.468528916048;11963.461644225858;12168.1098288504;12541;13004.739905202032;11276.830847537129;11493.482793274155;11757.529698812294;11803.996660283972;11865.703357415789;11213.327200368005;11226.943865280622;11390.772184556428;11405.771884562428;11689.123315751523;11464.025557827345;11656.766864662828;11749.29504229749;11758.470868810753;11861.347625880659;9575.616975320909;9726.203913655978;9999.550020249251;10050.447225402673;10547;9689.467079310705;9772.85340719904;9893.554790034323;9913.851292230478;9989 03:59:50 INFO - PROCESS | 1667 | __end_tp_report 03:59:50 INFO - PROCESS | 1667 | __start_cc_report 03:59:50 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1263 03:59:50 INFO - PROCESS | 1667 | __end_cc_report 03:59:50 INFO - PROCESS | 1667 | __startTimestamp1460631590354__endTimestamp 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | ------- Summary: start ------- 03:59:50 INFO - PROCESS | 1667 | Number of tests: 6 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5813.61 Median:6082.72 stddev:644.44 (10.6%) stddev-sans-first:617.82 03:59:50 INFO - PROCESS | 1667 | Values: 3393.4 3473.7 3511.8 3513.1 3541.9 4823.8 5679.9 5693.8 5791.3 5813.4 5747.6 5811.3 5815.4 5818.7 5820.9 5200.1 5205.5 5247.6 5261.3 5308.9 5322.0 5327.8 5331.5 5336.3 5359.6 5229.5 5309.1 5319.9 5323.1 5357.8 5286.8 5312.2 5362.6 5370.6 5375.4 5162.9 5188.4 5206.1 5290.4 5295.7 4693.3 5668.0 5682.9 5696.2 5739.9 6314.5 6362.8 6363.1 6373.0 6382.7 6169.7 6200.5 6285.5 6325.9 6332.0 5942.0 5971.3 5975.4 5977.7 5978.7 6358.3 6359.6 6364.0 6372.0 6372.1 6138.3 6172.2 6271.0 6280.7 6292.4 6285.0 6295.0 6311.8 6324.2 6326.2 6258.5 6333.0 6335.3 6340.4 6342.4 6153.3 6211.9 6307.5 6319.9 6325.5 4951.3 4996.9 5004.7 5007.6 5010.7 4482.0 4485.8 4498.5 4517.1 4552.7 5724.9 5808.9 5818.0 5827.1 5835.6 5256.6 6243.3 6251.1 6266.3 6319.1 5853.9 5859.4 5863.7 5864.3 5884.0 5420.6 5433.6 5438.5 5442.9 5458.5 6296.5 6336.5 6372.6 6458.0 6474.5 6264.7 6266.6 6276.3 6283.1 6289.2 6329.4 6441.9 6458.6 6460.0 6477.4 6106.6 6158.0 6252.3 6277.7 6297.1 6162.5 6207.1 6257.7 6287.2 6296.9 6085.6 6224.8 6246.4 6251.7 6271.5 6113.0 6224.8 6228.0 6240.8 6249.9 6018.2 6045.1 6082.7 6083.9 6102.9 6077.8 6156.1 6197.8 6224.9 6247.0 5982.0 6036.6 6044.3 6107.3 6110.2 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:60821.88 Median:35156.62 stddev:126752.80 (360.5%) stddev-sans-first:127027.54 03:59:50 INFO - PROCESS | 1667 | Values: 531.5 534.1 575.2 589.9 592.7 23842.5 30178.8 30202.0 30280.4 30284.4 30687.1 39207.6 40635.8 40662.6 40722.2 9499.4 9743.4 9760.0 9771.8 9797.1 8662.4 9522.0 9657.8 9662.2 9663.4 8719.0 8783.2 8810.6 8814.4 11749.8 11666.6 11756.7 11761.9 11763.5 11765.6 11591.7 11754.3 11754.6 11755.9 11761.1 31542.4 38481.4 40453.4 41072.6 41117.6 3150.0 3282.9 3364.9 3632.4 3816.5 27273.0 27678.6 27946.0 28028.0 28425.6 2642.4 2687.7 2696.6 2737.5 2799.0 427338.0 429232.0 429638.0 430274.0 430671.0 51103.7 58657.7 60343.0 60344.0 60542.1 58485.5 58588.0 58652.0 58696.7 58723.4 15223.9 15641.5 15903.5 15905.1 15944.7 12403.1 12507.3 12525.2 12737.9 12870.6 13446.7 13709.9 15533.9 15997.8 16148.8 5775.6 6297.2 7248.4 7271.7 7290.6 898.0 903.8 980.9 1034.7 1075.7 26078.0 26289.7 28575.1 29151.0 29311.0 1051.9 1056.8 1184.9 1208.3 1218.6 13821.2 14963.8 15267.8 15531.1 15630.8 573808.0 577877.0 585193.0 588201.0 588518.0 59699.7 60431.2 60537.7 60715.4 60732.0 1324.3 1454.9 1457.8 1484.7 1488.2 23342.9 28391.0 29376.7 29704.7 30240.5 48053.8 48500.5 48538.5 48616.8 48641.5 380607.0 394962.0 397894.0 397948.0 399246.0 32580.2 33147.5 33921.7 33956.5 37802.8 41914.0 41925.2 42366.2 43681.1 43682.6 33277.5 34446.8 35322.1 36245.9 36578.8 34900.5 34991.1 35730.0 35775.0 35803.6 35398.9 36137.3 36326.5 36496.5 37321.3 31300.8 32079.7 32220.0 33181.2 33554.3 23424.5 23706.0 24096.3 24156.9 24292.4 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:33756.51 Median:21736.73 stddev:95507.68 (439.4%) stddev-sans-first:95742.72 03:59:50 INFO - PROCESS | 1667 | Values: 374.2 389.3 393.6 399.3 405.4 13761.1 19829.9 19845.3 20345.9 20494.6 20454.7 20772.9 20820.9 21723.5 21750.0 5720.6 5903.5 5970.7 5973.1 5982.4 5900.3 5916.5 5992.3 6006.9 6510.9 6416.5 6416.7 6439.5 6448.1 6452.0 5512.6 5889.7 5900.0 5908.6 6448.1 4576.4 5686.0 5700.3 5915.6 5924.4 13796.7 14090.5 14155.8 16498.7 25866.7 1869.6 2051.2 2287.6 2415.6 2439.2 9807.3 10197.4 10285.4 10399.4 13767.7 1517.3 1602.9 1685.9 1764.6 1812.5 118089.0 124082.1 125374.0 127694.0 128695.0 11617.9 11627.5 11665.9 11691.4 11801.3 13345.4 14082.5 14108.2 15273.5 15301.9 7689.0 7710.5 8392.7 8594.7 8694.9 8416.9 8442.0 8448.7 8547.8 8551.7 4470.6 4637.5 4644.3 4646.1 4664.1 1698.9 1898.2 1975.3 1975.6 2003.5 856.8 862.1 945.3 987.8 1044.2 19846.0 20240.7 20305.8 20609.5 20645.0 953.4 964.9 982.3 984.4 1007.5 9234.6 10577.2 10836.9 10852.2 10903.4 549366.0 560059.0 578179.0 578281.0 583406.0 113166.0 124867.0 127008.4 130459.0 132899.3 998.4 1032.6 1041.7 1065.1 1067.4 18036.5 18144.5 18171.9 18182.0 18227.8 38044.6 48993.8 50839.0 51161.0 51727.7 69973.7 73108.0 73576.6 74735.3 75753.6 7944.5 8024.6 8125.7 8317.9 8345.2 9069.2 9996.5 10095.4 10594.6 12694.4 10533.6 10809.4 10811.6 10928.1 11031.7 10454.5 10494.4 10722.5 10892.6 11026.6 11254.3 11311.4 11381.4 11720.9 11777.3 7687.1 8143.4 8243.9 8416.4 8491.5 8144.4 10069.6 10880.3 11172.2 11215.8 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5681.98 Median:4908.58 stddev:3147.96 (64.1%) stddev-sans-first:3140.34 03:59:50 INFO - PROCESS | 1667 | Values: 1399.5 1566.7 1648.1 1862.9 1977.6 7889.4 8531.0 8763.0 8766.6 8830.0 7386.7 8364.2 8625.7 8632.5 8635.4 2078.3 2094.0 2148.7 2267.8 2347.0 2090.5 2465.0 2497.7 2499.0 2499.8 2439.4 2447.1 2459.7 2466.0 2467.7 2151.9 2394.4 2440.3 2472.4 2473.0 2452.8 2463.7 2484.8 2487.9 2492.2 8531.5 8665.2 8669.7 8679.8 8686.6 5201.7 5374.8 5411.4 5412.1 5442.7 3624.9 3663.8 3668.9 3715.1 3746.5 1039.1 1051.9 1055.2 1069.6 1070.9 11644.6 11698.7 11704.4 11712.8 11720.0 4015.5 4732.0 4754.7 4912.3 4916.4 9782.0 9841.8 9863.5 9867.5 9889.0 5395.6 5403.1 5437.0 5437.4 5451.4 4047.8 4401.5 4581.0 4906.9 4910.3 3942.7 3990.7 4054.2 4095.5 4110.3 1355.7 1365.0 1367.5 1367.5 1384.4 818.2 842.8 874.3 926.5 984.5 5110.6 5172.7 5647.0 5674.9 5978.9 1014.2 1040.1 1055.4 1061.3 1077.5 3764.7 3918.8 3967.2 3974.6 4016.6 9998.9 10476.6 10571.3 10586.7 10591.0 10390.6 10536.8 10552.9 10565.6 10697.9 7965.3 8091.8 8102.3 8103.9 8229.3 5466.5 5723.1 5824.2 5870.0 5889.7 9847.7 9849.9 9910.2 9979.4 10026.3 9492.9 9549.4 10137.5 10140.4 10284.4 7493.6 7786.5 7960.7 8069.7 8280.1 8338.9 8355.2 8419.5 8429.2 8437.6 7219.9 7222.6 7322.5 7457.3 7581.8 7243.3 7247.7 7264.1 7315.7 7377.8 6844.0 6911.9 6981.3 6986.2 6986.4 4754.4 4817.4 4891.9 4960.8 5149.6 4199.8 4738.7 4880.4 5040.4 5114.3 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5091.71 Median:5743.24 stddev:1600.88 (27.9%) stddev-sans-first:1564.72 03:59:50 INFO - PROCESS | 1667 | Values: 315.6 318.5 323.0 328.1 334.7 5923.6 5925.4 5949.8 5963.9 5992.5 5329.7 5884.7 5889.9 5910.6 5930.7 3358.6 4009.0 4095.3 4220.6 4323.3 4103.8 4431.7 4451.9 4470.4 4520.4 3729.8 4444.5 4459.8 4460.4 4469.4 3822.3 4159.8 4193.3 4433.6 4507.3 3830.6 3845.1 3845.3 3845.6 3866.8 4952.4 5712.2 5726.0 5730.5 5744.5 4367.0 4887.6 5203.6 5204.7 5205.0 5124.4 5171.9 5959.6 6121.7 6223.5 3536.3 4090.5 4326.8 4350.8 4360.5 5742.0 6123.7 6154.1 6583.3 6595.6 3797.3 4410.8 4413.1 4413.6 4432.0 3765.6 3788.9 4218.4 4435.1 4471.0 4743.6 5139.2 5166.4 5170.7 5215.3 6117.4 6227.2 6261.7 6263.7 6301.2 1475.3 1539.0 1550.7 1554.6 1571.2 964.5 989.5 1014.9 1036.7 1037.5 5261.5 5808.2 5936.6 5985.2 5985.9 6596.4 6609.0 6616.8 6624.2 6631.0 5117.3 5679.6 5914.8 5949.8 6014.3 3404.7 3455.5 3469.2 3476.1 3495.8 5685.0 5697.8 6272.3 6771.7 6885.9 6692.2 6729.9 6733.9 6756.6 6767.9 6593.4 6816.9 6818.2 6882.0 6894.6 4976.4 6487.5 6491.1 6543.5 6553.9 5381.5 5902.5 6401.7 6405.6 6443.2 6434.7 6505.9 6865.5 6869.7 6922.8 4179.9 4233.9 4237.2 4248.5 4261.6 6300.2 6355.4 6512.3 6551.5 6585.6 6216.4 6242.6 6261.8 6280.2 6337.6 5950.9 6239.5 6268.8 6272.2 6276.4 4946.4 5868.9 6006.9 6048.2 6138.9 5286.8 6320.9 6327.8 6330.5 6331.9 5227.6 6168.2 6190.0 6190.3 6193.7 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17125.13 Median:608.37 stddev:23297.66 (3829.5%) stddev-sans-first:23330.25 03:59:50 INFO - PROCESS | 1667 | Values: 667.6 738.5 759.8 761.1 790.3 14644.4 14939.0 14945.7 14963.3 14966.3 13654.2 13791.0 13903.9 13907.2 13940.3 907.0 929.7 932.9 937.2 937.3 897.9 909.2 911.9 914.0 915.4 972.5 977.1 977.2 977.2 979.5 932.2 939.9 966.3 968.1 970.2 722.4 724.5 724.9 724.9 726.9 13849.0 13878.4 13912.6 13918.2 13924.4 10599.3 10646.4 10766.9 10886.1 10909.2 9336.3 9468.1 9561.8 9587.9 9853.6 3389.7 3429.2 3474.8 3485.3 3540.9 64498.0 76787.6 77566.6 77573.6 78454.2 8931.2 9154.2 9676.5 9730.5 10476.9 21950.5 22240.7 22293.8 22312.7 22318.0 7563.2 7644.1 7706.8 7772.0 7980.0 4015.0 4051.4 4103.9 4118.2 4359.0 3471.5 3583.6 3592.5 3864.2 4019.8 694.7 700.6 701.1 703.6 706.5 530.4 546.9 559.9 575.0 605.3 7896.4 7920.6 7931.6 8011.4 8117.6 544.5 574.7 603.5 611.5 613.6 3698.2 3806.0 3876.4 3945.3 4014.9 80827.8 81632.2 83512.0 83533.0 83591.6 61584.7 75252.0 76657.6 76780.2 78460.8 66151.0 66162.7 66252.0 66982.7 67367.7 8252.1 8293.4 8349.2 8438.3 8507.9 40548.6 40849.4 42155.8 42835.4 42960.0 56522.0 56666.4 57185.4 57244.7 60235.7 10845.1 11083.7 11301.2 11326.5 11348.0 11810.5 11963.5 12168.1 12541.0 13004.7 11276.8 11493.5 11757.5 11804.0 11865.7 11213.3 11226.9 11390.8 11405.8 11689.1 11464.0 11656.8 11749.3 11758.5 11861.3 9575.6 9726.2 9999.6 10050.4 10547.0 9689.5 9772.9 9893.6 9913.9 9989.0 03:59:50 INFO - PROCESS | 1667 | -------- Summary: end -------- 03:59:50 INFO - PROCESS | 1667 | 03:59:50 INFO - TEST-INFO | 1667: exit 0 03:59:50 INFO - TEST-OK | dromaeo_css | took 1114953ms 03:59:50 INFO - TEST-START | kraken 03:59:50 INFO - operating with platform_type : mac_ 03:59:50 INFO - Initialising browser for kraken test... 03:59:50 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmp5O9N2k/profile http://localhost:49281/getInfo.html) 03:59:52 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 03:59:52 INFO - PROCESS | 1677 | colorDepth:24 03:59:52 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 03:59:52 INFO - PROCESS | 1677 | __metrics 03:59:53 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" 03:59:53 ERROR - PROCESS | 1677 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:59:53 INFO - TEST-INFO | 1677: exit 0 03:59:53 INFO - Browser initialized. 03:59:53 INFO - Running cycle 1/1 for kraken test... 03:59:53 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmp5O9N2k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:05 INFO - PROCESS | 1679 | RSS: Main: 237318144 04:00:05 INFO - PROCESS | 1679 | 04:00:08 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:09 INFO - PROCESS | 1679 | RSS: Main: 285585408 04:00:09 INFO - PROCESS | 1679 | 04:00:11 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 04:00:12 INFO - PROCESS | 1679 | RSS: Main: 299438080 04:00:12 INFO - PROCESS | 1679 | 04:00:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 04:00:16 INFO - PROCESS | 1679 | RSS: Main: 384110592 04:00:16 INFO - PROCESS | 1679 | 04:00:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 04:00:19 INFO - PROCESS | 1679 | RSS: Main: 287391744 04:00:19 INFO - PROCESS | 1679 | 04:00:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:21 INFO - PROCESS | 1679 | RSS: Main: 291774464 04:00:21 INFO - PROCESS | 1679 | 04:00:24 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:25 INFO - PROCESS | 1679 | RSS: Main: 330694656 04:00:25 INFO - PROCESS | 1679 | 04:00:28 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:28 INFO - PROCESS | 1679 | RSS: Main: 331055104 04:00:28 INFO - PROCESS | 1679 | 04:00:31 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 04:00:32 INFO - PROCESS | 1679 | RSS: Main: 328495104 04:00:32 INFO - PROCESS | 1679 | 04:00:33 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:34 INFO - PROCESS | 1679 | RSS: Main: 319860736 04:00:34 INFO - PROCESS | 1679 | 04:00:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:36 INFO - PROCESS | 1679 | RSS: Main: 327196672 04:00:36 INFO - PROCESS | 1679 | 04:00:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:39 INFO - PROCESS | 1679 | RSS: Main: 329498624 04:00:39 INFO - PROCESS | 1679 | 04:00:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:43 INFO - PROCESS | 1679 | RSS: Main: 334123008 04:00:43 INFO - PROCESS | 1679 | 04:00:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:47 INFO - PROCESS | 1679 | RSS: Main: 331898880 04:00:47 INFO - PROCESS | 1679 | 04:00:48 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 04:00:49 INFO - PROCESS | 1679 | RSS: Main: 395657216 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | __start_tp_report 04:00:49 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 04:00:49 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 04:00:49 INFO - PROCESS | 1679 | |i|pagename|runs| 04:00:49 INFO - PROCESS | 1679 | |0;ai-astar;111;109;112;112;111;112;118;111;112;111 04:00:49 INFO - PROCESS | 1679 | |1;audio-beat-detection;157;119;143;168;119;144;144;120;165;120 04:00:49 INFO - PROCESS | 1679 | |2;audio-dft;184;186;186;184;185;183;185;184;227;227 04:00:49 INFO - PROCESS | 1679 | |3;audio-fft;71;74;86;90;55;63;58;78;93;78 04:00:49 INFO - PROCESS | 1679 | |4;audio-oscillator;88;98;131;78;76;77;123;79;75;118 04:00:49 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;118;129;104;87;90;86;89;87;89;85 04:00:49 INFO - PROCESS | 1679 | |6;imaging-darkroom;93;94;94;94;93;93;93;94;93;97 04:00:49 INFO - PROCESS | 1679 | |7;imaging-desaturate;86;86;87;84;104;142;146;85;86;87 04:00:49 INFO - PROCESS | 1679 | |8;json-parse-financial;57;58;57;58;57;58;59;73;60;56 04:00:49 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;65;65;73;80;75;71;68;68;65;71 04:00:49 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;86;86;82;92;85;109;111;82;86;85 04:00:49 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;143;142;144;143;141;141;143;145;179;145 04:00:49 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;169;163;219;217;175;170;167;175;210;157 04:00:49 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;67;68;70;68;71;69;68;72;68;68 04:00:49 INFO - PROCESS | 1679 | __end_tp_report 04:00:49 INFO - PROCESS | 1679 | __start_cc_report 04:00:49 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,1915 04:00:49 INFO - PROCESS | 1679 | __end_cc_report 04:00:49 INFO - PROCESS | 1679 | __startTimestamp1460631649047__endTimestamp 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | ------- Summary: start ------- 04:00:49 INFO - PROCESS | 1679 | Number of tests: 14 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:2.33 (2.1%) stddev-sans-first:2.45 04:00:49 INFO - PROCESS | 1679 | Values: 111.0 109.0 112.0 112.0 111.0 112.0 118.0 111.0 112.0 111.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:144.00 stddev:19.50 (13.5%) stddev-sans-first:19.67 04:00:49 INFO - PROCESS | 1679 | Values: 157.0 119.0 143.0 168.0 119.0 144.0 144.0 120.0 165.0 120.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:193.10 Median:185.50 stddev:17.89 (9.6%) stddev-sans-first:18.67 04:00:49 INFO - PROCESS | 1679 | Values: 184.0 186.0 186.0 184.0 185.0 183.0 185.0 184.0 227.0 227.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:74.60 Median:78.00 stddev:13.07 (16.8%) stddev-sans-first:13.79 04:00:49 INFO - PROCESS | 1679 | Values: 71.0 74.0 86.0 90.0 55.0 63.0 58.0 78.0 93.0 78.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:77.50 stddev:21.84 (28.2%) stddev-sans-first:23.04 04:00:49 INFO - PROCESS | 1679 | Values: 88.0 98.0 131.0 78.0 76.0 77.0 123.0 79.0 75.0 118.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:87.00 stddev:15.46 (17.8%) stddev-sans-first:14.29 04:00:49 INFO - PROCESS | 1679 | Values: 118.0 129.0 104.0 87.0 90.0 86.0 89.0 87.0 89.0 85.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:1.23 (1.3%) stddev-sans-first:1.27 04:00:49 INFO - PROCESS | 1679 | Values: 93.0 94.0 94.0 94.0 93.0 93.0 93.0 94.0 93.0 97.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:99.30 Median:86.00 stddev:24.26 (28.2%) stddev-sans-first:25.25 04:00:49 INFO - PROCESS | 1679 | Values: 86.0 86.0 87.0 84.0 104.0 142.0 146.0 85.0 86.0 87.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:58.00 stddev:4.95 (8.5%) stddev-sans-first:5.17 04:00:49 INFO - PROCESS | 1679 | Values: 57.0 58.0 57.0 58.0 57.0 58.0 59.0 73.0 60.0 56.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:4.93 (6.9%) stddev-sans-first:4.87 04:00:49 INFO - PROCESS | 1679 | Values: 65.0 65.0 73.0 80.0 75.0 71.0 68.0 68.0 65.0 71.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:90.40 Median:85.50 stddev:10.70 (12.5%) stddev-sans-first:11.23 04:00:49 INFO - PROCESS | 1679 | Values: 86.0 86.0 82.0 92.0 85.0 109.0 111.0 82.0 86.0 85.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:143.50 stddev:11.47 (8.0%) stddev-sans-first:12.09 04:00:49 INFO - PROCESS | 1679 | Values: 143.0 142.0 144.0 143.0 141.0 141.0 143.0 145.0 179.0 145.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:175.00 stddev:23.57 (13.5%) stddev-sans-first:24.51 04:00:49 INFO - PROCESS | 1679 | Values: 169.0 163.0 219.0 217.0 175.0 170.0 167.0 175.0 210.0 157.0 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:1.60 (2.3%) stddev-sans-first:1.54 04:00:49 INFO - PROCESS | 1679 | Values: 67.0 68.0 70.0 68.0 71.0 69.0 68.0 72.0 68.0 68.0 04:00:49 INFO - PROCESS | 1679 | -------- Summary: end -------- 04:00:49 INFO - PROCESS | 1679 | 04:00:49 INFO - TEST-INFO | 1679: exit 0 04:00:49 INFO - TEST-OK | kraken | took 58929ms 04:00:49 INFO - SUITE-END | took 1173s 04:00:50 INFO - Completed test suite (00:19:34) 04:00:50 INFO - javascript benchmark 04:00:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3393.406153923064, 3473.6700013498726, 3511.8068506232157, 3513.1392808761825, 3541.8583256669717, 4823.78292976816, 5679.886402271952, 5693.829185124453, 5791.276090488689, 5813.418658134185, 5747.568932330081, 5811.302643682753, 5815.38938411467, 5818.650880947135, 5820.912686309709, 5200.08998425276, 5205.479452054793, 5247.632665713401, 5261.289725886994, 5308.946910530904, 5322.04203243416, 5327.760250788724, 5331.466853314676, 5336.332958380202, 5359.598030147735, 5229.477052294778, 5309.097453432925, 5319.893602127955, 5323.148296272597, 5357.8392648220615, 5286.841394758163, 5312.203169524563, 5362.624616276862, 5370.597205209586, 5375.354957405098, 5162.870928226786, 5188.429272779991, 5206.114960456694, 5290.391604965402, 5295.68225906443, 4693.319468677023, 5668.0, 5682.857928551778, 5696.202531645531, 5739.942600573982, 6314.494840412756, 6362.809115726535, 6363.140975968277, 6373.044043393482, 6382.712777925005, 6169.722362493699, 6200.534959878028, 6285.528585356116, 6325.936740632626, 6332.018537126753, 5942.0, 5971.28344598651, 5975.372585878507, 5977.731002104916, 5978.730957106897, 6358.268799088071, 6359.618422894641, 6364.013577895434, 6372.0, 6372.107904893319, 6138.263408391022, 6172.197614310111, 6270.968645156745, 6280.717367718372, 6292.370762923762, 6285.0, 6294.968525157345, 6311.779087731999, 6324.2410910691015, 6326.2092238470195, 6258.530610204253, 6332.968335158387, 6335.271443784024, 6340.397662222082, 6342.39747224013, 6153.261608606996, 6211.875762484816, 6307.526935479766, 6319.936800631935, 6325.462335701517, 4951.282064100686, 4996.875078123076, 5004.724740139327, 5007.624428167902, 5010.749462526859, 4482.036362182146, 4485.775711214426, 4498.460184777848, 4517.1417430688725, 4552.658550608651, 5724.885502289931, 5808.88382232353, 5817.981853175677, 5827.125931110282, 5835.620684655484, 5256.6057545684225, 6243.282022567463, 6251.093591429309, 6266.342034086355, 6319.05214217871, 5853.853653658607, 5859.355470898197, 5863.70681465925, 5864.32560255576, 5883.970580147072, 5420.593455490854, 5433.646812957145, 5438.5377242934, 5442.91835622466, 5458.50873421386, 6296.527760417987, 6336.4614007808, 6372.55392122547, 6458.0, 6474.546781725234, 6264.655443950626, 6266.592671476339, 6276.278228003838, 6283.088952101828, 6289.245290565162, 6329.430351268408, 6441.871162576816, 6458.580192287486, 6459.998700201476, 6477.4170324671, 6106.612350340411, 6157.96921015392, 6252.312245652884, 6277.686115694289, 6297.055441683784, 6162.537809664203, 6207.131001659862, 6257.749690012349, 6287.151234583455, 6296.905546416716, 6085.604435711664, 6224.844378890382, 6246.3753624637175, 6251.68741562911, 6271.4669253114, 6112.989854784024, 6224.844378890564, 6228.03465462854, 6240.7503699851495, 6249.906251406142, 6018.157457955977, 6045.1234570987845, 6082.722648076756, 6083.939160608337, 6102.938970610237, 6077.817665470043, 6156.076588511759, 6197.81406557804, 6224.9377506224355, 6246.968765156145, 5981.970090149522, 6036.577439579363, 6044.304904935989, 6107.328193898578, 6110.205673262448], "value": 5773.417812994745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.5322516185759, 534.1000414301901, 575.2234483447346, 589.9351670235229, 592.7273454211063, 23842.523149537, 30178.84910575444, 30202.0, 30280.3943921122, 30284.39431211377, 30687.079387618352, 39207.60792392083, 40635.79682101593, 40662.593374066324, 40722.18555628886, 9499.43003419797, 9743.366681165702, 9759.95120024399, 9771.804563908752, 9797.06927841854, 8662.393632445732, 9521.952390238039, 9657.806843863118, 9662.17871480925, 9663.371880827759, 8719.04090550039, 8783.209511143996, 8810.559472026405, 8814.427062240966, 11749.823752643717, 11666.591669291576, 11756.706082347924, 11761.94119029408, 11763.529458821637, 11765.647030589096, 11591.710207244887, 11754.294742315404, 11754.647360579196, 11755.94122029393, 11761.059115270758, 31542.36915261682, 38481.42277865834, 40453.393199102036, 41072.58927410717, 41117.58882411168, 3150.0, 3282.917927051819, 3364.8508023760032, 3632.4006538921312, 3816.503854498925, 27273.045443409585, 27678.584821227698, 27946.0, 28028.0, 28425.57361639577, 2642.3526236072285, 2687.7273406746804, 2696.5955106734145, 2737.5209338365707, 2799.0343331550584, 427338.0, 429232.0, 429638.0, 430274.0, 430671.0, 51103.72240693938, 58657.70671146617, 60343.0, 60344.0, 60542.09186862112, 58485.5378615538, 58588.0, 58652.0, 58696.706516467144, 58723.41276587265, 15223.923880380527, 15641.452549160726, 15903.52289431319, 15905.125218112884, 15944.681106377808, 12403.13178077544, 12507.312097834525, 12525.248485090742, 12737.93631031839, 12870.613881583567, 13446.663833404047, 13709.931450342685, 15533.91262611629, 15997.760033599272, 16148.83851161497, 5775.603124703285, 6297.2128483939505, 7248.383887369527, 7271.709131634675, 7290.5625662460425, 897.9775505612281, 903.8418276801533, 980.8915925004842, 1034.6844212515255, 1075.7418219627389, 26077.9568817249, 26289.73710262911, 28575.14274571766, 29151.0, 29310.97411590584, 1051.9474026298808, 1056.7886422715487, 1184.934828584419, 1208.3173007250875, 1218.5734992752643, 13821.239831809347, 14963.775543366859, 15267.770983435257, 15531.145786981599, 15630.843691563166, 573808.0, 577877.0, 585193.0, 588201.0, 588518.0, 59699.70150149308, 60431.18706438814, 60537.69731151404, 60715.39284607097, 60732.0, 1324.344449497505, 1454.898157129012, 1457.7521821290195, 1484.7475929092295, 1488.2112480385413, 23342.883285583463, 28391.00631477971, 29376.706232938253, 29704.70295297106, 30240.546391803702, 48053.75973120112, 48500.5149948496, 48538.5146148534, 48616.78458038577, 48641.51358486511, 380607.0, 394962.0, 397894.0, 397948.0, 399246.0, 32580.185495362806, 33147.50278745869, 33921.66078339185, 33956.49065264072, 37802.810985945995, 41914.0, 41925.16149676928, 42366.152676946906, 43681.12637747291, 43682.563174367846, 33277.50083748794, 34446.82776586101, 35322.11694707653, 36245.91262262136, 36578.8171059143, 34900.47649285314, 34991.125221868635, 35730.0, 35775.0, 35803.641963581074, 35398.938031859085, 36137.277254455286, 36326.45510317294, 36496.45255321226, 37321.2535749278, 31300.843495783287, 32079.67920320767, 32220.0, 33181.17047073746, 33554.32891342111, 23424.53150937006, 23706.0, 24096.27711168668, 24156.87921560381, 24292.39269018218], "value": 19158.579627471547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.19174582900934, 389.3458988898651, 393.61643821965794, 399.29874399686145, 405.43644334375205, 13761.089233428665, 19829.900850495746, 19845.305414310504, 20345.898270508646, 20494.590108197826, 20454.693179602316, 20772.89613551934, 20820.895895520538, 21723.456913577167, 21750.0, 5720.599558030929, 5903.4686878180955, 5970.701464926737, 5973.1040343948325, 5982.371850955652, 5900.321463031742, 5916.497097746696, 5992.280926288851, 6006.879862402771, 6510.869782604345, 6416.518761092913, 6416.743330266784, 6439.517036222279, 6448.065030570565, 6451.967740161293, 5512.5589952803675, 5889.734961926723, 5899.970500147515, 5908.586398952054, 6448.097266382711, 4576.427946506687, 5685.971570142165, 5700.3159620845345, 5915.615484993505, 5924.377940316291, 13796.655083622889, 14090.506832260822, 14155.787663184958, 16498.6700265994, 25866.741332586622, 1869.598036422162, 2051.1590247998247, 2287.611106111965, 2415.6376543518436, 2439.243834411338, 9807.26445516582, 10197.388156710622, 10285.434301113435, 10399.376037437778, 13767.692069253404, 1517.271709579397, 1602.9118398488079, 1685.8651307895339, 1764.559109736007, 1812.5196822841958, 118089.0, 124082.13876791856, 125374.0, 127694.0, 128695.0, 11617.88382116185, 11627.53489860413, 11665.941670291595, 11691.356975366436, 11801.291922484506, 13345.399457024458, 14082.450930397648, 14108.224047677477, 15273.465428710164, 15301.923490382476, 7689.0, 7710.498817576839, 8392.748217553482, 8594.65621375138, 8694.869576956351, 8416.873746893802, 8441.957790211132, 8448.662053517914, 8547.82904341922, 8551.700690475804, 4470.552944705569, 4637.5130611286, 4644.303354496785, 4646.117237724821, 4664.137134630104, 1698.88107832453, 1898.1837809741944, 1975.3086419753258, 1975.604879024201, 2003.4991252186953, 856.7986523167051, 862.1163307609625, 945.3193700535603, 987.8093757164256, 1044.1751016696876, 19846.0, 20240.696389554167, 20305.796942030687, 20609.48476288105, 20645.0, 953.3612479638658, 964.8552717092352, 982.3418309732497, 984.4290311619244, 1007.4761124215366, 9234.584443700049, 10577.197042783668, 10836.862129476449, 10852.240343175901, 10903.400312982862, 549366.0, 560059.0, 578179.0, 578281.0, 583406.0, 113166.0, 124867.0, 127008.36495817646, 130459.0, 132899.33550332187, 998.3959704378891, 1032.5921261101823, 1041.7083216699336, 1065.0787069185253, 1067.4342598422847, 18036.458906232834, 18144.546386340447, 18171.909140454212, 18181.99999000015, 18227.817721822612, 38044.61955380411, 48993.83147979954, 50839.0, 51161.0, 51727.74136129446, 69973.65013174902, 73108.0, 73576.63211684121, 74735.252647475, 75753.62123189348, 7944.496941363658, 8024.638891250024, 8125.674973001013, 8317.875231871647, 8345.248927596545, 9069.229115525255, 9996.450195239331, 10095.44475053879, 10594.629187978384, 12694.365281736062, 10533.578656853946, 10809.405482698212, 10811.56753729842, 10928.125749939827, 11031.724206894893, 10454.477276136315, 10494.422806745702, 10722.517486713272, 10892.61875834342, 11026.614068507564, 11254.268472549258, 11311.377874216669, 11381.374024428405, 11720.88279117232, 11777.291223018583, 7687.11598166218, 8143.389245806469, 8243.876341854757, 8416.4108512406, 8491.490510569385, 8144.389170812331, 10069.647562335284, 10880.347179169275, 11172.21794474379, 11215.831762523732], "value": 9366.60646244361, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.5451478269565, 1566.7493201087825, 1648.0688411047756, 1862.9441116766493, 1977.5563838397977, 7889.368850491961, 8531.0, 8763.0, 8766.605502752376, 8830.0, 7386.667599958001, 8364.163583641634, 8625.698100566482, 8632.482051076924, 8635.438696484724, 2078.3349328214977, 2093.9685904711405, 2148.677698345245, 2267.841251112423, 2347.049444974788, 2090.5191805884656, 2465.038634932369, 2497.67530221071, 2499.0378704198924, 2499.787518060967, 2439.3779586205583, 2447.070113356922, 2459.717132529764, 2465.9506809863883, 2467.6545283660303, 2151.924682636108, 2394.449276666359, 2440.2679196241147, 2472.431340791628, 2473.0478765675166, 2452.766987136219, 2463.6550882876413, 2484.813638977084, 2487.912923047703, 2492.1651246832334, 8531.530765807878, 8665.220130188314, 8669.69656062041, 8679.826403471958, 8686.609102590399, 5201.713905735183, 5374.758135883894, 5411.404745477994, 5412.052890744104, 5442.727863606843, 3624.9456258156147, 3663.7618554793853, 3668.9082772930624, 3715.145516531186, 3746.4942232798494, 1039.1478987230473, 1051.910587600055, 1055.1980494823913, 1069.5561342043043, 1070.903618674323, 11644.59243926467, 11698.707532311675, 11704.414779261087, 11712.824307635392, 11720.0, 4015.457913181683, 4731.981805348592, 4754.7147171169845, 4912.263160525878, 4916.360873086476, 9782.0, 9841.753956151153, 9863.457509836884, 9867.470542065992, 9889.011098890054, 5395.595330350239, 5403.0544654686055, 5437.021336159451, 5437.401885792559, 5451.37309209446, 4047.777372244496, 4401.471823381215, 4580.977095114503, 4906.852794416173, 4910.312556242129, 3942.664873485786, 3990.7206495545033, 4054.1688953764406, 4095.488063992001, 4110.301248787713, 1355.6610847288177, 1364.9931750341184, 1367.47352269377, 1367.541873472378, 1384.3908680180689, 818.1695578987333, 842.797728545157, 874.2918236228675, 926.5228407370209, 984.4585477987079, 5110.616703747234, 5172.663776854492, 5647.0, 5674.914876276859, 5978.940210597925, 1014.2291858187683, 1040.147079394904, 1055.440616473255, 1061.273027975839, 1077.4612693653173, 3764.7176461765475, 3918.8432462701744, 3967.2263908537557, 3974.602539746002, 4016.6184212499766, 9998.900010999796, 10476.63331783384, 10571.2600117991, 10586.735331616617, 10591.0, 10390.58437662485, 10536.789264214673, 10552.894471055344, 10565.577376904992, 10697.93020697924, 7965.322947549407, 8091.83816323682, 8102.270795628304, 8103.918960810434, 8229.300509456643, 5466.453354664502, 5723.084306510938, 5824.15549745293, 5870.031444811729, 5889.705514724333, 9847.704568862946, 9849.852252216366, 9910.15763660097, 9979.401235925578, 10026.298159128792, 9492.857607136037, 9549.427034377959, 10137.543810528396, 10140.391576505433, 10284.382937023802, 7493.550386976799, 7786.454948153575, 7960.721374752087, 8069.6772129116525, 8280.089190188954, 8338.874916876373, 8355.164483551596, 8419.452735572168, 8429.241368276884, 8437.620307086074, 7219.855602887807, 7222.602756848424, 7322.524035937647, 7457.291557302047, 7581.810454738455, 7243.311885370881, 7247.673854676657, 7264.055672762507, 7315.670794814353, 7377.8155546111775, 6843.965780171067, 6911.9264220732575, 6981.3367730065565, 6986.196587392515, 6986.371226589428, 4754.358161648272, 4817.445993710628, 4891.926621100757, 4960.826371076995, 5149.56228720548, 4199.790010499524, 4738.725059668245, 4880.438749543848, 5040.445550989315, 5114.309568208244], "value": 4601.943074667559, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.60234105027666, 318.4745170468726, 322.9757768167388, 328.1042753283536, 334.6603197754278, 5923.555733320002, 5925.407459254073, 5949.762009519625, 5963.940360596393, 5992.4606785389415, 5329.653572517784, 5884.734377264752, 5889.851478961604, 5910.615809972349, 5930.6738129402975, 3358.6473420290886, 4009.0, 4095.3413867383756, 4220.641245494129, 4323.329883868006, 4103.753774773523, 4431.689781715281, 4451.88870278244, 4470.441194850644, 4520.389747384094, 3729.8321575529167, 4444.511103778582, 4459.799309031086, 4460.420145381096, 4469.435697505879, 3822.311983842907, 4159.771212583307, 4193.329067349225, 4433.645308375354, 4507.346434766941, 3830.597787232356, 3845.1348446599573, 3845.346501004567, 3845.576986531479, 3866.8066596670337, 4952.4057113146655, 5712.171735098429, 5726.0, 5730.512906402961, 5744.482996530291, 4366.956330436687, 4887.560119589254, 5203.635745497817, 5204.661696989721, 5204.9739751301, 5124.436312005676, 5171.922421163686, 5959.582829201958, 6121.724522396503, 6223.471004964538, 3536.3104194682046, 4090.529589097262, 4326.805293761757, 4350.782460876975, 4360.520342762294, 5742.0, 6123.663198524079, 6154.138420621071, 6583.341665833378, 6595.571287866322, 3797.335466293443, 4410.80151393188, 4413.095315460323, 4413.558644135561, 4431.955680443154, 3765.585785563586, 3788.905277368033, 4218.388333691598, 4435.090806384684, 4471.0, 4743.57692692191, 5139.201279552127, 5166.43169251382, 5170.689758614495, 5215.348081489814, 6117.357677443804, 6227.221597300338, 6261.7182226799905, 6263.655498947602, 6301.204156815285, 1475.3066058952274, 1539.0457916092093, 1550.6511035017256, 1554.5724925645538, 1571.1594297051022, 964.5370222293199, 989.4508547756064, 1014.9441780702132, 1036.7356324137297, 1037.4657051618422, 5261.5264626183825, 5808.186853840466, 5936.614120082181, 5985.191999080069, 5985.880282394415, 6596.373344532358, 6609.0, 6616.801495955033, 6624.238212605515, 6631.0, 5117.336865518721, 5679.602427830012, 5914.792982245687, 5949.762009519657, 6014.271151885771, 3404.7446441516986, 3455.4775014239744, 3469.2020835208045, 3476.1309672581856, 3495.8288973194267, 5684.971575142181, 5697.829065128053, 6272.3100458949475, 6771.72913083481, 6885.862282754317, 6692.163479565054, 6729.8654026919185, 6733.865322693617, 6756.628385438848, 6767.932320676829, 6593.40659340652, 6816.897746533707, 6818.18181818185, 6881.965590172117, 6894.551854129466, 4976.402831660079, 6487.513436492376, 6491.058796474579, 6543.509236807164, 6553.901691474536, 5381.48875856793, 5902.498287645427, 6401.679916004275, 6405.583637063576, 6443.162388889415, 6434.742610295536, 6505.902411463737, 6865.485088618473, 6869.725210991504, 6922.7923162305215, 4179.89232853288, 4233.8518151865765, 4237.152569486054, 4248.532661407305, 4261.637760790368, 6300.243970723543, 6355.3644635536075, 6512.274247324557, 6551.49315657392, 6585.604863708193, 6216.409441103088, 6242.5942313749465, 6261.78083767066, 6280.152179455715, 6337.556371053982, 5950.9404905952115, 6239.500839932885, 6268.780592679234, 6272.153259310117, 6276.403741644536, 4946.35697359341, 5868.853278668067, 6006.909896351471, 6048.153258543719, 6138.907916381168, 5286.81496147633, 6320.873582528416, 6327.810165695037, 6330.493560515056, 6331.89191891408, 5227.607929405233, 6168.19813424252, 6189.96905015472, 6190.288116866438, 6193.659348735682], "value": 4580.404909792177, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.592768411269, 738.5494848142632, 759.7758661194947, 761.1475147834426, 790.3365657733439, 14644.414223431064, 14939.0, 14945.701085978288, 14963.251837408141, 14966.25168741564, 13654.249016304098, 13791.03462757605, 13903.930480347584, 13907.235102069382, 13940.302984850743, 906.9863952040724, 929.6560272699077, 932.9486878221695, 937.2314701944374, 937.2689302344182, 897.8742975983367, 909.245326379107, 911.8586619074055, 913.9862902056475, 915.3866909170838, 972.5283237629744, 977.0571398600349, 977.1742877268697, 977.218225419665, 979.5249304087512, 932.2169377722712, 939.9342046056813, 966.3139171188465, 968.1093394077395, 970.1656575345268, 722.3643193989255, 724.5073350121914, 724.8767709489399, 724.916634587024, 726.8982342472058, 13848.961327900348, 13878.375473103735, 13912.58262252134, 13918.234497102756, 13924.443022279096, 10599.258051936291, 10646.414447205401, 10766.892331076746, 10886.0746836519, 10909.1818113641, 9336.253099752072, 9468.100530449665, 9561.808763824685, 9587.856182157273, 9853.605855765762, 3389.694927456516, 3429.228423604694, 3474.7567670263093, 3485.337785820686, 3540.929181416383, 64498.0, 76787.61606191934, 77566.61216693936, 77573.61213193898, 78454.21545784526, 8931.151540603632, 9154.176124148726, 9676.516174191262, 9730.513474326397, 10476.895231047592, 21950.45123871916, 22240.666390004164, 22293.7738424385, 22312.665310020362, 22318.0, 7563.168051514329, 7644.0827100748265, 7706.845863082707, 7772.0, 7979.960100199578, 4014.979925100356, 4051.372037334218, 4103.85636502721, 4118.19695159447, 4359.019220675386, 3471.5139880416764, 3583.6416358363954, 3592.515010473605, 3864.188520410689, 4019.7789121598007, 694.6908625661532, 700.6146619359332, 701.0920857489564, 703.5532436902502, 706.523096909584, 530.3794560364383, 546.893355795624, 559.932808063035, 574.9770009199668, 605.276694350256, 7896.447248692652, 7920.6039698014865, 7931.56376399292, 8011.399145064143, 8117.634706438224, 544.5153813106339, 574.7413663851283, 603.5322624965687, 611.455804334143, 613.5643692978035, 3698.1679122197293, 3805.9809700951873, 3876.4185372194397, 3945.349017412152, 4014.8897887969893, 80827.7875831863, 81632.18367816365, 83512.0, 83533.0, 83591.5820420894, 61584.69207653933, 75252.0, 76657.61671191608, 76780.23219767731, 78460.82308765373, 66151.0, 66162.66918665376, 66252.00621990675, 66982.66508667426, 67367.6526469468, 8252.092269850431, 8293.445053687354, 8349.206825351583, 8438.324934005142, 8507.8723819144, 40548.59451405448, 40849.38725919173, 42155.789221053696, 42835.357469638606, 42960.0, 56522.0, 56666.433335666115, 57185.42814571801, 57244.71377643085, 60235.69882150561, 10845.078168355778, 11083.667489975314, 11301.15241356885, 11326.490307936327, 11348.0, 11810.468528916048, 11963.461644225858, 12168.1098288504, 12541.0, 13004.739905202032, 11276.830847537129, 11493.482793274155, 11757.529698812294, 11803.996660283972, 11865.703357415789, 11213.327200368005, 11226.943865280622, 11390.772184556428, 11405.771884562428, 11689.123315751523, 11464.025557827345, 11656.766864662828, 11749.29504229749, 11758.470868810753, 11861.347625880659, 9575.616975320909, 9726.203913655978, 9999.550020249251, 10050.447225402673, 10547.0, 9689.467079310705, 9772.85340719904, 9893.554790034323, 9913.851292230478, 9989.0], "value": 6816.799419554183, "unit": "score"}], "name": "dromaeo_css", "value": 7280.154052884654, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 112.0, 112.0, 111.0, 112.0, 118.0, 111.0, 112.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 119.0, 143.0, 168.0, 119.0, 144.0, 144.0, 120.0, 165.0, 120.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 186.0, 184.0, 185.0, 183.0, 185.0, 184.0, 227.0, 227.0], "value": 193.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 86.0, 90.0, 55.0, 63.0, 58.0, 78.0, 93.0, 78.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 98.0, 131.0, 78.0, 76.0, 77.0, 123.0, 79.0, 75.0, 118.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 129.0, 104.0, 87.0, 90.0, 86.0, 89.0, 87.0, 89.0, 85.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 97.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 84.0, 104.0, 142.0, 146.0, 85.0, 86.0, 87.0], "value": 99.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 58.0, 57.0, 58.0, 59.0, 73.0, 60.0, 56.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 73.0, 80.0, 75.0, 71.0, 68.0, 68.0, 65.0, 71.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 82.0, 92.0, 85.0, 109.0, 111.0, 82.0, 86.0, 85.0], "value": 90.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 144.0, 143.0, 141.0, 141.0, 143.0, 145.0, 179.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 163.0, 219.0, 217.0, 175.0, 170.0, 167.0, 175.0, 210.0, 157.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 68.0, 71.0, 69.0, 68.0, 72.0, 68.0, 68.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1520.8, "alertThreshold": 2.0}]} 04:00:50 INFO - Return code: 0 04:00:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:00:50 ERROR - # TBPL SUCCESS # 04:00:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:00:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:00:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:00:50 INFO - 2016-04-14 04:00:50.347 screenresolution[1683:9913] starting screenresolution argv=screenresolution get 04:00:50 INFO - 2016-04-14 04:00:50.349 screenresolution[1683:9913] Display 0: 1600x1200x32@60 04:00:50 INFO - 2016-04-14 04:00:50.355 screenresolution[1684:9916] starting screenresolution argv=screenresolution list 04:00:50 INFO - Available Modes on Display 0 04:00:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:00:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:00:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:00:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:00:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:00:50 INFO - Intel Iris: 04:00:50 INFO - Chipset Model: Intel Iris 04:00:50 INFO - Type: GPU 04:00:50 INFO - Bus: Built-In 04:00:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:00:50 INFO - Vendor: Intel (0x8086) 04:00:50 INFO - Device ID: 0x0a2e 04:00:50 INFO - Revision ID: 0x0009 04:00:50 INFO - Displays: 04:00:50 INFO - Display: 04:00:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:00:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:00:50 INFO - Display Serial Number: 1600x1200 60 04:00:50 INFO - Main Display: Yes 04:00:50 INFO - Mirror: Off 04:00:50 INFO - Online: Yes 04:00:50 INFO - Rotation: Supported 04:00:50 INFO - Return code: 0 04:00:50 INFO - Running post-action listener: _resource_record_post_action 04:00:50 INFO - Running post-run listener: _resource_record_post_run 04:00:51 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37824000; Write bytes: 692327936; Read time: 397; Write time: 1928 04:00:51 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 378020352; Write bytes: 367101440; Read time: 27941; Write time: 660 04:00:51 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 31571456; Write bytes: 295907328; Read time: 314; Write time: 1214 04:00:51 INFO - Running post-run listener: _upload_blobber_files 04:00:51 INFO - Blob upload gear active. 04:00:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:52 INFO - (blobuploader) - INFO - Done attempting. 04:00:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:53 INFO - (blobuploader) - INFO - Done attempting. 04:00:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:53 INFO - Return code: 0 04:00:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24e236e84891b8cf4a94adf6f954da6a6067b16b1df44e44a1757c4e5a427476faa20a49d9f9d1ca8263608d6432602c84d25293838975d23ba309221cb0bbb5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c97cbfbf5548e9cd369839cc66ca56a4f7a9e4b006907cdb2867cedf2eb47805c8ad97683d547d9e00c03847205ee46cd5aa0a78ac8df03d7cc1122f19452698"} 04:00:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:53 INFO - Contents: 04:00:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24e236e84891b8cf4a94adf6f954da6a6067b16b1df44e44a1757c4e5a427476faa20a49d9f9d1ca8263608d6432602c84d25293838975d23ba309221cb0bbb5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c97cbfbf5548e9cd369839cc66ca56a4f7a9e4b006907cdb2867cedf2eb47805c8ad97683d547d9e00c03847205ee46cd5aa0a78ac8df03d7cc1122f19452698"} 04:00:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:53 INFO - Copying logs to upload dir... 04:00:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.513687 ========= master_lag: 3.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-14 04:00:57.250339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-14 04:00:57.251397) ========= 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.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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/24e236e84891b8cf4a94adf6f954da6a6067b16b1df44e44a1757c4e5a427476faa20a49d9f9d1ca8263608d6432602c84d25293838975d23ba309221cb0bbb5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c97cbfbf5548e9cd369839cc66ca56a4f7a9e4b006907cdb2867cedf2eb47805c8ad97683d547d9e00c03847205ee46cd5aa0a78ac8df03d7cc1122f19452698"} build_url:https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010538 build_url: 'https://queue.taskcluster.net/v1/task/TFyrYCKoTeKDbR5uqIKvoA/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/24e236e84891b8cf4a94adf6f954da6a6067b16b1df44e44a1757c4e5a427476faa20a49d9f9d1ca8263608d6432602c84d25293838975d23ba309221cb0bbb5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c97cbfbf5548e9cd369839cc66ca56a4f7a9e4b006907cdb2867cedf2eb47805c8ad97683d547d9e00c03847205ee46cd5aa0a78ac8df03d7cc1122f19452698"}' ========= master_lag: 3.61 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-14 04:01:00.868980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 04:01:00.869347) ========= 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.oHrUngtSke/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.cSetaXPlQp/Listeners TMPDIR=/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/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.005140 ========= master_lag: 0.14 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 04:01:01.015449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 04:01:01.015748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 04:01:01.024229) ========= ========= Total master_lag: 10.74 =========