builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0074 starttime: 1463228188.71 results: success (0) buildid: 20160514030209 builduid: 13fb1502fd2b4d2d90ef0684026c5550 revision: 2afd8fa9bb5df5577e5566468bb423b76c63cc77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:28.713029) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:28.713494) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:28.713795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:28.801921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:28.802608) ========= 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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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-05-14 05:16:28-- 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% 9.51M=0.001s 2016-05-14 05:16:29 (9.51 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.457351 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:29.279819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:29.280102) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.027485 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:29.330104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-14 05:16:29.330422) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2afd8fa9bb5df5577e5566468bb423b76c63cc77 --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 2afd8fa9bb5df5577e5566468bb423b76c63cc77 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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-05-14 05:16:29,417 truncating revision to first 12 chars 2016-05-14 05:16:29,417 Setting DEBUG logging. 2016-05-14 05:16:29,417 attempt 1/10 2016-05-14 05:16:29,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2afd8fa9bb5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 05:16:30,161 unpacking tar archive at: mozilla-central-2afd8fa9bb5d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.995363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-14 05:16:30.343679) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:30.344006) ========= script_repo_revision: 2afd8fa9bb5df5577e5566468bb423b76c63cc77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:30.344389) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:30.344672) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 05:16:30.358636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2016-05-14 05:16:30.358997) ========= /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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:16:30 INFO - MultiFileLogger online at 20160514 05:16:30 in /builds/slave/test 05:16:30 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 05:16:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:30 INFO - {'append_to_log': False, 05:16:30 INFO - 'base_work_dir': '/builds/slave/test', 05:16:30 INFO - 'blob_upload_branch': 'Firefox', 05:16:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:30 INFO - 'branch': 'Firefox', 05:16:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:30 INFO - 'config_files': ('talos/mac_config.py',), 05:16:30 INFO - 'default_actions': ('clobber', 05:16:30 INFO - 'read-buildbot-config', 05:16:30 INFO - 'download-and-extract', 05:16:30 INFO - 'populate-webroot', 05:16:30 INFO - 'create-virtualenv', 05:16:30 INFO - 'install', 05:16:30 INFO - 'run-tests'), 05:16:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:30 INFO - 'download_minidump_stackwalk': True, 05:16:30 INFO - 'download_symbols': 'ondemand', 05:16:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:30 INFO - 'installer_path': 'installer.exe', 05:16:30 INFO - 'log_level': 'info', 05:16:30 INFO - 'log_name': 'talos', 05:16:30 INFO - 'log_to_console': True, 05:16:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:16:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:16:30 INFO - 'opt_config_files': (), 05:16:30 INFO - 'pip_index': False, 05:16:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:30 INFO - 'cmd': ('bash', 05:16:30 INFO - '-c', 05:16:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:30 INFO - 'enabled': True, 05:16:30 INFO - 'halt_on_failure': False, 05:16:30 INFO - 'name': 'check_screen_resolution'},), 05:16:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:30 INFO - 'cmd': ('bash', 05:16:30 INFO - '-c', 05:16:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:30 INFO - 'enabled': True, 05:16:30 INFO - 'halt_on_failure': False, 05:16:30 INFO - 'name': 'check_screen_resolution'},), 05:16:30 INFO - 'run_cmd_checks_enabled': True, 05:16:30 INFO - 'sps_profile': False, 05:16:30 INFO - 'sps_profile_interval': 0, 05:16:30 INFO - 'suite': 'dromaeojs-e10s', 05:16:30 INFO - 'system_bits': '32', 05:16:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:30 INFO - 'title': 't-yosemite-r7-0074', 05:16:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:30 INFO - 'use_talos_json': True, 05:16:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:30 INFO - 'work_dir': 'build'} 05:16:30 INFO - ##### 05:16:30 INFO - ##### Running clobber step. 05:16:30 INFO - ##### 05:16:30 INFO - Running pre-action listener: _resource_record_pre_action 05:16:30 INFO - Running main action method: clobber 05:16:30 INFO - rmtree: /builds/slave/test/build 05:16:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:32 INFO - Running post-action listener: _resource_record_post_action 05:16:32 INFO - ##### 05:16:32 INFO - ##### Finished clobber step (success) 05:16:32 INFO - ##### 05:16:32 INFO - ##### 05:16:32 INFO - ##### Running read-buildbot-config step. 05:16:32 INFO - ##### 05:16:32 INFO - Running pre-action listener: _resource_record_pre_action 05:16:32 INFO - Running main action method: read_buildbot_config 05:16:32 INFO - Using buildbot properties: 05:16:32 INFO - { 05:16:32 INFO - "project": "", 05:16:32 INFO - "product": "firefox", 05:16:32 INFO - "script_repo_revision": "production", 05:16:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:16:32 INFO - "repository": "", 05:16:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:16:32 INFO - "buildid": "20160514030209", 05:16:32 INFO - "stage_platform": "macosx64", 05:16:32 INFO - "basedir": "/builds/slave/test", 05:16:32 INFO - "nightly_build": "True", 05:16:32 INFO - "buildnumber": 274, 05:16:32 INFO - "slavename": "t-yosemite-r7-0074", 05:16:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:16:32 INFO - "platform": "yosemite_r7", 05:16:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:16:32 INFO - "branch": "mozilla-central", 05:16:32 INFO - "repo_path": "mozilla-central", 05:16:32 INFO - "revision": "2afd8fa9bb5df5577e5566468bb423b76c63cc77", 05:16:32 INFO - "pgo_build": "False", 05:16:32 INFO - "builduid": "13fb1502fd2b4d2d90ef0684026c5550", 05:16:32 INFO - "slavebuilddir": "test" 05:16:32 INFO - } 05:16:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:16:32 INFO - Running post-action listener: _resource_record_post_action 05:16:32 INFO - ##### 05:16:32 INFO - ##### Finished read-buildbot-config step (success) 05:16:32 INFO - ##### 05:16:32 INFO - ##### 05:16:32 INFO - ##### Running download-and-extract step. 05:16:32 INFO - ##### 05:16:32 INFO - Running pre-action listener: _resource_record_pre_action 05:16:32 INFO - Running main action method: download_and_extract 05:16:32 INFO - mkdir: /builds/slave/test/build/tests 05:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:32 INFO - https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:16:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:16:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:16:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:16:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 05:17:02 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 05:17:02 INFO - retry: attempt #1 caught exception: timed out 05:17:02 INFO - retry: Failed, sleeping 30 seconds before retrying 05:17:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #2 05:17:52 INFO - Downloaded 1199 bytes. 05:17:52 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:17:52 INFO - Using the following test package requirements: 05:17:52 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:17:52 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:17:52 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:17:52 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:17:52 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:17:52 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:17:52 INFO - u'jsshell-mac.zip'], 05:17:52 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:17:52 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:17:52 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:17:52 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:17:52 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:17:52 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:17:52 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:17:52 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:17:52 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:17:52 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:17:52 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:17:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:17:52 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')]} 05:17:52 INFO - https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:17:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:17:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:17:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:17:55 INFO - Downloaded 18266983 bytes. 05:17:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:17:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:17:58 INFO - Return code: 0 05:17:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:17:58 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')]} 05:17:58 INFO - https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:17:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:17:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:17:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:17:59 INFO - Downloaded 18266983 bytes. 05:17:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:17:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:18:03 INFO - Return code: 0 05:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:03 INFO - https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:18:04 INFO - Downloaded 10840194 bytes. 05:18:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:18:04 INFO - Return code: 0 05:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:04 INFO - https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:18:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:18:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:18:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:18:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 05:18:07 INFO - Downloaded 110142501 bytes. 05:18:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:18:07 INFO - mkdir: /builds/slave/test/properties 05:18:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:07 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:07 INFO - Contents: 05:18:07 INFO - build_url:https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:18:08 INFO - Running post-action listener: _resource_record_post_action 05:18:08 INFO - Running post-action listener: set_extra_try_arguments 05:18:08 INFO - ##### 05:18:08 INFO - ##### Finished download-and-extract step (success) 05:18:08 INFO - ##### 05:18:08 INFO - ##### 05:18:08 INFO - ##### Running populate-webroot step. 05:18:08 INFO - ##### 05:18:08 INFO - Running pre-action listener: _resource_record_pre_action 05:18:08 INFO - Running main action method: populate_webroot 05:18:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:08 INFO - '--tppagecycles', 05:18:08 INFO - '7'], 05:18:08 INFO - 'tests': ['tsvgm']}}, 05:18:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:18:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:18:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:18:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:08 INFO - 'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:08 INFO - 'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['damp', 'tps']}, 05:18:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:08 INFO - 'tests': ['damp', 'tps']}, 05:18:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['dromaeo_dom']}, 05:18:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['a11yr', 05:18:08 INFO - 'ts_paint', 05:18:08 INFO - 'tpaint', 05:18:08 INFO - 'sessionrestore', 05:18:08 INFO - 'sessionrestore_no_auto_restore', 05:18:08 INFO - 'tabpaint']}, 05:18:08 INFO - 'other-e10s': {'tests': ['a11yr', 05:18:08 INFO - 'ts_paint', 05:18:08 INFO - 'tpaint', 05:18:08 INFO - 'sessionrestore', 05:18:08 INFO - 'sessionrestore_no_auto_restore', 05:18:08 INFO - 'tabpaint']}, 05:18:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:18:08 INFO - 'ts_paint', 05:18:08 INFO - 'tpaint', 05:18:08 INFO - 'sessionrestore', 05:18:08 INFO - 'sessionrestore_no_auto_restore', 05:18:08 INFO - 'tabpaint']}, 05:18:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:18:08 INFO - 'ts_paint', 05:18:08 INFO - 'tpaint', 05:18:08 INFO - 'sessionrestore', 05:18:08 INFO - 'sessionrestore_no_auto_restore', 05:18:08 INFO - 'tabpaint']}, 05:18:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['a11yr', 05:18:08 INFO - 'ts_paint', 05:18:08 INFO - 'tpaint', 05:18:08 INFO - 'sessionrestore', 05:18:08 INFO - 'sessionrestore_no_auto_restore', 05:18:08 INFO - 'tabpaint']}, 05:18:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['a11yr', 05:18:08 INFO - 'ts_paint', 05:18:08 INFO - 'tpaint', 05:18:08 INFO - 'sessionrestore', 05:18:08 INFO - 'sessionrestore_no_auto_restore', 05:18:08 INFO - 'tabpaint']}, 05:18:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['tsvgx', 05:18:08 INFO - 'tsvgr_opacity', 05:18:08 INFO - 'tart', 05:18:08 INFO - 'tscrollx', 05:18:08 INFO - 'cart']}, 05:18:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:18:08 INFO - 'tsvgr_opacity', 05:18:08 INFO - 'tart', 05:18:08 INFO - 'tscrollx', 05:18:08 INFO - 'cart']}, 05:18:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:08 INFO - 'talos_options': ['--disable-e10s'], 05:18:08 INFO - 'tests': ['tp5o']}, 05:18:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:08 INFO - 'tests': ['tp5o']}, 05:18:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:08 INFO - 'talos_options': ['--disable-e10s', 05:18:08 INFO - '--xperf_path', 05:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:08 INFO - 'tests': ['tp5n']}, 05:18:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:08 INFO - 'talos_options': ['--xperf_path', 05:18:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:08 INFO - 'tests': ['tp5n']}}, 05:18:08 INFO - 'talos.zip': {'path': '', 05:18:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:08 INFO - Running post-action listener: _resource_record_post_action 05:18:08 INFO - ##### 05:18:08 INFO - ##### Finished populate-webroot step (success) 05:18:08 INFO - ##### 05:18:08 INFO - ##### 05:18:08 INFO - ##### Running create-virtualenv step. 05:18:08 INFO - ##### 05:18:08 INFO - Running pre-action listener: _resource_record_pre_action 05:18:08 INFO - Running main action method: create_virtualenv 05:18:08 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:08 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 05:18:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:08 INFO - Using real prefix '/tools/python27' 05:18:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:11 INFO - Installing pip.................done. 05:18:11 INFO - Return code: 0 05:18:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:11 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 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18:11 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 05:18:11 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 05:18:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:11 INFO - 'HOME': '/Users/cltbld', 05:18:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:11 INFO - 'LOGNAME': 'cltbld', 05:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:11 INFO - 'MOZ_NO_REMOTE': '1', 05:18:11 INFO - 'NO_EM_RESTART': '1', 05:18:11 INFO - 'PAGER': '/bin/cat', 05:18:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:11 INFO - 'PWD': '/builds/slave/test', 05:18:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:11 INFO - 'SHELL': '/bin/bash', 05:18:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:11 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:11 INFO - 'USER': 'cltbld', 05:18:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:11 INFO - 'XPC_FLAGS': '0x0', 05:18:11 INFO - 'XPC_SERVICE_NAME': '0', 05:18:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:12 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 05:18:12 INFO - Cleaning up... 05:18:12 INFO - Return code: 0 05:18:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:18: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')]} 05:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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')]} 05:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:18: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 psutil>=3.1.1 05:18:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:12 INFO - 'HOME': '/Users/cltbld', 05:18:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:12 INFO - 'LOGNAME': 'cltbld', 05:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:12 INFO - 'MOZ_NO_REMOTE': '1', 05:18:12 INFO - 'NO_EM_RESTART': '1', 05:18:12 INFO - 'PAGER': '/bin/cat', 05:18:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:12 INFO - 'PWD': '/builds/slave/test', 05:18:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:12 INFO - 'SHELL': '/bin/bash', 05:18:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:12 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:12 INFO - 'USER': 'cltbld', 05:18:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:12 INFO - 'XPC_FLAGS': '0x0', 05:18:12 INFO - 'XPC_SERVICE_NAME': '0', 05:18:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:12 INFO - Downloading/unpacking psutil>=3.1.1 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18: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 05:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:15 INFO - Installing collected packages: psutil 05:18:15 INFO - Running setup.py install for psutil 05:18:15 INFO - building 'psutil._psutil_osx' extension 05:18:15 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 05:18:16 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 05:18:16 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 05:18:16 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 05:18:16 INFO - building 'psutil._psutil_posix' extension 05:18:16 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 05:18:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:18:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:18:16 INFO - ^ 05:18:16 INFO - 1 warning generated. 05:18:16 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 05:18:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:16 INFO - Successfully installed psutil 05:18:16 INFO - Cleaning up... 05:18:16 INFO - Return code: 0 05:18:16 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 05:18:16 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')]} 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:16 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')]} 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:16 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.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18:16 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.1'] in /builds/slave/test/build 05:18:16 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.1 05:18:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:16 INFO - 'HOME': '/Users/cltbld', 05:18:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:16 INFO - 'LOGNAME': 'cltbld', 05:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:16 INFO - 'MOZ_NO_REMOTE': '1', 05:18:16 INFO - 'NO_EM_RESTART': '1', 05:18:16 INFO - 'PAGER': '/bin/cat', 05:18:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:16 INFO - 'PWD': '/builds/slave/test', 05:18:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:16 INFO - 'SHELL': '/bin/bash', 05:18:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:16 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:16 INFO - 'USER': 'cltbld', 05:18:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:16 INFO - 'XPC_FLAGS': '0x0', 05:18:16 INFO - 'XPC_SERVICE_NAME': '0', 05:18:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:17 INFO - Downloading/unpacking mozsystemmonitor==0.1 05:18:17 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 05:18:17 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 05:18:17 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 05:18:17 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 05:18:17 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 05:18:17 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 05:18:19 INFO - Downloading mozsystemmonitor-0.1.tar.gz 05:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 05:18:19 INFO - Installing collected packages: mozsystemmonitor 05:18:19 INFO - Running setup.py install for mozsystemmonitor 05:18:19 INFO - Successfully installed mozsystemmonitor 05:18:19 INFO - Cleaning up... 05:18:19 INFO - Return code: 0 05:18:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:19 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')]} 05:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:19 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')]} 05:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:19 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 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18:19 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 05:18:19 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 05:18:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:19 INFO - 'HOME': '/Users/cltbld', 05:18:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:19 INFO - 'LOGNAME': 'cltbld', 05:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:19 INFO - 'MOZ_NO_REMOTE': '1', 05:18:19 INFO - 'NO_EM_RESTART': '1', 05:18:19 INFO - 'PAGER': '/bin/cat', 05:18:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:19 INFO - 'PWD': '/builds/slave/test', 05:18:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:19 INFO - 'SHELL': '/bin/bash', 05:18:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:19 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:19 INFO - 'USER': 'cltbld', 05:18:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:19 INFO - 'XPC_FLAGS': '0x0', 05:18:19 INFO - 'XPC_SERVICE_NAME': '0', 05:18:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:22 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:22 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 05:18:22 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 05:18:22 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 05:18:22 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 05:18:22 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 05:18:22 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 05:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:23 INFO - Downloading docopt-0.6.1.tar.gz 05:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:23 INFO - Running setup.py install for blobuploader 05:18:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:23 INFO - Running setup.py install for requests 05:18:24 INFO - Running setup.py install for docopt 05:18:24 INFO - Successfully installed blobuploader requests docopt 05:18:24 INFO - Cleaning up... 05:18:24 INFO - Return code: 0 05:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:24 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 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18:24 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 05:18:24 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 05:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:24 INFO - 'HOME': '/Users/cltbld', 05:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:24 INFO - 'LOGNAME': 'cltbld', 05:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:24 INFO - 'MOZ_NO_REMOTE': '1', 05:18:24 INFO - 'NO_EM_RESTART': '1', 05:18:24 INFO - 'PAGER': '/bin/cat', 05:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:24 INFO - 'PWD': '/builds/slave/test', 05:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:24 INFO - 'SHELL': '/bin/bash', 05:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:24 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:24 INFO - 'USER': 'cltbld', 05:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:24 INFO - 'XPC_FLAGS': '0x0', 05:18:24 INFO - 'XPC_SERVICE_NAME': '0', 05:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-4nF4Ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ycqs_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-YM11rQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-dLodT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-vgOkUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-nNLDTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-EAQosR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-6RttG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Lgyev9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:25 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-U4GPKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-tvZSiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-7w7yyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-QBvXqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Cfwr76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-8X7mRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Y7evv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:26 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-PMOnUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:26 INFO - Running setup.py install for manifestparser 05:18:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:26 INFO - Running setup.py install for mozcrash 05:18:27 INFO - Running setup.py install for mozdebug 05:18:27 INFO - Running setup.py install for mozdevice 05:18:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:18:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:27 INFO - Running setup.py install for mozfile 05:18:27 INFO - Running setup.py install for mozhttpd 05:18:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:27 INFO - Running setup.py install for mozinfo 05:18:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:27 INFO - Running setup.py install for mozInstall 05:18:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:27 INFO - Running setup.py install for mozleak 05:18:28 INFO - Running setup.py install for mozlog 05:18:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:28 INFO - Running setup.py install for moznetwork 05:18:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:28 INFO - Running setup.py install for mozprocess 05:18:28 INFO - Running setup.py install for mozprofile 05:18:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:28 INFO - Running setup.py install for mozrunner 05:18:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:28 INFO - Running setup.py install for mozscreenshot 05:18:29 INFO - Running setup.py install for moztest 05:18:29 INFO - Running setup.py install for mozversion 05:18:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:29 INFO - Cleaning up... 05:18:29 INFO - Return code: 0 05:18:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:29 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 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18:29 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 05:18:29 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 05:18:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:29 INFO - 'HOME': '/Users/cltbld', 05:18:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:29 INFO - 'LOGNAME': 'cltbld', 05:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:29 INFO - 'MOZ_NO_REMOTE': '1', 05:18:29 INFO - 'NO_EM_RESTART': '1', 05:18:29 INFO - 'PAGER': '/bin/cat', 05:18:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:29 INFO - 'PWD': '/builds/slave/test', 05:18:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:29 INFO - 'SHELL': '/bin/bash', 05:18:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:29 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:29 INFO - 'USER': 'cltbld', 05:18:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:29 INFO - 'XPC_FLAGS': '0x0', 05:18:29 INFO - 'XPC_SERVICE_NAME': '0', 05:18:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:29 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-psbYZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:29 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)) 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:29 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-CxpPLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:29 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)) 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:29 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-O27awU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:29 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)) 05:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:29 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-JkF4MN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:30 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-Y1cW6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:30 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-xPseRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:30 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-ZwYu83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:30 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-VxCgqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:30 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-pM9yWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:30 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-GDaIYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-IYvypy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:30 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-xTaP9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:30 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)) 05:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:30 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-atXdLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:31 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)) 05:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:31 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-PgoMWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:31 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)) 05:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:31 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-vy0jrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:31 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)) 05:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:31 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-N_Nb3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:31 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)) 05:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:31 INFO - Running setup.py (path:/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/pip-XWXkRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:31 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)) 05:18:31 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)) 05:18:31 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)) 05:18:31 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)) 05:18:31 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)) 05:18:31 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)) 05:18:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:31 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 05:18:31 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 05:18:31 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 05:18:31 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 05:18:31 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 05:18:31 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 05:18:34 INFO - Downloading blessings-1.6.tar.gz 05:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:34 INFO - Installing collected packages: blessings 05:18:34 INFO - Running setup.py install for blessings 05:18:34 INFO - Successfully installed blessings 05:18:34 INFO - Cleaning up... 05:18:34 INFO - Return code: 0 05:18:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:18:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:34 INFO - Reading from file tmpfile_stdout 05:18:34 INFO - Current package versions: 05:18:34 INFO - blessings == 1.6 05:18:34 INFO - blobuploader == 1.2.4 05:18:34 INFO - docopt == 0.6.1 05:18:34 INFO - manifestparser == 1.1 05:18:34 INFO - mozInstall == 1.12 05:18:34 INFO - mozcrash == 0.17 05:18:34 INFO - mozdebug == 0.1 05:18:34 INFO - mozdevice == 0.48 05:18:34 INFO - mozfile == 1.2 05:18:34 INFO - mozhttpd == 0.7 05:18:34 INFO - mozinfo == 0.9 05:18:34 INFO - mozleak == 0.1 05:18:34 INFO - mozlog == 3.2 05:18:34 INFO - moznetwork == 0.27 05:18:34 INFO - mozprocess == 0.22 05:18:34 INFO - mozprofile == 0.28 05:18:34 INFO - mozrunner == 6.11 05:18:34 INFO - mozscreenshot == 0.1 05:18:34 INFO - mozsystemmonitor == 0.1 05:18:34 INFO - moztest == 0.7 05:18:34 INFO - mozversion == 1.4 05:18:34 INFO - psutil == 3.1.1 05:18:34 INFO - requests == 1.2.3 05:18:34 INFO - wsgiref == 0.1.2 05:18:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:34 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')]} 05:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:34 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')]} 05:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:34 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 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18:34 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 05:18:34 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 05:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:34 INFO - 'HOME': '/Users/cltbld', 05:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:34 INFO - 'LOGNAME': 'cltbld', 05:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:34 INFO - 'MOZ_NO_REMOTE': '1', 05:18:34 INFO - 'NO_EM_RESTART': '1', 05:18:34 INFO - 'PAGER': '/bin/cat', 05:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:34 INFO - 'PWD': '/builds/slave/test', 05:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:34 INFO - 'SHELL': '/bin/bash', 05:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:34 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:34 INFO - 'USER': 'cltbld', 05:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:34 INFO - 'XPC_FLAGS': '0x0', 05:18:34 INFO - 'XPC_SERVICE_NAME': '0', 05:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 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)) 05:18:35 INFO - Cleaning up... 05:18:35 INFO - Return code: 0 05:18:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:35 INFO - 'HOME': '/Users/cltbld', 05:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:35 INFO - 'LOGNAME': 'cltbld', 05:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:35 INFO - 'MOZ_NO_REMOTE': '1', 05:18:35 INFO - 'NO_EM_RESTART': '1', 05:18:35 INFO - 'PAGER': '/bin/cat', 05:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:35 INFO - 'PWD': '/builds/slave/test', 05:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:35 INFO - 'SHELL': '/bin/bash', 05:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:35 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:35 INFO - 'USER': 'cltbld', 05:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:35 INFO - 'XPC_FLAGS': '0x0', 05:18:35 INFO - 'XPC_SERVICE_NAME': '0', 05:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:35 INFO - Downloading/unpacking jsonschema 05:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:37 INFO - Downloading/unpacking functools32 (from jsonschema) 05:18:37 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 05:18:37 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 05:18:37 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 05:18:37 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 05:18:37 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 05:18:37 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 05:18:38 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:38 INFO - warning: no files found matching '*.txt' 05:18:38 INFO - no previously-included directories found matching 'build' 05:18:38 INFO - no previously-included directories found matching 'dist' 05:18:38 INFO - no previously-included directories found matching '.git*' 05:18:38 INFO - Installing collected packages: jsonschema, functools32 05:18:38 INFO - Running setup.py install for functools32 05:18:38 INFO - warning: no files found matching '*.txt' 05:18:38 INFO - no previously-included directories found matching 'build' 05:18:38 INFO - no previously-included directories found matching 'dist' 05:18:38 INFO - no previously-included directories found matching '.git*' 05:18:38 INFO - Successfully installed jsonschema functools32 05:18:38 INFO - Cleaning up... 05:18:38 INFO - Return code: 0 05:18:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e590a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e596570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5c0cb29a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, '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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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 05:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:18:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:18:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:38 INFO - 'HOME': '/Users/cltbld', 05:18:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:38 INFO - 'LOGNAME': 'cltbld', 05:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:38 INFO - 'MOZ_NO_REMOTE': '1', 05:18:38 INFO - 'NO_EM_RESTART': '1', 05:18:38 INFO - 'PAGER': '/bin/cat', 05:18:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:38 INFO - 'PWD': '/builds/slave/test', 05:18:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:38 INFO - 'SHELL': '/bin/bash', 05:18:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:18:38 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:18:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:38 INFO - 'USER': 'cltbld', 05:18:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:38 INFO - 'XPC_FLAGS': '0x0', 05:18:38 INFO - 'XPC_SERVICE_NAME': '0', 05:18:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:38 INFO - Downloading/unpacking flake8 05:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:18:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:18:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:42 INFO - no previously-included directories found matching 'docs/_build' 05:18:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:18:42 INFO - Running setup.py install for pep8 05:18:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:43 INFO - no previously-included directories found matching 'docs/_build' 05:18:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:18:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:18:43 INFO - Cleaning up... 05:18:43 INFO - Return code: 0 05:18:43 INFO - Running post-action listener: _resource_record_post_action 05:18:43 INFO - Running post-action listener: _start_resource_monitoring 05:18:43 INFO - Starting resource monitoring. 05:18:43 INFO - ##### 05:18:43 INFO - ##### Finished create-virtualenv step (success) 05:18:43 INFO - ##### 05:18:43 INFO - ##### 05:18:43 INFO - ##### Running install step. 05:18:43 INFO - ##### 05:18:43 INFO - Running pre-action listener: _resource_record_pre_action 05:18:43 INFO - Running main action method: install 05:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:18:43 INFO - Reading from file tmpfile_stdout 05:18:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:18:43 INFO - Reading from file tmpfile_stdout 05:18:43 INFO - Output received: 05:18:43 INFO - Usage: mozinstall [options] installer 05:18:43 INFO - Options: 05:18:43 INFO - -h, --help show this help message and exit 05:18:43 INFO - -d DEST, --destination=DEST 05:18:43 INFO - Directory to install application into. [default: 05:18:43 INFO - "/builds/slave/test"] 05:18:43 INFO - --app=APP Application being installed. [default: firefox] 05:18:43 INFO - mkdir: /builds/slave/test/build/application 05:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:19:17 INFO - Reading from file tmpfile_stdout 05:19:17 INFO - Output received: 05:19:17 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:19:17 INFO - Running post-action listener: _resource_record_post_action 05:19:17 INFO - ##### 05:19:17 INFO - ##### Finished install step (success) 05:19:17 INFO - ##### 05:19:17 INFO - ##### 05:19:17 INFO - ##### Running run-tests step. 05:19:17 INFO - ##### 05:19:17 INFO - Running pre-action listener: _resource_record_pre_action 05:19:17 INFO - Running main action method: run_tests 05:19:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:19:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:19:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:19:17 INFO - 2016-05-14 05:19:17.023 screenresolution[1651:8408] starting screenresolution argv=screenresolution get 05:19:17 INFO - 2016-05-14 05:19:17.026 screenresolution[1651:8408] Display 0: 1600x1200x32@60 05:19:17 INFO - 2016-05-14 05:19:17.031 screenresolution[1652:8410] starting screenresolution argv=screenresolution list 05:19:17 INFO - Available Modes on Display 0 05:19:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:19:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:19:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:19:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:19:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:19:17 INFO - Intel Iris: 05:19:17 INFO - Chipset Model: Intel Iris 05:19:17 INFO - Type: GPU 05:19:17 INFO - Bus: Built-In 05:19:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:19:17 INFO - Vendor: Intel (0x8086) 05:19:17 INFO - Device ID: 0x0a2e 05:19:17 INFO - Revision ID: 0x0009 05:19:17 INFO - Displays: 05:19:17 INFO - Display: 05:19:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:19:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:19:17 INFO - Display Serial Number: 1600x1200 60 05:19:17 INFO - Main Display: Yes 05:19:17 INFO - Mirror: Off 05:19:17 INFO - Online: Yes 05:19:17 INFO - Rotation: Supported 05:19:17 INFO - Return code: 0 05:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:19:17 INFO - Python 2.7.3 05:19:17 INFO - Return code: 0 05:19:17 INFO - grabbing minidump binary from tooltool 05:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:17 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e434d30>, '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 0x10e258db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e42bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:19:17 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 05:19:17 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 05:19:17 INFO - Calling ['/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'] with output_timeout 600 05:19:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:17 INFO - Return code: 0 05:19:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:19:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:19:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:19:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:19:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:19:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:19:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:19:18 INFO - Return code: 0 05:19:18 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 05:19:18 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0074 --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 05:19:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gsTvgS9HNT/Render', 05:19:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:18 INFO - 'HOME': '/Users/cltbld', 05:19:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:18 INFO - 'LOGNAME': 'cltbld', 05:19:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:19:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:18 INFO - 'MOZ_NO_REMOTE': '1', 05:19:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:19:18 INFO - 'NO_EM_RESTART': '1', 05:19:18 INFO - 'PAGER': '/bin/cat', 05:19:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:18 INFO - 'PWD': '/builds/slave/test', 05:19:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:19:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:18 INFO - 'SHELL': '/bin/bash', 05:19:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Q4MnhAX2hh/Listeners', 05:19:18 INFO - 'TMPDIR': '/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/', 05:19:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:18 INFO - 'USER': 'cltbld', 05:19:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:18 INFO - 'XPC_FLAGS': '0x0', 05:19:18 INFO - 'XPC_SERVICE_NAME': '0', 05:19:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:18 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0074', '--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 05:19:18 INFO - mozversion application_buildid: 20160514030209 05:19:18 INFO - mozversion application_changeset: 2afd8fa9bb5df5577e5566468bb423b76c63cc77 05:19:18 INFO - mozversion application_display_name: Nightly 05:19:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:18 INFO - mozversion application_name: Firefox 05:19:18 INFO - mozversion application_remotingname: firefox 05:19:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:19:18 INFO - mozversion application_vendor: Mozilla 05:19:18 INFO - mozversion application_version: 49.0a1 05:19:18 INFO - mozversion platform_buildid: 20160514030209 05:19:18 INFO - mozversion platform_changeset: 2afd8fa9bb5df5577e5566468bb423b76c63cc77 05:19:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:19:18 INFO - mozversion platform_version: 49.0a1 05:19:18 INFO - using testdate: 1463228358 05:19:18 INFO - actual date: 1463228358 05:19:18 INFO - starting webserver on 'localhost:49279' 05:19:18 INFO - SUITE-START | Running 2 tests 05:19:18 INFO - TEST-START | dromaeo_css 05:19:18 INFO - operating with platform_type : mac_ 05:19:18 INFO - Initialising browser for dromaeo_css test... 05:19:18 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpDyH12L/profile http://localhost:49279/getInfo.html) 05:19:21 INFO - PROCESS | 1670 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1273: ReferenceError: E10SUINotification is not defined 05:19:21 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 05:19:21 INFO - PROCESS | 1670 | colorDepth:24 05:19:21 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 05:19:21 INFO - PROCESS | 1670 | __metrics 05:19:22 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:19:22 INFO - TEST-INFO | 1670: exit 0 05:19:22 INFO - Browser initialized. 05:19:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:19:22 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmpDyH12L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:34 INFO - PROCESS | 1675 | RSS: Main: 249921536 05:19:34 INFO - PROCESS | 1675 | 05:20:24 INFO - PROCESS | 1675 | 1463228424304 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] 05:22:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 05:22:36 INFO - PROCESS | 1675 | RSS: Main: 262189056 05:22:36 INFO - PROCESS | 1675 | 05:25:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 05:25:39 INFO - PROCESS | 1675 | RSS: Main: 273514496 05:25:39 INFO - PROCESS | 1675 | 05:28:41 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 05:28:41 INFO - PROCESS | 1675 | RSS: Main: 275521536 05:28:41 INFO - PROCESS | 1675 | 05:31:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 05:31:44 INFO - PROCESS | 1675 | RSS: Main: 277147648 05:31:44 INFO - PROCESS | 1675 | 05:34:47 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 05:34:47 INFO - PROCESS | 1675 | RSS: Main: 280047616 05:34:47 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 05:37:50 INFO - PROCESS | 1675 | RSS: Main: 280981504 05:37:50 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | __start_tp_report 05:37:50 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:37:50 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:37:50 INFO - PROCESS | 1675 | |i|pagename|runs| 05:37:50 INFO - PROCESS | 1675 | |0;dojo.html;3476.0614634048807;3494.4408894576864;3527.365074286629;3552.2540266544024;3554.6089930107682;4834.395700537433;5759.10733836255;5800.129980502927;5843.298804143504;5868.354481007096;5691.231683722696;5804.419558044194;5808.6224395414265;5825.563082768798;5921.555883308748;5148.304978827867;5175.456577059402;5305.336832895888;5314.707691076989;5350.973245133789;110.98902813282132;4470.798814053375;5048.873778155557;5157.742112894359;5238.738063096849;5043.344365232515;5052.343195384613;5058.392992840846;5072.061668591323;5079.949200508003;5059.6458247922665;5102.387713474407;5113.667611605271;5115.130427827241;5122.154844450662;5104.872378190538;5175.611829112794;5238.371395432534;5244.65909715871;5304.389995150568;4409.536998615131;5609.9902017636805;5757.366689664133;5796.420357964212;5828;6129.695011270001;6266.686665666744;6347.333529979378;6357.33248008957;6361.01404282337;5188.610854185913;6265.780697675559;6293.433590976788;6304.243490781089;6311.684415779193;5913.113033045035;5935.970320148372;5937.228160339171;5945.137954996545;6000.189974353494;6260.749570017239;6264.1856558648;6288.5283603728985;6294.559380843389;6296.685165741695;4873.147199240118;5087.262346959744;5888.882222355529;5890.8821823563285;6176.536759743038;6056.9697151513965;6091.604045737013;6107.114468402146;6113.480354169857;6147.754089836446;5120.795168193231;6049.727762250709;6086.908696369558;6185.41238582343;6219.626822390671;6266.874662506815;6285.811425657238;6321.083442900754;6326.49388048955;6332.366763323723;4962.60299176065;4984.501549845059;4994.200927851526;4996.850094497171;5002.549770520671;3770.679492243135;4328;4430.13612345596;4458.77706114693;4500.459944806578;5866.8533286667325;5922.082077278029;5941.465268125889;6000.399960003964;6027.758889644365;6301.590396624205;6321.083442900754;6344.524160687967;6363.809085727436;6387.808365749035;5674.716264186774;5943.257092863392;5982.282126144891;6038.396160384014;6073.848153796191;5496.972515137479;5537.335519737658;5540.196671482612;5543.805966791224;5553.639013464192;4919.926201106986;6263.467605253604;6500.674966251669;6505.60966342002;6513.706883190268;5273.89452210946;6228.377162283736;6273.529485288713;6359.459445947146;6367.108604795239;6494.415502604599;6527.05357723137;6555.082288479522;6556;6564.868702625825;4994.2508623706735;6216.689165541615;6258.874822503433;6279.717412716347;6304.211973503312;6186.257649081959;6292.653904035322;6302.464290535172;6303.590266632654;6311.842203944938;6248.562600617913;6254.343293954069;6279.120923070683;6284.591501552384;6306.432421082125;6124.877502449837;6139.798803208702;6172.722227499684;6237.688115594293;6251.124842521959;6019.097135429721;6123.466143003804;6126.792505495216;6135.815925522242;6145.631262124108;6205.317415084427;6228.593552998589;6298.496120310456;6298.653574053288;6301.96849015752;5966.49284810796;6061.484773794277;6108.038540470994;6129.295131059986;6136.754529818757 05:37:50 INFO - PROCESS | 1675 | |1;ext.html;504.30406039665235;518.5799502403053;533.3945971322551;543.7852048440868;569.9059655156898;28076.85961570192;40383.39424908629;40409.797951010274;40422;41350;30029.54955675661;41418;41440;41556.58443415565;41558.16883662333;8863.911360886405;9008.594613242387;9496.00291969342;9733.172680322146;9734.26992975526;9476.43141411514;9507.714768556954;9550.665726699566;9556.569954352037;9585;9520.285978551601;9581.425114493153;9609.030148819511;9610.951945240264;9612.615495380176;8149.225823546753;9507.90492095077;9557.378770379903;9577.090176433228;9599.088086631758;9467.242620590336;9491.050894910522;9495.525223738854;9554.474503902282;9605.471699056548;38854.83435496911;38994.80502597497;39005;39051;39379.606203938165;2541.9745802541925;2807.2560771395392;3223.4842425212087;3327.6959808993092;3366.797992120456;22985.885070574706;27405;27492.725072749217;28291.434171316458;28395.432091358263;2639.4853003664293;2654.1772050664354;2678.1028355500735;2721.5101281769275;2803.551431770927;455761;459047;462080;462261.3773862252;466004;33946;34174.14564635904;34180.82909585436;34200.48699269513;34265.828670856485;35418.82290588582;35884.28231435409;36250.91247262587;36265.81867090701;37424.064398390256;16417.014979101292;16571.83428165703;16580.917095414447;16597.668046639243;16646.250918708687;12687.17533360347;12780.424880880382;12861.614151575468;12881.935590321988;12892.548760793326;19061.714074288895;19147.712784308245;19198.904005479882;19235.615287694167;19278.32525861588;8021.117677055519;8101.108878023413;8158.2657560818625;8235.517606830708;8300.298438820028;809.5992483720596;990.9306348555532;1006.4766321512773;1085.2728671789919;1091.9408174071139;28414.147575572766;29264;29462.206542271128;29893.850530747208;30190;973.6981535723949;1134.427114307286;1144.1247445704043;1169.5731207926485;1171.344047333479;15373.846261537465;15381.769273460906;15505.061867266591;15547.922260388626;15913.283902224197;680207;697994.5501362507;698848;699352;701963;56638.86722265532;58512.41487585155;58754.118688219714;58817.11774323389;58932.705336473045;1431.1484666623342;1463.370750577262;1474.1204963671405;1480.977785333221;1485.3093311609937;29176.27059323534;29269.121926342243;29274.121776346743;29737.70262297436;29902.70097299086;49980.75048123826;50532.747336263084;50861.49138508715;50871;50888.72778180427;383693;457761;457872;458204;458880;25934.962601496485;26295.4740905177;26350.341241469116;26654.067107651914;26729.46541069129;45175.548244518446;45322.32016519689;45483;46312.53687463082;46771.76614116908;35380.64619353876;37236.81381593075;37635.24729505449;38055;38858.02854928649;37661.81169094137;37708.43437348387;38053.04867378338;38128.428073579475;38976.41535377028;32807.17982050468;36767.81616091902;38184;38211.662591810265;38295.6170438292;31618.209544761565;33341.666583333856;33882;33900.152496187795;33905;22179.445513862283;23475.64786528169;24746.752532475166;24765.1332203372;25357.492850143262 05:37:50 INFO - PROCESS | 1675 | |2;jquery.html;389.3206354910681;392.5270049590244;393.6103257774803;395;416.0680076628353;17786.644267114683;20236.797632023674;21680;21747.23884664037;21895.562088758215;17213.053282069483;21570.784292157074;21771;22235.777642223573;22236;5287.814926477574;5908.734106965187;6198.44214020738;6208.037754148114;6209.813705588839;5970.761169553212;6048.667323297217;6062.302835173945;6133.846653833645;6148.815535533941;6081.1790408294755;6083.48290395317;6085.117657939596;6095.542834287424;6113.9388606114035;5966.433188847074;6030.155778191057;6066.787662431793;6097.969510152443;6106.0535616979;5209.973950130225;5302.734863256822;5356.196570514415;5370.006548788487;5378.811741589026;26493.88048956079;26897;26999.460010799674;27049.72950270492;27379.726202738115;2323.697919270484;2351.7177938647474;2452.3256104571205;2572.2926195296445;2825.1806975976942;14544.418223271057;15142.848571514363;15213.163276019815;15507.069575825373;16018.279177436927;1732.71410217314;1749.3377861931508;1765.5850875044355;1803.404876390801;1858.4424672598166;113146;114571;116906.41546792211;117328;117983.64032719383;11145.275557088764;11457.369844658457;11640.380914294385;11662.241954272946;11877.168598198043;14530.636734081732;14531.709365812625;14561.635959100895;14587.489437869835;14602.48891288821;7342.4493163012985;8798.780030499289;8851.46891186531;9024.278057755364;9097.363184577016;7742.845143097219;8256.711015114442;8953.59708813105;8982.730518084469;9098.954505227432;6108.389161083856;7092.872138358472;7165.247648996885;7182.281771822776;7200.567965922061;1729.5848996240811;1762.594603241236;1961.3625571689258;1984.8610597258053;1987.3938448773263;943.9150476457014;960.6685693435753;965.6041023180462;984.2322988069318;986.6694657289745;21554.03006864695;22041.89790510468;22170.44573885666;22171.00230489632;22564.097436102373;949.7910459698855;950.5199874063692;997.3915911294105;1012.9442880641635;1044.6918159143072;11466.369349685847;11789.174757767045;11907.464164112636;11932.463039163258;12013.819792703116;559001;594780;609671;609967;612093;68819;105868.47065764622;116904;118818;125998;1018.5823812236947;1043.274923927878;1065.1532032034552;1068.9893101069044;1071.4267866691282;19298;19298.614027719086;19441.416757497296;19660;19726.901365493653;44501.554984449744;57999.840003200545;59064.1140382886;59241.11138333015;59629.50926226879;82772;83790;83794;84654.73017904614;85106.57446712727;6394.712237949397;7098.254683258184;7631.923680763121;7865.134835168013;8439.324854011787;10957.616483423042;13050.54323098687;13083.607491775261;13379.933100334436;13568.660783480493;11032.834507482234;11094.944525277322;11283.887161128612;11439.714007149887;11458;9294;11004.899510048932;11270.60552880678;11396.829047564459;11428.714282143013;11221.326720396475;11535.01952334061;11619.593314233962;11680.70798230051;11775.35235562018;7602.087749470099;7606;7693.961315222374;7741.535507869546;7786.7663970080985;8552.57237138153;10670.039696427359;11041;11346.432678365883;11451.427428628702 05:37:50 INFO - PROCESS | 1675 | |3;mootools.html;1613.0644226348716;1654.842789934956;1725.8101608823035;1904.343001664426;1955.4622478818324;7925.762227133181;8448.324134069275;8644.308455323575;9119;9146.405483643559;9337.066293370659;9439.150476457118;9459.810803783921;9559.42643441394;9662.951685241564;1938.3797184900836;1980.395979226339;2055.578606385695;2176.8245147620264;2516.0816302049802;2390.282915125464;2460.7785299323145;2462.6182941643983;2491.1405565080017;2502.987485062572;2459.508098380331;2463.4457247119435;2466.7163276223287;2468.827182097254;2491.7134529529153;2457.7665121813397;2461.716902556211;2475.10896077412;2476.1457297232428;2485.3662316109458;2401.3156250468533;2462.544429280571;2469.160485434943;2474.542209691213;2481.78904793091;9307.90692093077;9319.673811416567;9323.741294925167;9401.388909720914;9429.104235097655;5548.472895074961;5582.972085139589;5717.656940583578;5720.942790572082;5725.597228678958;3654.7441679082476;3709.5919448860604;3710.703143748494;3753.5871054184017;3763.6236376362144;986.9950650246775;1057.746140926172;1066.53605681528;1068.1881769854888;1073.2701762801291;12299.446524906401;12480.375981200903;12537.99696024316;12577.993760499137;12583.496660133584;4784.87555424475;4985.52637499437;5014.17266151081;5113.181890897513;5158.277841102249;9583.808323833624;10477.947610262052;10612.575496980035;10639.840402393815;10658.680239592824;5622.32532096151;5634.5210657093785;5705.914411283834;5706.743196556165;5708.229389032511;4442.267025940683;5114.360704911886;5173.456787037307;5177.896442071137;5225.216217567319;4226.436218599077;4227.788610569459;4273.166732487135;4307.978460107679;4325.718828276152;1389.1873254146437;1411.84469708332;1412.3220853990142;1420.1195258939524;1422.4879043544315;896.4800415758845;907.2333877873186;924.3621900888365;947.6446332625266;960.2414092866696;5966.403359663999;6108.900397928415;6130.908036379458;6220.875582488325;6246.93802053652;469.0408115404007;469.8496481126007;471.4907899468566;480.5098799224841;484.34371426716996;4011.458453108793;4108.589141085868;4126.216018956388;4149.128682976609;4181.414601955728;11010.669679909615;11338.603148889913;11522.481488333045;11529.365884876244;11577.015953644035;11255.380954047607;11368.431578421047;11369.772604547863;11469.139814513945;11475.713107172387;6292.779752708633;8583.0987746287;8593.097724738938;8611.78470538229;8735.825283494294;6056.939430605637;6075.422834830684;6197.194364732556;6205.844853878689;6373.6494492801485;10197.082262596401;10395.84406233892;10609.416482093251;10612.310199836986;10616.628418005334;10499.527521261409;10671.839922401325;10810.621628242974;10854.131669466266;10934.617288394868;7184.568925864465;7912.960435197787;7944.086430060617;8010.879836802336;8058.274755272054;8773;8859.689910853089;8872.911270887467;8944;8961.865572016555;6732.360425759545;7748.806279843049;7887.211278872067;7958;7959.920400795918;7646.8088297793;7727.536347819148;7753.728619498291;7831.725889594065;7956.5226086435;6726.730930762715;6894.413974812197;7302.452316076209;7355.595442250514;7388.445866560137;4879.780409881635;5087.949120508895;5111.974440127776;5159.819406320761;5189.76646050921;4715.528447155257;5013.621254155137;5152.819651312186;5226.947730522646;5329.173978033411 05:37:50 INFO - PROCESS | 1675 | |4;prototype.html;303.3039175093161;313.38107238204543;320.33050923569743;321.3027729826277;326.43689635378973;5011.69929804212;5208.578011224779;5503.20203570482;5555.3611334696525;5563.499285064348;5519.724013799314;5535.280413546244;5535.916961245584;5567.777288908449;5628.465295796903;3650;3684.926301473969;3752.212035472554;4100.261952848486;4219.810108545115;3368.0906155338043;3956.76259424434;4092.631663150316;4093.406456063869;4240.5759424057505;3836.846526138951;4013.9397909031386;4047.3524236122225;4122.443470131524;4162.458880345551;3528.752987290865;4184.581541845821;4209.484585549199;4227.027783609757;4237.559229861831;3516.9120771980647;3663.230721548478;3679.6688298053305;3686.1337585667347;3690.9146332322152;5160.329157209576;5167.560757335631;5255.737213139328;5281.683099014072;5317.361916569997;4687.218856834415;4818.951810481885;4855.028994201174;4863.975680121612;4874.975625121887;4906.4544668429335;5356.4375740547075;5396.163594642837;5815;5840.7079646017955;3146.590943177372;3304.93390132196;3838.81187722998;3977.5624681285035;3982.2234664240486;6054.576179667425;6101.505131242874;6152.969235153795;6190.628562286277;6201.87596248077;3752.024473636874;3875.205582855508;3979.522457305084;3992.780397078189;4008.9175922500763;3809.8095095245126;4033.717639765247;4040.393940908887;4078.938815917764;4079.551249362568;3787.791671458096;4360.4767427908855;4733.296013435161;4754;4769.902922327815;4681.8361357353015;5532;5653.689047102449;5945.554083443759;5964.373740757158;1240.6588188248124;1326.6086504481202;1350.797380392949;1376.843451500744;1391.9768969807183;703.1562125449481;759.5974133709143;832.2301870769514;840.7561807076002;843.8649816029406;4249.683922262375;4333.050127442663;4547.431571053618;4566.39715362247;4697.906041879143;4697.577218050392;4846.030793841175;4983.825566105169;5038.143515602356;5190.039842629126;3991.381335892941;4207.221663992172;4600.205919691323;4617.399738034102;4627.611716485108;2148.52732398872;2409.361519197414;2488.7386824383543;2581.8897873914398;2587.5083734090463;5065.822696205615;5302;5306.893862122736;5311.778290993016;5335.839924802262;4775.928297055112;4884.65807393479;4993.575546078551;5176.628193528718;5190.532852043334;4714.703456549408;4917.827876024322;5114.795408183631;5269.71016594091;5312.282841816383;5066.544011039025;5087.4149472811105;5089.847304580869;5107.770150343318;5147.845564633067;4118.855840045584;4600.159936025617;4922.483139270325;5019.52314530119;5184.126920694535;6006.639601623741;6115.2391279363765;6374.776882809079;6389.680515974275;6393.904091438725;3695.6304369562827;3892.7080468965505;4007.3788562772816;4022.592092767508;4031.93952090713;5288.365396152486;5601.551875850004;6018.428249316308;6081.239845019372;6085.847853803691;5184.429712731521;5429.918551221655;5675.602707810413;5830.82507524775;5977.491913187428;5328.66783304174;5511.614187006871;5863.824085277449;5899.67551784656;5901.793437229677;5073.919692925882;5515.338159420895;5729.684867332337;5749.310082790092;5758.740856661544;4804.879878002938;5042.369703787027;5659.179418984142;5807.274090738658;5857.1300062967985;5450.333158421044;5661.179129026185;5716.79991200306;5730.255066841451;5762.279715035621 05:37:50 INFO - PROCESS | 1675 | |5;yui.html;593.3532449629903;749.7600767754317;759.142169348636;761.2919984414494;770.7957391291305;14825.555233343004;15414;15526.146061966587;15579.84420155798;15582.688346233068;13902.930485347584;14214.502492412768;14381.496647617336;14413.78379324311;14447.855521444782;712.248577750473;881.7663319220412;900.8468560344758;913.3241401362977;921.138735282513;906.6282824042144;910.3263584947125;911.9407238529475;915.4964769376816;915.8900931888182;945.4988855906381;968.7093871838456;970.5632465390568;972.6401231544303;976.067855198284;931.5575101826646;948.7628092976756;958.2525630008604;963.9759006024835;966.5988614724881;688.0607970120799;700.0933790741003;711.5481669140081;712.1347562711279;716.4554938246918;15064.472743454036;15112.244387780676;15123;15139.091654500766;15165.620859478491;12472.37445863851;12533;12616.116871818977;12788.040896932767;12815.423305951255;9976.632029035933;10141.2394070445;10262;10357.585696572129;10557.524332418268;2984.328526081636;3451.4995325677887;3460.498227756961;3482.669146431085;3519.5248641433336;72310;74537;75404.62297688531;94101;94305;9365.391249568756;9375.718728438158;9464.195543378752;9642.228621710246;9689.854652180224;21005.264815731683;21021.47446313824;21037.57924841525;21054.052567634186;21097.261595844073;6681.966590167115;7428.888566671504;7501.737439189602;7830.4518683691595;7944.364450843918;4079.755214687128;4102.0360215349365;4103.5691252418665;4107.096438783463;4113.835446582163;3583.552055993001;3635.2547727715755;3676.6690997810324;3677.558692956862;3683.2265224303196;596.7970889897368;644.9165402124382;646.49250338485;663.0485253661012;668.1180841289452;563.6843367714011;584.8537865533617;603.722287747641;608.558794873713;618.9257289125334;7592.386774103909;7832.490888092256;7891.408144389194;7994.960025199837;8083.514989100673;574.7212601888081;595.4224402329734;607.1499900139839;616.4451993206061;624.9468795152463;3359.4792807114936;3657.191682149175;3764.868229612005;3947.9802600987387;3949.6445319921345;76332.61833690907;87809;88307.55846220856;89009;89152;77828.61085694535;78583;78798.21201788023;80882;83188;24848.006079756608;32523.34953300921;39779.60771372988;69166;73423.26576734272;6884;8218.21926916942;8266.462679925786;8303.833923321621;8368.41421100517;44053.55946440495;44663.776681117684;47179.52820471751;47630.28554571753;49860;58437.70781146067;65904.34095659174;66262;66714.66642666755;66999.99500007601;10924.945375273073;10950;10998.175136864607;11030.944845275722;11370.488328025092;11878.287302761863;12329.630111096682;12385.752284954431;12481.313527756061;12505.656586753435;11166.44167791591;11231;11277.379744114152;11407.315561066363;11450.541978320774;11054.889451105708;11255.155863310121;11484.425778711198;11543.653690389301;11568.537258509901;10961.780764384826;11029.724256893642;11058.447077646246;11059.889401105886;11170.776584468103;9360.531973401166;9478.668246611336;9760.316777825485;9795.755106122118;9926.900730992598;9476.57355418994;9569.186619137452;9598.232141428529;9634.470104144058;9641.710748677551 05:37:50 INFO - PROCESS | 1675 | __end_tp_report 05:37:50 INFO - PROCESS | 1675 | __start_cc_report 05:37:50 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,421 05:37:50 INFO - PROCESS | 1675 | __end_cc_report 05:37:50 INFO - PROCESS | 1675 | __startTimestamp1463229470652__endTimestamp 05:37:50 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:37:50 INFO - PROCESS | 1675 | Number of tests: 6 05:37:50 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5716.32 Median:6019.10 stddev:818.56 (13.6%) stddev-sans-first:801.98 05:37:50 INFO - PROCESS | 1675 | Values: 3476.1 3494.4 3527.4 3552.3 3554.6 4834.4 5759.1 5800.1 5843.3 5868.4 5691.2 5804.4 5808.6 5825.6 5921.6 5148.3 5175.5 5305.3 5314.7 5351.0 111.0 4470.8 5048.9 5157.7 5238.7 5043.3 5052.3 5058.4 5072.1 5079.9 5059.6 5102.4 5113.7 5115.1 5122.2 5104.9 5175.6 5238.4 5244.7 5304.4 4409.5 5610.0 5757.4 5796.4 5828.0 6129.7 6266.7 6347.3 6357.3 6361.0 5188.6 6265.8 6293.4 6304.2 6311.7 5913.1 5936.0 5937.2 5945.1 6000.2 6260.7 6264.2 6288.5 6294.6 6296.7 4873.1 5087.3 5888.9 5890.9 6176.5 6057.0 6091.6 6107.1 6113.5 6147.8 5120.8 6049.7 6086.9 6185.4 6219.6 6266.9 6285.8 6321.1 6326.5 6332.4 4962.6 4984.5 4994.2 4996.9 5002.5 3770.7 4328.0 4430.1 4458.8 4500.5 5866.9 5922.1 5941.5 6000.4 6027.8 6301.6 6321.1 6344.5 6363.8 6387.8 5674.7 5943.3 5982.3 6038.4 6073.8 5497.0 5537.3 5540.2 5543.8 5553.6 4919.9 6263.5 6500.7 6505.6 6513.7 5273.9 6228.4 6273.5 6359.5 6367.1 6494.4 6527.1 6555.1 6556.0 6564.9 4994.3 6216.7 6258.9 6279.7 6304.2 6186.3 6292.7 6302.5 6303.6 6311.8 6248.6 6254.3 6279.1 6284.6 6306.4 6124.9 6139.8 6172.7 6237.7 6251.1 6019.1 6123.5 6126.8 6135.8 6145.6 6205.3 6228.6 6298.5 6298.7 6302.0 5966.5 6061.5 6108.0 6129.3 6136.8 05:37:50 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:65361.94 Median:37880.74 stddev:146269.95 (386.1%) stddev-sans-first:146599.21 05:37:50 INFO - PROCESS | 1675 | Values: 504.3 518.6 533.4 543.8 569.9 28076.9 40383.4 40409.8 40422.0 41350.0 30029.5 41418.0 41440.0 41556.6 41558.2 8863.9 9008.6 9496.0 9733.2 9734.3 9476.4 9507.7 9550.7 9556.6 9585.0 9520.3 9581.4 9609.0 9611.0 9612.6 8149.2 9507.9 9557.4 9577.1 9599.1 9467.2 9491.1 9495.5 9554.5 9605.5 38854.8 38994.8 39005.0 39051.0 39379.6 2542.0 2807.3 3223.5 3327.7 3366.8 22985.9 27405.0 27492.7 28291.4 28395.4 2639.5 2654.2 2678.1 2721.5 2803.6 455761.0 459047.0 462080.0 462261.4 466004.0 33946.0 34174.1 34180.8 34200.5 34265.8 35418.8 35884.3 36250.9 36265.8 37424.1 16417.0 16571.8 16580.9 16597.7 16646.3 12687.2 12780.4 12861.6 12881.9 12892.5 19061.7 19147.7 19198.9 19235.6 19278.3 8021.1 8101.1 8158.3 8235.5 8300.3 809.6 990.9 1006.5 1085.3 1091.9 28414.1 29264.0 29462.2 29893.9 30190.0 973.7 1134.4 1144.1 1169.6 1171.3 15373.8 15381.8 15505.1 15547.9 15913.3 680207.0 697994.6 698848.0 699352.0 701963.0 56638.9 58512.4 58754.1 58817.1 58932.7 1431.1 1463.4 1474.1 1481.0 1485.3 29176.3 29269.1 29274.1 29737.7 29902.7 49980.8 50532.7 50861.5 50871.0 50888.7 383693.0 457761.0 457872.0 458204.0 458880.0 25935.0 26295.5 26350.3 26654.1 26729.5 45175.5 45322.3 45483.0 46312.5 46771.8 35380.6 37236.8 37635.2 38055.0 38858.0 37661.8 37708.4 38053.0 38128.4 38976.4 32807.2 36767.8 38184.0 38211.7 38295.6 31618.2 33341.7 33882.0 33900.2 33905.0 22179.4 23475.6 24746.8 24765.1 25357.5 05:37:50 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:34986.04 Median:2402.02 stddev:99276.23 (4133.0%) stddev-sans-first:99520.74 05:37:50 INFO - PROCESS | 1675 | Values: 389.3 392.5 393.6 395.0 416.1 17786.6 20236.8 21680.0 21747.2 21895.6 17213.1 21570.8 21771.0 22235.8 22236.0 5287.8 5908.7 6198.4 6208.0 6209.8 5970.8 6048.7 6062.3 6133.8 6148.8 6081.2 6083.5 6085.1 6095.5 6113.9 5966.4 6030.2 6066.8 6098.0 6106.1 5210.0 5302.7 5356.2 5370.0 5378.8 26493.9 26897.0 26999.5 27049.7 27379.7 2323.7 2351.7 2452.3 2572.3 2825.2 14544.4 15142.8 15213.2 15507.1 16018.3 1732.7 1749.3 1765.6 1803.4 1858.4 113146.0 114571.0 116906.4 117328.0 117983.6 11145.3 11457.4 11640.4 11662.2 11877.2 14530.6 14531.7 14561.6 14587.5 14602.5 7342.4 8798.8 8851.5 9024.3 9097.4 7742.8 8256.7 8953.6 8982.7 9099.0 6108.4 7092.9 7165.2 7182.3 7200.6 1729.6 1762.6 1961.4 1984.9 1987.4 943.9 960.7 965.6 984.2 986.7 21554.0 22041.9 22170.4 22171.0 22564.1 949.8 950.5 997.4 1012.9 1044.7 11466.4 11789.2 11907.5 11932.5 12013.8 559001.0 594780.0 609671.0 609967.0 612093.0 68819.0 105868.5 116904.0 118818.0 125998.0 1018.6 1043.3 1065.2 1069.0 1071.4 19298.0 19298.6 19441.4 19660.0 19726.9 44501.6 57999.8 59064.1 59241.1 59629.5 82772.0 83790.0 83794.0 84654.7 85106.6 6394.7 7098.3 7631.9 7865.1 8439.3 10957.6 13050.5 13083.6 13379.9 13568.7 11032.8 11094.9 11283.9 11439.7 11458.0 9294.0 11004.9 11270.6 11396.8 11428.7 11221.3 11535.0 11619.6 11680.7 11775.4 7602.1 7606.0 7694.0 7741.5 7786.8 8552.6 10670.0 11041.0 11346.4 11451.4 05:37:50 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5984.95 Median:2682.06 stddev:3419.86 (127.5%) stddev-sans-first:3413.68 05:37:50 INFO - PROCESS | 1675 | Values: 1613.1 1654.8 1725.8 1904.3 1955.5 7925.8 8448.3 8644.3 9119.0 9146.4 9337.1 9439.2 9459.8 9559.4 9663.0 1938.4 1980.4 2055.6 2176.8 2516.1 2390.3 2460.8 2462.6 2491.1 2503.0 2459.5 2463.4 2466.7 2468.8 2491.7 2457.8 2461.7 2475.1 2476.1 2485.4 2401.3 2462.5 2469.2 2474.5 2481.8 9307.9 9319.7 9323.7 9401.4 9429.1 5548.5 5583.0 5717.7 5720.9 5725.6 3654.7 3709.6 3710.7 3753.6 3763.6 987.0 1057.7 1066.5 1068.2 1073.3 12299.4 12480.4 12538.0 12578.0 12583.5 4784.9 4985.5 5014.2 5113.2 5158.3 9583.8 10477.9 10612.6 10639.8 10658.7 5622.3 5634.5 5705.9 5706.7 5708.2 4442.3 5114.4 5173.5 5177.9 5225.2 4226.4 4227.8 4273.2 4308.0 4325.7 1389.2 1411.8 1412.3 1420.1 1422.5 896.5 907.2 924.4 947.6 960.2 5966.4 6108.9 6130.9 6220.9 6246.9 469.0 469.8 471.5 480.5 484.3 4011.5 4108.6 4126.2 4149.1 4181.4 11010.7 11338.6 11522.5 11529.4 11577.0 11255.4 11368.4 11369.8 11469.1 11475.7 6292.8 8583.1 8593.1 8611.8 8735.8 6056.9 6075.4 6197.2 6205.8 6373.6 10197.1 10395.8 10609.4 10612.3 10616.6 10499.5 10671.8 10810.6 10854.1 10934.6 7184.6 7913.0 7944.1 8010.9 8058.3 8773.0 8859.7 8872.9 8944.0 8961.9 6732.4 7748.8 7887.2 7958.0 7959.9 7646.8 7727.5 7753.7 7831.7 7956.5 6726.7 6894.4 7302.5 7355.6 7388.4 4879.8 5087.9 5112.0 5159.8 5189.8 4715.5 5013.6 5152.8 5226.9 5329.2 05:37:50 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:4492.14 Median:4920.16 stddev:1404.89 (28.6%) stddev-sans-first:1373.20 05:37:50 INFO - PROCESS | 1675 | Values: 303.3 313.4 320.3 321.3 326.4 5011.7 5208.6 5503.2 5555.4 5563.5 5519.7 5535.3 5535.9 5567.8 5628.5 3650.0 3684.9 3752.2 4100.3 4219.8 3368.1 3956.8 4092.6 4093.4 4240.6 3836.8 4013.9 4047.4 4122.4 4162.5 3528.8 4184.6 4209.5 4227.0 4237.6 3516.9 3663.2 3679.7 3686.1 3690.9 5160.3 5167.6 5255.7 5281.7 5317.4 4687.2 4819.0 4855.0 4864.0 4875.0 4906.5 5356.4 5396.2 5815.0 5840.7 3146.6 3304.9 3838.8 3977.6 3982.2 6054.6 6101.5 6153.0 6190.6 6201.9 3752.0 3875.2 3979.5 3992.8 4008.9 3809.8 4033.7 4040.4 4078.9 4079.6 3787.8 4360.5 4733.3 4754.0 4769.9 4681.8 5532.0 5653.7 5945.6 5964.4 1240.7 1326.6 1350.8 1376.8 1392.0 703.2 759.6 832.2 840.8 843.9 4249.7 4333.1 4547.4 4566.4 4697.9 4697.6 4846.0 4983.8 5038.1 5190.0 3991.4 4207.2 4600.2 4617.4 4627.6 2148.5 2409.4 2488.7 2581.9 2587.5 5065.8 5302.0 5306.9 5311.8 5335.8 4775.9 4884.7 4993.6 5176.6 5190.5 4714.7 4917.8 5114.8 5269.7 5312.3 5066.5 5087.4 5089.8 5107.8 5147.8 4118.9 4600.2 4922.5 5019.5 5184.1 6006.6 6115.2 6374.8 6389.7 6393.9 3695.6 3892.7 4007.4 4022.6 4031.9 5288.4 5601.6 6018.4 6081.2 6085.8 5184.4 5429.9 5675.6 5830.8 5977.5 5328.7 5511.6 5863.8 5899.7 5901.8 5073.9 5515.3 5729.7 5749.3 5758.7 4804.9 5042.4 5659.2 5807.3 5857.1 5450.3 5661.2 5716.8 5730.3 5762.3 05:37:50 INFO - PROCESS | 1675 | 05:37:50 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:17427.85 Median:607.85 stddev:24431.74 (4019.3%) stddev-sans-first:24467.58 05:37:50 INFO - PROCESS | 1675 | Values: 593.4 749.8 759.1 761.3 770.8 14825.6 15414.0 15526.1 15579.8 15582.7 13902.9 14214.5 14381.5 14413.8 14447.9 712.2 881.8 900.8 913.3 921.1 906.6 910.3 911.9 915.5 915.9 945.5 968.7 970.6 972.6 976.1 931.6 948.8 958.3 964.0 966.6 688.1 700.1 711.5 712.1 716.5 15064.5 15112.2 15123.0 15139.1 15165.6 12472.4 12533.0 12616.1 12788.0 12815.4 9976.6 10141.2 10262.0 10357.6 10557.5 2984.3 3451.5 3460.5 3482.7 3519.5 72310.0 74537.0 75404.6 94101.0 94305.0 9365.4 9375.7 9464.2 9642.2 9689.9 21005.3 21021.5 21037.6 21054.1 21097.3 6682.0 7428.9 7501.7 7830.5 7944.4 4079.8 4102.0 4103.6 4107.1 4113.8 3583.6 3635.3 3676.7 3677.6 3683.2 596.8 644.9 646.5 663.0 668.1 563.7 584.9 603.7 608.6 618.9 7592.4 7832.5 7891.4 7995.0 8083.5 574.7 595.4 607.1 616.4 624.9 3359.5 3657.2 3764.9 3948.0 3949.6 76332.6 87809.0 88307.6 89009.0 89152.0 77828.6 78583.0 78798.2 80882.0 83188.0 24848.0 32523.3 39779.6 69166.0 73423.3 6884.0 8218.2 8266.5 8303.8 8368.4 44053.6 44663.8 47179.5 47630.3 49860.0 58437.7 65904.3 66262.0 66714.7 67000.0 10924.9 10950.0 10998.2 11030.9 11370.5 11878.3 12329.6 12385.8 12481.3 12505.7 11166.4 11231.0 11277.4 11407.3 11450.5 11054.9 11255.2 11484.4 11543.7 11568.5 10961.8 11029.7 11058.4 11059.9 11170.8 9360.5 9478.7 9760.3 9795.8 9926.9 9476.6 9569.2 9598.2 9634.5 9641.7 05:37:50 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:37:50 INFO - PROCESS | 1675 | 05:37:51 INFO - TEST-INFO | 1675: exit 0 05:37:51 INFO - TEST-OK | dromaeo_css | took 1112478ms 05:37:51 INFO - TEST-START | kraken 05:37:51 INFO - operating with platform_type : mac_ 05:37:51 INFO - Initialising browser for kraken test... 05:37:51 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp9ZrimK/profile http://localhost:49279/getInfo.html) 05:37:53 INFO - PROCESS | 1684 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1273: ReferenceError: E10SUINotification is not defined 05:37:54 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 05:37:54 INFO - PROCESS | 1684 | colorDepth:24 05:37:54 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 05:37:54 INFO - PROCESS | 1684 | __metrics 05:37:54 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:37:54 INFO - TEST-INFO | 1684: exit 0 05:37:54 INFO - Browser initialized. 05:37:54 INFO - Running cycle 1/1 for kraken test... 05:37:54 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/T/tmp9ZrimK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:06 INFO - PROCESS | 1688 | RSS: Main: 250105856 05:38:06 INFO - PROCESS | 1688 | 05:38:09 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:10 INFO - PROCESS | 1688 | RSS: Main: 261767168 05:38:10 INFO - PROCESS | 1688 | 05:38:13 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 05:38:13 INFO - PROCESS | 1688 | RSS: Main: 266457088 05:38:13 INFO - PROCESS | 1688 | 05:38:17 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 05:38:18 INFO - PROCESS | 1688 | RSS: Main: 266797056 05:38:18 INFO - PROCESS | 1688 | 05:38:20 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 05:38:20 INFO - PROCESS | 1688 | RSS: Main: 267358208 05:38:20 INFO - PROCESS | 1688 | 05:38:23 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:23 INFO - PROCESS | 1688 | RSS: Main: 268062720 05:38:23 INFO - PROCESS | 1688 | 05:38:26 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:27 INFO - PROCESS | 1688 | RSS: Main: 268410880 05:38:27 INFO - PROCESS | 1688 | 05:38:30 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:31 INFO - PROCESS | 1688 | RSS: Main: 269021184 05:38:31 INFO - PROCESS | 1688 | 05:38:33 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 05:38:34 INFO - PROCESS | 1688 | RSS: Main: 268816384 05:38:34 INFO - PROCESS | 1688 | 05:38:36 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:38:36 INFO - PROCESS | 1688 | RSS: Main: 268189696 05:38:36 INFO - PROCESS | 1688 | 05:38:38 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:38:39 INFO - PROCESS | 1688 | RSS: Main: 268234752 05:38:39 INFO - PROCESS | 1688 | 05:38:41 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:42 INFO - PROCESS | 1688 | RSS: Main: 268439552 05:38:42 INFO - PROCESS | 1688 | 05:38:45 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:45 INFO - PROCESS | 1688 | RSS: Main: 268513280 05:38:45 INFO - PROCESS | 1688 | 05:38:48 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:49 INFO - PROCESS | 1688 | RSS: Main: 268484608 05:38:49 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 05:38:51 INFO - PROCESS | 1688 | RSS: Main: 270282752 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | __start_tp_report 05:38:51 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 05:38:51 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 05:38:51 INFO - PROCESS | 1688 | |i|pagename|runs| 05:38:51 INFO - PROCESS | 1688 | |0;ai-astar;113;117;110;115;116;118;108;113;114;116 05:38:51 INFO - PROCESS | 1688 | |1;audio-beat-detection;191;113;134;249;111;156;163;141;204;146 05:38:51 INFO - PROCESS | 1688 | |2;audio-dft;181;250;251;266;228;196;205;197;193;196 05:38:51 INFO - PROCESS | 1688 | |3;audio-fft;73;85;102;198;79;60;60;62;125;58 05:38:51 INFO - PROCESS | 1688 | |4;audio-oscillator;110;92;139;85;111;125;158;83;81;126 05:38:51 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;89;85;88;95;116;85;91;86;89;86 05:38:51 INFO - PROCESS | 1688 | |6;imaging-darkroom;95;95;95;94;94;94;106;127;95;94 05:38:51 INFO - PROCESS | 1688 | |7;imaging-desaturate;93;92;90;98;91;92;91;91;91;91 05:38:51 INFO - PROCESS | 1688 | |8;json-parse-financial;58;59;58;57;57;58;70;124;59;58 05:38:51 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;62;66;64;77;72;71;66;67;68;69 05:38:51 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;88;86;87;89;88;86;86;87;89;89 05:38:51 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;141;141;153;146;149;135;137;134;213;140 05:38:51 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;161;166;165;234;217;163;163;163;175;226 05:38:51 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;56;81;88;63;63;65;67;64;66;64 05:38:51 INFO - PROCESS | 1688 | __end_tp_report 05:38:51 INFO - PROCESS | 1688 | __start_cc_report 05:38:51 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,1069 05:38:51 INFO - PROCESS | 1688 | __end_cc_report 05:38:51 INFO - PROCESS | 1688 | __startTimestamp1463229531602__endTimestamp 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | ------- Summary: start ------- 05:38:51 INFO - PROCESS | 1688 | Number of tests: 14 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.50 stddev:3.13 (2.7%) stddev-sans-first:3.30 05:38:51 INFO - PROCESS | 1688 | Values: 113.0 117.0 110.0 115.0 116.0 118.0 108.0 113.0 114.0 116.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:160.80 Median:159.50 stddev:43.05 (27.0%) stddev-sans-first:44.25 05:38:51 INFO - PROCESS | 1688 | Values: 191.0 113.0 134.0 249.0 111.0 156.0 163.0 141.0 204.0 146.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:216.30 Median:216.50 stddev:29.93 (13.8%) stddev-sans-first:28.89 05:38:51 INFO - PROCESS | 1688 | Values: 181.0 250.0 251.0 266.0 228.0 196.0 205.0 197.0 193.0 196.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:90.20 Median:61.00 stddev:43.56 (71.4%) stddev-sans-first:45.75 05:38:51 INFO - PROCESS | 1688 | Values: 73.0 85.0 102.0 198.0 79.0 60.0 60.0 62.0 125.0 58.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:119.50 stddev:26.11 (21.9%) stddev-sans-first:27.69 05:38:51 INFO - PROCESS | 1688 | Values: 110.0 92.0 139.0 85.0 111.0 125.0 158.0 83.0 81.0 126.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:88.50 stddev:9.31 (10.5%) stddev-sans-first:9.85 05:38:51 INFO - PROCESS | 1688 | Values: 89.0 85.0 88.0 95.0 116.0 85.0 91.0 86.0 89.0 86.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:98.90 Median:94.50 stddev:10.52 (11.1%) stddev-sans-first:11.07 05:38:51 INFO - PROCESS | 1688 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 106.0 127.0 95.0 94.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:92.00 Median:91.50 stddev:2.26 (2.5%) stddev-sans-first:2.37 05:38:51 INFO - PROCESS | 1688 | Values: 93.0 92.0 90.0 98.0 91.0 92.0 91.0 91.0 91.0 91.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:58.00 stddev:20.80 (35.9%) stddev-sans-first:21.87 05:38:51 INFO - PROCESS | 1688 | Values: 58.0 59.0 58.0 57.0 57.0 58.0 70.0 124.0 59.0 58.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:4.32 (6.3%) stddev-sans-first:3.95 05:38:51 INFO - PROCESS | 1688 | Values: 62.0 66.0 64.0 77.0 72.0 71.0 66.0 67.0 68.0 69.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:88.00 stddev:1.27 (1.4%) stddev-sans-first:1.33 05:38:51 INFO - PROCESS | 1688 | Values: 88.0 86.0 87.0 89.0 88.0 86.0 86.0 87.0 89.0 89.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:143.50 stddev:23.32 (16.3%) stddev-sans-first:24.56 05:38:51 INFO - PROCESS | 1688 | Values: 141.0 141.0 153.0 146.0 149.0 135.0 137.0 134.0 213.0 140.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.30 Median:170.50 stddev:29.75 (17.4%) stddev-sans-first:30.44 05:38:51 INFO - PROCESS | 1688 | Values: 161.0 166.0 165.0 234.0 217.0 163.0 163.0 163.0 175.0 226.0 05:38:51 INFO - PROCESS | 1688 | 05:38:51 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:65.50 stddev:9.48 (14.5%) stddev-sans-first:9.06 05:38:51 INFO - PROCESS | 1688 | Values: 56.0 81.0 88.0 63.0 63.0 65.0 67.0 64.0 66.0 64.0 05:38:51 INFO - PROCESS | 1688 | -------- Summary: end -------- 05:38:51 INFO - PROCESS | 1688 | 05:38:52 INFO - TEST-INFO | 1688: exit 0 05:38:52 INFO - TEST-OK | kraken | took 61199ms 05:38:52 INFO - SUITE-END | took 1173s 05:38:52 INFO - Completed test suite (00:19:34) 05:38:52 INFO - javascript benchmark 05:38:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7190.065582855976, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3476.0614634048807, 3494.4408894576864, 3527.365074286629, 3552.2540266544024, 3554.6089930107682, 4834.395700537433, 5759.10733836255, 5800.129980502927, 5843.298804143504, 5868.354481007096, 5691.231683722696, 5804.419558044194, 5808.6224395414265, 5825.563082768798, 5921.555883308748, 5148.304978827867, 5175.456577059402, 5305.336832895888, 5314.707691076989, 5350.973245133789, 110.98902813282132, 4470.798814053375, 5048.873778155557, 5157.742112894359, 5238.738063096849, 5043.344365232515, 5052.343195384613, 5058.392992840846, 5072.061668591323, 5079.949200508003, 5059.6458247922665, 5102.387713474407, 5113.667611605271, 5115.130427827241, 5122.154844450662, 5104.872378190538, 5175.611829112794, 5238.371395432534, 5244.65909715871, 5304.389995150568, 4409.536998615131, 5609.9902017636805, 5757.366689664133, 5796.420357964212, 5828.0, 6129.695011270001, 6266.686665666744, 6347.333529979378, 6357.33248008957, 6361.01404282337, 5188.610854185913, 6265.780697675559, 6293.433590976788, 6304.243490781089, 6311.684415779193, 5913.113033045035, 5935.970320148372, 5937.228160339171, 5945.137954996545, 6000.189974353494, 6260.749570017239, 6264.1856558648, 6288.5283603728985, 6294.559380843389, 6296.685165741695, 4873.147199240118, 5087.262346959744, 5888.882222355529, 5890.8821823563285, 6176.536759743038, 6056.9697151513965, 6091.604045737013, 6107.114468402146, 6113.480354169857, 6147.754089836446, 5120.795168193231, 6049.727762250709, 6086.908696369558, 6185.41238582343, 6219.626822390671, 6266.874662506815, 6285.811425657238, 6321.083442900754, 6326.49388048955, 6332.366763323723, 4962.60299176065, 4984.501549845059, 4994.200927851526, 4996.850094497171, 5002.549770520671, 3770.679492243135, 4328.0, 4430.13612345596, 4458.77706114693, 4500.459944806578, 5866.8533286667325, 5922.082077278029, 5941.465268125889, 6000.399960003964, 6027.758889644365, 6301.590396624205, 6321.083442900754, 6344.524160687967, 6363.809085727436, 6387.808365749035, 5674.716264186774, 5943.257092863392, 5982.282126144891, 6038.396160384014, 6073.848153796191, 5496.972515137479, 5537.335519737658, 5540.196671482612, 5543.805966791224, 5553.639013464192, 4919.926201106986, 6263.467605253604, 6500.674966251669, 6505.60966342002, 6513.706883190268, 5273.89452210946, 6228.377162283736, 6273.529485288713, 6359.459445947146, 6367.108604795239, 6494.415502604599, 6527.05357723137, 6555.082288479522, 6556.0, 6564.868702625825, 4994.2508623706735, 6216.689165541615, 6258.874822503433, 6279.717412716347, 6304.211973503312, 6186.257649081959, 6292.653904035322, 6302.464290535172, 6303.590266632654, 6311.842203944938, 6248.562600617913, 6254.343293954069, 6279.120923070683, 6284.591501552384, 6306.432421082125, 6124.877502449837, 6139.798803208702, 6172.722227499684, 6237.688115594293, 6251.124842521959, 6019.097135429721, 6123.466143003804, 6126.792505495216, 6135.815925522242, 6145.631262124108, 6205.317415084427, 6228.593552998589, 6298.496120310456, 6298.653574053288, 6301.96849015752, 5966.49284810796, 6061.484773794277, 6108.038540470994, 6129.295131059986, 6136.754529818757], "value": 5666.473466144158, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.30406039665235, 518.5799502403053, 533.3945971322551, 543.7852048440868, 569.9059655156898, 28076.85961570192, 40383.39424908629, 40409.797951010274, 40422.0, 41350.0, 30029.54955675661, 41418.0, 41440.0, 41556.58443415565, 41558.16883662333, 8863.911360886405, 9008.594613242387, 9496.00291969342, 9733.172680322146, 9734.26992975526, 9476.43141411514, 9507.714768556954, 9550.665726699566, 9556.569954352037, 9585.0, 9520.285978551601, 9581.425114493153, 9609.030148819511, 9610.951945240264, 9612.615495380176, 8149.225823546753, 9507.90492095077, 9557.378770379903, 9577.090176433228, 9599.088086631758, 9467.242620590336, 9491.050894910522, 9495.525223738854, 9554.474503902282, 9605.471699056548, 38854.83435496911, 38994.80502597497, 39005.0, 39051.0, 39379.606203938165, 2541.9745802541925, 2807.2560771395392, 3223.4842425212087, 3327.6959808993092, 3366.797992120456, 22985.885070574706, 27405.0, 27492.725072749217, 28291.434171316458, 28395.432091358263, 2639.4853003664293, 2654.1772050664354, 2678.1028355500735, 2721.5101281769275, 2803.551431770927, 455761.0, 459047.0, 462080.0, 462261.3773862252, 466004.0, 33946.0, 34174.14564635904, 34180.82909585436, 34200.48699269513, 34265.828670856485, 35418.82290588582, 35884.28231435409, 36250.91247262587, 36265.81867090701, 37424.064398390256, 16417.014979101292, 16571.83428165703, 16580.917095414447, 16597.668046639243, 16646.250918708687, 12687.17533360347, 12780.424880880382, 12861.614151575468, 12881.935590321988, 12892.548760793326, 19061.714074288895, 19147.712784308245, 19198.904005479882, 19235.615287694167, 19278.32525861588, 8021.117677055519, 8101.108878023413, 8158.2657560818625, 8235.517606830708, 8300.298438820028, 809.5992483720596, 990.9306348555532, 1006.4766321512773, 1085.2728671789919, 1091.9408174071139, 28414.147575572766, 29264.0, 29462.206542271128, 29893.850530747208, 30190.0, 973.6981535723949, 1134.427114307286, 1144.1247445704043, 1169.5731207926485, 1171.344047333479, 15373.846261537465, 15381.769273460906, 15505.061867266591, 15547.922260388626, 15913.283902224197, 680207.0, 697994.5501362507, 698848.0, 699352.0, 701963.0, 56638.86722265532, 58512.41487585155, 58754.118688219714, 58817.11774323389, 58932.705336473045, 1431.1484666623342, 1463.370750577262, 1474.1204963671405, 1480.977785333221, 1485.3093311609937, 29176.27059323534, 29269.121926342243, 29274.121776346743, 29737.70262297436, 29902.70097299086, 49980.75048123826, 50532.747336263084, 50861.49138508715, 50871.0, 50888.72778180427, 383693.0, 457761.0, 457872.0, 458204.0, 458880.0, 25934.962601496485, 26295.4740905177, 26350.341241469116, 26654.067107651914, 26729.46541069129, 45175.548244518446, 45322.32016519689, 45483.0, 46312.53687463082, 46771.76614116908, 35380.64619353876, 37236.81381593075, 37635.24729505449, 38055.0, 38858.02854928649, 37661.81169094137, 37708.43437348387, 38053.04867378338, 38128.428073579475, 38976.41535377028, 32807.17982050468, 36767.81616091902, 38184.0, 38211.662591810265, 38295.6170438292, 31618.209544761565, 33341.666583333856, 33882.0, 33900.152496187795, 33905.0, 22179.445513862283, 23475.64786528169, 24746.752532475166, 24765.1332203372, 25357.492850143262], "value": 18969.744136040154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3206354910681, 392.5270049590244, 393.6103257774803, 395.0, 416.0680076628353, 17786.644267114683, 20236.797632023674, 21680.0, 21747.23884664037, 21895.562088758215, 17213.053282069483, 21570.784292157074, 21771.0, 22235.777642223573, 22236.0, 5287.814926477574, 5908.734106965187, 6198.44214020738, 6208.037754148114, 6209.813705588839, 5970.761169553212, 6048.667323297217, 6062.302835173945, 6133.846653833645, 6148.815535533941, 6081.1790408294755, 6083.48290395317, 6085.117657939596, 6095.542834287424, 6113.9388606114035, 5966.433188847074, 6030.155778191057, 6066.787662431793, 6097.969510152443, 6106.0535616979, 5209.973950130225, 5302.734863256822, 5356.196570514415, 5370.006548788487, 5378.811741589026, 26493.88048956079, 26897.0, 26999.460010799674, 27049.72950270492, 27379.726202738115, 2323.697919270484, 2351.7177938647474, 2452.3256104571205, 2572.2926195296445, 2825.1806975976942, 14544.418223271057, 15142.848571514363, 15213.163276019815, 15507.069575825373, 16018.279177436927, 1732.71410217314, 1749.3377861931508, 1765.5850875044355, 1803.404876390801, 1858.4424672598166, 113146.0, 114571.0, 116906.41546792211, 117328.0, 117983.64032719383, 11145.275557088764, 11457.369844658457, 11640.380914294385, 11662.241954272946, 11877.168598198043, 14530.636734081732, 14531.709365812625, 14561.635959100895, 14587.489437869835, 14602.48891288821, 7342.4493163012985, 8798.780030499289, 8851.46891186531, 9024.278057755364, 9097.363184577016, 7742.845143097219, 8256.711015114442, 8953.59708813105, 8982.730518084469, 9098.954505227432, 6108.389161083856, 7092.872138358472, 7165.247648996885, 7182.281771822776, 7200.567965922061, 1729.5848996240811, 1762.594603241236, 1961.3625571689258, 1984.8610597258053, 1987.3938448773263, 943.9150476457014, 960.6685693435753, 965.6041023180462, 984.2322988069318, 986.6694657289745, 21554.03006864695, 22041.89790510468, 22170.44573885666, 22171.00230489632, 22564.097436102373, 949.7910459698855, 950.5199874063692, 997.3915911294105, 1012.9442880641635, 1044.6918159143072, 11466.369349685847, 11789.174757767045, 11907.464164112636, 11932.463039163258, 12013.819792703116, 559001.0, 594780.0, 609671.0, 609967.0, 612093.0, 68819.0, 105868.47065764622, 116904.0, 118818.0, 125998.0, 1018.5823812236947, 1043.274923927878, 1065.1532032034552, 1068.9893101069044, 1071.4267866691282, 19298.0, 19298.614027719086, 19441.416757497296, 19660.0, 19726.901365493653, 44501.554984449744, 57999.840003200545, 59064.1140382886, 59241.11138333015, 59629.50926226879, 82772.0, 83790.0, 83794.0, 84654.73017904614, 85106.57446712727, 6394.712237949397, 7098.254683258184, 7631.923680763121, 7865.134835168013, 8439.324854011787, 10957.616483423042, 13050.54323098687, 13083.607491775261, 13379.933100334436, 13568.660783480493, 11032.834507482234, 11094.944525277322, 11283.887161128612, 11439.714007149887, 11458.0, 9294.0, 11004.899510048932, 11270.60552880678, 11396.829047564459, 11428.714282143013, 11221.326720396475, 11535.01952334061, 11619.593314233962, 11680.70798230051, 11775.35235562018, 7602.087749470099, 7606.0, 7693.961315222374, 7741.535507869546, 7786.7663970080985, 8552.57237138153, 10670.039696427359, 11041.0, 11346.432678365883, 11451.427428628702], "value": 9917.282630872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1613.0644226348716, 1654.842789934956, 1725.8101608823035, 1904.343001664426, 1955.4622478818324, 7925.762227133181, 8448.324134069275, 8644.308455323575, 9119.0, 9146.405483643559, 9337.066293370659, 9439.150476457118, 9459.810803783921, 9559.42643441394, 9662.951685241564, 1938.3797184900836, 1980.395979226339, 2055.578606385695, 2176.8245147620264, 2516.0816302049802, 2390.282915125464, 2460.7785299323145, 2462.6182941643983, 2491.1405565080017, 2502.987485062572, 2459.508098380331, 2463.4457247119435, 2466.7163276223287, 2468.827182097254, 2491.7134529529153, 2457.7665121813397, 2461.716902556211, 2475.10896077412, 2476.1457297232428, 2485.3662316109458, 2401.3156250468533, 2462.544429280571, 2469.160485434943, 2474.542209691213, 2481.78904793091, 9307.90692093077, 9319.673811416567, 9323.741294925167, 9401.388909720914, 9429.104235097655, 5548.472895074961, 5582.972085139589, 5717.656940583578, 5720.942790572082, 5725.597228678958, 3654.7441679082476, 3709.5919448860604, 3710.703143748494, 3753.5871054184017, 3763.6236376362144, 986.9950650246775, 1057.746140926172, 1066.53605681528, 1068.1881769854888, 1073.2701762801291, 12299.446524906401, 12480.375981200903, 12537.99696024316, 12577.993760499137, 12583.496660133584, 4784.87555424475, 4985.52637499437, 5014.17266151081, 5113.181890897513, 5158.277841102249, 9583.808323833624, 10477.947610262052, 10612.575496980035, 10639.840402393815, 10658.680239592824, 5622.32532096151, 5634.5210657093785, 5705.914411283834, 5706.743196556165, 5708.229389032511, 4442.267025940683, 5114.360704911886, 5173.456787037307, 5177.896442071137, 5225.216217567319, 4226.436218599077, 4227.788610569459, 4273.166732487135, 4307.978460107679, 4325.718828276152, 1389.1873254146437, 1411.84469708332, 1412.3220853990142, 1420.1195258939524, 1422.4879043544315, 896.4800415758845, 907.2333877873186, 924.3621900888365, 947.6446332625266, 960.2414092866696, 5966.403359663999, 6108.900397928415, 6130.908036379458, 6220.875582488325, 6246.93802053652, 469.0408115404007, 469.8496481126007, 471.4907899468566, 480.5098799224841, 484.34371426716996, 4011.458453108793, 4108.589141085868, 4126.216018956388, 4149.128682976609, 4181.414601955728, 11010.669679909615, 11338.603148889913, 11522.481488333045, 11529.365884876244, 11577.015953644035, 11255.380954047607, 11368.431578421047, 11369.772604547863, 11469.139814513945, 11475.713107172387, 6292.779752708633, 8583.0987746287, 8593.097724738938, 8611.78470538229, 8735.825283494294, 6056.939430605637, 6075.422834830684, 6197.194364732556, 6205.844853878689, 6373.6494492801485, 10197.082262596401, 10395.84406233892, 10609.416482093251, 10612.310199836986, 10616.628418005334, 10499.527521261409, 10671.839922401325, 10810.621628242974, 10854.131669466266, 10934.617288394868, 7184.568925864465, 7912.960435197787, 7944.086430060617, 8010.879836802336, 8058.274755272054, 8773.0, 8859.689910853089, 8872.911270887467, 8944.0, 8961.865572016555, 6732.360425759545, 7748.806279843049, 7887.211278872067, 7958.0, 7959.920400795918, 7646.8088297793, 7727.536347819148, 7753.728619498291, 7831.725889594065, 7956.5226086435, 6726.730930762715, 6894.413974812197, 7302.452316076209, 7355.595442250514, 7388.445866560137, 4879.780409881635, 5087.949120508895, 5111.974440127776, 5159.819406320761, 5189.76646050921, 4715.528447155257, 5013.621254155137, 5152.819651312186, 5226.947730522646, 5329.173978033411], "value": 4708.366658714722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.3039175093161, 313.38107238204543, 320.33050923569743, 321.3027729826277, 326.43689635378973, 5011.69929804212, 5208.578011224779, 5503.20203570482, 5555.3611334696525, 5563.499285064348, 5519.724013799314, 5535.280413546244, 5535.916961245584, 5567.777288908449, 5628.465295796903, 3650.0, 3684.926301473969, 3752.212035472554, 4100.261952848486, 4219.810108545115, 3368.0906155338043, 3956.76259424434, 4092.631663150316, 4093.406456063869, 4240.5759424057505, 3836.846526138951, 4013.9397909031386, 4047.3524236122225, 4122.443470131524, 4162.458880345551, 3528.752987290865, 4184.581541845821, 4209.484585549199, 4227.027783609757, 4237.559229861831, 3516.9120771980647, 3663.230721548478, 3679.6688298053305, 3686.1337585667347, 3690.9146332322152, 5160.329157209576, 5167.560757335631, 5255.737213139328, 5281.683099014072, 5317.361916569997, 4687.218856834415, 4818.951810481885, 4855.028994201174, 4863.975680121612, 4874.975625121887, 4906.4544668429335, 5356.4375740547075, 5396.163594642837, 5815.0, 5840.7079646017955, 3146.590943177372, 3304.93390132196, 3838.81187722998, 3977.5624681285035, 3982.2234664240486, 6054.576179667425, 6101.505131242874, 6152.969235153795, 6190.628562286277, 6201.87596248077, 3752.024473636874, 3875.205582855508, 3979.522457305084, 3992.780397078189, 4008.9175922500763, 3809.8095095245126, 4033.717639765247, 4040.393940908887, 4078.938815917764, 4079.551249362568, 3787.791671458096, 4360.4767427908855, 4733.296013435161, 4754.0, 4769.902922327815, 4681.8361357353015, 5532.0, 5653.689047102449, 5945.554083443759, 5964.373740757158, 1240.6588188248124, 1326.6086504481202, 1350.797380392949, 1376.843451500744, 1391.9768969807183, 703.1562125449481, 759.5974133709143, 832.2301870769514, 840.7561807076002, 843.8649816029406, 4249.683922262375, 4333.050127442663, 4547.431571053618, 4566.39715362247, 4697.906041879143, 4697.577218050392, 4846.030793841175, 4983.825566105169, 5038.143515602356, 5190.039842629126, 3991.381335892941, 4207.221663992172, 4600.205919691323, 4617.399738034102, 4627.611716485108, 2148.52732398872, 2409.361519197414, 2488.7386824383543, 2581.8897873914398, 2587.5083734090463, 5065.822696205615, 5302.0, 5306.893862122736, 5311.778290993016, 5335.839924802262, 4775.928297055112, 4884.65807393479, 4993.575546078551, 5176.628193528718, 5190.532852043334, 4714.703456549408, 4917.827876024322, 5114.795408183631, 5269.71016594091, 5312.282841816383, 5066.544011039025, 5087.4149472811105, 5089.847304580869, 5107.770150343318, 5147.845564633067, 4118.855840045584, 4600.159936025617, 4922.483139270325, 5019.52314530119, 5184.126920694535, 6006.639601623741, 6115.2391279363765, 6374.776882809079, 6389.680515974275, 6393.904091438725, 3695.6304369562827, 3892.7080468965505, 4007.3788562772816, 4022.592092767508, 4031.93952090713, 5288.365396152486, 5601.551875850004, 6018.428249316308, 6081.239845019372, 6085.847853803691, 5184.429712731521, 5429.918551221655, 5675.602707810413, 5830.82507524775, 5977.491913187428, 5328.66783304174, 5511.614187006871, 5863.824085277449, 5899.67551784656, 5901.793437229677, 5073.919692925882, 5515.338159420895, 5729.684867332337, 5749.310082790092, 5758.740856661544, 4804.879878002938, 5042.369703787027, 5659.179418984142, 5807.274090738658, 5857.1300062967985, 5450.333158421044, 5661.179129026185, 5716.79991200306, 5730.255066841451, 5762.279715035621], "value": 4041.375789648344, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.3532449629903, 749.7600767754317, 759.142169348636, 761.2919984414494, 770.7957391291305, 14825.555233343004, 15414.0, 15526.146061966587, 15579.84420155798, 15582.688346233068, 13902.930485347584, 14214.502492412768, 14381.496647617336, 14413.78379324311, 14447.855521444782, 712.248577750473, 881.7663319220412, 900.8468560344758, 913.3241401362977, 921.138735282513, 906.6282824042144, 910.3263584947125, 911.9407238529475, 915.4964769376816, 915.8900931888182, 945.4988855906381, 968.7093871838456, 970.5632465390568, 972.6401231544303, 976.067855198284, 931.5575101826646, 948.7628092976756, 958.2525630008604, 963.9759006024835, 966.5988614724881, 688.0607970120799, 700.0933790741003, 711.5481669140081, 712.1347562711279, 716.4554938246918, 15064.472743454036, 15112.244387780676, 15123.0, 15139.091654500766, 15165.620859478491, 12472.37445863851, 12533.0, 12616.116871818977, 12788.040896932767, 12815.423305951255, 9976.632029035933, 10141.2394070445, 10262.0, 10357.585696572129, 10557.524332418268, 2984.328526081636, 3451.4995325677887, 3460.498227756961, 3482.669146431085, 3519.5248641433336, 72310.0, 74537.0, 75404.62297688531, 94101.0, 94305.0, 9365.391249568756, 9375.718728438158, 9464.195543378752, 9642.228621710246, 9689.854652180224, 21005.264815731683, 21021.47446313824, 21037.57924841525, 21054.052567634186, 21097.261595844073, 6681.966590167115, 7428.888566671504, 7501.737439189602, 7830.4518683691595, 7944.364450843918, 4079.755214687128, 4102.0360215349365, 4103.5691252418665, 4107.096438783463, 4113.835446582163, 3583.552055993001, 3635.2547727715755, 3676.6690997810324, 3677.558692956862, 3683.2265224303196, 596.7970889897368, 644.9165402124382, 646.49250338485, 663.0485253661012, 668.1180841289452, 563.6843367714011, 584.8537865533617, 603.722287747641, 608.558794873713, 618.9257289125334, 7592.386774103909, 7832.490888092256, 7891.408144389194, 7994.960025199837, 8083.514989100673, 574.7212601888081, 595.4224402329734, 607.1499900139839, 616.4451993206061, 624.9468795152463, 3359.4792807114936, 3657.191682149175, 3764.868229612005, 3947.9802600987387, 3949.6445319921345, 76332.61833690907, 87809.0, 88307.55846220856, 89009.0, 89152.0, 77828.61085694535, 78583.0, 78798.21201788023, 80882.0, 83188.0, 24848.006079756608, 32523.34953300921, 39779.60771372988, 69166.0, 73423.26576734272, 6884.0, 8218.21926916942, 8266.462679925786, 8303.833923321621, 8368.41421100517, 44053.55946440495, 44663.776681117684, 47179.52820471751, 47630.28554571753, 49860.0, 58437.70781146067, 65904.34095659174, 66262.0, 66714.66642666755, 66999.99500007601, 10924.945375273073, 10950.0, 10998.175136864607, 11030.944845275722, 11370.488328025092, 11878.287302761863, 12329.630111096682, 12385.752284954431, 12481.313527756061, 12505.656586753435, 11166.44167791591, 11231.0, 11277.379744114152, 11407.315561066363, 11450.541978320774, 11054.889451105708, 11255.155863310121, 11484.425778711198, 11543.653690389301, 11568.537258509901, 10961.780764384826, 11029.724256893642, 11058.447077646246, 11059.889401105886, 11170.776584468103, 9360.531973401166, 9478.668246611336, 9760.316777825485, 9795.755106122118, 9926.900730992598, 9476.57355418994, 9569.186619137452, 9598.232141428529, 9634.470104144058, 9641.710748677551], "value": 6810.613012643048, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 110.0, 115.0, 116.0, 118.0, 108.0, 113.0, 114.0, 116.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 113.0, 134.0, 249.0, 111.0, 156.0, 163.0, 141.0, 204.0, 146.0], "value": 160.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 250.0, 251.0, 266.0, 228.0, 196.0, 205.0, 197.0, 193.0, 196.0], "value": 216.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 85.0, 102.0, 198.0, 79.0, 60.0, 60.0, 62.0, 125.0, 58.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 92.0, 139.0, 85.0, 111.0, 125.0, 158.0, 83.0, 81.0, 126.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 95.0, 116.0, 85.0, 91.0, 86.0, 89.0, 86.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 106.0, 127.0, 95.0, 94.0], "value": 98.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 90.0, 98.0, 91.0, 92.0, 91.0, 91.0, 91.0, 91.0], "value": 92.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 57.0, 57.0, 58.0, 70.0, 124.0, 59.0, 58.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 64.0, 77.0, 72.0, 71.0, 66.0, 67.0, 68.0, 69.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 89.0, 88.0, 86.0, 86.0, 87.0, 89.0, 89.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 153.0, 146.0, 149.0, 135.0, 137.0, 134.0, 213.0, 140.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 165.0, 234.0, 217.0, 163.0, 163.0, 163.0, 175.0, 226.0], "value": 183.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 81.0, 88.0, 63.0, 63.0, 65.0, 67.0, 64.0, 66.0, 64.0], "value": 67.7, "unit": "score"}]}]} 05:38:52 INFO - Return code: 0 05:38:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:38:52 ERROR - # TBPL SUCCESS # 05:38:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:38:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:38:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:38:52 INFO - 2016-05-14 05:38:52.951 screenresolution[1694:11260] starting screenresolution argv=screenresolution get 05:38:52 INFO - 2016-05-14 05:38:52.954 screenresolution[1694:11260] Display 0: 1600x1200x32@60 05:38:52 INFO - 2016-05-14 05:38:52.960 screenresolution[1695:11262] starting screenresolution argv=screenresolution list 05:38:52 INFO - Available Modes on Display 0 05:38:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:38:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:38:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:38:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:38:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:38:53 INFO - Intel Iris: 05:38:53 INFO - Chipset Model: Intel Iris 05:38:53 INFO - Type: GPU 05:38:53 INFO - Bus: Built-In 05:38:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:38:53 INFO - Vendor: Intel (0x8086) 05:38:53 INFO - Device ID: 0x0a2e 05:38:53 INFO - Revision ID: 0x0009 05:38:53 INFO - Displays: 05:38:53 INFO - Display: 05:38:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:38:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:38:53 INFO - Display Serial Number: 1600x1200 60 05:38:53 INFO - Main Display: Yes 05:38:53 INFO - Mirror: Off 05:38:53 INFO - Online: Yes 05:38:53 INFO - Rotation: Supported 05:38:53 INFO - Return code: 0 05:38:53 INFO - Running post-action listener: _resource_record_post_action 05:38:53 INFO - ##### 05:38:53 INFO - ##### Finished run-tests step (success) 05:38:53 INFO - ##### 05:38:53 INFO - Running post-run listener: _resource_record_post_run 05:38:53 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 33611264; Write bytes: 698985472; Read time: 346; Write time: 1923 05:38:53 INFO - TinderboxPrint: CPU usage
54.6% 05:38:53 INFO - TinderboxPrint: I/O read bytes / time
33,611,264 / 346 05:38:53 INFO - TinderboxPrint: I/O write bytes / time
698,985,472 / 1,923 05:38:53 INFO - TinderboxPrint: CPU idle
2,196.7 (45.4%) 05:38:53 INFO - TinderboxPrint: CPU system
971.7 (20.1%) 05:38:53 INFO - TinderboxPrint: CPU user
1,669.3 (34.5%) 05:38:53 INFO - TinderboxPrint: Swap in / out
425,041,920 / 0 05:38:53 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 378298880; Write bytes: 373020160; Read time: 28162; Write time: 725 05:38:53 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 32689664; Write bytes: 301102592; Read time: 333; Write time: 1146 05:38:53 INFO - Running post-run listener: _upload_blobber_files 05:38:53 INFO - Blob upload gear active. 05:38:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:53 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 05:38:53 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'] 05:38:53 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 05:38:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:38:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:38:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:55 INFO - (blobuploader) - INFO - Done attempting. 05:38:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:38:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:38:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:56 INFO - (blobuploader) - INFO - Done attempting. 05:38:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:38:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:38:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:59 INFO - (blobuploader) - INFO - Done attempting. 05:38:59 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:59 INFO - Return code: 0 05:38:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/055720d1df725c688c5a04ca4abd8c49b81b825930e181961defa20c4736ef6646c99b8fd07b3b2d6350dd9ad7f5256ab690850555796343015220d654b64d8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56a044875fc177de777eb3ea5c18904011d679ecde48d8dfcb8de92f419da653b01f0fe9b2d6b1788ebba32c6f6b7819b3e134e7f66fa438fd116d17a351baf4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d74c554d103d5cafd0822d101abf4c433f9b46d88f069bb19eda87664f9d5139e28178e6355d21526326924335ea68def85543526cbc40138eb0db6892e789a"} 05:38:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:59 INFO - Contents: 05:38:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/055720d1df725c688c5a04ca4abd8c49b81b825930e181961defa20c4736ef6646c99b8fd07b3b2d6350dd9ad7f5256ab690850555796343015220d654b64d8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56a044875fc177de777eb3ea5c18904011d679ecde48d8dfcb8de92f419da653b01f0fe9b2d6b1788ebba32c6f6b7819b3e134e7f66fa438fd116d17a351baf4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d74c554d103d5cafd0822d101abf4c433f9b46d88f069bb19eda87664f9d5139e28178e6355d21526326924335ea68def85543526cbc40138eb0db6892e789a"} 05:38:59 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:59 INFO - Copying logs to upload dir... 05:38:59 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1348.694591 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2016-05-14 05:38:59.089262) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 05:38:59.092843) ========= 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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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/055720d1df725c688c5a04ca4abd8c49b81b825930e181961defa20c4736ef6646c99b8fd07b3b2d6350dd9ad7f5256ab690850555796343015220d654b64d8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56a044875fc177de777eb3ea5c18904011d679ecde48d8dfcb8de92f419da653b01f0fe9b2d6b1788ebba32c6f6b7819b3e134e7f66fa438fd116d17a351baf4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d74c554d103d5cafd0822d101abf4c433f9b46d88f069bb19eda87664f9d5139e28178e6355d21526326924335ea68def85543526cbc40138eb0db6892e789a"} build_url:https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010806 build_url: 'https://queue.taskcluster.net/v1/task/IBLIV1oFTjed8XrB3dpr1A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/055720d1df725c688c5a04ca4abd8c49b81b825930e181961defa20c4736ef6646c99b8fd07b3b2d6350dd9ad7f5256ab690850555796343015220d654b64d8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56a044875fc177de777eb3ea5c18904011d679ecde48d8dfcb8de92f419da653b01f0fe9b2d6b1788ebba32c6f6b7819b3e134e7f66fa438fd116d17a351baf4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d74c554d103d5cafd0822d101abf4c433f9b46d88f069bb19eda87664f9d5139e28178e6355d21526326924335ea68def85543526cbc40138eb0db6892e789a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 05:38:59.120773) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 05:38:59.121170) ========= 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.gsTvgS9HNT/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.Q4MnhAX2hh/Listeners TMPDIR=/var/folders/vl/3c7h2z3s5b9bcs05s56c_y5w00000w/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.005102 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 05:38:59.175708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 05:38:59.176067) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 05:38:59.176514) ========= ========= Total master_lag: 0.16 =========