builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0066 starttime: 1459834661.89 results: success (0) buildid: 20160404203620 builduid: c9dddf275bad433599905d88e7d65b1b revision: fd37367d1b1f2952c7a970c4b41e650d7233c717 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:41.886775) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:41.887290) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:41.887621) ========= 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.MCCwWVnQyk/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.XTDx5Yp8sc/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.005639 basedir: '/builds/slave/test' ========= master_lag: 0.12 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.013151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.013487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.032413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.033086) ========= 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.MCCwWVnQyk/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.XTDx5Yp8sc/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.005381 ========= master_lag: 0.28 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.316257) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.317036) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.317874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.318620) ========= 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.MCCwWVnQyk/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.XTDx5Yp8sc/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-04 22:37: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% 165M=0s 2016-04-04 22:37:42 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.207917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.550351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.551131) ========= 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.MCCwWVnQyk/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.XTDx5Yp8sc/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.026631 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:42.607353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-04 22:37:42.608162) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd37367d1b1f2952c7a970c4b41e650d7233c717 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fd37367d1b1f2952c7a970c4b41e650d7233c717 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MCCwWVnQyk/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.XTDx5Yp8sc/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-04 22:37:42,707 truncating revision to first 12 chars 2016-04-04 22:37:42,707 Setting DEBUG logging. 2016-04-04 22:37:42,707 attempt 1/10 2016-04-04 22:37:42,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd37367d1b1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-04 22:37:45,339 unpacking tar archive at: mozilla-central-fd37367d1b1f/testing/mozharness/ program finished with exit code 0 elapsedTime=3.453795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-04-04 22:37:46.080501) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:46.081373) ========= echo fd37367d1b1f2952c7a970c4b41e650d7233c717 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fd37367d1b1f2952c7a970c4b41e650d7233c717'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MCCwWVnQyk/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.XTDx5Yp8sc/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 fd37367d1b1f2952c7a970c4b41e650d7233c717 program finished with exit code 0 elapsedTime=0.005779 script_repo_revision: 'fd37367d1b1f2952c7a970c4b41e650d7233c717' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:46.137043) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:46.137362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-04 22:37:46.150644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-04-04 22:37:46.150968) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:37:46 INFO - MultiFileLogger online at 20160404 22:37:46 in /builds/slave/test 22:37:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:37:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:37:46 INFO - {'append_to_log': False, 22:37:46 INFO - 'base_work_dir': '/builds/slave/test', 22:37:46 INFO - 'blob_upload_branch': 'Firefox', 22:37:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:37:46 INFO - 'branch': 'Firefox', 22:37:46 INFO - 'buildbot_json_path': 'buildprops.json', 22:37:46 INFO - 'config_files': ('talos/mac_config.py',), 22:37:46 INFO - 'default_actions': ('clobber', 22:37:46 INFO - 'read-buildbot-config', 22:37:46 INFO - 'download-and-extract', 22:37:46 INFO - 'populate-webroot', 22:37:46 INFO - 'create-virtualenv', 22:37:46 INFO - 'install', 22:37:46 INFO - 'run-tests'), 22:37:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:37:46 INFO - 'download_minidump_stackwalk': True, 22:37:46 INFO - 'download_symbols': 'ondemand', 22:37:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:37:46 INFO - 'tooltool.py': '/tools/tooltool.py', 22:37:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:37:46 INFO - '/tools/misc-python/virtualenv.py')}, 22:37:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:37:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:37:46 INFO - 'installer_path': 'installer.exe', 22:37:46 INFO - 'log_level': 'info', 22:37:46 INFO - 'log_name': 'talos', 22:37:46 INFO - 'log_to_console': True, 22:37:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:37:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:37:46 INFO - 'opt_config_files': (), 22:37:46 INFO - 'pip_index': False, 22:37:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:37:46 INFO - 'cmd': ('bash', 22:37:46 INFO - '-c', 22:37:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:37:46 INFO - 'enabled': True, 22:37:46 INFO - 'halt_on_failure': False, 22:37:46 INFO - 'name': 'check_screen_resolution'},), 22:37:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:37:46 INFO - 'cmd': ('bash', 22:37:46 INFO - '-c', 22:37:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:37:46 INFO - 'enabled': True, 22:37:46 INFO - 'halt_on_failure': False, 22:37:46 INFO - 'name': 'check_screen_resolution'},), 22:37:46 INFO - 'run_cmd_checks_enabled': True, 22:37:46 INFO - 'sps_profile': False, 22:37:46 INFO - 'sps_profile_interval': 0, 22:37:46 INFO - 'suite': 'dromaeojs-e10s', 22:37:46 INFO - 'system_bits': '32', 22:37:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:37:46 INFO - 'title': 't-yosemite-r7-0066', 22:37:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:37:46 INFO - 'use_talos_json': True, 22:37:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:37:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:37:46 INFO - 'work_dir': 'build'} 22:37:46 INFO - ##### 22:37:46 INFO - ##### Running clobber step. 22:37:46 INFO - ##### 22:37:46 INFO - Running pre-action listener: _resource_record_pre_action 22:37:46 INFO - Running main action method: clobber 22:37:46 INFO - rmtree: /builds/slave/test/build 22:37:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:37:47 INFO - Running post-action listener: _resource_record_post_action 22:37:47 INFO - ##### 22:37:47 INFO - ##### Running read-buildbot-config step. 22:37:47 INFO - ##### 22:37:47 INFO - Running pre-action listener: _resource_record_pre_action 22:37:47 INFO - Running main action method: read_buildbot_config 22:37:47 INFO - Using buildbot properties: 22:37:47 INFO - { 22:37:47 INFO - "project": "", 22:37:47 INFO - "product": "firefox", 22:37:47 INFO - "script_repo_revision": "production", 22:37:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 22:37:47 INFO - "repository": "", 22:37:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 22:37:47 INFO - "buildid": "20160404203620", 22:37:47 INFO - "pgo_build": "False", 22:37:47 INFO - "basedir": "/builds/slave/test", 22:37:47 INFO - "buildnumber": 170, 22:37:47 INFO - "slavename": "t-yosemite-r7-0066", 22:37:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:37:47 INFO - "platform": "yosemite_r7", 22:37:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 22:37:47 INFO - "branch": "mozilla-central", 22:37:47 INFO - "repo_path": "mozilla-central", 22:37:47 INFO - "revision": "fd37367d1b1f2952c7a970c4b41e650d7233c717", 22:37:47 INFO - "stage_platform": "macosx64", 22:37:47 INFO - "builduid": "c9dddf275bad433599905d88e7d65b1b", 22:37:47 INFO - "slavebuilddir": "test" 22:37:47 INFO - } 22:37:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 22:37:47 INFO - Running post-action listener: _resource_record_post_action 22:37:47 INFO - ##### 22:37:47 INFO - ##### Running download-and-extract step. 22:37:47 INFO - ##### 22:37:47 INFO - Running pre-action listener: _resource_record_pre_action 22:37:47 INFO - Running main action method: download_and_extract 22:37:47 INFO - mkdir: /builds/slave/test/build/tests 22:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:47 INFO - https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 22:37:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:37:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 22:37:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:37:49 INFO - Downloaded 1199 bytes. 22:37:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 22:37:49 INFO - Using the following test package requirements: 22:37:49 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:37:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:37:49 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 22:37:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:37:49 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 22:37:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:37:49 INFO - u'jsshell-mac.zip'], 22:37:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:37:49 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 22:37:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 22:37:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:37:49 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 22:37:49 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:37:49 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 22:37:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:37:49 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 22:37:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 22:37:49 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 22:37:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:49 INFO - https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:37:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:37:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:37:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:37:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:37:50 INFO - Downloaded 17959954 bytes. 22:37:50 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'] 22:37:50 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 22:37:54 INFO - Return code: 0 22:37:54 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 22:37:54 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')]} 22:37:54 INFO - https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:37:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:37:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 22:37:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:37:55 INFO - Downloaded 17959954 bytes. 22:37:55 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'] 22:37:55 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 22:37:59 INFO - Return code: 0 22:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:59 INFO - https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:37:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:37:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 22:37:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:37:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:38:01 INFO - Downloaded 10847584 bytes. 22:38: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'] 22:38: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 22:38:01 INFO - Return code: 0 22:38: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')]} 22:38:01 INFO - https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:38:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:38:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:38:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 22:38:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HHEvda4nR-GWYTIBcqpeQA/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 22:38:33 INFO - Downloaded 111355180 bytes. 22:38:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:38:33 INFO - mkdir: /builds/slave/test/properties 22:38:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:38:33 INFO - Writing to file /builds/slave/test/properties/build_url 22:38:33 INFO - Contents: 22:38:33 INFO - build_url:https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 22:38:35 INFO - Running post-action listener: _resource_record_post_action 22:38:35 INFO - Running post-action listener: set_extra_try_arguments 22:38:35 INFO - ##### 22:38:35 INFO - ##### Running populate-webroot step. 22:38:35 INFO - ##### 22:38:35 INFO - Running pre-action listener: _resource_record_pre_action 22:38:35 INFO - Running main action method: populate_webroot 22:38:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:38:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:38:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:38:35 INFO - '--tppagecycles', 22:38:35 INFO - '7'], 22:38:35 INFO - 'tests': ['tsvgm']}}, 22:38:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:38:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:38:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:38:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:38:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:35 INFO - 'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:35 INFO - 'tests': ['damp', 'tps']}, 22:38:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:35 INFO - 'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['damp', 'tps']}, 22:38:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:38:35 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['dromaeo_dom']}, 22:38:35 INFO - 'other': {'tests': ['a11yr', 22:38:35 INFO - 'ts_paint', 22:38:35 INFO - 'tpaint', 22:38:35 INFO - 'sessionrestore', 22:38:35 INFO - 'sessionrestore_no_auto_restore', 22:38:35 INFO - 'tabpaint']}, 22:38:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['a11yr', 22:38:35 INFO - 'ts_paint', 22:38:35 INFO - 'tpaint', 22:38:35 INFO - 'sessionrestore', 22:38:35 INFO - 'sessionrestore_no_auto_restore', 22:38:35 INFO - 'tabpaint']}, 22:38:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['a11yr', 22:38:35 INFO - 'ts_paint', 22:38:35 INFO - 'tpaint', 22:38:35 INFO - 'sessionrestore', 22:38:35 INFO - 'sessionrestore_no_auto_restore', 22:38:35 INFO - 'tabpaint']}, 22:38:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['a11yr', 22:38:35 INFO - 'ts_paint', 22:38:35 INFO - 'tpaint', 22:38:35 INFO - 'sessionrestore', 22:38:35 INFO - 'sessionrestore_no_auto_restore', 22:38:35 INFO - 'tabpaint']}, 22:38:35 INFO - 'other_l64': {'tests': ['a11yr', 22:38:35 INFO - 'ts_paint', 22:38:35 INFO - 'tpaint', 22:38:35 INFO - 'sessionrestore', 22:38:35 INFO - 'sessionrestore_no_auto_restore', 22:38:35 INFO - 'tabpaint']}, 22:38:35 INFO - 'other_nol64': {'tests': ['a11yr', 22:38:35 INFO - 'ts_paint', 22:38:35 INFO - 'tpaint', 22:38:35 INFO - 'sessionrestore', 22:38:35 INFO - 'sessionrestore_no_auto_restore', 22:38:35 INFO - 'tabpaint']}, 22:38:35 INFO - 'svgr': {'tests': ['tsvgx', 22:38:35 INFO - 'tsvgr_opacity', 22:38:35 INFO - 'tart', 22:38:35 INFO - 'tscrollx', 22:38:35 INFO - 'cart']}, 22:38:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['tsvgx', 22:38:35 INFO - 'tsvgr_opacity', 22:38:35 INFO - 'tart', 22:38:35 INFO - 'tscrollx', 22:38:35 INFO - 'cart']}, 22:38:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:35 INFO - 'tests': ['tp5o']}, 22:38:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:35 INFO - 'talos_options': ['--e10s'], 22:38:35 INFO - 'tests': ['tp5o']}, 22:38:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:35 INFO - 'talos_options': ['--xperf_path', 22:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:35 INFO - 'tests': ['tp5n']}, 22:38:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:35 INFO - 'talos_options': ['--e10s', 22:38:35 INFO - '--xperf_path', 22:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:35 INFO - 'tests': ['tp5n']}}, 22:38:35 INFO - 'talos.zip': {'path': '', 22:38:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:38:35 INFO - Running post-action listener: _resource_record_post_action 22:38:35 INFO - ##### 22:38:35 INFO - ##### Running create-virtualenv step. 22:38:35 INFO - ##### 22:38:35 INFO - Running pre-action listener: _resource_record_pre_action 22:38:35 INFO - Running main action method: create_virtualenv 22:38:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:38:35 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 22:38:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:38:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:38:35 INFO - Using real prefix '/tools/python27' 22:38:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:38:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:38:39 INFO - Installing pip.................done. 22:38:39 INFO - Return code: 0 22:38:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:38:39 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')]} 22:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:40 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')]} 22:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:40 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:38:40 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 22:38:40 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 22:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:38:40 INFO - 'HOME': '/Users/cltbld', 22:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:38:40 INFO - 'LOGNAME': 'cltbld', 22:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:40 INFO - 'MOZ_NO_REMOTE': '1', 22:38:40 INFO - 'NO_EM_RESTART': '1', 22:38:40 INFO - 'PAGER': '/bin/cat', 22:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:40 INFO - 'PWD': '/builds/slave/test', 22:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:38:40 INFO - 'SHELL': '/bin/bash', 22:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:38:40 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:38:40 INFO - 'USER': 'cltbld', 22:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:40 INFO - 'XPC_FLAGS': '0x0', 22:38:40 INFO - 'XPC_SERVICE_NAME': '0', 22:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:40 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 22:38:40 INFO - Cleaning up... 22:38:40 INFO - Return code: 0 22:38:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:38:40 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')]} 22:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:40 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')]} 22:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:40 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:38:40 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 22:38:40 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 22:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:38:40 INFO - 'HOME': '/Users/cltbld', 22:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:38:40 INFO - 'LOGNAME': 'cltbld', 22:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:40 INFO - 'MOZ_NO_REMOTE': '1', 22:38:40 INFO - 'NO_EM_RESTART': '1', 22:38:40 INFO - 'PAGER': '/bin/cat', 22:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:40 INFO - 'PWD': '/builds/slave/test', 22:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:38:40 INFO - 'SHELL': '/bin/bash', 22:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:38:40 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:38:40 INFO - 'USER': 'cltbld', 22:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:40 INFO - 'XPC_FLAGS': '0x0', 22:38:40 INFO - 'XPC_SERVICE_NAME': '0', 22:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:40 INFO - Downloading/unpacking psutil>=0.7.1 22:38:40 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 22:38:40 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 22:38:40 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 22:38:40 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 22:38:40 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 22:38:40 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 22:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:38:44 INFO - Installing collected packages: psutil 22:38:44 INFO - Running setup.py install for psutil 22:38:44 INFO - building 'psutil._psutil_osx' extension 22:38:44 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 22:38:45 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 22:38:45 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 22:38:45 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 22:38:45 INFO - building 'psutil._psutil_posix' extension 22:38:45 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 22:38:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:38:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:38:45 INFO - ^ 22:38:45 INFO - 1 warning generated. 22:38:45 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 22:38:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:38:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:38:45 INFO - Successfully installed psutil 22:38:45 INFO - Cleaning up... 22:38:45 INFO - Return code: 0 22:38:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:38:45 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')]} 22:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:45 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')]} 22:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:45 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:38:45 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 22:38:45 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 22:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:38:45 INFO - 'HOME': '/Users/cltbld', 22:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:38:45 INFO - 'LOGNAME': 'cltbld', 22:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:45 INFO - 'MOZ_NO_REMOTE': '1', 22:38:45 INFO - 'NO_EM_RESTART': '1', 22:38:45 INFO - 'PAGER': '/bin/cat', 22:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:45 INFO - 'PWD': '/builds/slave/test', 22:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:38:45 INFO - 'SHELL': '/bin/bash', 22:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:38:45 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:38:45 INFO - 'USER': 'cltbld', 22:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:45 INFO - 'XPC_FLAGS': '0x0', 22:38:45 INFO - 'XPC_SERVICE_NAME': '0', 22:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:38:45 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 22:38:45 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 22:38:45 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 22:38:45 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 22:38:45 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 22:38:45 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 22:38:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:38:49 INFO - Installing collected packages: mozsystemmonitor 22:38:49 INFO - Running setup.py install for mozsystemmonitor 22:38:50 INFO - Successfully installed mozsystemmonitor 22:38:50 INFO - Cleaning up... 22:38:50 INFO - Return code: 0 22:38:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:38: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')]} 22:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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')]} 22:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:50 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:38:50 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 22:38:50 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 22:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:38:50 INFO - 'HOME': '/Users/cltbld', 22:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:38:50 INFO - 'LOGNAME': 'cltbld', 22:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:50 INFO - 'MOZ_NO_REMOTE': '1', 22:38:50 INFO - 'NO_EM_RESTART': '1', 22:38:50 INFO - 'PAGER': '/bin/cat', 22:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:50 INFO - 'PWD': '/builds/slave/test', 22:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:38:50 INFO - 'SHELL': '/bin/bash', 22:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:38:50 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:38:50 INFO - 'USER': 'cltbld', 22:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:50 INFO - 'XPC_FLAGS': '0x0', 22:38:50 INFO - 'XPC_SERVICE_NAME': '0', 22:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:50 INFO - Downloading/unpacking blobuploader==1.2.4 22:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:38:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:38:54 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 22:38:54 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 22:38:54 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 22:38:54 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 22:38:54 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 22:38:54 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 22:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:38:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:55 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 22:38:56 INFO - Downloading docopt-0.6.1.tar.gz 22:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:38:56 INFO - Installing collected packages: blobuploader, requests, docopt 22:38:56 INFO - Running setup.py install for blobuploader 22:38:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:38:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:38:56 INFO - Running setup.py install for requests 22:38:56 INFO - Running setup.py install for docopt 22:38:57 INFO - Successfully installed blobuploader requests docopt 22:38:57 INFO - Cleaning up... 22:38:57 INFO - Return code: 0 22:38:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:38:57 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')]} 22:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:57 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')]} 22:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:57 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:38:57 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 22:38:57 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 22:38:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:38:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:38:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:38:57 INFO - 'HOME': '/Users/cltbld', 22:38:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:38:57 INFO - 'LOGNAME': 'cltbld', 22:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:57 INFO - 'MOZ_NO_REMOTE': '1', 22:38:57 INFO - 'NO_EM_RESTART': '1', 22:38:57 INFO - 'PAGER': '/bin/cat', 22:38:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:57 INFO - 'PWD': '/builds/slave/test', 22:38:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:38:57 INFO - 'SHELL': '/bin/bash', 22:38:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:38:57 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:38:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:38:57 INFO - 'USER': 'cltbld', 22:38:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:38:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:57 INFO - 'XPC_FLAGS': '0x0', 22:38:57 INFO - 'XPC_SERVICE_NAME': '0', 22:38:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:38:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-nRkxYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:38:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-NsJiqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:38:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Yu1OMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:38:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-YS1il7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:38:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-CLE2Xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:38:57 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-I6E63Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-2TQQ37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-nPICFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-YOa4_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-512G5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-1E1CSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-E1tMJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-JQ7aJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-rh1tck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-f6Ioed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:38:58 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-XcSDJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:38:59 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-h0mEyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:38:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:38:59 INFO - Running setup.py install for manifestparser 22:38:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:38:59 INFO - Running setup.py install for mozcrash 22:38:59 INFO - Running setup.py install for mozdebug 22:38:59 INFO - Running setup.py install for mozdevice 22:38:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:38:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:38:59 INFO - Running setup.py install for mozfile 22:38:59 INFO - Running setup.py install for mozhttpd 22:39:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:39:00 INFO - Running setup.py install for mozinfo 22:39:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:39:00 INFO - Running setup.py install for mozInstall 22:39:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:39:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:39:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:39:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:39:00 INFO - Running setup.py install for mozleak 22:39:00 INFO - Running setup.py install for mozlog 22:39:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:39:00 INFO - Running setup.py install for moznetwork 22:39:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:39:00 INFO - Running setup.py install for mozprocess 22:39:00 INFO - Running setup.py install for mozprofile 22:39:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:39:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:39:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:39:01 INFO - Running setup.py install for mozrunner 22:39:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:39:01 INFO - Running setup.py install for mozscreenshot 22:39:01 INFO - Running setup.py install for moztest 22:39:01 INFO - Running setup.py install for mozversion 22:39:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:39:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:39:01 INFO - Cleaning up... 22:39:01 INFO - Return code: 0 22:39:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39: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')]} 22:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39: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')]} 22:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:01 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:39:01 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 22:39:01 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 22:39:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:39:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:01 INFO - 'HOME': '/Users/cltbld', 22:39:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:01 INFO - 'LOGNAME': 'cltbld', 22:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:01 INFO - 'MOZ_NO_REMOTE': '1', 22:39:01 INFO - 'NO_EM_RESTART': '1', 22:39:01 INFO - 'PAGER': '/bin/cat', 22:39:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:01 INFO - 'PWD': '/builds/slave/test', 22:39:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:01 INFO - 'SHELL': '/bin/bash', 22:39:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:39:01 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:39:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:01 INFO - 'USER': 'cltbld', 22:39:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:01 INFO - 'XPC_FLAGS': '0x0', 22:39:01 INFO - 'XPC_SERVICE_NAME': '0', 22:39:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:39:01 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Fbzw_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-2nNmco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-Uj5X_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-zn5E1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-iUT0Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-BHfweO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-9k4gs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-MhGR28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-ehvfTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:39:02 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)) 22:39:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:39:02 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-j0Ltbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:39:03 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)) 22:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-SIs9wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:39:03 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)) 22:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-k4ghUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:39:03 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)) 22:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-KJh93S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:39:03 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)) 22:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-2wEL_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:39:03 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)) 22:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-wc2O1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:39:03 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)) 22:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-mUjRF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:39:03 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)) 22:39:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:39:03 INFO - Running setup.py (path:/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/pip-9bITT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:39:03 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)) 22:39:03 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)) 22:39:03 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)) 22:39:03 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)) 22:39:03 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)) 22:39:03 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)) 22:39:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:06 INFO - Downloading blessings-1.6.tar.gz 22:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:39:06 INFO - Installing collected packages: blessings 22:39:06 INFO - Running setup.py install for blessings 22:39:07 INFO - Successfully installed blessings 22:39:07 INFO - Cleaning up... 22:39:07 INFO - Return code: 0 22:39:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:39:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:39:07 INFO - Reading from file tmpfile_stdout 22:39:07 INFO - Current package versions: 22:39:07 INFO - blessings == 1.6 22:39:07 INFO - blobuploader == 1.2.4 22:39:07 INFO - docopt == 0.6.1 22:39:07 INFO - manifestparser == 1.1 22:39:07 INFO - mozInstall == 1.12 22:39:07 INFO - mozcrash == 0.17 22:39:07 INFO - mozdebug == 0.1 22:39:07 INFO - mozdevice == 0.48 22:39:07 INFO - mozfile == 1.2 22:39:07 INFO - mozhttpd == 0.7 22:39:07 INFO - mozinfo == 0.9 22:39:07 INFO - mozleak == 0.1 22:39:07 INFO - mozlog == 3.1 22:39:07 INFO - moznetwork == 0.27 22:39:07 INFO - mozprocess == 0.22 22:39:07 INFO - mozprofile == 0.28 22:39:07 INFO - mozrunner == 6.11 22:39:07 INFO - mozscreenshot == 0.1 22:39:07 INFO - mozsystemmonitor == 0.0 22:39:07 INFO - moztest == 0.7 22:39:07 INFO - mozversion == 1.4 22:39:07 INFO - psutil == 3.1.1 22:39:07 INFO - requests == 1.2.3 22:39:07 INFO - wsgiref == 0.1.2 22:39:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:07 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:39:07 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 22:39:07 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 22:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:07 INFO - 'HOME': '/Users/cltbld', 22:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:07 INFO - 'LOGNAME': 'cltbld', 22:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:07 INFO - 'MOZ_NO_REMOTE': '1', 22:39:07 INFO - 'NO_EM_RESTART': '1', 22:39:07 INFO - 'PAGER': '/bin/cat', 22:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:07 INFO - 'PWD': '/builds/slave/test', 22:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:07 INFO - 'SHELL': '/bin/bash', 22:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:39:07 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:07 INFO - 'USER': 'cltbld', 22:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:07 INFO - 'XPC_FLAGS': '0x0', 22:39:07 INFO - 'XPC_SERVICE_NAME': '0', 22:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 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)) 22:39:07 INFO - Cleaning up... 22:39:07 INFO - Return code: 0 22:39:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:07 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:39:07 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 22:39:07 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 22:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:07 INFO - 'HOME': '/Users/cltbld', 22:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:07 INFO - 'LOGNAME': 'cltbld', 22:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:07 INFO - 'MOZ_NO_REMOTE': '1', 22:39:07 INFO - 'NO_EM_RESTART': '1', 22:39:07 INFO - 'PAGER': '/bin/cat', 22:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:07 INFO - 'PWD': '/builds/slave/test', 22:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:07 INFO - 'SHELL': '/bin/bash', 22:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:39:07 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:07 INFO - 'USER': 'cltbld', 22:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:07 INFO - 'XPC_FLAGS': '0x0', 22:39:07 INFO - 'XPC_SERVICE_NAME': '0', 22:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:07 INFO - Downloading/unpacking jsonschema 22:39:07 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 22:39:07 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 22:39:07 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 22:39:07 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 22:39:07 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 22:39:07 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 22:39:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:39:11 INFO - Downloading/unpacking functools32 (from jsonschema) 22:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:11 INFO - Downloading functools32-3.2.3-2.tar.gz 22:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:39:11 INFO - warning: no files found matching '*.txt' 22:39:11 INFO - no previously-included directories found matching 'build' 22:39:11 INFO - no previously-included directories found matching 'dist' 22:39:11 INFO - no previously-included directories found matching '.git*' 22:39:11 INFO - Installing collected packages: jsonschema, functools32 22:39:11 INFO - Running setup.py install for functools32 22:39:11 INFO - warning: no files found matching '*.txt' 22:39:11 INFO - no previously-included directories found matching 'build' 22:39:11 INFO - no previously-included directories found matching 'dist' 22:39:11 INFO - no previously-included directories found matching '.git*' 22:39:12 INFO - Successfully installed jsonschema functools32 22:39:12 INFO - Cleaning up... 22:39:12 INFO - Return code: 0 22:39:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:39:12 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 0x10e8a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb325a33c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, '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.MCCwWVnQyk/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.XTDx5Yp8sc/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 22:39:12 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 22:39:12 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 22:39:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:12 INFO - 'HOME': '/Users/cltbld', 22:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:12 INFO - 'LOGNAME': 'cltbld', 22:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:12 INFO - 'MOZ_NO_REMOTE': '1', 22:39:12 INFO - 'NO_EM_RESTART': '1', 22:39:12 INFO - 'PAGER': '/bin/cat', 22:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:12 INFO - 'PWD': '/builds/slave/test', 22:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:12 INFO - 'SHELL': '/bin/bash', 22:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:39:12 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:12 INFO - 'USER': 'cltbld', 22:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:12 INFO - 'XPC_FLAGS': '0x0', 22:39:12 INFO - 'XPC_SERVICE_NAME': '0', 22:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:39:12 INFO - Downloading/unpacking flake8 22:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:39:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:39:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:39:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:39:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:15 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 22:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:39:16 INFO - no previously-included directories found matching 'docs/_build' 22:39:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:39:16 INFO - Running setup.py install for pep8 22:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:39:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:39:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:39:16 INFO - no previously-included directories found matching 'docs/_build' 22:39:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:39:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:39:16 INFO - Cleaning up... 22:39:16 INFO - Return code: 0 22:39:16 INFO - Running post-action listener: _resource_record_post_action 22:39:16 INFO - Running post-action listener: _start_resource_monitoring 22:39:16 INFO - Starting resource monitoring. 22:39:16 INFO - ##### 22:39:16 INFO - ##### Running install step. 22:39:16 INFO - ##### 22:39:16 INFO - Running pre-action listener: _resource_record_pre_action 22:39:16 INFO - Running main action method: install 22:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:39:17 INFO - Reading from file tmpfile_stdout 22:39:17 INFO - Detecting whether we're running mozinstall >=1.0... 22:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:39:17 INFO - Reading from file tmpfile_stdout 22:39:17 INFO - Output received: 22:39:17 INFO - Usage: mozinstall [options] installer 22:39:17 INFO - Options: 22:39:17 INFO - -h, --help show this help message and exit 22:39:17 INFO - -d DEST, --destination=DEST 22:39:17 INFO - Directory to install application into. [default: 22:39:17 INFO - "/builds/slave/test"] 22:39:17 INFO - --app=APP Application being installed. [default: firefox] 22:39:17 INFO - mkdir: /builds/slave/test/build/application 22:39:17 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'] 22:39:17 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 22:39:50 INFO - Reading from file tmpfile_stdout 22:39:50 INFO - Output received: 22:39:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:39:50 INFO - Running post-action listener: _resource_record_post_action 22:39:50 INFO - ##### 22:39:50 INFO - ##### Running run-tests step. 22:39:50 INFO - ##### 22:39:50 INFO - Running pre-action listener: _resource_record_pre_action 22:39:50 INFO - Running main action method: run_tests 22:39:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:39:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:39:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:39:50 INFO - 2016-04-04 22:39:50.735 screenresolution[1646:7584] starting screenresolution argv=screenresolution get 22:39:50 INFO - 2016-04-04 22:39:50.738 screenresolution[1646:7584] Display 0: 1600x1200x32@60 22:39:50 INFO - 2016-04-04 22:39:50.743 screenresolution[1647:7586] starting screenresolution argv=screenresolution list 22:39:50 INFO - Available Modes on Display 0 22:39:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:39:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:39:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:39:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:39:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:39:50 INFO - Intel Iris: 22:39:50 INFO - Chipset Model: Intel Iris 22:39:50 INFO - Type: GPU 22:39:50 INFO - Bus: Built-In 22:39:50 INFO - VRAM (Dynamic, Max): 1536 MB 22:39:50 INFO - Vendor: Intel (0x8086) 22:39:50 INFO - Device ID: 0x0a2e 22:39:50 INFO - Revision ID: 0x0009 22:39:50 INFO - Displays: 22:39:50 INFO - Display: 22:39:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:39:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:39:50 INFO - Display Serial Number: 1600x1200 60 22:39:50 INFO - Main Display: Yes 22:39:50 INFO - Mirror: Off 22:39:50 INFO - Online: Yes 22:39:50 INFO - Rotation: Supported 22:39:50 INFO - Return code: 0 22:39:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:39:50 INFO - Python 2.7.3 22:39:50 INFO - Return code: 0 22:39:50 INFO - grabbing minidump binary from tooltool 22: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')]} 22:39:50 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 0x10e743e00>, '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 0x10e5acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e73eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:39:50 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 22:39:50 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 22:39:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:39:51 INFO - Return code: 0 22:39:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:39:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:39:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:39:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:39:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:39:52 INFO - Return code: 0 22:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MCCwWVnQyk/Render', 22:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:39:52 INFO - 'HOME': '/Users/cltbld', 22:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:39:52 INFO - 'LOGNAME': 'cltbld', 22:39:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:39:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:52 INFO - 'MOZ_NO_REMOTE': '1', 22:39:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:39:52 INFO - 'NO_EM_RESTART': '1', 22:39:52 INFO - 'PAGER': '/bin/cat', 22:39:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:52 INFO - 'PWD': '/builds/slave/test', 22:39:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:39:52 INFO - 'SHELL': '/bin/bash', 22:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTDx5Yp8sc/Listeners', 22:39:52 INFO - 'TMPDIR': '/var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/', 22:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:39:52 INFO - 'USER': 'cltbld', 22:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:52 INFO - 'XPC_FLAGS': '0x0', 22:39:52 INFO - 'XPC_SERVICE_NAME': '0', 22:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:39:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:39:52 INFO - mozversion application_buildid: 20160404203620 22:39:52 INFO - mozversion application_changeset: fd37367d1b1f2952c7a970c4b41e650d7233c717 22:39:52 INFO - mozversion application_display_name: Nightly 22:39:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:39:52 INFO - mozversion application_name: Firefox 22:39:52 INFO - mozversion application_remotingname: firefox 22:39:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:39:52 INFO - mozversion application_vendor: Mozilla 22:39:52 INFO - mozversion application_version: 48.0a1 22:39:52 INFO - mozversion platform_buildid: 20160404203620 22:39:52 INFO - mozversion platform_changeset: fd37367d1b1f2952c7a970c4b41e650d7233c717 22:39:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:39:52 INFO - mozversion platform_version: 48.0a1 22:39:52 INFO - using testdate: 1459834792 22:39:52 INFO - actual date: 1459834792 22:39:52 INFO - starting webserver on 'localhost:49278' 22:39:52 INFO - SUITE-START | Running 2 tests 22:39:52 INFO - TEST-START | dromaeo_css 22:39:52 INFO - operating with platform_type : mac_ 22:39:52 INFO - Initialising browser for dromaeo_css test... 22:39:52 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpPvCKKQ/profile http://localhost:49278/getInfo.html) 22:39:54 INFO - PROCESS | 1665 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:39:55 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 22:39:55 INFO - PROCESS | 1665 | colorDepth:24 22:39:55 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 22:39:55 INFO - PROCESS | 1665 | __metrics 22:39:55 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 22:39:55 INFO - TEST-INFO | 1665: exit 0 22:39:55 INFO - Browser initialized. 22:39:55 INFO - Running cycle 1/1 for dromaeo_css test... 22:39:55 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpPvCKKQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:40:07 INFO - PROCESS | 1668 | RSS: Main: 246726656 22:40:07 INFO - PROCESS | 1668 | 22:40:57 INFO - PROCESS | 1668 | 1459834857376 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] 22:43:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 22:43:09 INFO - PROCESS | 1668 | RSS: Main: 257437696 22:43:09 INFO - PROCESS | 1668 | 22:46:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 22:46:12 INFO - PROCESS | 1668 | RSS: Main: 270213120 22:46:12 INFO - PROCESS | 1668 | 22:49:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 22:49:14 INFO - PROCESS | 1668 | RSS: Main: 271966208 22:49:14 INFO - PROCESS | 1668 | 22:52:16 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 22:52:17 INFO - PROCESS | 1668 | RSS: Main: 275435520 22:52:17 INFO - PROCESS | 1668 | 22:55:19 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 22:55:20 INFO - PROCESS | 1668 | RSS: Main: 275005440 22:55:20 INFO - PROCESS | 1668 | 22:58:22 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 22:58:22 INFO - PROCESS | 1668 | RSS: Main: 279093248 22:58:22 INFO - PROCESS | 1668 | 22:58:22 INFO - PROCESS | 1668 | __start_tp_report 22:58:22 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 22:58:22 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 22:58:22 INFO - PROCESS | 1668 | |i|pagename|runs| 22:58:22 INFO - PROCESS | 1668 | |0;dojo.html;3508.193115583416;3543.5393398858155;3575.9821200893994;3580.3913334733093;3607.2244467439496;4557.293619488976;5783.566232532556;5809.564282678795;5812.302523697152;5823.563232757544;5762.827115186541;5874.118882167677;5936.673482958436;5942.732577034033;6081.695915204245;5260.316158899357;5260.842174734764;5343.866403339928;5379.354477462691;5390.326209223847;5295.258663787073;5361.490658387447;5377.193420986844;5432.320959880015;5436.21174929635;5223.138182199932;5340.198970154469;5343.786248550073;5351.277577527023;5354.143337066051;5330.840074797762;5347.438518955531;5348.064088784486;5353.518183363477;5360.303160589137;5196.32447781786;5268.5521730652945;5332.413434522199;5368.677879327252;5397.433269506684;5793.333766616851;5837.211976383176;5843.883122337529;5871.031279838821;5884.52923766102;6216.813495595139;6264.7807326743805;6270.153529273535;6271.466925311354;6274.184356033732;6159.168512250833;6239.003518873962;6241.375862413723;6277.52918531112;6299.370062993664;6049.576529642883;6052.394760523956;6053.8486537836025;6086.239220097488;6124.7243874025335;6361.0414753407185;6411.230652321751;6411.871762564722;6417.9679101605125;6440.066190402459;6131.682521312696;6202.224721909762;6228.564000520011;6283;6306.527010474233;6254.186955695731;6281.120643109968;6306.432421082033;6318.052292156121;6323.146375239376;4643.605293550086;5349.732513374393;5432.402435732066;6103.2164526668375;6151.96924015377;5141.511556402136;6125.632272693312;6246.593971391845;6260;6270.7491700331475;4345.152695224464;4951.752412379366;5006.574441172468;5012.147934851084;5047.924281135786;3774.452704357908;4505.707129036602;4528.366028755977;4530.478994915561;4561.201789686792;5780.855478612984;5919.822405327847;5963.940360596339;5995.490383317379;6000.33996260411;6247.96876015617;6252.437280644764;6323.936760632335;6343.460805831463;6350.650714210763;5970;5989.431004054608;6010.729517171738;6042.728077236535;6044.637321760709;5405.135178371442;5488.780448782084;5537.2524709163745;5564.916526252109;5587.217789509472;5232.215167724872;5840.503557197686;6457.838554036092;6499.2850786413455;6508.414242718178;5194.610404219774;5283.2075188722;6296.748130074929;6310.716017779119;6326.3041065483685;5374.2171111963935;6435.549511534147;6467.773627923;6506.772262970773;6534.444572211225;6254.593451425642;6277.529185311028;6295.433410993032;6322.2729386119345;6335.90496142549;5507.779688812403;5567.24842146305;6043.912095822794;6242.65665388408;6247.5939063960695;6135.416406698409;6137.989923150331;6170.444659980623;6195.690215489298;6253.249610046823;4844.903101938012;6177.320494745664;6203.844903877439;6234.189555357956;6234.844128896632;6016.969915150396;6047.576669633084;6149.0776383542825;6157.384261573807;6163.907541386972;5948.821535353946;6168.136460895568;6189;6242.469390101892;6284.371562843679;6143.754249829957;6180.381961803783;6181.1655426516845;6195.473384762346;6203.565750397429 22:58:22 INFO - PROCESS | 1668 | |1;ext.html;449.8875281179707;475.32503844540736;561.1358507897837;574.253470488365;629.7764293675745;32207;38312;38344.80827595862;38429;38452.038699032506;39185.41221881674;39213.21573568527;39639.009024774394;39713.00717482065;39846.80076599613;9297.767555811108;9495.620175192984;9535.380200286994;9555.378900371454;9564.56959436827;9414.858777118348;9422.246220302359;9430.811383772321;9435.15083642472;9444;9391.154796068353;9418.340716149873;9472.857907131398;9491.14579687828;9505.762355941122;9483.478408687519;9499.145076943109;9564.665236716717;9581.664641737541;9594.90405095947;9492.240620750323;9585.185259252972;9608.903910960871;9658.855117173249;9669.854952175723;38384.61615383838;38550.03624909372;38843.61156388428;39057.609423905684;39063.60936390628;2634.4599357131933;3050.5119180930947;3488.0930957950864;3664.175560498893;3963.4054891766177;27100.593491097454;27349.179524614294;27876.581851272247;27920.441591168063;28722.673857451377;2755.834649921011;2765.6542932133484;2768.6400767900045;2771.237909574863;2837.233946834343;409965;410084;415067.9246603778;415593;416627.91686041676;58663.41336586665;66142.6771464568;66324.01027969169;66731;66758.66620666963;57828;70170.64914675496;74305.6284718573;75192.62403687947;75320;16550.917245413697;16786.244618992176;16989.150542472828;17076.89000214982;17096;12501.937490312672;12672.11295209345;12754.298513581842;12857.485700571873;12956.28740419286;21584.92075396224;21606.891965540388;21824.345269641937;21924.013419396164;21995;7632.503887247422;9358.906410935939;9383.202427793578;9398.812023759487;9404.717858464257;923.8060007398522;937.9108984646448;1138.8120960041665;1163.964071975942;1192.3084610925641;29264.853675731487;29686.0870688541;29914;29925.25186870302;30203.848980754956;1038.4081073787868;1120.3222050659397;1129.6949823547761;1173.02052785923;1181.7990941539958;12055.939720301518;12491.625251242478;14188.574342769733;15067.171305578078;15452.918295719192;543585;543928;549126;550865;551992;58707.412925871045;58847.82304353889;59151.70424147852;59268.70365648144;59752.50618734479;1299.259422129377;1405.6696676281065;1447.5874375802846;1475.25499622692;1483.0953118597647;29383.412331753672;29393.559096613997;29617.407651847272;29951.251218719706;30108.54837177488;52244.21633675574;52378.21432678589;52558.211626824865;52645;52715;416657;424716;424969;427452;430924;32428.83785581057;33693.32613347768;33841.49237761386;34157.487637685954;34170.31659366848;44221.83002311739;45026.3246051316;45284.54715452803;45630;46563.76718116523;36522.8173859129;37073.44389834101;37304.44043339406;37845.43231851579;37956.24087518289;27301.044463443683;36916.446253306756;37103.44344834776;37511;37857.432138518496;36905.63094369022;36937.44593831148;37009.62990370062;37115.515379384524;37279.06802329855;29281.85359073191;32416.675833241366;32714.018579442654;33048.33903321968;33407.83296083504;24854.627180591942;24905.62641560342;25138.62292065584;25186.359715386603;25350.619740703536 22:58:22 INFO - PROCESS | 1668 | |2;jquery.html;351.6255188224539;361.1224723920873;362.80045974713903;364.9744517883749;366.53084052412913;18366;18817.717734233996;19593.11830967606;19611.803881961176;19638.214471421143;19136.80863191368;19974.800251997476;20105.29631462899;20194.394168174942;20427.693584596243;5456.836294911149;5616.691081990489;5659.51894089003;5736.311642602894;5764.106563482646;5421.783128674848;5632.155176723483;5642.74607642655;5664.235328230678;5713.800016999406;5587.38538760736;5664.20701101846;5688.288963879515;5710.514606258473;5730.512906402961;5356.143017117242;5642.74607642653;5693.658380497183;5694.886102277952;5697.43025697429;4929.383827021622;4939.506049395031;4962.553370196663;4964.379452568429;4978.726170060645;24816.131435399675;25005;25183;25271.115510957028;25630.718464076723;2122.1193204819983;2221.577900198957;2234.3855439754034;2241.1595651630637;2806.6070750095005;9546;9899.851502227473;10074.395536267848;12537.811932821014;14603.634909127251;1693.9237734301987;1707.3512065415186;1730.9913450432794;1761.4891681412375;1787.294018862542;92561.53719231428;94990;102776.48611756969;104042;106264;11062.557497700163;11256.380899050468;11267.211295209258;11283.887161128448;11356.829647555292;13696.109752866032;13717;13732.382042807898;13791.655208619864;13805.447782088604;8350.164983501723;8496.660133594587;8532.061473237938;8582.184692454206;8609.397342185986;7554.924450755422;8521.488710677379;8524.70163544273;8640.654373824977;8720.127987201357;4325.243082460557;4352.978235108868;4419.64642828573;4463.754493502824;4480.596746292849;1563.5543869996995;1891.5743957609427;1911.4361263427322;1935.7580302462193;1940.5827747034455;900.9774755631031;923.9353245272766;959.2374062620233;974.0746291023556;977.0815433492494;14561.277588372519;19354.516137096685;19634.803651963583;20803.68794468084;20867.269645562636;898.7438580004667;908.7913075609424;909.2180724576858;954.5847556312888;1027.7893031928436;10878.238523303293;11160.386178760245;11163.441827908571;11165.609203677832;11217.775644487065;617576;623577;631961;643790;648046;67049;116028.41985790017;117526.8247317533;119604;121131;975.1272611013245;986.5807032011367;1006.8993100690019;1006.959721611142;1031.3554028731892;17809;17914.820851791836;18065.54836129055;18366.81633183651;18395.54011149732;48186.75906620585;48955.79992340698;49709.75145124251;50793.730156744896;51435.48564514457;70498.64750676419;71734;72396.63801680958;72804.63597681977;72819.63590182015;7751.457397982313;7871.173526779835;7880.881786773089;7981.201879812204;8226.876596851173;9065;11801;12303.69240768988;12670.746585068062;12796.232226066466;8603.881495405558;10147.543360548942;10554.313969591953;10919.454027298762;10976.35354696802;8795.824083518166;10499.527521261409;10712.625058122929;10755.032047115797;11197.720056998314;8824.91175088241;10710;11055.336679799238;11130.888691112985;11224;7381.298776616213;7711.344535714527;7882.487638303492;7922.920770792219;8165.836683266421;9285.535723213947;10542.631007914686;10727.463626818784;10792.56829726802;10932.016118549369 22:58:22 INFO - PROCESS | 1668 | |3;mootools.html;1433.4409580263696;1590.7772911792351;1819.3905041810992;1948.4836518322657;1963.8919859407727;7907.44647874649;8537.658493660247;8651.351148663853;8846.071162527931;8926.687565935194;8587.48475091495;8595.742127736177;8689.608967596458;8691.130886911305;8692.34807389445;2455.103887081216;2471.4439251168524;2472.7156377016604;2474.072222916406;2479.169478224797;2414.517096580682;2475.591527397977;2475.851448913062;2479.3925488255313;2502.4995000999784;2435.841670291434;2453.129139155601;2481.962770558443;2484.3789052736815;2489.800815934721;2442.7679370459778;2456.4227406559444;2466.950660986779;2469.703635563744;2471.233917485576;2431.0397393029652;2440.2069327468466;2463.1502131764514;2463.507298540281;2478.566250906102;8839.116088391109;8887.866681999774;8905.376623636348;8910.732678019669;8917.821643567093;4434.135343607998;4770.45139808923;5444.7822087116865;5454.945450545523;5461.754221060062;3562.305350456662;3641.035125691694;3665.560132784083;3667.8899633010788;3691.7969511676847;886.8093359927582;1030.7680771826354;1046.748780292732;1047.0367262118868;1052.7999680060764;11455.484503197376;11461.598844040502;11578.652640420802;11681.007114395286;11903.512060992376;4833.347498087784;4913.87715307113;4948.331975183304;4976.735585308676;4980.551750342414;10045.39273716202;10156.289059765893;10158.288919775692;10175.84736228957;10195.898041019644;5467.371252305956;5469.480399362054;5484.067708489566;5561.805336813273;5564.527015203753;4454.331850222427;4845.927311090337;4948;4955.083309587666;5009.824656137018;3860.7876566788536;3929.76421414716;3933.252681990413;3950.940735888964;3986.1629057897585;1312.9146605470614;1315.0794443889315;1316.2036967634635;1328.31591730259;1337.3714354253486;1088.6679562733284;1102.2339474065448;1292.515306759965;1355.722076974218;1389.7984792205073;8133.10535841057;8202;8231.34149268057;8243.711470098518;8261.339092872557;502.24913753938097;517.5600739371579;521.3196778204403;523.7486006716797;524.3759925688419;6122.173506576644;6208.410201030985;6213.099100630383;6275.058741188767;6277.811665650038;10450.843237351446;10807.78384432307;10810.783784324269;10838.67483975482;10941.83587246192;10367.688969330931;10558.52486638103;10622.575096996188;10625.84061239082;10664.946675266574;8335.49987000782;8408.453450525696;8413.663453461793;8421.284190843724;8430.662773489114;7731.574763387843;7885;7929.484583502054;7930.643121059451;7937.722179723682;8423.199796019368;9139.451632902048;9483.66807161746;9507.429554226768;9683.080107389787;9437.19783818383;9719.319647624881;9765.9023409765;9850;9885.802283954137;5996.2504686914135;6839.965800171166;7249.166345870292;7471.290227428385;7492.063492063492;8206.753797386087;8277.006759188936;8329.541875196923;8334.624941877752;8341.24928756415;6257.843553911189;7188.741970155306;7296.306850849161;7308.926910730825;7448.664810083451;6083.574149809648;7164;7227.530210536298;7295.306945840137;7313.890291645736;7540.057492813398;7607.619619019138;7621.618919053914;7673.616319183907;7720.227977202235;5993.910091348721;6969.54697944632;6983.057287266154;7024.859502810017;7094.006839042641;6391.201099862517;7095.82260443493;7119.252478489684;7124.536905101152;7165.498415110892 22:58:23 INFO - PROCESS | 1668 | |4;prototype.html;291.82782158526476;329.9373119107369;330.00832498342476;334.33501164202255;337.77706713569034;6890.931090689091;6961.860762784754;6970.790876273707;6977.930220697798;7003.684834182462;6797.864042719143;6856.417204537608;6912.481563882704;6944.51388402812;6958.234594194634;4517.254652982254;4762.714237145782;4817.205161148407;4938.728369939652;5103.260027296049;4186.434831297766;5018.071656743496;5019.799208031693;5036.84889453317;5106.668066575679;5041.420236672775;5071.873203169914;5082.110630639641;5082.339295891529;5098.133317336044;5064.772085256135;5089.160288552384;5094.923576146361;5097.464766199551;5119.360079990001;4348.434703488526;4348.673849461303;4357.629601483846;4361.5856493633055;4362.781860906974;6303.590266632654;6608.834779130512;6654;6659.467242620579;6664.866702665968;5825.475707186331;5840;5869.50109240715;5883;5924.674142922137;7342.192358840523;7347.595882226476;7358.77923662291;7361.4846960712775;7372.299631534996;4686.671932964694;4695.694779839299;4695.980728286835;4700.788464519105;4715.127701375257;7397.186309506003;7724.845503089907;7799.96100019502;7833.64748586315;7845.254700803414;4473.888152796206;4553.658475614342;4629.166749984967;4694.2723877799;4717.646176536773;4772.95227047732;4789.185838407479;4792.185328494164;4797.376341075638;4805.615550756001;5717.199592057115;5765.625234359753;5775.711214439261;5789.421057894261;5868.618539794899;7401.629918504161;7420.220876807965;7420.480566360411;7434.851302974019;7446.553206807609;1574.2443627059076;1624.3908534299637;1653.2395098254697;1655.1393275496914;1677.3123019561922;1041.8593489878922;1050.2700623066896;1062.1555863088863;1068.2041878800344;1068.3494001767288;6776.9322306777285;6813.761518346834;6814.693338799766;6835.624040677711;6848.760293389708;7643.69425222996;7661.731839385706;7668.65491052904;7669.616519174019;7708.2291770823595;6743.460523158135;6800.761973331008;6819.829504262334;6820.386165245052;6835.350641689031;3722.1625134344554;4028.3957406389277;4059.6955228357992;4061.614146656063;4068.613481719291;5762.530554708523;6287.402696743893;6482.384173503604;7788.9095526626315;7999.080220747095;7278;7990.520568765776;8000.159983201796;8008.27925486709;8013.318867896178;8056.476329038594;8086.636101375452;8096.10942796292;8128.691793349534;8129.227723366271;6129.743402602545;7645.235476452311;7738.41961852852;7755.72854950074;7770.106437759504;7525.774226773206;7575.469717119749;7581.12817026027;7584.355329797029;7611.238876112345;6490.805275841543;8034;8052.194780522135;8055.637496312563;8087.47431416956;4708.623310135113;4748.358971538798;4748.92876606858;4755.358026666356;4776.9761151194025;6002.309734380602;7667.424943129399;7704.884426733715;7724;7730.92269077302;5848.590598658053;6046.7278972445465;7359.153697324876;7409.999650047174;7441.441891858024;7330.853382932418;7345.338919497271;7393.1497877742595;7398.11222653285;7419.258074192538;7171.318724721144;7245.311695388929;7250.274972502708;7258.274172582699;7265.128184617668;7108.3602475777425;7365.410767138723;7411.62941852916;7451.850962980601;7475.289847464483;7254.528455650577;7298.919807854736;7314.195438501867;7331.78004659861;7340.15588207363 22:58:23 INFO - PROCESS | 1668 | |5;yui.html;675.4090171100286;684.8596037812248;692.7402224165937;737.3769165055533;786.7010535996324;12015.339156346397;14545.709085818276;14724.969252152367;14758.778618320734;14811.185384803844;13485.528006519773;15208;15444.073355598672;15458.222304434994;15474.61313467164;906.9183773460404;914.5107367558358;917.1241464401514;920.4799288402031;921.2491819167391;740.459464590849;908.6683360573376;917.4082716647758;929.2426672262119;935.1910597333292;852.7910661887846;973.1387721866164;974.790420059687;976.6874600127962;981.0434826044585;930.3022732950287;940.5344354544544;952.552300418802;966.5553845231202;969.6606187834273;689.0835189198405;720.272524750001;725.960072196029;726.2991213478965;730.9488335816495;12647.43086561107;14977.1013739176;15033.398664053424;15136.167510786903;15225.467108651255;12028.27830330183;12349.814752778715;12396.755710990365;12562.74874502514;12628.621141365773;8862.468251904842;9192.724218273463;10201.387916724945;10805.945970270099;11413.714657133554;3447.5580623097985;3465.6707612777;3521.9295614087573;3550.449680299532;3556.928861422757;69698;69965;70652.29347706509;70728.6463567684;71881.28118718798;9140.725778226664;9253;9310.022447643036;9417.340786144903;9452.10957808441;20186.798132018786;20427.8978605109;20845.478863028242;20879.47801304949;20886.791132088485;7314.171457135716;7431.966973441015;7549.5847728374365;7566.772996810105;7628.54228746277;4001.0197501612292;4018.1361007383553;4123.319652257344;4143.02638879863;4162.375643653476;3614.0603443104455;3617.2042150726797;3619.8914032579064;3667.7249206309634;3693.5779724805607;588.9882202356015;658.7694306992514;673.1148539670415;688.0985908459834;698.3575110897884;566.5297802823646;582.5637768393652;600.177756473634;610.9837536130751;613.6471528870917;7908.130105688369;7940.523568585903;8014.2386473286115;8092.109867914524;8135.145809690016;517.3821830789684;583.4602992232168;584.4885724990634;609.5458883132095;617.9803324514587;3773.8301776420126;3830.9808450958126;3849.095462566295;3871.7096217783214;3882;78064.60967695125;78625.2137478618;79278;85155;98092;62685.37314626887;63318.41703957438;63783.72432551323;69454.30545694579;73213;60253;60374;60729;60780;62030.37969620336;8247.051589067334;8285.130061343472;8445.451045682012;8449.87325190135;8628.266597339296;44241.33637995368;45784.7710761444;50009.74975625639;50338;51175.74412127915;53739.19391209213;62021.68989155025;65618.67190664016;65637.34362656312;68332.63334733377;10497.842532362174;10700;10733.087687546333;10964.890351096386;11049.668509944715;11682.649520514398;11689.88310116922;11805.645830625095;12115;12356.135070544975;10982.450877455936;11031.393273370042;11088.833667495155;11250.774984500427;11305.321680699184;11120.277181983145;11318.94340528292;11553;11913.106517011433;12092.313938691712;9066.773330666787;10759.196556098219;11036;11069;11351.829722554003;9246.630134794534;9578.616855325989;9605.855912161463;9646.42121472714;9682.806343873224;8014.959925200336;9467.810643786948;9532.95233523828;9602.279829012712;9671 22:58:23 INFO - PROCESS | 1668 | __end_tp_report 22:58:23 INFO - PROCESS | 1668 | __start_cc_report 22:58:23 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,353 22:58:23 INFO - PROCESS | 1668 | __end_cc_report 22:58:23 INFO - PROCESS | 1668 | __startTimestamp1459835902987__endTimestamp 22:58:23 INFO - PROCESS | 1668 | 22:58:23 INFO - PROCESS | 1668 | ------- Summary: start ------- 22:58:23 INFO - PROCESS | 1668 | Number of tests: 6 22:58:23 INFO - PROCESS | 1668 | 22:58:23 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5778.62 Median:6043.91 stddev:654.13 (10.8%) stddev-sans-first:631.42 22:58:23 INFO - PROCESS | 1668 | Values: 3508.2 3543.5 3576.0 3580.4 3607.2 4557.3 5783.6 5809.6 5812.3 5823.6 5762.8 5874.1 5936.7 5942.7 6081.7 5260.3 5260.8 5343.9 5379.4 5390.3 5295.3 5361.5 5377.2 5432.3 5436.2 5223.1 5340.2 5343.8 5351.3 5354.1 5330.8 5347.4 5348.1 5353.5 5360.3 5196.3 5268.6 5332.4 5368.7 5397.4 5793.3 5837.2 5843.9 5871.0 5884.5 6216.8 6264.8 6270.2 6271.5 6274.2 6159.2 6239.0 6241.4 6277.5 6299.4 6049.6 6052.4 6053.8 6086.2 6124.7 6361.0 6411.2 6411.9 6418.0 6440.1 6131.7 6202.2 6228.6 6283.0 6306.5 6254.2 6281.1 6306.4 6318.1 6323.1 4643.6 5349.7 5432.4 6103.2 6152.0 5141.5 6125.6 6246.6 6260.0 6270.7 4345.2 4951.8 5006.6 5012.1 5047.9 3774.5 4505.7 4528.4 4530.5 4561.2 5780.9 5919.8 5963.9 5995.5 6000.3 6248.0 6252.4 6323.9 6343.5 6350.7 5970.0 5989.4 6010.7 6042.7 6044.6 5405.1 5488.8 5537.3 5564.9 5587.2 5232.2 5840.5 6457.8 6499.3 6508.4 5194.6 5283.2 6296.7 6310.7 6326.3 5374.2 6435.5 6467.8 6506.8 6534.4 6254.6 6277.5 6295.4 6322.3 6335.9 5507.8 5567.2 6043.9 6242.7 6247.6 6135.4 6138.0 6170.4 6195.7 6253.2 4844.9 6177.3 6203.8 6234.2 6234.8 6017.0 6047.6 6149.1 6157.4 6163.9 5948.8 6168.1 6189.0 6242.5 6284.4 6143.8 6180.4 6181.2 6195.5 6203.6 22:58:23 INFO - PROCESS | 1668 | 22:58:23 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:61508.91 Median:38406.81 stddev:123793.61 (322.3%) stddev-sans-first:124056.00 22:58:23 INFO - PROCESS | 1668 | Values: 449.9 475.3 561.1 574.3 629.8 32207.0 38312.0 38344.8 38429.0 38452.0 39185.4 39213.2 39639.0 39713.0 39846.8 9297.8 9495.6 9535.4 9555.4 9564.6 9414.9 9422.2 9430.8 9435.2 9444.0 9391.2 9418.3 9472.9 9491.1 9505.8 9483.5 9499.1 9564.7 9581.7 9594.9 9492.2 9585.2 9608.9 9658.9 9669.9 38384.6 38550.0 38843.6 39057.6 39063.6 2634.5 3050.5 3488.1 3664.2 3963.4 27100.6 27349.2 27876.6 27920.4 28722.7 2755.8 2765.7 2768.6 2771.2 2837.2 409965.0 410084.0 415067.9 415593.0 416627.9 58663.4 66142.7 66324.0 66731.0 66758.7 57828.0 70170.6 74305.6 75192.6 75320.0 16550.9 16786.2 16989.2 17076.9 17096.0 12501.9 12672.1 12754.3 12857.5 12956.3 21584.9 21606.9 21824.3 21924.0 21995.0 7632.5 9358.9 9383.2 9398.8 9404.7 923.8 937.9 1138.8 1164.0 1192.3 29264.9 29686.1 29914.0 29925.3 30203.8 1038.4 1120.3 1129.7 1173.0 1181.8 12055.9 12491.6 14188.6 15067.2 15452.9 543585.0 543928.0 549126.0 550865.0 551992.0 58707.4 58847.8 59151.7 59268.7 59752.5 1299.3 1405.7 1447.6 1475.3 1483.1 29383.4 29393.6 29617.4 29951.3 30108.5 52244.2 52378.2 52558.2 52645.0 52715.0 416657.0 424716.0 424969.0 427452.0 430924.0 32428.8 33693.3 33841.5 34157.5 34170.3 44221.8 45026.3 45284.5 45630.0 46563.8 36522.8 37073.4 37304.4 37845.4 37956.2 27301.0 36916.4 37103.4 37511.0 37857.4 36905.6 36937.4 37009.6 37115.5 37279.1 29281.9 32416.7 32714.0 33048.3 33407.8 24854.6 24905.6 25138.6 25186.4 25350.6 22:58:23 INFO - PROCESS | 1668 | 22:58:23 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:34426.34 Median:361.96 stddev:104603.87 (28899.2%) stddev-sans-first:104866.02 22:58:23 INFO - PROCESS | 1668 | Values: 351.6 361.1 362.8 365.0 366.5 18366.0 18817.7 19593.1 19611.8 19638.2 19136.8 19974.8 20105.3 20194.4 20427.7 5456.8 5616.7 5659.5 5736.3 5764.1 5421.8 5632.2 5642.7 5664.2 5713.8 5587.4 5664.2 5688.3 5710.5 5730.5 5356.1 5642.7 5693.7 5694.9 5697.4 4929.4 4939.5 4962.6 4964.4 4978.7 24816.1 25005.0 25183.0 25271.1 25630.7 2122.1 2221.6 2234.4 2241.2 2806.6 9546.0 9899.9 10074.4 12537.8 14603.6 1693.9 1707.4 1731.0 1761.5 1787.3 92561.5 94990.0 102776.5 104042.0 106264.0 11062.6 11256.4 11267.2 11283.9 11356.8 13696.1 13717.0 13732.4 13791.7 13805.4 8350.2 8496.7 8532.1 8582.2 8609.4 7554.9 8521.5 8524.7 8640.7 8720.1 4325.2 4353.0 4419.6 4463.8 4480.6 1563.6 1891.6 1911.4 1935.8 1940.6 901.0 923.9 959.2 974.1 977.1 14561.3 19354.5 19634.8 20803.7 20867.3 898.7 908.8 909.2 954.6 1027.8 10878.2 11160.4 11163.4 11165.6 11217.8 617576.0 623577.0 631961.0 643790.0 648046.0 67049.0 116028.4 117526.8 119604.0 121131.0 975.1 986.6 1006.9 1007.0 1031.4 17809.0 17914.8 18065.5 18366.8 18395.5 48186.8 48955.8 49709.8 50793.7 51435.5 70498.6 71734.0 72396.6 72804.6 72819.6 7751.5 7871.2 7880.9 7981.2 8226.9 9065.0 11801.0 12303.7 12670.7 12796.2 8603.9 10147.5 10554.3 10919.5 10976.4 8795.8 10499.5 10712.6 10755.0 11197.7 8824.9 10710.0 11055.3 11130.9 11224.0 7381.3 7711.3 7882.5 7922.9 8165.8 9285.5 10542.6 10727.5 10792.6 10932.0 22:58:23 INFO - PROCESS | 1668 | 22:58:23 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5997.60 Median:2984.58 stddev:3175.16 (106.4%) stddev-sans-first:3165.54 22:58:23 INFO - PROCESS | 1668 | Values: 1433.4 1590.8 1819.4 1948.5 1963.9 7907.4 8537.7 8651.4 8846.1 8926.7 8587.5 8595.7 8689.6 8691.1 8692.3 2455.1 2471.4 2472.7 2474.1 2479.2 2414.5 2475.6 2475.9 2479.4 2502.5 2435.8 2453.1 2482.0 2484.4 2489.8 2442.8 2456.4 2467.0 2469.7 2471.2 2431.0 2440.2 2463.2 2463.5 2478.6 8839.1 8887.9 8905.4 8910.7 8917.8 4434.1 4770.5 5444.8 5454.9 5461.8 3562.3 3641.0 3665.6 3667.9 3691.8 886.8 1030.8 1046.7 1047.0 1052.8 11455.5 11461.6 11578.7 11681.0 11903.5 4833.3 4913.9 4948.3 4976.7 4980.6 10045.4 10156.3 10158.3 10175.8 10195.9 5467.4 5469.5 5484.1 5561.8 5564.5 4454.3 4845.9 4948.0 4955.1 5009.8 3860.8 3929.8 3933.3 3950.9 3986.2 1312.9 1315.1 1316.2 1328.3 1337.4 1088.7 1102.2 1292.5 1355.7 1389.8 8133.1 8202.0 8231.3 8243.7 8261.3 502.2 517.6 521.3 523.7 524.4 6122.2 6208.4 6213.1 6275.1 6277.8 10450.8 10807.8 10810.8 10838.7 10941.8 10367.7 10558.5 10622.6 10625.8 10664.9 8335.5 8408.5 8413.7 8421.3 8430.7 7731.6 7885.0 7929.5 7930.6 7937.7 8423.2 9139.5 9483.7 9507.4 9683.1 9437.2 9719.3 9765.9 9850.0 9885.8 5996.3 6840.0 7249.2 7471.3 7492.1 8206.8 8277.0 8329.5 8334.6 8341.2 6257.8 7188.7 7296.3 7308.9 7448.7 6083.6 7164.0 7227.5 7295.3 7313.9 7540.1 7607.6 7621.6 7673.6 7720.2 5993.9 6969.5 6983.1 7024.9 7094.0 6391.2 7095.8 7119.3 7124.5 7165.5 22:58:23 INFO - PROCESS | 1668 | 22:58:23 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5971.82 Median:6799.31 stddev:1941.59 (28.6%) stddev-sans-first:1899.66 22:58:23 INFO - PROCESS | 1668 | Values: 291.8 329.9 330.0 334.3 337.8 6890.9 6961.9 6970.8 6977.9 7003.7 6797.9 6856.4 6912.5 6944.5 6958.2 4517.3 4762.7 4817.2 4938.7 5103.3 4186.4 5018.1 5019.8 5036.8 5106.7 5041.4 5071.9 5082.1 5082.3 5098.1 5064.8 5089.2 5094.9 5097.5 5119.4 4348.4 4348.7 4357.6 4361.6 4362.8 6303.6 6608.8 6654.0 6659.5 6664.9 5825.5 5840.0 5869.5 5883.0 5924.7 7342.2 7347.6 7358.8 7361.5 7372.3 4686.7 4695.7 4696.0 4700.8 4715.1 7397.2 7724.8 7800.0 7833.6 7845.3 4473.9 4553.7 4629.2 4694.3 4717.6 4773.0 4789.2 4792.2 4797.4 4805.6 5717.2 5765.6 5775.7 5789.4 5868.6 7401.6 7420.2 7420.5 7434.9 7446.6 1574.2 1624.4 1653.2 1655.1 1677.3 1041.9 1050.3 1062.2 1068.2 1068.3 6776.9 6813.8 6814.7 6835.6 6848.8 7643.7 7661.7 7668.7 7669.6 7708.2 6743.5 6800.8 6819.8 6820.4 6835.4 3722.2 4028.4 4059.7 4061.6 4068.6 5762.5 6287.4 6482.4 7788.9 7999.1 7278.0 7990.5 8000.2 8008.3 8013.3 8056.5 8086.6 8096.1 8128.7 8129.2 6129.7 7645.2 7738.4 7755.7 7770.1 7525.8 7575.5 7581.1 7584.4 7611.2 6490.8 8034.0 8052.2 8055.6 8087.5 4708.6 4748.4 4748.9 4755.4 4777.0 6002.3 7667.4 7704.9 7724.0 7730.9 5848.6 6046.7 7359.2 7410.0 7441.4 7330.9 7345.3 7393.1 7398.1 7419.3 7171.3 7245.3 7250.3 7258.3 7265.1 7108.4 7365.4 7411.6 7451.9 7475.3 7254.5 7298.9 7314.2 7331.8 7340.2 22:58:23 INFO - PROCESS | 1668 | 22:58:23 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:16952.07 Median:612.32 stddev:22844.81 (3730.9%) stddev-sans-first:22876.20 22:58:23 INFO - PROCESS | 1668 | Values: 675.4 684.9 692.7 737.4 786.7 12015.3 14545.7 14725.0 14758.8 14811.2 13485.5 15208.0 15444.1 15458.2 15474.6 906.9 914.5 917.1 920.5 921.2 740.5 908.7 917.4 929.2 935.2 852.8 973.1 974.8 976.7 981.0 930.3 940.5 952.6 966.6 969.7 689.1 720.3 726.0 726.3 730.9 12647.4 14977.1 15033.4 15136.2 15225.5 12028.3 12349.8 12396.8 12562.7 12628.6 8862.5 9192.7 10201.4 10805.9 11413.7 3447.6 3465.7 3521.9 3550.4 3556.9 69698.0 69965.0 70652.3 70728.6 71881.3 9140.7 9253.0 9310.0 9417.3 9452.1 20186.8 20427.9 20845.5 20879.5 20886.8 7314.2 7432.0 7549.6 7566.8 7628.5 4001.0 4018.1 4123.3 4143.0 4162.4 3614.1 3617.2 3619.9 3667.7 3693.6 589.0 658.8 673.1 688.1 698.4 566.5 582.6 600.2 611.0 613.6 7908.1 7940.5 8014.2 8092.1 8135.1 517.4 583.5 584.5 609.5 618.0 3773.8 3831.0 3849.1 3871.7 3882.0 78064.6 78625.2 79278.0 85155.0 98092.0 62685.4 63318.4 63783.7 69454.3 73213.0 60253.0 60374.0 60729.0 60780.0 62030.4 8247.1 8285.1 8445.5 8449.9 8628.3 44241.3 45784.8 50009.7 50338.0 51175.7 53739.2 62021.7 65618.7 65637.3 68332.6 10497.8 10700.0 10733.1 10964.9 11049.7 11682.6 11689.9 11805.6 12115.0 12356.1 10982.5 11031.4 11088.8 11250.8 11305.3 11120.3 11318.9 11553.0 11913.1 12092.3 9066.8 10759.2 11036.0 11069.0 11351.8 9246.6 9578.6 9605.9 9646.4 9682.8 8015.0 9467.8 9533.0 9602.3 9671.0 22:58:23 INFO - PROCESS | 1668 | -------- Summary: end -------- 22:58:23 INFO - PROCESS | 1668 | 22:58:23 INFO - TEST-INFO | 1668: exit 0 22:58:23 INFO - TEST-OK | dromaeo_css | took 1110890ms 22:58:23 INFO - TEST-START | kraken 22:58:23 INFO - operating with platform_type : mac_ 22:58:23 INFO - Initialising browser for kraken test... 22:58:23 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpjupsJV/profile http://localhost:49278/getInfo.html) 22:58:25 INFO - PROCESS | 1676 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 22:58:26 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 22:58:26 INFO - PROCESS | 1676 | colorDepth:24 22:58:26 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 22:58:26 INFO - PROCESS | 1676 | __metrics 22:58:26 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 22:58:26 INFO - TEST-INFO | 1676: exit 0 22:58:26 INFO - Browser initialized. 22:58:26 INFO - Running cycle 1/1 for kraken test... 22:58:26 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_p/g082hxs10zx5k7kq_ngsqt0h00000w/T/tmpjupsJV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:58:38 INFO - PROCESS | 1679 | RSS: Main: 246644736 22:58:38 INFO - PROCESS | 1679 | 22:58:41 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 22:58:41 INFO - PROCESS | 1679 | RSS: Main: 258760704 22:58:41 INFO - PROCESS | 1679 | 22:58:44 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 22:58:45 INFO - PROCESS | 1679 | RSS: Main: 268251136 22:58:45 INFO - PROCESS | 1679 | 22:58:48 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 22:58:49 INFO - PROCESS | 1679 | RSS: Main: 270729216 22:58:49 INFO - PROCESS | 1679 | 22:58:51 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 22:58:51 INFO - PROCESS | 1679 | RSS: Main: 271929344 22:58:51 INFO - PROCESS | 1679 | 22:58:54 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:58:54 INFO - PROCESS | 1679 | RSS: Main: 272183296 22:58:54 INFO - PROCESS | 1679 | 22:58:57 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 22:58:58 INFO - PROCESS | 1679 | RSS: Main: 274427904 22:58:58 INFO - PROCESS | 1679 | 22:59:01 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 22:59:01 INFO - PROCESS | 1679 | RSS: Main: 274178048 22:59:01 INFO - PROCESS | 1679 | 22:59:04 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 22:59:05 INFO - PROCESS | 1679 | RSS: Main: 274468864 22:59:05 INFO - PROCESS | 1679 | 22:59:06 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:59:07 INFO - PROCESS | 1679 | RSS: Main: 273416192 22:59:07 INFO - PROCESS | 1679 | 22:59:09 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:59:09 INFO - PROCESS | 1679 | RSS: Main: 273682432 22:59:09 INFO - PROCESS | 1679 | 22:59:11 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:59:12 INFO - PROCESS | 1679 | RSS: Main: 274571264 22:59:12 INFO - PROCESS | 1679 | 22:59:15 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:59:15 INFO - PROCESS | 1679 | RSS: Main: 274284544 22:59:15 INFO - PROCESS | 1679 | 22:59:18 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:59:19 INFO - PROCESS | 1679 | RSS: Main: 273956864 22:59:19 INFO - PROCESS | 1679 | 22:59:20 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 22:59:21 INFO - PROCESS | 1679 | RSS: Main: 276078592 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | __start_tp_report 22:59:21 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 22:59:21 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 22:59:21 INFO - PROCESS | 1679 | |i|pagename|runs| 22:59:21 INFO - PROCESS | 1679 | |0;ai-astar;114;111;113;115;115;124;115;114;118;115 22:59:21 INFO - PROCESS | 1679 | |1;audio-beat-detection;184;112;184;194;157;140;141;125;160;133 22:59:21 INFO - PROCESS | 1679 | |2;audio-dft;190;194;196;269;228;262;185;181;223;192 22:59:21 INFO - PROCESS | 1679 | |3;audio-fft;57;59;65;82;92;155;75;57;59;60 22:59:21 INFO - PROCESS | 1679 | |4;audio-oscillator;85;77;153;113;114;122;117;78;85;114 22:59:21 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;89;87;90;88;93;85;80;91;87;129 22:59:21 INFO - PROCESS | 1679 | |6;imaging-darkroom;95;99;95;132;102;148;117;95;96;96 22:59:21 INFO - PROCESS | 1679 | |7;imaging-desaturate;91;93;90;92;101;90;91;93;91;92 22:59:21 INFO - PROCESS | 1679 | |8;json-parse-financial;56;57;55;56;56;62;58;73;55;54 22:59:21 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;58;99;91;73;73;75;69;85;98;97 22:59:21 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;85;109;111;90;87;84;84;86;84;83 22:59:21 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;138;136;117;139;134;111;137;123;115;132 22:59:21 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;175;179;183;141;140;143;183;179;142;131 22:59:21 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;67;69;67;68;72;67;65;67;64;68 22:59:21 INFO - PROCESS | 1679 | __end_tp_report 22:59:21 INFO - PROCESS | 1679 | __start_cc_report 22:59:21 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,988 22:59:21 INFO - PROCESS | 1679 | __end_cc_report 22:59:21 INFO - PROCESS | 1679 | __startTimestamp1459835961045__endTimestamp 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | ------- Summary: start ------- 22:59:21 INFO - PROCESS | 1679 | Number of tests: 14 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.00 stddev:3.50 (3.0%) stddev-sans-first:3.68 22:59:21 INFO - PROCESS | 1679 | Values: 114.0 111.0 113.0 115.0 115.0 124.0 115.0 114.0 118.0 115.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:158.50 stddev:27.58 (17.4%) stddev-sans-first:26.88 22:59:21 INFO - PROCESS | 1679 | Values: 184.0 112.0 184.0 194.0 157.0 140.0 141.0 125.0 160.0 133.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:212.00 Median:209.50 stddev:32.11 (15.3%) stddev-sans-first:33.06 22:59:21 INFO - PROCESS | 1679 | Values: 190.0 194.0 196.0 269.0 228.0 262.0 185.0 181.0 223.0 192.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:76.10 Median:62.50 stddev:30.20 (48.3%) stddev-sans-first:31.24 22:59:21 INFO - PROCESS | 1679 | Values: 57.0 59.0 65.0 82.0 92.0 155.0 75.0 57.0 59.0 60.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:115.00 stddev:24.20 (21.0%) stddev-sans-first:24.47 22:59:21 INFO - PROCESS | 1679 | Values: 85.0 77.0 153.0 113.0 114.0 122.0 117.0 78.0 85.0 114.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:91.90 Median:88.50 stddev:13.51 (15.3%) stddev-sans-first:14.29 22:59:21 INFO - PROCESS | 1679 | Values: 89.0 87.0 90.0 88.0 93.0 85.0 80.0 91.0 87.0 129.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:95.00 stddev:18.76 (19.7%) stddev-sans-first:19.34 22:59:21 INFO - PROCESS | 1679 | Values: 95.0 99.0 95.0 132.0 102.0 148.0 117.0 95.0 96.0 96.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:91.50 stddev:3.20 (3.5%) stddev-sans-first:3.36 22:59:21 INFO - PROCESS | 1679 | Values: 91.0 93.0 90.0 92.0 101.0 90.0 91.0 93.0 91.0 92.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:56.50 stddev:5.65 (10.0%) stddev-sans-first:5.94 22:59:21 INFO - PROCESS | 1679 | Values: 56.0 57.0 55.0 56.0 56.0 62.0 58.0 73.0 55.0 54.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:81.80 Median:88.00 stddev:14.20 (16.1%) stddev-sans-first:12.18 22:59:21 INFO - PROCESS | 1679 | Values: 58.0 99.0 91.0 73.0 73.0 75.0 69.0 85.0 98.0 97.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:84.50 stddev:10.58 (12.5%) stddev-sans-first:11.05 22:59:21 INFO - PROCESS | 1679 | Values: 85.0 109.0 111.0 90.0 87.0 84.0 84.0 86.0 84.0 83.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:135.00 stddev:10.65 (7.9%) stddev-sans-first:10.69 22:59:21 INFO - PROCESS | 1679 | Values: 138.0 136.0 117.0 139.0 134.0 111.0 137.0 123.0 115.0 132.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:177.00 stddev:21.65 (12.2%) stddev-sans-first:22.23 22:59:21 INFO - PROCESS | 1679 | Values: 175.0 179.0 183.0 141.0 140.0 143.0 183.0 179.0 142.0 131.0 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:2.17 (3.2%) stddev-sans-first:2.30 22:59:21 INFO - PROCESS | 1679 | Values: 67.0 69.0 67.0 68.0 72.0 67.0 65.0 67.0 64.0 68.0 22:59:21 INFO - PROCESS | 1679 | -------- Summary: end -------- 22:59:21 INFO - PROCESS | 1679 | 22:59:21 INFO - TEST-INFO | 1679: exit 0 22:59:21 INFO - TEST-OK | kraken | took 58242ms 22:59:21 INFO - SUITE-END | took 1169s 22:59:21 INFO - Completed test suite (00:19:29) 22:59:21 INFO - javascript benchmark 22:59:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3508.193115583416, 3543.5393398858155, 3575.9821200893994, 3580.3913334733093, 3607.2244467439496, 4557.293619488976, 5783.566232532556, 5809.564282678795, 5812.302523697152, 5823.563232757544, 5762.827115186541, 5874.118882167677, 5936.673482958436, 5942.732577034033, 6081.695915204245, 5260.316158899357, 5260.842174734764, 5343.866403339928, 5379.354477462691, 5390.326209223847, 5295.258663787073, 5361.490658387447, 5377.193420986844, 5432.320959880015, 5436.21174929635, 5223.138182199932, 5340.198970154469, 5343.786248550073, 5351.277577527023, 5354.143337066051, 5330.840074797762, 5347.438518955531, 5348.064088784486, 5353.518183363477, 5360.303160589137, 5196.32447781786, 5268.5521730652945, 5332.413434522199, 5368.677879327252, 5397.433269506684, 5793.333766616851, 5837.211976383176, 5843.883122337529, 5871.031279838821, 5884.52923766102, 6216.813495595139, 6264.7807326743805, 6270.153529273535, 6271.466925311354, 6274.184356033732, 6159.168512250833, 6239.003518873962, 6241.375862413723, 6277.52918531112, 6299.370062993664, 6049.576529642883, 6052.394760523956, 6053.8486537836025, 6086.239220097488, 6124.7243874025335, 6361.0414753407185, 6411.230652321751, 6411.871762564722, 6417.9679101605125, 6440.066190402459, 6131.682521312696, 6202.224721909762, 6228.564000520011, 6283.0, 6306.527010474233, 6254.186955695731, 6281.120643109968, 6306.432421082033, 6318.052292156121, 6323.146375239376, 4643.605293550086, 5349.732513374393, 5432.402435732066, 6103.2164526668375, 6151.96924015377, 5141.511556402136, 6125.632272693312, 6246.593971391845, 6260.0, 6270.7491700331475, 4345.152695224464, 4951.752412379366, 5006.574441172468, 5012.147934851084, 5047.924281135786, 3774.452704357908, 4505.707129036602, 4528.366028755977, 4530.478994915561, 4561.201789686792, 5780.855478612984, 5919.822405327847, 5963.940360596339, 5995.490383317379, 6000.33996260411, 6247.96876015617, 6252.437280644764, 6323.936760632335, 6343.460805831463, 6350.650714210763, 5970.0, 5989.431004054608, 6010.729517171738, 6042.728077236535, 6044.637321760709, 5405.135178371442, 5488.780448782084, 5537.2524709163745, 5564.916526252109, 5587.217789509472, 5232.215167724872, 5840.503557197686, 6457.838554036092, 6499.2850786413455, 6508.414242718178, 5194.610404219774, 5283.2075188722, 6296.748130074929, 6310.716017779119, 6326.3041065483685, 5374.2171111963935, 6435.549511534147, 6467.773627923, 6506.772262970773, 6534.444572211225, 6254.593451425642, 6277.529185311028, 6295.433410993032, 6322.2729386119345, 6335.90496142549, 5507.779688812403, 5567.24842146305, 6043.912095822794, 6242.65665388408, 6247.5939063960695, 6135.416406698409, 6137.989923150331, 6170.444659980623, 6195.690215489298, 6253.249610046823, 4844.903101938012, 6177.320494745664, 6203.844903877439, 6234.189555357956, 6234.844128896632, 6016.969915150396, 6047.576669633084, 6149.0776383542825, 6157.384261573807, 6163.907541386972, 5948.821535353946, 6168.136460895568, 6189.0, 6242.469390101892, 6284.371562843679, 6143.754249829957, 6180.381961803783, 6181.1655426516845, 6195.473384762346, 6203.565750397429], "unit": "score", "name": "dojo.html", "value": 5741.816940349446}, {"lowerIsBetter": false, "replicates": [449.8875281179707, 475.32503844540736, 561.1358507897837, 574.253470488365, 629.7764293675745, 32207.0, 38312.0, 38344.80827595862, 38429.0, 38452.038699032506, 39185.41221881674, 39213.21573568527, 39639.009024774394, 39713.00717482065, 39846.80076599613, 9297.767555811108, 9495.620175192984, 9535.380200286994, 9555.378900371454, 9564.56959436827, 9414.858777118348, 9422.246220302359, 9430.811383772321, 9435.15083642472, 9444.0, 9391.154796068353, 9418.340716149873, 9472.857907131398, 9491.14579687828, 9505.762355941122, 9483.478408687519, 9499.145076943109, 9564.665236716717, 9581.664641737541, 9594.90405095947, 9492.240620750323, 9585.185259252972, 9608.903910960871, 9658.855117173249, 9669.854952175723, 38384.61615383838, 38550.03624909372, 38843.61156388428, 39057.609423905684, 39063.60936390628, 2634.4599357131933, 3050.5119180930947, 3488.0930957950864, 3664.175560498893, 3963.4054891766177, 27100.593491097454, 27349.179524614294, 27876.581851272247, 27920.441591168063, 28722.673857451377, 2755.834649921011, 2765.6542932133484, 2768.6400767900045, 2771.237909574863, 2837.233946834343, 409965.0, 410084.0, 415067.9246603778, 415593.0, 416627.91686041676, 58663.41336586665, 66142.6771464568, 66324.01027969169, 66731.0, 66758.66620666963, 57828.0, 70170.64914675496, 74305.6284718573, 75192.62403687947, 75320.0, 16550.917245413697, 16786.244618992176, 16989.150542472828, 17076.89000214982, 17096.0, 12501.937490312672, 12672.11295209345, 12754.298513581842, 12857.485700571873, 12956.28740419286, 21584.92075396224, 21606.891965540388, 21824.345269641937, 21924.013419396164, 21995.0, 7632.503887247422, 9358.906410935939, 9383.202427793578, 9398.812023759487, 9404.717858464257, 923.8060007398522, 937.9108984646448, 1138.8120960041665, 1163.964071975942, 1192.3084610925641, 29264.853675731487, 29686.0870688541, 29914.0, 29925.25186870302, 30203.848980754956, 1038.4081073787868, 1120.3222050659397, 1129.6949823547761, 1173.02052785923, 1181.7990941539958, 12055.939720301518, 12491.625251242478, 14188.574342769733, 15067.171305578078, 15452.918295719192, 543585.0, 543928.0, 549126.0, 550865.0, 551992.0, 58707.412925871045, 58847.82304353889, 59151.70424147852, 59268.70365648144, 59752.50618734479, 1299.259422129377, 1405.6696676281065, 1447.5874375802846, 1475.25499622692, 1483.0953118597647, 29383.412331753672, 29393.559096613997, 29617.407651847272, 29951.251218719706, 30108.54837177488, 52244.21633675574, 52378.21432678589, 52558.211626824865, 52645.0, 52715.0, 416657.0, 424716.0, 424969.0, 427452.0, 430924.0, 32428.83785581057, 33693.32613347768, 33841.49237761386, 34157.487637685954, 34170.31659366848, 44221.83002311739, 45026.3246051316, 45284.54715452803, 45630.0, 46563.76718116523, 36522.8173859129, 37073.44389834101, 37304.44043339406, 37845.43231851579, 37956.24087518289, 27301.044463443683, 36916.446253306756, 37103.44344834776, 37511.0, 37857.432138518496, 36905.63094369022, 36937.44593831148, 37009.62990370062, 37115.515379384524, 37279.06802329855, 29281.85359073191, 32416.675833241366, 32714.018579442654, 33048.33903321968, 33407.83296083504, 24854.627180591942, 24905.62641560342, 25138.62292065584, 25186.359715386603, 25350.619740703536], "unit": "score", "name": "ext.html", "value": 19774.43797661671}, {"lowerIsBetter": false, "replicates": [351.6255188224539, 361.1224723920873, 362.80045974713903, 364.9744517883749, 366.53084052412913, 18366.0, 18817.717734233996, 19593.11830967606, 19611.803881961176, 19638.214471421143, 19136.80863191368, 19974.800251997476, 20105.29631462899, 20194.394168174942, 20427.693584596243, 5456.836294911149, 5616.691081990489, 5659.51894089003, 5736.311642602894, 5764.106563482646, 5421.783128674848, 5632.155176723483, 5642.74607642655, 5664.235328230678, 5713.800016999406, 5587.38538760736, 5664.20701101846, 5688.288963879515, 5710.514606258473, 5730.512906402961, 5356.143017117242, 5642.74607642653, 5693.658380497183, 5694.886102277952, 5697.43025697429, 4929.383827021622, 4939.506049395031, 4962.553370196663, 4964.379452568429, 4978.726170060645, 24816.131435399675, 25005.0, 25183.0, 25271.115510957028, 25630.718464076723, 2122.1193204819983, 2221.577900198957, 2234.3855439754034, 2241.1595651630637, 2806.6070750095005, 9546.0, 9899.851502227473, 10074.395536267848, 12537.811932821014, 14603.634909127251, 1693.9237734301987, 1707.3512065415186, 1730.9913450432794, 1761.4891681412375, 1787.294018862542, 92561.53719231428, 94990.0, 102776.48611756969, 104042.0, 106264.0, 11062.557497700163, 11256.380899050468, 11267.211295209258, 11283.887161128448, 11356.829647555292, 13696.109752866032, 13717.0, 13732.382042807898, 13791.655208619864, 13805.447782088604, 8350.164983501723, 8496.660133594587, 8532.061473237938, 8582.184692454206, 8609.397342185986, 7554.924450755422, 8521.488710677379, 8524.70163544273, 8640.654373824977, 8720.127987201357, 4325.243082460557, 4352.978235108868, 4419.64642828573, 4463.754493502824, 4480.596746292849, 1563.5543869996995, 1891.5743957609427, 1911.4361263427322, 1935.7580302462193, 1940.5827747034455, 900.9774755631031, 923.9353245272766, 959.2374062620233, 974.0746291023556, 977.0815433492494, 14561.277588372519, 19354.516137096685, 19634.803651963583, 20803.68794468084, 20867.269645562636, 898.7438580004667, 908.7913075609424, 909.2180724576858, 954.5847556312888, 1027.7893031928436, 10878.238523303293, 11160.386178760245, 11163.441827908571, 11165.609203677832, 11217.775644487065, 617576.0, 623577.0, 631961.0, 643790.0, 648046.0, 67049.0, 116028.41985790017, 117526.8247317533, 119604.0, 121131.0, 975.1272611013245, 986.5807032011367, 1006.8993100690019, 1006.959721611142, 1031.3554028731892, 17809.0, 17914.820851791836, 18065.54836129055, 18366.81633183651, 18395.54011149732, 48186.75906620585, 48955.79992340698, 49709.75145124251, 50793.730156744896, 51435.48564514457, 70498.64750676419, 71734.0, 72396.63801680958, 72804.63597681977, 72819.63590182015, 7751.457397982313, 7871.173526779835, 7880.881786773089, 7981.201879812204, 8226.876596851173, 9065.0, 11801.0, 12303.69240768988, 12670.746585068062, 12796.232226066466, 8603.881495405558, 10147.543360548942, 10554.313969591953, 10919.454027298762, 10976.35354696802, 8795.824083518166, 10499.527521261409, 10712.625058122929, 10755.032047115797, 11197.720056998314, 8824.91175088241, 10710.0, 11055.336679799238, 11130.888691112985, 11224.0, 7381.298776616213, 7711.344535714527, 7882.487638303492, 7922.920770792219, 8165.836683266421, 9285.535723213947, 10542.631007914686, 10727.463626818784, 10792.56829726802, 10932.016118549369], "unit": "score", "name": "jquery.html", "value": 9212.975250236144}, {"lowerIsBetter": false, "replicates": [1433.4409580263696, 1590.7772911792351, 1819.3905041810992, 1948.4836518322657, 1963.8919859407727, 7907.44647874649, 8537.658493660247, 8651.351148663853, 8846.071162527931, 8926.687565935194, 8587.48475091495, 8595.742127736177, 8689.608967596458, 8691.130886911305, 8692.34807389445, 2455.103887081216, 2471.4439251168524, 2472.7156377016604, 2474.072222916406, 2479.169478224797, 2414.517096580682, 2475.591527397977, 2475.851448913062, 2479.3925488255313, 2502.4995000999784, 2435.841670291434, 2453.129139155601, 2481.962770558443, 2484.3789052736815, 2489.800815934721, 2442.7679370459778, 2456.4227406559444, 2466.950660986779, 2469.703635563744, 2471.233917485576, 2431.0397393029652, 2440.2069327468466, 2463.1502131764514, 2463.507298540281, 2478.566250906102, 8839.116088391109, 8887.866681999774, 8905.376623636348, 8910.732678019669, 8917.821643567093, 4434.135343607998, 4770.45139808923, 5444.7822087116865, 5454.945450545523, 5461.754221060062, 3562.305350456662, 3641.035125691694, 3665.560132784083, 3667.8899633010788, 3691.7969511676847, 886.8093359927582, 1030.7680771826354, 1046.748780292732, 1047.0367262118868, 1052.7999680060764, 11455.484503197376, 11461.598844040502, 11578.652640420802, 11681.007114395286, 11903.512060992376, 4833.347498087784, 4913.87715307113, 4948.331975183304, 4976.735585308676, 4980.551750342414, 10045.39273716202, 10156.289059765893, 10158.288919775692, 10175.84736228957, 10195.898041019644, 5467.371252305956, 5469.480399362054, 5484.067708489566, 5561.805336813273, 5564.527015203753, 4454.331850222427, 4845.927311090337, 4948.0, 4955.083309587666, 5009.824656137018, 3860.7876566788536, 3929.76421414716, 3933.252681990413, 3950.940735888964, 3986.1629057897585, 1312.9146605470614, 1315.0794443889315, 1316.2036967634635, 1328.31591730259, 1337.3714354253486, 1088.6679562733284, 1102.2339474065448, 1292.515306759965, 1355.722076974218, 1389.7984792205073, 8133.10535841057, 8202.0, 8231.34149268057, 8243.711470098518, 8261.339092872557, 502.24913753938097, 517.5600739371579, 521.3196778204403, 523.7486006716797, 524.3759925688419, 6122.173506576644, 6208.410201030985, 6213.099100630383, 6275.058741188767, 6277.811665650038, 10450.843237351446, 10807.78384432307, 10810.783784324269, 10838.67483975482, 10941.83587246192, 10367.688969330931, 10558.52486638103, 10622.575096996188, 10625.84061239082, 10664.946675266574, 8335.49987000782, 8408.453450525696, 8413.663453461793, 8421.284190843724, 8430.662773489114, 7731.574763387843, 7885.0, 7929.484583502054, 7930.643121059451, 7937.722179723682, 8423.199796019368, 9139.451632902048, 9483.66807161746, 9507.429554226768, 9683.080107389787, 9437.19783818383, 9719.319647624881, 9765.9023409765, 9850.0, 9885.802283954137, 5996.2504686914135, 6839.965800171166, 7249.166345870292, 7471.290227428385, 7492.063492063492, 8206.753797386087, 8277.006759188936, 8329.541875196923, 8334.624941877752, 8341.24928756415, 6257.843553911189, 7188.741970155306, 7296.306850849161, 7308.926910730825, 7448.664810083451, 6083.574149809648, 7164.0, 7227.530210536298, 7295.306945840137, 7313.890291645736, 7540.057492813398, 7607.619619019138, 7621.618919053914, 7673.616319183907, 7720.227977202235, 5993.910091348721, 6969.54697944632, 6983.057287266154, 7024.859502810017, 7094.006839042641, 6391.201099862517, 7095.82260443493, 7119.252478489684, 7124.536905101152, 7165.498415110892], "unit": "score", "name": "mootools.html", "value": 4816.066602557108}, {"lowerIsBetter": false, "replicates": [291.82782158526476, 329.9373119107369, 330.00832498342476, 334.33501164202255, 337.77706713569034, 6890.931090689091, 6961.860762784754, 6970.790876273707, 6977.930220697798, 7003.684834182462, 6797.864042719143, 6856.417204537608, 6912.481563882704, 6944.51388402812, 6958.234594194634, 4517.254652982254, 4762.714237145782, 4817.205161148407, 4938.728369939652, 5103.260027296049, 4186.434831297766, 5018.071656743496, 5019.799208031693, 5036.84889453317, 5106.668066575679, 5041.420236672775, 5071.873203169914, 5082.110630639641, 5082.339295891529, 5098.133317336044, 5064.772085256135, 5089.160288552384, 5094.923576146361, 5097.464766199551, 5119.360079990001, 4348.434703488526, 4348.673849461303, 4357.629601483846, 4361.5856493633055, 4362.781860906974, 6303.590266632654, 6608.834779130512, 6654.0, 6659.467242620579, 6664.866702665968, 5825.475707186331, 5840.0, 5869.50109240715, 5883.0, 5924.674142922137, 7342.192358840523, 7347.595882226476, 7358.77923662291, 7361.4846960712775, 7372.299631534996, 4686.671932964694, 4695.694779839299, 4695.980728286835, 4700.788464519105, 4715.127701375257, 7397.186309506003, 7724.845503089907, 7799.96100019502, 7833.64748586315, 7845.254700803414, 4473.888152796206, 4553.658475614342, 4629.166749984967, 4694.2723877799, 4717.646176536773, 4772.95227047732, 4789.185838407479, 4792.185328494164, 4797.376341075638, 4805.615550756001, 5717.199592057115, 5765.625234359753, 5775.711214439261, 5789.421057894261, 5868.618539794899, 7401.629918504161, 7420.220876807965, 7420.480566360411, 7434.851302974019, 7446.553206807609, 1574.2443627059076, 1624.3908534299637, 1653.2395098254697, 1655.1393275496914, 1677.3123019561922, 1041.8593489878922, 1050.2700623066896, 1062.1555863088863, 1068.2041878800344, 1068.3494001767288, 6776.9322306777285, 6813.761518346834, 6814.693338799766, 6835.624040677711, 6848.760293389708, 7643.69425222996, 7661.731839385706, 7668.65491052904, 7669.616519174019, 7708.2291770823595, 6743.460523158135, 6800.761973331008, 6819.829504262334, 6820.386165245052, 6835.350641689031, 3722.1625134344554, 4028.3957406389277, 4059.6955228357992, 4061.614146656063, 4068.613481719291, 5762.530554708523, 6287.402696743893, 6482.384173503604, 7788.9095526626315, 7999.080220747095, 7278.0, 7990.520568765776, 8000.159983201796, 8008.27925486709, 8013.318867896178, 8056.476329038594, 8086.636101375452, 8096.10942796292, 8128.691793349534, 8129.227723366271, 6129.743402602545, 7645.235476452311, 7738.41961852852, 7755.72854950074, 7770.106437759504, 7525.774226773206, 7575.469717119749, 7581.12817026027, 7584.355329797029, 7611.238876112345, 6490.805275841543, 8034.0, 8052.194780522135, 8055.637496312563, 8087.47431416956, 4708.623310135113, 4748.358971538798, 4748.92876606858, 4755.358026666356, 4776.9761151194025, 6002.309734380602, 7667.424943129399, 7704.884426733715, 7724.0, 7730.92269077302, 5848.590598658053, 6046.7278972445465, 7359.153697324876, 7409.999650047174, 7441.441891858024, 7330.853382932418, 7345.338919497271, 7393.1497877742595, 7398.11222653285, 7419.258074192538, 7171.318724721144, 7245.311695388929, 7250.274972502708, 7258.274172582699, 7265.128184617668, 7108.3602475777425, 7365.410767138723, 7411.62941852916, 7451.850962980601, 7475.289847464483, 7254.528455650577, 7298.919807854736, 7314.195438501867, 7331.78004659861, 7340.15588207363], "unit": "score", "name": "prototype.html", "value": 5313.0654899713645}, {"lowerIsBetter": false, "replicates": [675.4090171100286, 684.8596037812248, 692.7402224165937, 737.3769165055533, 786.7010535996324, 12015.339156346397, 14545.709085818276, 14724.969252152367, 14758.778618320734, 14811.185384803844, 13485.528006519773, 15208.0, 15444.073355598672, 15458.222304434994, 15474.61313467164, 906.9183773460404, 914.5107367558358, 917.1241464401514, 920.4799288402031, 921.2491819167391, 740.459464590849, 908.6683360573376, 917.4082716647758, 929.2426672262119, 935.1910597333292, 852.7910661887846, 973.1387721866164, 974.790420059687, 976.6874600127962, 981.0434826044585, 930.3022732950287, 940.5344354544544, 952.552300418802, 966.5553845231202, 969.6606187834273, 689.0835189198405, 720.272524750001, 725.960072196029, 726.2991213478965, 730.9488335816495, 12647.43086561107, 14977.1013739176, 15033.398664053424, 15136.167510786903, 15225.467108651255, 12028.27830330183, 12349.814752778715, 12396.755710990365, 12562.74874502514, 12628.621141365773, 8862.468251904842, 9192.724218273463, 10201.387916724945, 10805.945970270099, 11413.714657133554, 3447.5580623097985, 3465.6707612777, 3521.9295614087573, 3550.449680299532, 3556.928861422757, 69698.0, 69965.0, 70652.29347706509, 70728.6463567684, 71881.28118718798, 9140.725778226664, 9253.0, 9310.022447643036, 9417.340786144903, 9452.10957808441, 20186.798132018786, 20427.8978605109, 20845.478863028242, 20879.47801304949, 20886.791132088485, 7314.171457135716, 7431.966973441015, 7549.5847728374365, 7566.772996810105, 7628.54228746277, 4001.0197501612292, 4018.1361007383553, 4123.319652257344, 4143.02638879863, 4162.375643653476, 3614.0603443104455, 3617.2042150726797, 3619.8914032579064, 3667.7249206309634, 3693.5779724805607, 588.9882202356015, 658.7694306992514, 673.1148539670415, 688.0985908459834, 698.3575110897884, 566.5297802823646, 582.5637768393652, 600.177756473634, 610.9837536130751, 613.6471528870917, 7908.130105688369, 7940.523568585903, 8014.2386473286115, 8092.109867914524, 8135.145809690016, 517.3821830789684, 583.4602992232168, 584.4885724990634, 609.5458883132095, 617.9803324514587, 3773.8301776420126, 3830.9808450958126, 3849.095462566295, 3871.7096217783214, 3882.0, 78064.60967695125, 78625.2137478618, 79278.0, 85155.0, 98092.0, 62685.37314626887, 63318.41703957438, 63783.72432551323, 69454.30545694579, 73213.0, 60253.0, 60374.0, 60729.0, 60780.0, 62030.37969620336, 8247.051589067334, 8285.130061343472, 8445.451045682012, 8449.87325190135, 8628.266597339296, 44241.33637995368, 45784.7710761444, 50009.74975625639, 50338.0, 51175.74412127915, 53739.19391209213, 62021.68989155025, 65618.67190664016, 65637.34362656312, 68332.63334733377, 10497.842532362174, 10700.0, 10733.087687546333, 10964.890351096386, 11049.668509944715, 11682.649520514398, 11689.88310116922, 11805.645830625095, 12115.0, 12356.135070544975, 10982.450877455936, 11031.393273370042, 11088.833667495155, 11250.774984500427, 11305.321680699184, 11120.277181983145, 11318.94340528292, 11553.0, 11913.106517011433, 12092.313938691712, 9066.773330666787, 10759.196556098219, 11036.0, 11069.0, 11351.829722554003, 9246.630134794534, 9578.616855325989, 9605.855912161463, 9646.42121472714, 9682.806343873224, 8014.959925200336, 9467.810643786948, 9532.95233523828, 9602.279829012712, 9671.0], "unit": "score", "name": "yui.html", "value": 6760.779049619782}], "name": "dromaeo_css", "value": 7520.909587988308}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 113.0, 115.0, 115.0, 124.0, 115.0, 114.0, 118.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.4}, {"lowerIsBetter": true, "replicates": [184.0, 112.0, 184.0, 194.0, 157.0, 140.0, 141.0, 125.0, 160.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 153.0}, {"lowerIsBetter": true, "replicates": [190.0, 194.0, 196.0, 269.0, 228.0, 262.0, 185.0, 181.0, 223.0, 192.0], "unit": "score", "name": "audio-dft", "value": 212.0}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 65.0, 82.0, 92.0, 155.0, 75.0, 57.0, 59.0, 60.0], "unit": "score", "name": "audio-fft", "value": 76.1}, {"lowerIsBetter": true, "replicates": [85.0, 77.0, 153.0, 113.0, 114.0, 122.0, 117.0, 78.0, 85.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [89.0, 87.0, 90.0, 88.0, 93.0, 85.0, 80.0, 91.0, 87.0, 129.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.9}, {"lowerIsBetter": true, "replicates": [95.0, 99.0, 95.0, 132.0, 102.0, 148.0, 117.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 107.5}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 90.0, 92.0, 101.0, 90.0, 91.0, 93.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 92.4}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 55.0, 56.0, 56.0, 62.0, 58.0, 73.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [58.0, 99.0, 91.0, 73.0, 73.0, 75.0, 69.0, 85.0, 98.0, 97.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.8}, {"lowerIsBetter": true, "replicates": [85.0, 109.0, 111.0, 90.0, 87.0, 84.0, 84.0, 86.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.3}, {"lowerIsBetter": true, "replicates": [138.0, 136.0, 117.0, 139.0, 134.0, 111.0, 137.0, 123.0, 115.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.2}, {"lowerIsBetter": true, "replicates": [175.0, 179.0, 183.0, 141.0, 140.0, 143.0, 183.0, 179.0, 142.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.6}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 67.0, 68.0, 72.0, 67.0, 65.0, 67.0, 64.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1539.6}]} 22:59:21 INFO - Return code: 0 22:59:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:59:21 ERROR - # TBPL SUCCESS # 22:59:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:59:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:59:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:59:21 INFO - 2016-04-04 22:59:21.863 screenresolution[1684:10275] starting screenresolution argv=screenresolution get 22:59:21 INFO - 2016-04-04 22:59:21.866 screenresolution[1684:10275] Display 0: 1600x1200x32@60 22:59:21 INFO - 2016-04-04 22:59:21.872 screenresolution[1685:10278] starting screenresolution argv=screenresolution list 22:59:21 INFO - Available Modes on Display 0 22:59:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:59:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:59:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:59:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:59:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:59:22 INFO - Intel Iris: 22:59:22 INFO - Chipset Model: Intel Iris 22:59:22 INFO - Type: GPU 22:59:22 INFO - Bus: Built-In 22:59:22 INFO - VRAM (Dynamic, Max): 1536 MB 22:59:22 INFO - Vendor: Intel (0x8086) 22:59:22 INFO - Device ID: 0x0a2e 22:59:22 INFO - Revision ID: 0x0009 22:59:22 INFO - Displays: 22:59:22 INFO - Display: 22:59:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:59:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:59:22 INFO - Display Serial Number: 1600x1200 60 22:59:22 INFO - Main Display: Yes 22:59:22 INFO - Mirror: Off 22:59:22 INFO - Online: Yes 22:59:22 INFO - Rotation: Supported 22:59:22 INFO - Return code: 0 22:59:22 INFO - Running post-action listener: _resource_record_post_action 22:59:22 INFO - Running post-run listener: _resource_record_post_run 22:59:23 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 37586432; Write bytes: 701218816; Read time: 397; Write time: 1867 22:59:23 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 385391104; Write bytes: 374032384; Read time: 28542; Write time: 719 22:59:23 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 31342080; Write bytes: 297986048; Read time: 316; Write time: 1093 22:59:23 INFO - Running post-run listener: _upload_blobber_files 22:59:23 INFO - Blob upload gear active. 22:59:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:59:23 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 22:59:23 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:59:23 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:59:23 INFO - (blobuploader) - INFO - Open directory for files ... 22:59:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:59:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:59:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:59:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:59:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:59:24 INFO - (blobuploader) - INFO - Done attempting. 22:59:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:59:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:59:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:59:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:59:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:59:25 INFO - (blobuploader) - INFO - Done attempting. 22:59:25 INFO - (blobuploader) - INFO - Iteration through files over. 22:59:25 INFO - Return code: 0 22:59:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:59:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:59:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20fde87950ae8bfcebdfe54f9a0aa2f88743f372a8e6dfa6332c87f3fd851122abe83ed68c0af70e551eb0f89f7a1a55456c7dab77ef273f4c63b7720223a683", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9883e50dac4a8179d5e6b421600708f98b8b5454d0719471c8c733c729f4f4be785a87cb77f1154e9c11ecbd4521df8a539b976f28bcd2b6b7ad6fe54c6571fa"} 22:59:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:59:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:59:25 INFO - Contents: 22:59:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20fde87950ae8bfcebdfe54f9a0aa2f88743f372a8e6dfa6332c87f3fd851122abe83ed68c0af70e551eb0f89f7a1a55456c7dab77ef273f4c63b7720223a683", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9883e50dac4a8179d5e6b421600708f98b8b5454d0719471c8c733c729f4f4be785a87cb77f1154e9c11ecbd4521df8a539b976f28bcd2b6b7ad6fe54c6571fa"} 22:59:25 INFO - Running post-run listener: copy_logs_to_upload_dir 22:59:25 INFO - Copying logs to upload dir... 22:59:25 INFO - mkdir: /builds/slave/test/build/upload/logs 22:59:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1299.145204 ========= master_lag: 4.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-04-04 22:59:29.450215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-04 22:59:29.457250) ========= 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.MCCwWVnQyk/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.XTDx5Yp8sc/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20fde87950ae8bfcebdfe54f9a0aa2f88743f372a8e6dfa6332c87f3fd851122abe83ed68c0af70e551eb0f89f7a1a55456c7dab77ef273f4c63b7720223a683", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9883e50dac4a8179d5e6b421600708f98b8b5454d0719471c8c733c729f4f4be785a87cb77f1154e9c11ecbd4521df8a539b976f28bcd2b6b7ad6fe54c6571fa"} build_url:https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011426 build_url: 'https://queue.taskcluster.net/v1/task/HHEvda4nR-GWYTIBcqpeQA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/20fde87950ae8bfcebdfe54f9a0aa2f88743f372a8e6dfa6332c87f3fd851122abe83ed68c0af70e551eb0f89f7a1a55456c7dab77ef273f4c63b7720223a683", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9883e50dac4a8179d5e6b421600708f98b8b5454d0719471c8c733c729f4f4be785a87cb77f1154e9c11ecbd4521df8a539b976f28bcd2b6b7ad6fe54c6571fa"}' ========= master_lag: 1.62 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-04-04 22:59:31.089900) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:59:31.090266) ========= 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.MCCwWVnQyk/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.XTDx5Yp8sc/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.005202 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-04 22:59:31.115662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 22:59:31.115963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-04 22:59:31.117212) ========= ========= Total master_lag: 6.31 =========