builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0259 starttime: 1463262162.11 results: success (0) buildid: 20160514130527 builduid: 2ff7712dfe204a41a0a665e4771196ee revision: 403912ca555eb65f814b18ecf38ad8e8e98569f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.107860) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.108333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.108611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.252142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.252408) ========= 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.IogFMdIyII/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.a6JyPtRkmf/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:42:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 126M=0s 2016-05-14 14:42:42 (126 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085420 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.372977) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.373278) ========= 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.IogFMdIyII/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.a6JyPtRkmf/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.020147 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.427405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:42.427744) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 403912ca555eb65f814b18ecf38ad8e8e98569f5 --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 403912ca555eb65f814b18ecf38ad8e8e98569f5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IogFMdIyII/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.a6JyPtRkmf/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:42:42,431 truncating revision to first 12 chars 2016-05-14 14:42:42,431 Setting DEBUG logging. 2016-05-14 14:42:42,431 attempt 1/10 2016-05-14 14:42:42,431 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/403912ca555e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-14 14:42:43,026 unpacking tar archive at: mozilla-central-403912ca555e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.852565 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:43.317961) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:43.318251) ========= script_repo_revision: 403912ca555eb65f814b18ecf38ad8e8e98569f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:43.318628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:43.322945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-14 14:42:43.362450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 12 secs) (at 2016-05-14 14:42:43.362715) ========= /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.IogFMdIyII/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.a6JyPtRkmf/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:42:43 INFO - MultiFileLogger online at 20160514 14:42:43 in /builds/slave/test 14:42:43 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 14:42:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:42:43 INFO - {'append_to_log': False, 14:42:43 INFO - 'base_work_dir': '/builds/slave/test', 14:42:43 INFO - 'blob_upload_branch': 'Firefox', 14:42:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:42:43 INFO - 'branch': 'Firefox', 14:42:43 INFO - 'buildbot_json_path': 'buildprops.json', 14:42:43 INFO - 'config_files': ('talos/mac_config.py',), 14:42:43 INFO - 'default_actions': ('clobber', 14:42:43 INFO - 'read-buildbot-config', 14:42:43 INFO - 'download-and-extract', 14:42:43 INFO - 'populate-webroot', 14:42:43 INFO - 'create-virtualenv', 14:42:43 INFO - 'install', 14:42:43 INFO - 'run-tests'), 14:42:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:42:43 INFO - 'download_minidump_stackwalk': True, 14:42:43 INFO - 'download_symbols': 'ondemand', 14:42:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:42:43 INFO - 'tooltool.py': '/tools/tooltool.py', 14:42:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:42:43 INFO - '/tools/misc-python/virtualenv.py')}, 14:42:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:42:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:42:43 INFO - 'installer_path': 'installer.exe', 14:42:43 INFO - 'log_level': 'info', 14:42:43 INFO - 'log_name': 'talos', 14:42:43 INFO - 'log_to_console': True, 14:42:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:42:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:42:43 INFO - 'opt_config_files': (), 14:42:43 INFO - 'pip_index': False, 14:42:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:42:43 INFO - 'cmd': ('bash', 14:42:43 INFO - '-c', 14:42:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:42:43 INFO - 'enabled': True, 14:42:43 INFO - 'halt_on_failure': False, 14:42:43 INFO - 'name': 'check_screen_resolution'},), 14:42:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:42:43 INFO - 'cmd': ('bash', 14:42:43 INFO - '-c', 14:42:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:42:43 INFO - 'enabled': True, 14:42:43 INFO - 'halt_on_failure': False, 14:42:43 INFO - 'name': 'check_screen_resolution'},), 14:42:43 INFO - 'run_cmd_checks_enabled': True, 14:42:43 INFO - 'sps_profile': False, 14:42:43 INFO - 'sps_profile_interval': 0, 14:42:43 INFO - 'suite': 'dromaeojs-e10s', 14:42:43 INFO - 'system_bits': '32', 14:42:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:42:43 INFO - 'title': 't-yosemite-r7-0259', 14:42:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:42:43 INFO - 'use_talos_json': True, 14:42:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:42:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:42:43 INFO - 'work_dir': 'build'} 14:42:43 INFO - ##### 14:42:43 INFO - ##### Running clobber step. 14:42:43 INFO - ##### 14:42:43 INFO - Running pre-action listener: _resource_record_pre_action 14:42:43 INFO - Running main action method: clobber 14:42:43 INFO - rmtree: /builds/slave/test/build 14:42:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:42:44 INFO - Running post-action listener: _resource_record_post_action 14:42:44 INFO - ##### 14:42:44 INFO - ##### Finished clobber step (success) 14:42:44 INFO - ##### 14:42:44 INFO - ##### 14:42:44 INFO - ##### Running read-buildbot-config step. 14:42:44 INFO - ##### 14:42:44 INFO - Running pre-action listener: _resource_record_pre_action 14:42:44 INFO - Running main action method: read_buildbot_config 14:42:44 INFO - Using buildbot properties: 14:42:44 INFO - { 14:42:44 INFO - "project": "", 14:42:44 INFO - "product": "firefox", 14:42:44 INFO - "script_repo_revision": "production", 14:42:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:42:44 INFO - "repository": "", 14:42:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:42:44 INFO - "buildid": "20160514130527", 14:42:44 INFO - "pgo_build": "False", 14:42:44 INFO - "basedir": "/builds/slave/test", 14:42:44 INFO - "buildnumber": 45, 14:42:44 INFO - "slavename": "t-yosemite-r7-0259", 14:42:44 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:42:44 INFO - "platform": "yosemite_r7", 14:42:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:42:44 INFO - "branch": "mozilla-central", 14:42:44 INFO - "repo_path": "mozilla-central", 14:42:44 INFO - "revision": "403912ca555eb65f814b18ecf38ad8e8e98569f5", 14:42:44 INFO - "stage_platform": "macosx64", 14:42:44 INFO - "builduid": "2ff7712dfe204a41a0a665e4771196ee", 14:42:44 INFO - "slavebuilddir": "test" 14:42:44 INFO - } 14:42:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 14:42:44 INFO - Running post-action listener: _resource_record_post_action 14:42:44 INFO - ##### 14:42:44 INFO - ##### Finished read-buildbot-config step (success) 14:42:44 INFO - ##### 14:42:44 INFO - ##### 14:42:44 INFO - ##### Running download-and-extract step. 14:42:44 INFO - ##### 14:42:44 INFO - Running pre-action listener: _resource_record_pre_action 14:42:44 INFO - Running main action method: download_and_extract 14:42:44 INFO - mkdir: /builds/slave/test/build/tests 14:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:42:44 INFO - https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:42:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 14:42:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 14:42:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:42:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:43:15 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json: timed out 14:43:15 INFO - retry: attempt #1 caught exception: timed out 14:43:15 INFO - retry: Failed, sleeping 30 seconds before retrying 14:43:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:43:50 INFO - Downloaded 1199 bytes. 14:43:50 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 14:43:50 INFO - Using the following test package requirements: 14:43:50 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 14:43:50 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:43:50 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 14:43:50 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:43:50 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 14:43:50 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:43:50 INFO - u'jsshell-mac.zip'], 14:43:50 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:43:50 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 14:43:50 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 14:43:50 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:43:50 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 14:43:50 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:43:50 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 14:43:50 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:43:50 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 14:43:50 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 14:43:50 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 14:43:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:50 INFO - https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:43:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:43:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:43:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:43:51 INFO - Downloaded 18267589 bytes. 14:43:51 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'] 14:43:51 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 14:43:54 INFO - Return code: 0 14:43:54 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 14:43:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:54 INFO - https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:43:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:43:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 14:43:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:43:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:43:55 INFO - Downloaded 18267589 bytes. 14:43: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'] 14:43: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 14:43:59 INFO - Return code: 0 14:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:43:59 INFO - https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:43:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 14:43:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 14:43:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:43:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:44:00 INFO - Downloaded 10840194 bytes. 14:44:00 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'] 14:44:00 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 14:44:00 INFO - Return code: 0 14:44:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:44:00 INFO - https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:44:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:44:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:44:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 14:44:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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 14:44:03 INFO - Downloaded 109985713 bytes. 14:44:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:44:03 INFO - mkdir: /builds/slave/test/properties 14:44:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:44:03 INFO - Writing to file /builds/slave/test/properties/build_url 14:44:03 INFO - Contents: 14:44:03 INFO - build_url:https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 14:44:04 INFO - Running post-action listener: _resource_record_post_action 14:44:04 INFO - Running post-action listener: set_extra_try_arguments 14:44:04 INFO - ##### 14:44:04 INFO - ##### Finished download-and-extract step (success) 14:44:04 INFO - ##### 14:44:04 INFO - ##### 14:44:04 INFO - ##### Running populate-webroot step. 14:44:04 INFO - ##### 14:44:04 INFO - Running pre-action listener: _resource_record_pre_action 14:44:04 INFO - Running main action method: populate_webroot 14:44:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:44:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:44:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:44:04 INFO - '--tppagecycles', 14:44:04 INFO - '7'], 14:44:04 INFO - 'tests': ['tsvgm']}}, 14:44:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:44:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:44:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:44:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:44:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:04 INFO - 'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:44:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:44:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:04 INFO - 'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['damp', 'tps']}, 14:44:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:04 INFO - 'tests': ['damp', 'tps']}, 14:44:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['dromaeo_dom']}, 14:44:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:44:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['a11yr', 14:44:04 INFO - 'ts_paint', 14:44:04 INFO - 'tpaint', 14:44:04 INFO - 'sessionrestore', 14:44:04 INFO - 'sessionrestore_no_auto_restore', 14:44:04 INFO - 'tabpaint']}, 14:44:04 INFO - 'other-e10s': {'tests': ['a11yr', 14:44:04 INFO - 'ts_paint', 14:44:04 INFO - 'tpaint', 14:44:04 INFO - 'sessionrestore', 14:44:04 INFO - 'sessionrestore_no_auto_restore', 14:44:04 INFO - 'tabpaint']}, 14:44:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:44:04 INFO - 'ts_paint', 14:44:04 INFO - 'tpaint', 14:44:04 INFO - 'sessionrestore', 14:44:04 INFO - 'sessionrestore_no_auto_restore', 14:44:04 INFO - 'tabpaint']}, 14:44:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:44:04 INFO - 'ts_paint', 14:44:04 INFO - 'tpaint', 14:44:04 INFO - 'sessionrestore', 14:44:04 INFO - 'sessionrestore_no_auto_restore', 14:44:04 INFO - 'tabpaint']}, 14:44:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['a11yr', 14:44:04 INFO - 'ts_paint', 14:44:04 INFO - 'tpaint', 14:44:04 INFO - 'sessionrestore', 14:44:04 INFO - 'sessionrestore_no_auto_restore', 14:44:04 INFO - 'tabpaint']}, 14:44:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['a11yr', 14:44:04 INFO - 'ts_paint', 14:44:04 INFO - 'tpaint', 14:44:04 INFO - 'sessionrestore', 14:44:04 INFO - 'sessionrestore_no_auto_restore', 14:44:04 INFO - 'tabpaint']}, 14:44:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['tsvgx', 14:44:04 INFO - 'tsvgr_opacity', 14:44:04 INFO - 'tart', 14:44:04 INFO - 'tscrollx', 14:44:04 INFO - 'cart']}, 14:44:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:44:04 INFO - 'tsvgr_opacity', 14:44:04 INFO - 'tart', 14:44:04 INFO - 'tscrollx', 14:44:04 INFO - 'cart']}, 14:44:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:04 INFO - 'talos_options': ['--disable-e10s'], 14:44:04 INFO - 'tests': ['tp5o']}, 14:44:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:04 INFO - 'tests': ['tp5o']}, 14:44:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:04 INFO - 'talos_options': ['--disable-e10s', 14:44:04 INFO - '--xperf_path', 14:44:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:44:04 INFO - 'tests': ['tp5n']}, 14:44:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:44:04 INFO - 'talos_options': ['--xperf_path', 14:44:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:44:04 INFO - 'tests': ['tp5n']}}, 14:44:04 INFO - 'talos.zip': {'path': '', 14:44:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:44:04 INFO - Running post-action listener: _resource_record_post_action 14:44:04 INFO - ##### 14:44:04 INFO - ##### Finished populate-webroot step (success) 14:44:04 INFO - ##### 14:44:04 INFO - ##### 14:44:04 INFO - ##### Running create-virtualenv step. 14:44:04 INFO - ##### 14:44:04 INFO - Running pre-action listener: _resource_record_pre_action 14:44:04 INFO - Running main action method: create_virtualenv 14:44:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:44:04 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 14:44:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:44:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:44:04 INFO - Using real prefix '/tools/python27' 14:44:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:44:05 INFO - Installing distribute.............................................................................................................................................................................................done. 14:44:08 INFO - Installing pip.................done. 14:44:08 INFO - Return code: 0 14:44:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:44:08 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')]} 14:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:08 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')]} 14:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:08 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 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:08 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 14:44:08 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 14:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:08 INFO - 'HOME': '/Users/cltbld', 14:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:08 INFO - 'LOGNAME': 'cltbld', 14:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:08 INFO - 'MOZ_NO_REMOTE': '1', 14:44:08 INFO - 'NO_EM_RESTART': '1', 14:44:08 INFO - 'PAGER': '/bin/cat', 14:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:08 INFO - 'PWD': '/builds/slave/test', 14:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:08 INFO - 'SHELL': '/bin/bash', 14:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:08 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:08 INFO - 'USER': 'cltbld', 14:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:08 INFO - 'XPC_FLAGS': '0x0', 14:44:08 INFO - 'XPC_SERVICE_NAME': '0', 14:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:08 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 14:44:08 INFO - Cleaning up... 14:44:08 INFO - Return code: 0 14:44:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:44:08 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')]} 14:44:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:08 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')]} 14:44:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:08 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 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:08 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 14:44:08 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 14:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:08 INFO - 'HOME': '/Users/cltbld', 14:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:08 INFO - 'LOGNAME': 'cltbld', 14:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:08 INFO - 'MOZ_NO_REMOTE': '1', 14:44:08 INFO - 'NO_EM_RESTART': '1', 14:44:08 INFO - 'PAGER': '/bin/cat', 14:44:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:08 INFO - 'PWD': '/builds/slave/test', 14:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:08 INFO - 'SHELL': '/bin/bash', 14:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:08 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:08 INFO - 'USER': 'cltbld', 14:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:08 INFO - 'XPC_FLAGS': '0x0', 14:44:08 INFO - 'XPC_SERVICE_NAME': '0', 14:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:08 INFO - Downloading/unpacking psutil>=3.1.1 14:44:08 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 14:44:08 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 14:44:08 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 14:44:08 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 14:44:08 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 14:44:08 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 14:44:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:44:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:44:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:44:12 INFO - Installing collected packages: psutil 14:44:12 INFO - Running setup.py install for psutil 14:44:12 INFO - building 'psutil._psutil_osx' extension 14:44:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:44:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:44:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:44:12 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 14:44:12 INFO - building 'psutil._psutil_posix' extension 14:44:12 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 14:44:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:44:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:44:12 INFO - ^ 14:44:12 INFO - 1 warning generated. 14:44:12 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 14:44:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:44:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:44:12 INFO - Successfully installed psutil 14:44:12 INFO - Cleaning up... 14:44:13 INFO - Return code: 0 14:44:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:44:13 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')]} 14:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:13 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')]} 14:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:13 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:13 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.3'] in /builds/slave/test/build 14:44:13 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.3 14:44:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:13 INFO - 'HOME': '/Users/cltbld', 14:44:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:13 INFO - 'LOGNAME': 'cltbld', 14:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:13 INFO - 'MOZ_NO_REMOTE': '1', 14:44:13 INFO - 'NO_EM_RESTART': '1', 14:44:13 INFO - 'PAGER': '/bin/cat', 14:44:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:13 INFO - 'PWD': '/builds/slave/test', 14:44:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:13 INFO - 'SHELL': '/bin/bash', 14:44:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:13 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:13 INFO - 'USER': 'cltbld', 14:44:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:13 INFO - 'XPC_FLAGS': '0x0', 14:44:13 INFO - 'XPC_SERVICE_NAME': '0', 14:44:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:44:13 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 14:44:13 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 14:44:13 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 14:44:13 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 14:44:13 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 14:44:13 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 14:44:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:44:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:44:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:44:15 INFO - Installing collected packages: mozsystemmonitor 14:44:15 INFO - Running setup.py install for mozsystemmonitor 14:44:15 INFO - Successfully installed mozsystemmonitor 14:44:15 INFO - Cleaning up... 14:44:15 INFO - Return code: 0 14:44:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:44:15 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')]} 14:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:15 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')]} 14:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:15 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 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:15 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 14:44:15 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 14:44:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:15 INFO - 'HOME': '/Users/cltbld', 14:44:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:15 INFO - 'LOGNAME': 'cltbld', 14:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:15 INFO - 'MOZ_NO_REMOTE': '1', 14:44:15 INFO - 'NO_EM_RESTART': '1', 14:44:15 INFO - 'PAGER': '/bin/cat', 14:44:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:15 INFO - 'PWD': '/builds/slave/test', 14:44:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:15 INFO - 'SHELL': '/bin/bash', 14:44:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:15 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:15 INFO - 'USER': 'cltbld', 14:44:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:16 INFO - 'XPC_FLAGS': '0x0', 14:44:16 INFO - 'XPC_SERVICE_NAME': '0', 14:44:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:44:16 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 14:44:16 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 14:44:16 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 14:44:16 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 14:44:16 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 14:44:16 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 14:44:18 INFO - Downloading blobuploader-1.2.4.tar.gz 14:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:44:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:44:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:44:19 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 14:44:19 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 14:44:19 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 14:44:19 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 14:44:19 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 14:44:19 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 14:44:19 INFO - Downloading docopt-0.6.1.tar.gz 14:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:44:20 INFO - Installing collected packages: blobuploader, requests, docopt 14:44:20 INFO - Running setup.py install for blobuploader 14:44:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:44:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:44:20 INFO - Running setup.py install for requests 14:44:20 INFO - Running setup.py install for docopt 14:44:20 INFO - Successfully installed blobuploader requests docopt 14:44:20 INFO - Cleaning up... 14:44:20 INFO - Return code: 0 14:44:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:44:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:44:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:20 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 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:20 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 14:44:20 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 14:44:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:20 INFO - 'HOME': '/Users/cltbld', 14:44:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:20 INFO - 'LOGNAME': 'cltbld', 14:44:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:20 INFO - 'MOZ_NO_REMOTE': '1', 14:44:20 INFO - 'NO_EM_RESTART': '1', 14:44:20 INFO - 'PAGER': '/bin/cat', 14:44:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:20 INFO - 'PWD': '/builds/slave/test', 14:44:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:20 INFO - 'SHELL': '/bin/bash', 14:44:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:20 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:20 INFO - 'USER': 'cltbld', 14:44:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:20 INFO - 'XPC_FLAGS': '0x0', 14:44:20 INFO - 'XPC_SERVICE_NAME': '0', 14:44:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:44:21 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-0xSZ2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:44:21 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Hq8HId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:44:21 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ADhxo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:44:21 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-7SPFRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:44:21 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-a3fGWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:44:21 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-uDEz3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:44:21 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-eGkOmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:44:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:44:21 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-z7rdX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-CFneRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-YX6DE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PfKBGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-vvBitJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-lwGNVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-xHJEPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-_FQMYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-el8c6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:44:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:44:22 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-CPGs3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:44:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:44:22 INFO - Running setup.py install for manifestparser 14:44:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:44:23 INFO - Running setup.py install for mozcrash 14:44:23 INFO - Running setup.py install for mozdebug 14:44:23 INFO - Running setup.py install for mozdevice 14:44:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:44:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:44:23 INFO - Running setup.py install for mozfile 14:44:23 INFO - Running setup.py install for mozhttpd 14:44:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:44:23 INFO - Running setup.py install for mozinfo 14:44:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:44:23 INFO - Running setup.py install for mozInstall 14:44:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Running setup.py install for mozleak 14:44:24 INFO - Running setup.py install for mozlog 14:44:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Running setup.py install for moznetwork 14:44:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Running setup.py install for mozprocess 14:44:24 INFO - Running setup.py install for mozprofile 14:44:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:44:24 INFO - Running setup.py install for mozrunner 14:44:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:44:25 INFO - Running setup.py install for mozscreenshot 14:44:25 INFO - Running setup.py install for moztest 14:44:25 INFO - Running setup.py install for mozversion 14:44:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:44:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:44:25 INFO - Cleaning up... 14:44:25 INFO - Return code: 0 14:44:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:44:25 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')]} 14:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:25 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')]} 14:44:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:25 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 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:25 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 14:44:25 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 14:44:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:25 INFO - 'HOME': '/Users/cltbld', 14:44:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:25 INFO - 'LOGNAME': 'cltbld', 14:44:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:25 INFO - 'MOZ_NO_REMOTE': '1', 14:44:25 INFO - 'NO_EM_RESTART': '1', 14:44:25 INFO - 'PAGER': '/bin/cat', 14:44:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:25 INFO - 'PWD': '/builds/slave/test', 14:44:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:25 INFO - 'SHELL': '/bin/bash', 14:44:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:25 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:25 INFO - 'USER': 'cltbld', 14:44:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:25 INFO - 'XPC_FLAGS': '0x0', 14:44:25 INFO - 'XPC_SERVICE_NAME': '0', 14:44:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:44:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-jUcWEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:44:25 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)) 14:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:44:25 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-eZUGaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-briYVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-dsCVcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-m9Gixg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-hpT7kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-BeL7dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-ykWcWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-4mfhQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-_6PhQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:44:26 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)) 14:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:44:26 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-boHm61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:44:27 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)) 14:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:44:27 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-f3pan1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:44:27 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)) 14:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:44:27 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-bvVhIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:44:27 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)) 14:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:44:27 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-pgIgvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:44:27 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)) 14:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:44:27 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-95G_IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:44:27 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)) 14:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:44:27 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-WNraRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:44:27 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)) 14:44:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:44:27 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-AYEAC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:44:27 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)) 14:44:27 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)) 14:44:27 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)) 14:44:27 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)) 14:44:27 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)) 14:44:27 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)) 14:44:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:44:27 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 14:44:27 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 14:44:27 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 14:44:27 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 14:44:27 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 14:44:27 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 14:44:30 INFO - Downloading blessings-1.6.tar.gz 14:44:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:44:30 INFO - Installing collected packages: blessings 14:44:30 INFO - Running setup.py install for blessings 14:44:30 INFO - Successfully installed blessings 14:44:30 INFO - Cleaning up... 14:44:30 INFO - Return code: 0 14:44:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:44:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:44:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:44:30 INFO - Reading from file tmpfile_stdout 14:44:30 INFO - Current package versions: 14:44:30 INFO - blessings == 1.6 14:44:30 INFO - blobuploader == 1.2.4 14:44:30 INFO - docopt == 0.6.1 14:44:30 INFO - manifestparser == 1.1 14:44:30 INFO - mozInstall == 1.12 14:44:30 INFO - mozcrash == 0.17 14:44:30 INFO - mozdebug == 0.1 14:44:30 INFO - mozdevice == 0.48 14:44:30 INFO - mozfile == 1.2 14:44:30 INFO - mozhttpd == 0.7 14:44:30 INFO - mozinfo == 0.9 14:44:30 INFO - mozleak == 0.1 14:44:30 INFO - mozlog == 3.2 14:44:30 INFO - moznetwork == 0.27 14:44:30 INFO - mozprocess == 0.22 14:44:30 INFO - mozprofile == 0.28 14:44:30 INFO - mozrunner == 6.11 14:44:30 INFO - mozscreenshot == 0.1 14:44:30 INFO - mozsystemmonitor == 0.3 14:44:30 INFO - moztest == 0.7 14:44:30 INFO - mozversion == 1.4 14:44:30 INFO - psutil == 3.1.1 14:44:30 INFO - requests == 1.2.3 14:44:30 INFO - wsgiref == 0.1.2 14:44:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:44:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:44:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:30 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 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:30 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 14:44:30 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 14:44:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:30 INFO - 'HOME': '/Users/cltbld', 14:44:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:30 INFO - 'LOGNAME': 'cltbld', 14:44:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:30 INFO - 'MOZ_NO_REMOTE': '1', 14:44:30 INFO - 'NO_EM_RESTART': '1', 14:44:30 INFO - 'PAGER': '/bin/cat', 14:44:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:30 INFO - 'PWD': '/builds/slave/test', 14:44:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:30 INFO - 'SHELL': '/bin/bash', 14:44:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:30 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:30 INFO - 'USER': 'cltbld', 14:44:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:30 INFO - 'XPC_FLAGS': '0x0', 14:44:30 INFO - 'XPC_SERVICE_NAME': '0', 14:44:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 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)) 14:44:31 INFO - Cleaning up... 14:44:31 INFO - Return code: 0 14:44:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:44:31 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')]} 14:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:31 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')]} 14:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:31 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 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:31 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 14:44:31 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 14:44:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:31 INFO - 'HOME': '/Users/cltbld', 14:44:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:31 INFO - 'LOGNAME': 'cltbld', 14:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:31 INFO - 'MOZ_NO_REMOTE': '1', 14:44:31 INFO - 'NO_EM_RESTART': '1', 14:44:31 INFO - 'PAGER': '/bin/cat', 14:44:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:31 INFO - 'PWD': '/builds/slave/test', 14:44:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:31 INFO - 'SHELL': '/bin/bash', 14:44:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:31 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:31 INFO - 'USER': 'cltbld', 14:44:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:31 INFO - 'XPC_FLAGS': '0x0', 14:44:31 INFO - 'XPC_SERVICE_NAME': '0', 14:44:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:31 INFO - Downloading/unpacking jsonschema 14:44: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 14:44: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 14:44: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 14:44: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 14:44: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 14:44: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 14:44:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:44:33 INFO - Downloading/unpacking functools32 (from jsonschema) 14:44:33 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 14:44:33 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 14:44:33 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 14:44:33 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 14:44:33 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 14:44:33 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 14:44:34 INFO - Downloading functools32-3.2.3-2.tar.gz 14:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:44:34 INFO - warning: no files found matching '*.txt' 14:44:34 INFO - no previously-included directories found matching 'build' 14:44:34 INFO - no previously-included directories found matching 'dist' 14:44:34 INFO - no previously-included directories found matching '.git*' 14:44:34 INFO - Installing collected packages: jsonschema, functools32 14:44:34 INFO - Running setup.py install for functools32 14:44:34 INFO - warning: no files found matching '*.txt' 14:44:34 INFO - no previously-included directories found matching 'build' 14:44:34 INFO - no previously-included directories found matching 'dist' 14:44:34 INFO - no previously-included directories found matching '.git*' 14:44:34 INFO - Successfully installed jsonschema functools32 14:44:34 INFO - Cleaning up... 14:44:34 INFO - Return code: 0 14:44:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:44: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')]} 14:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44: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')]} 14:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:44:34 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 0x10107da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101083570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7c25671b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, '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.IogFMdIyII/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.a6JyPtRkmf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 14:44:34 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 14:44:34 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 14:44:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:44:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:44:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:44:34 INFO - 'HOME': '/Users/cltbld', 14:44:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:44:34 INFO - 'LOGNAME': 'cltbld', 14:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:44:34 INFO - 'MOZ_NO_REMOTE': '1', 14:44:34 INFO - 'NO_EM_RESTART': '1', 14:44:34 INFO - 'PAGER': '/bin/cat', 14:44:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:44:34 INFO - 'PWD': '/builds/slave/test', 14:44:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:44:34 INFO - 'SHELL': '/bin/bash', 14:44:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:44:34 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:44:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:44:34 INFO - 'USER': 'cltbld', 14:44:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:44:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:44:34 INFO - 'XPC_FLAGS': '0x0', 14:44:34 INFO - 'XPC_SERVICE_NAME': '0', 14:44:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:44:34 INFO - Downloading/unpacking flake8 14:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:44:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:44:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:44: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 14:44: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 14:44: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 14:44: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 14:44: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 14:44: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 14:44:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:44:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:44: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 14:44: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 14:44: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 14:44: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 14:44: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 14:44: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 14:44:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:44: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 14:44: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 14:44: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 14:44: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 14:44: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 14:44: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 14:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:44:38 INFO - no previously-included directories found matching 'docs/_build' 14:44:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:44:38 INFO - Running setup.py install for pep8 14:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:44:38 INFO - no previously-included directories found matching 'docs/_build' 14:44:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:44:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:44:38 INFO - Cleaning up... 14:44:38 INFO - Return code: 0 14:44:38 INFO - Running post-action listener: _resource_record_post_action 14:44:38 INFO - Running post-action listener: _start_resource_monitoring 14:44:38 INFO - Starting resource monitoring. 14:44:38 INFO - ##### 14:44:38 INFO - ##### Finished create-virtualenv step (success) 14:44:38 INFO - ##### 14:44:38 INFO - ##### 14:44:38 INFO - ##### Running install step. 14:44:38 INFO - ##### 14:44:38 INFO - Running pre-action listener: _resource_record_pre_action 14:44:38 INFO - Running main action method: install 14:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:44:39 INFO - Reading from file tmpfile_stdout 14:44:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:44:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:44:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:44:39 INFO - Reading from file tmpfile_stdout 14:44:39 INFO - Output received: 14:44:39 INFO - Usage: mozinstall [options] installer 14:44:39 INFO - Options: 14:44:39 INFO - -h, --help show this help message and exit 14:44:39 INFO - -d DEST, --destination=DEST 14:44:39 INFO - Directory to install application into. [default: 14:44:39 INFO - "/builds/slave/test"] 14:44:39 INFO - --app=APP Application being installed. [default: firefox] 14:44:39 INFO - mkdir: /builds/slave/test/build/application 14:44:39 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'] 14:44:39 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 14:45:12 INFO - Reading from file tmpfile_stdout 14:45:12 INFO - Output received: 14:45:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:45:12 INFO - Running post-action listener: _resource_record_post_action 14:45:12 INFO - ##### 14:45:12 INFO - ##### Finished install step (success) 14:45:12 INFO - ##### 14:45:12 INFO - ##### 14:45:12 INFO - ##### Running run-tests step. 14:45:12 INFO - ##### 14:45:12 INFO - Running pre-action listener: _resource_record_pre_action 14:45:12 INFO - Running main action method: run_tests 14:45:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:45:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:45:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:45:12 INFO - 2016-05-14 14:45:12.621 screenresolution[2237:42248] starting screenresolution argv=screenresolution get 14:45:12 INFO - 2016-05-14 14:45:12.624 screenresolution[2237:42248] Display 0: 1600x1200x32@60 14:45:12 INFO - 2016-05-14 14:45:12.630 screenresolution[2238:42250] starting screenresolution argv=screenresolution list 14:45:12 INFO - Available Modes on Display 0 14:45:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:45:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:45:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:45:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:45:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:45:12 INFO - Intel Iris: 14:45:12 INFO - Chipset Model: Intel Iris 14:45:12 INFO - Type: GPU 14:45:12 INFO - Bus: Built-In 14:45:12 INFO - VRAM (Dynamic, Max): 1536 MB 14:45:12 INFO - Vendor: Intel (0x8086) 14:45:12 INFO - Device ID: 0x0a2e 14:45:12 INFO - Revision ID: 0x0009 14:45:12 INFO - Displays: 14:45:12 INFO - Display: 14:45:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:45:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:45:12 INFO - Display Serial Number: 1600x1200 60 14:45:12 INFO - Main Display: Yes 14:45:12 INFO - Mirror: Off 14:45:12 INFO - Online: Yes 14:45:12 INFO - Rotation: Supported 14:45:12 INFO - Return code: 0 14:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:45:12 INFO - Python 2.7.3 14:45:12 INFO - Return code: 0 14:45:12 INFO - grabbing minidump binary from tooltool 14:45: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')]} 14:45:12 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 0x100f21d30>, '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 0x100d45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f18b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:45:12 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 14:45:12 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 14:45:12 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 14:45:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:45:12 INFO - Return code: 0 14:45:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:45:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:45:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:45:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:45:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:45:14 INFO - Return code: 0 14:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 14:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0259 --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 14:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IogFMdIyII/Render', 14:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:45:14 INFO - 'HOME': '/Users/cltbld', 14:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:45:14 INFO - 'LOGNAME': 'cltbld', 14:45:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:45:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:45:14 INFO - 'MOZ_NO_REMOTE': '1', 14:45:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:45:14 INFO - 'NO_EM_RESTART': '1', 14:45:14 INFO - 'PAGER': '/bin/cat', 14:45:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:45:14 INFO - 'PWD': '/builds/slave/test', 14:45:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:45:14 INFO - 'SHELL': '/bin/bash', 14:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a6JyPtRkmf/Listeners', 14:45:14 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 14:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:45:14 INFO - 'USER': 'cltbld', 14:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:45:14 INFO - 'XPC_FLAGS': '0x0', 14:45:14 INFO - 'XPC_SERVICE_NAME': '0', 14:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:45:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 14:45:14 INFO - mozversion application_buildid: 20160514130527 14:45:14 INFO - mozversion application_changeset: 403912ca555eb65f814b18ecf38ad8e8e98569f5 14:45:14 INFO - mozversion application_display_name: Nightly 14:45:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:45:14 INFO - mozversion application_name: Firefox 14:45:14 INFO - mozversion application_remotingname: firefox 14:45:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:45:14 INFO - mozversion application_vendor: Mozilla 14:45:14 INFO - mozversion application_version: 49.0a1 14:45:14 INFO - mozversion platform_buildid: 20160514130527 14:45:14 INFO - mozversion platform_changeset: 403912ca555eb65f814b18ecf38ad8e8e98569f5 14:45:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:45:14 INFO - mozversion platform_version: 49.0a1 14:45:14 INFO - using testdate: 1463262314 14:45:14 INFO - actual date: 1463262314 14:45:14 INFO - starting webserver on 'localhost:54310' 14:45:14 INFO - SUITE-START | Running 2 tests 14:45:14 INFO - TEST-START | dromaeo_css 14:45:14 INFO - operating with platform_type : mac_ 14:45:14 INFO - Initialising browser for dromaeo_css test... 14:45:14 INFO - TEST-INFO | started process 2256 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpHVVBmo/profile http://localhost:54310/getInfo.html) 14:45:16 INFO - PROCESS | 2256 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 14:45:17 INFO - PROCESS | 2256 | __metrics Screen width/height:1600/1200 14:45:17 INFO - PROCESS | 2256 | colorDepth:24 14:45:17 INFO - PROCESS | 2256 | Browser inner width/height: 1024/689 14:45:17 INFO - PROCESS | 2256 | __metrics 14:45:17 ERROR - PROCESS | 2256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:45:17 INFO - TEST-INFO | 2256: exit 0 14:45:17 INFO - Browser initialized. 14:45:17 INFO - Running cycle 1/1 for dromaeo_css test... 14:45:17 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpHVVBmo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:45:29 INFO - PROCESS | 2259 | RSS: Main: 249778176 14:45:29 INFO - PROCESS | 2259 | 14:46:19 INFO - PROCESS | 2259 | 1463262379459 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] 14:48:31 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:54310/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54310/tests/dromaeo/cssquery-ext.html) 14:48:32 INFO - PROCESS | 2259 | RSS: Main: 261783552 14:48:32 INFO - PROCESS | 2259 | 14:51:35 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:54310/tests/dromaeo/cssquery-ext.html (next: http://localhost:54310/tests/dromaeo/cssquery-jquery.html) 14:51:35 INFO - PROCESS | 2259 | RSS: Main: 273477632 14:51:35 INFO - PROCESS | 2259 | 14:54:37 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:54310/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54310/tests/dromaeo/cssquery-mootools.html) 14:54:38 INFO - PROCESS | 2259 | RSS: Main: 275505152 14:54:38 INFO - PROCESS | 2259 | 14:57:40 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:54310/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54310/tests/dromaeo/cssquery-prototype.html) 14:57:40 INFO - PROCESS | 2259 | RSS: Main: 277139456 14:57:40 INFO - PROCESS | 2259 | 15:00:43 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:54310/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54310/tests/dromaeo/cssquery-yui.html) 15:00:44 INFO - PROCESS | 2259 | RSS: Main: 279900160 15:00:44 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:54310/tests/dromaeo/cssquery-yui.html (next: http://localhost:54310/tests/dromaeo/cssquery-dojo.html) 15:03:47 INFO - PROCESS | 2259 | RSS: Main: 281186304 15:03:47 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | __start_tp_report 15:03:47 INFO - PROCESS | 2259 | _x_x_mozilla_page_load 15:03:47 INFO - PROCESS | 2259 | _x_x_mozilla_page_load_details 15:03:47 INFO - PROCESS | 2259 | |i|pagename|runs| 15:03:47 INFO - PROCESS | 2259 | |0;dojo.html;3378.2567835076284;3517.472379143129;3534.3991521441353;3569.179088809574;3575.2849430113984;4875.317455556216;5683.403242659523;5867.354590994993;5987.790427335044;5989.431004054613;5763.884722305552;5892.499137573301;5955.761769529214;5972.7312270947805;6017.879642407149;4945.23348880924;4999.925016121533;5284.313039304885;5328.6269961102735;5431.972840135793;4460.66545009124;5479.698616576086;5502.697351645658;5526.668399895999;5526.944730552704;5271.182966640177;5286.392064912546;5293.550048245904;5367.329083864517;5381.946180538203;5340.519353258225;5351.518363347317;5359.732013399314;5378.058839703036;5393.865153371158;5090.880006398586;5360.731963401814;5380.28589928775;5400.459954004568;5421.620486565942;5204.8959020819375;5776.277965254343;5847.619904706223;5855.209546711182;5886.764529418818;6213.720382582795;6241.028708133989;6246.469050130744;6252.749890004395;6290.24517057956;6146.7233974471255;6314.905276420857;6324.494040476797;6332.461740752042;6341.8097457076365;5926.822195334147;5968.1942937703725;5993.760249590055;5994.220751302303;6011.729472173763;6374.043893415932;6409.134766806515;6413.903791443132;6414.102025716404;6414.903776443357;6101.610781564068;6200.3179650238435;6260.686965651699;6282.654454004982;6295.874082518324;6222.595531290452;6325.493960483151;6330.620162790247;6333.524985626004;6344.048392741126;6113.749968913926;6201.410865967726;6235.376462353819;6259.874802504016;6267.561270711007;6114.996965385541;6186.443220110212;6196;6308.779192728324;6310.716017779211;4927.852164435073;4984.476629953875;4985.950140498621;5012.699238045729;5021.6735912165595;4367.475902891673;4438.977805110953;4444.73331600105;4454.77726113693;4527.501974782771;5868.559858010666;5906.114082887601;5965.970170149121;5969.552283578749;6025.307089684655;6331.620102793847;6342.619442833445;6349.460295874902;6354.809355719336;6389.488840892717;6048.788292409745;6063.060225665029;6069.848253793691;6077.544184186204;6086.056661217518;5472.261244731911;5515.117581186991;5531.917021244684;5545.085060964976;5550.167474878801;6520.021996700533;6583.604983700993;6584.670766461658;6590.340965903371;6613.2394774601535;6321.968390158204;6352.174217351715;6359.236891573041;6362.936370636235;6364.140840986408;5474.91787623178;5524.309461317335;5568.303962004749;6376.52176086786;6450.41946224842;5553.805616803393;6203.100550420074;6237.719302631302;6243.719032643451;6251.093591429309;4941.382327209099;5264.684118952875;6104.337893874414;6267.655278959701;6329.746810127727;5659.3491748447805;6120.477608373184;6201.534884883562;6212.47193988516;6240.625562466266;6220.844478888064;6242.750289988349;6248.9062664059165;6249.375062493896;6264.404881536247;6137.171481850071;6160.969195153995;6230.096635987847;6249.531285153541;6259.186305780219;6161.476274516537;6171.197744293393;6184;6191.19514463117;6265.843353916189;6201.782937597162;6212.875742485216;6223.968880155751;6229.4393504584805;6229.813105606839 15:03:47 INFO - PROCESS | 2259 | |1;ext.html;508.3645443196005;516.2179298362978;549.6866785932019;553.3553410277027;555.8804856955753;37783.81108094459;42254.57745422545;42283;42283.57716422835;42319;43269.78365108178;43661;43748.3437748434;43799.46701865435;43850.561494385045;9459;9559.665411710592;9587.520623968774;9676.371035882681;9697.563609637584;8360.498370097814;9553.949065602777;9583.856242156373;9656;9731.51342432879;8602.924634420697;9236.353455258135;9647;9660.178884794801;9738.51307434629;9645.22838172948;9651.372660777028;9672.08115229052;9708.660196893075;9708.708738737849;9465.810683786285;9465.952670236606;9533.237341012771;9570.282228832795;9577.712668619952;36278;38910.41634375486;39032.804835975636;39155.608443915764;39459.01352466182;2851.230167854668;3208.502682084281;3241.3031198292247;3253.235489659928;3284.2774589590254;27724.722752772417;28876.855615721997;29861.10416687503;29971.550426743615;30182.396352073054;2768.2387343480505;2785.4846853332197;2829.122971878724;2854;2880.9711902880913;361754;362803;362827;364780;364871;34851.30297394089;35689.46465803015;36021;36949;59444;36799.08002299964;36866.893993180245;37093.88718338454;37094.88715338544;37167.25665486675;14849.480268190562;15158.772618410732;15344.693106137815;15356.232188390535;15364.923175384052;12858.9357053216;12949.352532373343;12982.221066736027;12994.350282485839;13084.018698597452;8137.8372432552205;8161.5919204039565;8241.917580824114;8265.545395003212;8267.214614611603;3406.625271220164;3426.794392336468;3433.364827506919;3450.585929688403;3479;906.7869050773063;1047.1361127070197;1054.541274545575;1129.4578602270956;1181.5214837990627;26612.46775064488;29368.412631747244;29702.405951880843;29802.64169473192;29841.701582984326;1115.3475216997986;1137.8919002694731;1177.4760231696812;1216.3735676126803;1232.168286406672;12888;15119.697606047817;15342;15428.614284642974;16180.838191618168;518762;960735;971950;977040;980213;59679.70160149172;61014.389856101756;61230.69384653137;61237.38762612406;61899.69050154721;1470.6617477980124;1502.6994601079828;1505.4505105636365;1513.4627207341455;1522.1704171226709;29622.851885740434;29696.257593560334;29761.851190743906;30160.5475917857;30480.542791857697;50281.24578131258;50643;51239.48760512496;51274.23088653599;51316.74341628268;618416;619584;624454;625063;626774;26691.86654066795;26851.597226041235;27142.185734428;27168.049118280764;27185.864070680313;43728;44629.55370446254;44702.3294650587;45544.316835246835;45773.77113114413;35805.283894322485;37226;37462.43806342962;37798.81100594479;37830.81084594559;36304;36635;36749.08127296839;36756.44865327076;37166;30881.382372352877;32731.85438509641;36713;36879.70921017751;37226.627733722315;29263.7073629261;32469.35061298808;32629.247636522105;32826.83586582052;32870.34259314752;20984.790152098285;21378.037988290253;23841.92711328029;24556;24920.875395623632 15:03:47 INFO - PROCESS | 2259 | |2;jquery.html;390.2604564350556;397.88063580925717;399.1518024198578;399.9082504762;418.8157210827236;11672.416379181028;19013.52466188346;19292.228310867584;19598.216071357147;20266.898665506687;20166.495837604067;20238;20280.797192028076;21322.57354852906;21335.893320533374;5665.461781130786;5674.290713660793;5696.344920334152;5718.199452076692;5768.538516918647;5897.351291357947;5904.291485021803;5937.40625937405;5955.761769529214;5970.492508136814;5631.2960879890015;5861.3552509223955;5925.170476133345;5951.702414879239;5955.85110372242;5620.662760234358;5835.503982161521;5904;5935.080062590284;5955.166276721263;5111.361079865017;5118.97440512795;5139.254808052849;5150.48495150482;5159.226116082617;25323.62014569783;26120.73879261202;26159.215223543324;26487.867560662267;26653.733462665317;2498.850068995848;2726.836389816617;2923.1522858371045;2937.911862644124;2980.4337175936503;9459.24326053914;10143.543540540693;15485.380584776596;15519.068855868683;15821.971571847793;1395.3511617097997;1755.5435586747537;1769.6991511442957;1770.1326350088364;1806.9006204658738;99205.01589968233;125180;125271;126226;126854.73145268521;8305.626246818787;10339.948300258451;10407.271490995558;10488.31825931312;11601.01391381742;12261.754764904652;12522.499100036079;12532.436040378205;12586.748265034648;12644.936775316064;6727.966360168168;8224.62989165489;8266.545340006238;8275.54484503346;8366.874496882552;8679.481090809084;8684;8695.521746303888;8770.210681038738;8803.119688031275;3969.1069509360163;3985.80070996449;4038.919221615551;4049.3116170250537;4089.0390758171807;1819.6087841114224;1978.3570339639675;2034.9389518314474;2036.4399790057853;2038.6941958706313;890.5572971785748;904.1410659873147;935.4948327902993;1010.282699283517;1013.2400699475394;20405.2858149967;20830.479238019172;20928;21109.9445027748;21222.25722099719;842.2419822160105;934.495372498843;986.0386123529502;1020.9030142136485;1043.0768769638923;8750.91249087501;9119.407238529608;10938.343699377903;10976.890231097746;11084.113270938467;486155;593408;602221;610446;617283;122411;130987;134378;135558.32220838833;139751.30124349517;1002.8997100290059;1032.808930347888;1033.560736686905;1036.8341065429495;1040.557762950743;14914;16389.78737870372;17911.641767164325;18207.544811379823;18221.45335639933;35583.644163558034;36214;47407;50632.24051639155;58022.7098864503;76771.23228767641;77217;77603;78305;79230.81153782814;7810.687572497037;7886.566238856689;7932.881006785018;8019.917311162918;8155.592220389076;11689.240199387013;12211.572594959134;12722.236665800081;12830.743385132431;12880.806787898002;11131.499082541142;11304.660860174208;11414.94292528532;11469.655910322703;11488.310701357945;10206.744831378977;10870.184736144663;11089.168312376443;11111.38887361203;11216.990470857661;9209.907900921173;9579.808403832023;9777.85333219988;11167.609133680282;11456.109741892495;7791.805204869924;8173.34613230952;8207.876881846896;8265.545395003333;8273.875891861506;8377.790555236168;10486.790264194826;10691.946540267249;10962.890371096506;11125.499352529318 15:03:47 INFO - PROCESS | 2259 | |3;mootools.html;1298.4870975964495;1522.7715842623604;1730.3857130718595;1962.2347284559016;1979.0698371765284;7803.336716379101;8824;8839.204471597555;9363.812723745521;9386.249100071986;8922.77693057674;9000.594973226203;9169.54152292386;9172.770680732985;9201.447913125217;2431.744666809986;2461.8276720629474;2461.950760984779;2471.159805666073;2487.502499500098;2177.3032629558547;2427.757224277567;2495.6880389951257;2497.7127630322566;2509.4855554611263;2247.4044378239696;2457.3242358351417;2468.4075821802726;2475.356407334097;2484.9438988429847;2443.1937460637946;2452.8160387970797;2460.90156393744;2465.4822487277693;2471.9629205561932;2385.415573184581;2411.44536756547;2413.5655581995234;2421.4309637235237;2458.397692565333;9086.409383390059;9142.908570914338;9170.724878253663;9176.174144326977;9198.724038278862;5405.999890020319;5547.72261386933;5579.7489112990015;5581.246531718207;5592.245046918654;3607.549056367954;3618.2763447310645;3653.1597732521404;3702.129999450127;3710.684591809699;1056.6037735849056;1064.9467526623637;1067.2742535076145;1074.08702602787;1077.412810018534;11307.886921130848;12052.457639406248;12123.93938030313;12144.089193310625;12167.330796806173;4903.41159060915;4913.557779799835;5064.366954130734;5072.797088116434;5080.364954380702;10342.069213770646;10383.532741026673;10390.324628899098;10391.740206494898;10416.166706663449;5457.426970168154;5541.196526503634;5546.251256080458;5584.190292407659;5591.021571225019;4585.220512512881;4880.511948805091;5033.345665063518;5041.697498150123;5046.571041461517;4147.170565886835;4182.079942412664;4189.539150693421;4225.302825033897;4278.422412974271;1162.9068675445055;1179.2511755035443;1329.9094742311213;1342.1074985134776;1374.6391072837819;849.0363437498361;892.9285657147412;930.1024511346448;940.3074465961242;948.9572969216401;5779.133130030529;5880.676562789002;6113.113598528277;6283.560150789401;6346.524010699216;787.9330256928225;993.2997236947934;996.8405055191134;1014.2545229256491;1024.7489365105596;3886.7473614214987;3959.772470534086;4009.1380353224195;4057.8985525361513;4059.512858456945;9555.761105972406;11050.944745276222;11170.162237832195;11192.888071119185;11217.326960382403;11136.832947505794;11189.272697274651;11190.776184476264;11203.831942520868;11254.38100904458;8136.633851476698;8527.019392769911;8576.013758417737;8589.699360522352;8613.052564217931;5762.654240745401;5966.164736936746;5998.310194327708;6069.36271691466;6073.271207455134;10018;10346.275760696679;10489.842652360374;10499.895001049892;10501.949805019436;9328.300377471582;10564.471776411303;10662;10677.46612669379;10825.945870270913;6692.498062645223;7036.19083805369;7230.24082471354;7335.7432489862595;7397.001404810282;8244.258016778518;8674.219320261207;8679.783005424915;8776.385653004229;8803.339749518684;7693.230676932262;7793.64928578204;7827.217278272355;7830.060392752906;7924.20757924203;7315;7426.183119856703;7475.289847464483;7568.886466702894;7715.57564333967;7314.524555903849;7366.410687145123;7379.077615298088;7385.778426646994;7415.147258065392;4873.756312184448;5024.447310795883;5096.031753966735;5104.515071068243;5122.385313762373;4823.9517604824905;4971.179755340473;5011.649184557046;5036.597072234139;5242.318498595158 15:03:47 INFO - PROCESS | 2259 | |4;prototype.html;298.4821334983804;317.55225132563083;319.4122814022199;321.4856230031949;327.51527738946373;5348.946510534894;5405.783768649249;5590.329160500741;5597.552195824334;5614.859628509279;5357.794496238344;5481.314835645544;5490.478404551562;5526.944730552693;5575.721213939297;3994.64048235658;4070.5725898780497;4148.751074935499;4167.562405947378;4173;3409.573803274591;3955.347367684343;4030.5816510093855;4166.791630427188;4185.162967406515;3443.8794642187527;4051.554329023805;4097.774622395767;4108.746832216173;4167.020580285096;3092.979316825453;3824.368979118442;4151.8962025949595;4155.39746736723;4170.436991006206;3526.982365088158;3531.0642679689904;3544.7416167260767;3554.5556805399324;3572.964270357289;5020;5149.433562308143;5177.249298851683;5202.895942081137;5227.3465816772905;4503.954960450419;4580.312953057035;4685.976570117162;4691.9530804692195;4715.292706094079;5703.230063941398;5768.192453056576;5779.9422005779825;5780.971095144498;5814.447627475425;3886.1644746379666;3900.2979463696524;3905.1994341159993;3913.98043009786;3936.9606303937167;4917.975445101273;6031.698415079229;6060.696965151769;6069.878602427971;6149.938500614981;3785.413260944558;3935.9729739184345;3968.2857085724268;3979.7015223858325;3984.820683069269;3774.6602805747616;3991.6806655467494;3999.700022498266;4006.959930400717;4055.6755459563165;4048;4683.367745354401;4690.413698287714;4706.552877476634;4747.905041899143;5505.256790333334;5843.2403787507355;5857.163557869602;5867.354590994987;5903.734331955073;1360.53741727813;1380.7790753479394;1381.896357773171;1384.5569417786212;1386.6671998720235;757.3070640364116;833.4123494742526;836.3016880904391;852.7825404521807;903.3586153830854;4280.587406155961;5283.735813209324;5315.468453154654;5344.8663783404945;5381.596380271495;5340.19897015443;5814.656572470762;5839.299284085937;5906.645601263938;5911.76352945886;4200.718780771894;5121.20621303691;5316.7669578777;5331.173668081454;5336.332958380202;2849.971500285012;2933.985330073336;3093.7370323522305;3098.2873938994157;3134.49848024315;4918.926216106761;5614.775408983676;6128.846778830476;6166.475849552839;6175.938240617536;5205.55752761012;5330.706811125426;5377.4891385319115;5718.342390625048;6078.143272661842;4687.0625874825855;5534.1145416733125;6142.57002009855;6179.497303592052;6196.597221180609;4651.86044418668;5104.591632669303;5874.324452687995;5881.823545293648;5952.690408110208;4750.888168249802;5567.359753628384;5709.3719690834805;5829.318513483675;5849.239598852122;5359.355638165928;5517.36550296705;5542.115680668592;5630.930123276565;5862.472377486047;3024.228821650465;3200.535922291208;3843.9039024024623;3933.409988501633;4016.1686011362503;5049.974750126225;5133.101707201299;5165.044466773659;5886.676232807236;6011.579189456696;4938.950610493849;5854.502367298827;5868.210195890294;5889.882202355843;5901.586888917906;5498.625343664084;5515.889682206413;5882.823515294548;5909.497692695997;5928.762849485972;5473.28847249855;5741.425857414225;5765.855853603525;5776.855578610568;5789.536837052941;4935.975320123376;5146.665466744649;5260.894782104413;5788.581797459481;5865.266841644794;5464.535514481155;5563.9150365679925;5704.971475142764;5720.427957204246;5753.453421924911 15:03:47 INFO - PROCESS | 2259 | |5;yui.html;655.2595567009279;671.3588522960576;695.2387136085985;735.2353552305602;760.1524300405047;15208.54374368768;15234.923825380858;15486.535403937873;15599.766003509956;15684.921575392107;14246.358913848875;14326.99711020229;14395.712085758278;14411.495597654084;14419.495317663885;753.6608526163221;924.1267002682467;931.6273490603745;944.759086432962;947.1286416496805;936.9484678342689;942.8821397325335;944.0512285153445;945.2579724915907;949.2595775295247;988.3032462114193;991.990080099197;992.3995982430633;998.3610489286863;1010.1615659003047;964.2864280432465;985.3250523391499;985.6303886042734;985.9408435493857;987.9259055570789;696.5507247825175;698.183125742882;708.9113860767404;725.5755383100892;744.0884915977938;13733.931330343385;14923.776143357858;15011.549653510412;15027.849721502755;15051.172185529791;9172;11614.36121013344;11986.88013119875;12726.745465090646;12834.614961551168;9372.343935924488;9412.823397075366;9913.058259465412;10101.393916365041;10387.220958428148;2888.24905524563;3253.844885065815;3342.8328583570724;3365.326934613063;3477.7217822574385;67424.32575674278;83915;84522.57738711267;86459.56770216172;87175.56412217961;9387.436753794795;9480.952595237117;9581.568829402555;9641.035896410443;10007;21397.465063373227;22125.225617103646;22461.55076898453;22529.32412027609;22555.210567630053;7380;7441.181470038291;7479.887801682979;7522.548647081083;7839;3977.9801100994887;4010.258102251093;4020.4170395292517;4027.516697996259;4100.138970816162;3434.6050204226835;3525.1010992196825;3550.076979985171;3551.751377403557;3564.518789963322;553.4520824383911;573.7360814025595;579.1139556478595;580.35870363248;582.988340233193;540.7972010496064;577.6678409914316;577.8945441411474;591.3111225422335;622.3403192615841;8346.582670866432;8388.203120703523;8493.872591911126;8518.020427650776;8570.400071995025;495.3535635994989;562.3364429972589;600.4355905448864;606.6693651959692;613.2518327640272;3414.351273258073;3945.447637330776;4012.879613611596;4015.6185162409524;4083.6528895044253;78637.4272514558;97800.51099744455;98380;102061.97938020673;103452;90550.73623159342;91543.54228228817;91962;92306;92611;81239;81854.59072704718;81854.9999999988;82332.58833705913;82388.58805706054;7839.568823714751;7853.960730196541;7970.442069055111;8050.154733752872;8059.637316320897;48363.75818121028;48952.75523622359;49772.751136244086;50471;50855.49144508508;56070.43929560652;63194.68402658141;64046.797660117736;64085.359146407936;66515.33484665286;9380.34337596389;10956.945215273872;11063.391513466837;11188.552457901593;11606.651800446;12081;12556.497740090294;12643.557475488315;12699.174553653984;13284.136531125447;11567.537298507965;11591.594294199662;11712.063034957353;11921.463534141158;12025.45885435175;11691.240069395462;11783;11915.463804128662;12084;12618.747625047632;11166.635881204804;11240.213185076966;11309.943450283025;11329.886701132884;11415.657530274106;9382.76543086401;9876.506174691092;9972.650957216752;10081.092701656886;10579.682609521727;9892.85160722604;9922.542402430881;10028.348157369748;10179.338343007681;10294.227932904912 15:03:47 INFO - PROCESS | 2259 | __end_tp_report 15:03:47 INFO - PROCESS | 2259 | __start_cc_report 15:03:47 INFO - PROCESS | 2259 | _x_x_mozilla_cycle_collect,419 15:03:47 INFO - PROCESS | 2259 | __end_cc_report 15:03:47 INFO - PROCESS | 2259 | __startTimestamp1463263427522__endTimestamp 15:03:47 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | ------- Summary: start ------- 15:03:47 INFO - PROCESS | 2259 | Number of tests: 6 15:03:47 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | [#0] dojo.html Cycles:165 Average:5824.71 Median:6101.61 stddev:654.26 (10.7%) stddev-sans-first:627.49 15:03:47 INFO - PROCESS | 2259 | Values: 3378.3 3517.5 3534.4 3569.2 3575.3 4875.3 5683.4 5867.4 5987.8 5989.4 5763.9 5892.5 5955.8 5972.7 6017.9 4945.2 4999.9 5284.3 5328.6 5432.0 4460.7 5479.7 5502.7 5526.7 5526.9 5271.2 5286.4 5293.6 5367.3 5381.9 5340.5 5351.5 5359.7 5378.1 5393.9 5090.9 5360.7 5380.3 5400.5 5421.6 5204.9 5776.3 5847.6 5855.2 5886.8 6213.7 6241.0 6246.5 6252.7 6290.2 6146.7 6314.9 6324.5 6332.5 6341.8 5926.8 5968.2 5993.8 5994.2 6011.7 6374.0 6409.1 6413.9 6414.1 6414.9 6101.6 6200.3 6260.7 6282.7 6295.9 6222.6 6325.5 6330.6 6333.5 6344.0 6113.7 6201.4 6235.4 6259.9 6267.6 6115.0 6186.4 6196.0 6308.8 6310.7 4927.9 4984.5 4986.0 5012.7 5021.7 4367.5 4439.0 4444.7 4454.8 4527.5 5868.6 5906.1 5966.0 5969.6 6025.3 6331.6 6342.6 6349.5 6354.8 6389.5 6048.8 6063.1 6069.8 6077.5 6086.1 5472.3 5515.1 5531.9 5545.1 5550.2 6520.0 6583.6 6584.7 6590.3 6613.2 6322.0 6352.2 6359.2 6362.9 6364.1 5474.9 5524.3 5568.3 6376.5 6450.4 5553.8 6203.1 6237.7 6243.7 6251.1 4941.4 5264.7 6104.3 6267.7 6329.7 5659.3 6120.5 6201.5 6212.5 6240.6 6220.8 6242.8 6248.9 6249.4 6264.4 6137.2 6161.0 6230.1 6249.5 6259.2 6161.5 6171.2 6184.0 6191.2 6265.8 6201.8 6212.9 6224.0 6229.4 6229.8 15:03:47 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | [#1] ext.html Cycles:180 Average:72723.20 Median:36777.76 stddev:180523.25 (490.8%) stddev-sans-first:180948.24 15:03:47 INFO - PROCESS | 2259 | Values: 508.4 516.2 549.7 553.4 555.9 37783.8 42254.6 42283.0 42283.6 42319.0 43269.8 43661.0 43748.3 43799.5 43850.6 9459.0 9559.7 9587.5 9676.4 9697.6 8360.5 9553.9 9583.9 9656.0 9731.5 8602.9 9236.4 9647.0 9660.2 9738.5 9645.2 9651.4 9672.1 9708.7 9708.7 9465.8 9466.0 9533.2 9570.3 9577.7 36278.0 38910.4 39032.8 39155.6 39459.0 2851.2 3208.5 3241.3 3253.2 3284.3 27724.7 28876.9 29861.1 29971.6 30182.4 2768.2 2785.5 2829.1 2854.0 2881.0 361754.0 362803.0 362827.0 364780.0 364871.0 34851.3 35689.5 36021.0 36949.0 59444.0 36799.1 36866.9 37093.9 37094.9 37167.3 14849.5 15158.8 15344.7 15356.2 15364.9 12858.9 12949.4 12982.2 12994.4 13084.0 8137.8 8161.6 8241.9 8265.5 8267.2 3406.6 3426.8 3433.4 3450.6 3479.0 906.8 1047.1 1054.5 1129.5 1181.5 26612.5 29368.4 29702.4 29802.6 29841.7 1115.3 1137.9 1177.5 1216.4 1232.2 12888.0 15119.7 15342.0 15428.6 16180.8 518762.0 960735.0 971950.0 977040.0 980213.0 59679.7 61014.4 61230.7 61237.4 61899.7 1470.7 1502.7 1505.5 1513.5 1522.2 29622.9 29696.3 29761.9 30160.5 30480.5 50281.2 50643.0 51239.5 51274.2 51316.7 618416.0 619584.0 624454.0 625063.0 626774.0 26691.9 26851.6 27142.2 27168.0 27185.9 43728.0 44629.6 44702.3 45544.3 45773.8 35805.3 37226.0 37462.4 37798.8 37830.8 36304.0 36635.0 36749.1 36756.4 37166.0 30881.4 32731.9 36713.0 36879.7 37226.6 29263.7 32469.4 32629.2 32826.8 32870.3 20984.8 21378.0 23841.9 24556.0 24920.9 15:03:47 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | [#2] jquery.html Cycles:180 Average:34386.95 Median:14690.28 stddev:97837.67 (666.0%) stddev-sans-first:98078.82 15:03:47 INFO - PROCESS | 2259 | Values: 390.3 397.9 399.2 399.9 418.8 11672.4 19013.5 19292.2 19598.2 20266.9 20166.5 20238.0 20280.8 21322.6 21335.9 5665.5 5674.3 5696.3 5718.2 5768.5 5897.4 5904.3 5937.4 5955.8 5970.5 5631.3 5861.4 5925.2 5951.7 5955.9 5620.7 5835.5 5904.0 5935.1 5955.2 5111.4 5119.0 5139.3 5150.5 5159.2 25323.6 26120.7 26159.2 26487.9 26653.7 2498.9 2726.8 2923.2 2937.9 2980.4 9459.2 10143.5 15485.4 15519.1 15822.0 1395.4 1755.5 1769.7 1770.1 1806.9 99205.0 125180.0 125271.0 126226.0 126854.7 8305.6 10339.9 10407.3 10488.3 11601.0 12261.8 12522.5 12532.4 12586.7 12644.9 6728.0 8224.6 8266.5 8275.5 8366.9 8679.5 8684.0 8695.5 8770.2 8803.1 3969.1 3985.8 4038.9 4049.3 4089.0 1819.6 1978.4 2034.9 2036.4 2038.7 890.6 904.1 935.5 1010.3 1013.2 20405.3 20830.5 20928.0 21109.9 21222.3 842.2 934.5 986.0 1020.9 1043.1 8750.9 9119.4 10938.3 10976.9 11084.1 486155.0 593408.0 602221.0 610446.0 617283.0 122411.0 130987.0 134378.0 135558.3 139751.3 1002.9 1032.8 1033.6 1036.8 1040.6 14914.0 16389.8 17911.6 18207.5 18221.5 35583.6 36214.0 47407.0 50632.2 58022.7 76771.2 77217.0 77603.0 78305.0 79230.8 7810.7 7886.6 7932.9 8019.9 8155.6 11689.2 12211.6 12722.2 12830.7 12880.8 11131.5 11304.7 11414.9 11469.7 11488.3 10206.7 10870.2 11089.2 11111.4 11217.0 9209.9 9579.8 9777.9 11167.6 11456.1 7791.8 8173.3 8207.9 8265.5 8273.9 8377.8 10486.8 10691.9 10962.9 11125.5 15:03:47 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | [#3] mootools.html Cycles:180 Average:5896.96 Median:4942.37 stddev:3306.58 (66.9%) stddev-sans-first:3297.80 15:03:47 INFO - PROCESS | 2259 | Values: 1298.5 1522.8 1730.4 1962.2 1979.1 7803.3 8824.0 8839.2 9363.8 9386.2 8922.8 9000.6 9169.5 9172.8 9201.4 2431.7 2461.8 2462.0 2471.2 2487.5 2177.3 2427.8 2495.7 2497.7 2509.5 2247.4 2457.3 2468.4 2475.4 2484.9 2443.2 2452.8 2460.9 2465.5 2472.0 2385.4 2411.4 2413.6 2421.4 2458.4 9086.4 9142.9 9170.7 9176.2 9198.7 5406.0 5547.7 5579.7 5581.2 5592.2 3607.5 3618.3 3653.2 3702.1 3710.7 1056.6 1064.9 1067.3 1074.1 1077.4 11307.9 12052.5 12123.9 12144.1 12167.3 4903.4 4913.6 5064.4 5072.8 5080.4 10342.1 10383.5 10390.3 10391.7 10416.2 5457.4 5541.2 5546.3 5584.2 5591.0 4585.2 4880.5 5033.3 5041.7 5046.6 4147.2 4182.1 4189.5 4225.3 4278.4 1162.9 1179.3 1329.9 1342.1 1374.6 849.0 892.9 930.1 940.3 949.0 5779.1 5880.7 6113.1 6283.6 6346.5 787.9 993.3 996.8 1014.3 1024.7 3886.7 3959.8 4009.1 4057.9 4059.5 9555.8 11050.9 11170.2 11192.9 11217.3 11136.8 11189.3 11190.8 11203.8 11254.4 8136.6 8527.0 8576.0 8589.7 8613.1 5762.7 5966.2 5998.3 6069.4 6073.3 10018.0 10346.3 10489.8 10499.9 10501.9 9328.3 10564.5 10662.0 10677.5 10825.9 6692.5 7036.2 7230.2 7335.7 7397.0 8244.3 8674.2 8679.8 8776.4 8803.3 7693.2 7793.6 7827.2 7830.1 7924.2 7315.0 7426.2 7475.3 7568.9 7715.6 7314.5 7366.4 7379.1 7385.8 7415.1 4873.8 5024.4 5096.0 5104.5 5122.4 4824.0 4971.2 5011.6 5036.6 5242.3 15:03:47 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | [#4] prototype.html Cycles:180 Average:4624.65 Median:5244.12 stddev:1436.60 (27.4%) stddev-sans-first:1403.45 15:03:47 INFO - PROCESS | 2259 | Values: 298.5 317.6 319.4 321.5 327.5 5348.9 5405.8 5590.3 5597.6 5614.9 5357.8 5481.3 5490.5 5526.9 5575.7 3994.6 4070.6 4148.8 4167.6 4173.0 3409.6 3955.3 4030.6 4166.8 4185.2 3443.9 4051.6 4097.8 4108.7 4167.0 3093.0 3824.4 4151.9 4155.4 4170.4 3527.0 3531.1 3544.7 3554.6 3573.0 5020.0 5149.4 5177.2 5202.9 5227.3 4504.0 4580.3 4686.0 4692.0 4715.3 5703.2 5768.2 5779.9 5781.0 5814.4 3886.2 3900.3 3905.2 3914.0 3937.0 4918.0 6031.7 6060.7 6069.9 6149.9 3785.4 3936.0 3968.3 3979.7 3984.8 3774.7 3991.7 3999.7 4007.0 4055.7 4048.0 4683.4 4690.4 4706.6 4747.9 5505.3 5843.2 5857.2 5867.4 5903.7 1360.5 1380.8 1381.9 1384.6 1386.7 757.3 833.4 836.3 852.8 903.4 4280.6 5283.7 5315.5 5344.9 5381.6 5340.2 5814.7 5839.3 5906.6 5911.8 4200.7 5121.2 5316.8 5331.2 5336.3 2850.0 2934.0 3093.7 3098.3 3134.5 4918.9 5614.8 6128.8 6166.5 6175.9 5205.6 5330.7 5377.5 5718.3 6078.1 4687.1 5534.1 6142.6 6179.5 6196.6 4651.9 5104.6 5874.3 5881.8 5952.7 4750.9 5567.4 5709.4 5829.3 5849.2 5359.4 5517.4 5542.1 5630.9 5862.5 3024.2 3200.5 3843.9 3933.4 4016.2 5050.0 5133.1 5165.0 5886.7 6011.6 4939.0 5854.5 5868.2 5889.9 5901.6 5498.6 5515.9 5882.8 5909.5 5928.8 5473.3 5741.4 5765.9 5776.9 5789.5 4936.0 5146.7 5260.9 5788.6 5865.3 5464.5 5563.9 5705.0 5720.4 5753.5 15:03:47 INFO - PROCESS | 2259 | 15:03:47 INFO - PROCESS | 2259 | [#5] yui.html Cycles:180 Average:19063.72 Median:577.78 stddev:27551.96 (4768.6%) stddev-sans-first:27594.58 15:03:47 INFO - PROCESS | 2259 | Values: 655.3 671.4 695.2 735.2 760.2 15208.5 15234.9 15486.5 15599.8 15684.9 14246.4 14327.0 14395.7 14411.5 14419.5 753.7 924.1 931.6 944.8 947.1 936.9 942.9 944.1 945.3 949.3 988.3 992.0 992.4 998.4 1010.2 964.3 985.3 985.6 985.9 987.9 696.6 698.2 708.9 725.6 744.1 13733.9 14923.8 15011.5 15027.8 15051.2 9172.0 11614.4 11986.9 12726.7 12834.6 9372.3 9412.8 9913.1 10101.4 10387.2 2888.2 3253.8 3342.8 3365.3 3477.7 67424.3 83915.0 84522.6 86459.6 87175.6 9387.4 9481.0 9581.6 9641.0 10007.0 21397.5 22125.2 22461.6 22529.3 22555.2 7380.0 7441.2 7479.9 7522.5 7839.0 3978.0 4010.3 4020.4 4027.5 4100.1 3434.6 3525.1 3550.1 3551.8 3564.5 553.5 573.7 579.1 580.4 583.0 540.8 577.7 577.9 591.3 622.3 8346.6 8388.2 8493.9 8518.0 8570.4 495.4 562.3 600.4 606.7 613.3 3414.4 3945.4 4012.9 4015.6 4083.7 78637.4 97800.5 98380.0 102062.0 103452.0 90550.7 91543.5 91962.0 92306.0 92611.0 81239.0 81854.6 81855.0 82332.6 82388.6 7839.6 7854.0 7970.4 8050.2 8059.6 48363.8 48952.8 49772.8 50471.0 50855.5 56070.4 63194.7 64046.8 64085.4 66515.3 9380.3 10956.9 11063.4 11188.6 11606.7 12081.0 12556.5 12643.6 12699.2 13284.1 11567.5 11591.6 11712.1 11921.5 12025.5 11691.2 11783.0 11915.5 12084.0 12618.7 11166.6 11240.2 11309.9 11329.9 11415.7 9382.8 9876.5 9972.7 10081.1 10579.7 9892.9 9922.5 10028.3 10179.3 10294.2 15:03:47 INFO - PROCESS | 2259 | -------- Summary: end -------- 15:03:47 INFO - PROCESS | 2259 | 15:03:48 INFO - TEST-INFO | 2259: exit 0 15:03:48 INFO - TEST-OK | dromaeo_css | took 1113759ms 15:03:48 INFO - TEST-START | kraken 15:03:48 INFO - operating with platform_type : mac_ 15:03:48 INFO - Initialising browser for kraken test... 15:03:48 INFO - TEST-INFO | started process 2263 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmptBp0wK/profile http://localhost:54310/getInfo.html) 15:03:50 INFO - PROCESS | 2263 | JavaScript error: resource://app/components/nsBrowserGlue.js, line 1275: ReferenceError: E10SUINotification is not defined 15:03:51 INFO - PROCESS | 2263 | __metrics Screen width/height:1600/1200 15:03:51 INFO - PROCESS | 2263 | colorDepth:24 15:03:51 INFO - PROCESS | 2263 | Browser inner width/height: 1024/689 15:03:51 INFO - PROCESS | 2263 | __metrics 15:03:51 ERROR - PROCESS | 2263 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:03:52 INFO - TEST-INFO | 2263: exit 0 15:03:52 INFO - Browser initialized. 15:03:52 INFO - Running cycle 1/1 for kraken test... 15:03:52 INFO - TEST-INFO | started process 2266 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmptBp0wK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:04:03 INFO - PROCESS | 2266 | RSS: Main: 250195968 15:04:03 INFO - PROCESS | 2266 | 15:04:06 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54310/tests/kraken/driver.html?testName=audio-beat-detection) 15:04:07 INFO - PROCESS | 2266 | RSS: Main: 262049792 15:04:07 INFO - PROCESS | 2266 | 15:04:10 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54310/tests/kraken/driver.html?testName=audio-dft) 15:04:11 INFO - PROCESS | 2266 | RSS: Main: 267304960 15:04:11 INFO - PROCESS | 2266 | 15:04:14 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54310/tests/kraken/driver.html?testName=audio-fft) 15:04:15 INFO - PROCESS | 2266 | RSS: Main: 267145216 15:04:15 INFO - PROCESS | 2266 | 15:04:17 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54310/tests/kraken/driver.html?testName=audio-oscillator) 15:04:17 INFO - PROCESS | 2266 | RSS: Main: 267853824 15:04:17 INFO - PROCESS | 2266 | 15:04:20 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54310/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:04:20 INFO - PROCESS | 2266 | RSS: Main: 268369920 15:04:20 INFO - PROCESS | 2266 | 15:04:23 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54310/tests/kraken/driver.html?testName=imaging-darkroom) 15:04:24 INFO - PROCESS | 2266 | RSS: Main: 269582336 15:04:24 INFO - PROCESS | 2266 | 15:04:27 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54310/tests/kraken/driver.html?testName=imaging-desaturate) 15:04:28 INFO - PROCESS | 2266 | RSS: Main: 270721024 15:04:28 INFO - PROCESS | 2266 | 15:04:31 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54310/tests/kraken/driver.html?testName=json-parse-financial) 15:04:32 INFO - PROCESS | 2266 | RSS: Main: 271736832 15:04:32 INFO - PROCESS | 2266 | 15:04:34 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54310/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:04:34 INFO - PROCESS | 2266 | RSS: Main: 270856192 15:04:34 INFO - PROCESS | 2266 | 15:04:36 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54310/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:04:37 INFO - PROCESS | 2266 | RSS: Main: 270876672 15:04:37 INFO - PROCESS | 2266 | 15:04:39 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54310/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:04:40 INFO - PROCESS | 2266 | RSS: Main: 271339520 15:04:40 INFO - PROCESS | 2266 | 15:04:43 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:04:44 INFO - PROCESS | 2266 | RSS: Main: 271523840 15:04:44 INFO - PROCESS | 2266 | 15:04:46 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:04:47 INFO - PROCESS | 2266 | RSS: Main: 271364096 15:04:47 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:54310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54310/tests/kraken/driver.html?testName=ai-astar) 15:04:49 INFO - PROCESS | 2266 | RSS: Main: 273702912 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | __start_tp_report 15:04:49 INFO - PROCESS | 2266 | _x_x_mozilla_page_load 15:04:49 INFO - PROCESS | 2266 | _x_x_mozilla_page_load_details 15:04:49 INFO - PROCESS | 2266 | |i|pagename|runs| 15:04:49 INFO - PROCESS | 2266 | |0;ai-astar;110;121;113;116;116;117;114;165;161;116 15:04:49 INFO - PROCESS | 2266 | |1;audio-beat-detection;156;117;151;201;123;144;151;151;185;118 15:04:49 INFO - PROCESS | 2266 | |2;audio-dft;265;249;236;198;196;197;194;208;196;192 15:04:49 INFO - PROCESS | 2266 | |3;audio-fft;73;73;72;194;50;49;68;85;164;82 15:04:49 INFO - PROCESS | 2266 | |4;audio-oscillator;80;80;147;81;82;86;156;96;82;127 15:04:49 INFO - PROCESS | 2266 | |5;imaging-gaussian-blur;89;86;107;114;134;131;90;87;89;79 15:04:49 INFO - PROCESS | 2266 | |6;imaging-darkroom;96;124;148;96;100;98;150;113;94;94 15:04:49 INFO - PROCESS | 2266 | |7;imaging-desaturate;95;96;151;142;101;92;76;144;151;95 15:04:49 INFO - PROCESS | 2266 | |8;json-parse-financial;58;61;63;62;62;59;59;117;61;58 15:04:49 INFO - PROCESS | 2266 | |9;json-stringify-tinderbox;67;65;72;80;78;69;67;71;67;66 15:04:49 INFO - PROCESS | 2266 | |10;stanford-crypto-aes;86;88;91;85;88;87;101;86;87;77 15:04:49 INFO - PROCESS | 2266 | |11;stanford-crypto-ccm;146;147;157;148;155;150;144;150;239;141 15:04:49 INFO - PROCESS | 2266 | |12;stanford-crypto-pbkdf2;168;168;168;169;166;166;165;168;164;191 15:04:49 INFO - PROCESS | 2266 | |13;stanford-crypto-sha256-iterative;63;68;64;66;67;70;66;68;64;67 15:04:49 INFO - PROCESS | 2266 | __end_tp_report 15:04:49 INFO - PROCESS | 2266 | __start_cc_report 15:04:49 INFO - PROCESS | 2266 | _x_x_mozilla_cycle_collect,1081 15:04:49 INFO - PROCESS | 2266 | __end_cc_report 15:04:49 INFO - PROCESS | 2266 | __startTimestamp1463263489557__endTimestamp 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | ------- Summary: start ------- 15:04:49 INFO - PROCESS | 2266 | Number of tests: 14 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#0] ai-astar Cycles:10 Average:124.90 Median:116.50 stddev:20.30 (17.4%) stddev-sans-first:20.80 15:04:49 INFO - PROCESS | 2266 | Values: 110.0 121.0 113.0 116.0 116.0 117.0 114.0 165.0 161.0 116.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:151.00 stddev:27.37 (18.1%) stddev-sans-first:28.94 15:04:49 INFO - PROCESS | 2266 | Values: 156.0 117.0 151.0 201.0 123.0 144.0 151.0 151.0 185.0 118.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#2] audio-dft Cycles:10 Average:213.10 Median:203.00 stddev:26.70 (13.2%) stddev-sans-first:20.68 15:04:49 INFO - PROCESS | 2266 | Values: 265.0 249.0 236.0 198.0 196.0 197.0 194.0 208.0 196.0 192.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#3] audio-fft Cycles:10 Average:91.00 Median:72.50 stddev:48.35 (66.7%) stddev-sans-first:50.84 15:04:49 INFO - PROCESS | 2266 | Values: 73.0 73.0 72.0 194.0 50.0 49.0 68.0 85.0 164.0 82.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:81.50 stddev:29.94 (36.7%) stddev-sans-first:30.71 15:04:49 INFO - PROCESS | 2266 | Values: 80.0 80.0 147.0 81.0 82.0 86.0 156.0 96.0 82.0 127.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:86.50 stddev:19.74 (22.8%) stddev-sans-first:20.48 15:04:49 INFO - PROCESS | 2266 | Values: 89.0 86.0 107.0 114.0 134.0 131.0 90.0 87.0 89.0 79.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#6] imaging-darkroom Cycles:10 Average:111.30 Median:94.00 stddev:22.06 (23.5%) stddev-sans-first:22.69 15:04:49 INFO - PROCESS | 2266 | Values: 96.0 124.0 148.0 96.0 100.0 98.0 150.0 113.0 94.0 94.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#7] imaging-desaturate Cycles:10 Average:114.30 Median:84.00 stddev:28.99 (34.5%) stddev-sans-first:29.90 15:04:49 INFO - PROCESS | 2266 | Values: 95.0 96.0 151.0 142.0 101.0 92.0 76.0 144.0 151.0 95.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:61.00 stddev:18.01 (29.5%) stddev-sans-first:18.86 15:04:49 INFO - PROCESS | 2266 | Values: 58.0 61.0 63.0 62.0 62.0 59.0 59.0 117.0 61.0 58.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:5.14 (7.3%) stddev-sans-first:5.32 15:04:49 INFO - PROCESS | 2266 | Values: 67.0 65.0 72.0 80.0 78.0 69.0 67.0 71.0 67.0 66.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:87.00 stddev:5.93 (6.8%) stddev-sans-first:6.26 15:04:49 INFO - PROCESS | 2266 | Values: 86.0 88.0 91.0 85.0 88.0 87.0 101.0 86.0 87.0 77.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#11] stanford-crypto-ccm Cycles:10 Average:157.70 Median:150.00 stddev:28.96 (19.3%) stddev-sans-first:30.41 15:04:49 INFO - PROCESS | 2266 | Values: 146.0 147.0 157.0 148.0 155.0 150.0 144.0 150.0 239.0 141.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:168.00 stddev:7.79 (4.6%) stddev-sans-first:8.25 15:04:49 INFO - PROCESS | 2266 | Values: 168.0 168.0 168.0 169.0 166.0 166.0 165.0 168.0 164.0 191.0 15:04:49 INFO - PROCESS | 2266 | 15:04:49 INFO - PROCESS | 2266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:2.16 (3.2%) stddev-sans-first:1.94 15:04:49 INFO - PROCESS | 2266 | Values: 63.0 68.0 64.0 66.0 67.0 70.0 66.0 68.0 64.0 67.0 15:04:49 INFO - PROCESS | 2266 | -------- Summary: end -------- 15:04:49 INFO - PROCESS | 2266 | 15:04:50 INFO - TEST-INFO | 2266: exit 0 15:04:50 INFO - TEST-OK | kraken | took 62437ms 15:04:50 INFO - SUITE-END | took 1176s 15:04:50 INFO - Completed test suite (00:19:36) 15:04:50 INFO - javascript benchmark 15:04:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7198.796367643393, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3378.2567835076284, 3517.472379143129, 3534.3991521441353, 3569.179088809574, 3575.2849430113984, 4875.317455556216, 5683.403242659523, 5867.354590994993, 5987.790427335044, 5989.431004054613, 5763.884722305552, 5892.499137573301, 5955.761769529214, 5972.7312270947805, 6017.879642407149, 4945.23348880924, 4999.925016121533, 5284.313039304885, 5328.6269961102735, 5431.972840135793, 4460.66545009124, 5479.698616576086, 5502.697351645658, 5526.668399895999, 5526.944730552704, 5271.182966640177, 5286.392064912546, 5293.550048245904, 5367.329083864517, 5381.946180538203, 5340.519353258225, 5351.518363347317, 5359.732013399314, 5378.058839703036, 5393.865153371158, 5090.880006398586, 5360.731963401814, 5380.28589928775, 5400.459954004568, 5421.620486565942, 5204.8959020819375, 5776.277965254343, 5847.619904706223, 5855.209546711182, 5886.764529418818, 6213.720382582795, 6241.028708133989, 6246.469050130744, 6252.749890004395, 6290.24517057956, 6146.7233974471255, 6314.905276420857, 6324.494040476797, 6332.461740752042, 6341.8097457076365, 5926.822195334147, 5968.1942937703725, 5993.760249590055, 5994.220751302303, 6011.729472173763, 6374.043893415932, 6409.134766806515, 6413.903791443132, 6414.102025716404, 6414.903776443357, 6101.610781564068, 6200.3179650238435, 6260.686965651699, 6282.654454004982, 6295.874082518324, 6222.595531290452, 6325.493960483151, 6330.620162790247, 6333.524985626004, 6344.048392741126, 6113.749968913926, 6201.410865967726, 6235.376462353819, 6259.874802504016, 6267.561270711007, 6114.996965385541, 6186.443220110212, 6196.0, 6308.779192728324, 6310.716017779211, 4927.852164435073, 4984.476629953875, 4985.950140498621, 5012.699238045729, 5021.6735912165595, 4367.475902891673, 4438.977805110953, 4444.73331600105, 4454.77726113693, 4527.501974782771, 5868.559858010666, 5906.114082887601, 5965.970170149121, 5969.552283578749, 6025.307089684655, 6331.620102793847, 6342.619442833445, 6349.460295874902, 6354.809355719336, 6389.488840892717, 6048.788292409745, 6063.060225665029, 6069.848253793691, 6077.544184186204, 6086.056661217518, 5472.261244731911, 5515.117581186991, 5531.917021244684, 5545.085060964976, 5550.167474878801, 6520.021996700533, 6583.604983700993, 6584.670766461658, 6590.340965903371, 6613.2394774601535, 6321.968390158204, 6352.174217351715, 6359.236891573041, 6362.936370636235, 6364.140840986408, 5474.91787623178, 5524.309461317335, 5568.303962004749, 6376.52176086786, 6450.41946224842, 5553.805616803393, 6203.100550420074, 6237.719302631302, 6243.719032643451, 6251.093591429309, 4941.382327209099, 5264.684118952875, 6104.337893874414, 6267.655278959701, 6329.746810127727, 5659.3491748447805, 6120.477608373184, 6201.534884883562, 6212.47193988516, 6240.625562466266, 6220.844478888064, 6242.750289988349, 6248.9062664059165, 6249.375062493896, 6264.404881536247, 6137.171481850071, 6160.969195153995, 6230.096635987847, 6249.531285153541, 6259.186305780219, 6161.476274516537, 6171.197744293393, 6184.0, 6191.19514463117, 6265.843353916189, 6201.782937597162, 6212.875742485216, 6223.968880155751, 6229.4393504584805, 6229.813105606839], "value": 5785.138045320642, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.3645443196005, 516.2179298362978, 549.6866785932019, 553.3553410277027, 555.8804856955753, 37783.81108094459, 42254.57745422545, 42283.0, 42283.57716422835, 42319.0, 43269.78365108178, 43661.0, 43748.3437748434, 43799.46701865435, 43850.561494385045, 9459.0, 9559.665411710592, 9587.520623968774, 9676.371035882681, 9697.563609637584, 8360.498370097814, 9553.949065602777, 9583.856242156373, 9656.0, 9731.51342432879, 8602.924634420697, 9236.353455258135, 9647.0, 9660.178884794801, 9738.51307434629, 9645.22838172948, 9651.372660777028, 9672.08115229052, 9708.660196893075, 9708.708738737849, 9465.810683786285, 9465.952670236606, 9533.237341012771, 9570.282228832795, 9577.712668619952, 36278.0, 38910.41634375486, 39032.804835975636, 39155.608443915764, 39459.01352466182, 2851.230167854668, 3208.502682084281, 3241.3031198292247, 3253.235489659928, 3284.2774589590254, 27724.722752772417, 28876.855615721997, 29861.10416687503, 29971.550426743615, 30182.396352073054, 2768.2387343480505, 2785.4846853332197, 2829.122971878724, 2854.0, 2880.9711902880913, 361754.0, 362803.0, 362827.0, 364780.0, 364871.0, 34851.30297394089, 35689.46465803015, 36021.0, 36949.0, 59444.0, 36799.08002299964, 36866.893993180245, 37093.88718338454, 37094.88715338544, 37167.25665486675, 14849.480268190562, 15158.772618410732, 15344.693106137815, 15356.232188390535, 15364.923175384052, 12858.9357053216, 12949.352532373343, 12982.221066736027, 12994.350282485839, 13084.018698597452, 8137.8372432552205, 8161.5919204039565, 8241.917580824114, 8265.545395003212, 8267.214614611603, 3406.625271220164, 3426.794392336468, 3433.364827506919, 3450.585929688403, 3479.0, 906.7869050773063, 1047.1361127070197, 1054.541274545575, 1129.4578602270956, 1181.5214837990627, 26612.46775064488, 29368.412631747244, 29702.405951880843, 29802.64169473192, 29841.701582984326, 1115.3475216997986, 1137.8919002694731, 1177.4760231696812, 1216.3735676126803, 1232.168286406672, 12888.0, 15119.697606047817, 15342.0, 15428.614284642974, 16180.838191618168, 518762.0, 960735.0, 971950.0, 977040.0, 980213.0, 59679.70160149172, 61014.389856101756, 61230.69384653137, 61237.38762612406, 61899.69050154721, 1470.6617477980124, 1502.6994601079828, 1505.4505105636365, 1513.4627207341455, 1522.1704171226709, 29622.851885740434, 29696.257593560334, 29761.851190743906, 30160.5475917857, 30480.542791857697, 50281.24578131258, 50643.0, 51239.48760512496, 51274.23088653599, 51316.74341628268, 618416.0, 619584.0, 624454.0, 625063.0, 626774.0, 26691.86654066795, 26851.597226041235, 27142.185734428, 27168.049118280764, 27185.864070680313, 43728.0, 44629.55370446254, 44702.3294650587, 45544.316835246835, 45773.77113114413, 35805.283894322485, 37226.0, 37462.43806342962, 37798.81100594479, 37830.81084594559, 36304.0, 36635.0, 36749.08127296839, 36756.44865327076, 37166.0, 30881.382372352877, 32731.85438509641, 36713.0, 36879.70921017751, 37226.627733722315, 29263.7073629261, 32469.35061298808, 32629.247636522105, 32826.83586582052, 32870.34259314752, 20984.790152098285, 21378.037988290253, 23841.92711328029, 24556.0, 24920.875395623632], "value": 18503.892507007524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.2604564350556, 397.88063580925717, 399.1518024198578, 399.9082504762, 418.8157210827236, 11672.416379181028, 19013.52466188346, 19292.228310867584, 19598.216071357147, 20266.898665506687, 20166.495837604067, 20238.0, 20280.797192028076, 21322.57354852906, 21335.893320533374, 5665.461781130786, 5674.290713660793, 5696.344920334152, 5718.199452076692, 5768.538516918647, 5897.351291357947, 5904.291485021803, 5937.40625937405, 5955.761769529214, 5970.492508136814, 5631.2960879890015, 5861.3552509223955, 5925.170476133345, 5951.702414879239, 5955.85110372242, 5620.662760234358, 5835.503982161521, 5904.0, 5935.080062590284, 5955.166276721263, 5111.361079865017, 5118.97440512795, 5139.254808052849, 5150.48495150482, 5159.226116082617, 25323.62014569783, 26120.73879261202, 26159.215223543324, 26487.867560662267, 26653.733462665317, 2498.850068995848, 2726.836389816617, 2923.1522858371045, 2937.911862644124, 2980.4337175936503, 9459.24326053914, 10143.543540540693, 15485.380584776596, 15519.068855868683, 15821.971571847793, 1395.3511617097997, 1755.5435586747537, 1769.6991511442957, 1770.1326350088364, 1806.9006204658738, 99205.01589968233, 125180.0, 125271.0, 126226.0, 126854.73145268521, 8305.626246818787, 10339.948300258451, 10407.271490995558, 10488.31825931312, 11601.01391381742, 12261.754764904652, 12522.499100036079, 12532.436040378205, 12586.748265034648, 12644.936775316064, 6727.966360168168, 8224.62989165489, 8266.545340006238, 8275.54484503346, 8366.874496882552, 8679.481090809084, 8684.0, 8695.521746303888, 8770.210681038738, 8803.119688031275, 3969.1069509360163, 3985.80070996449, 4038.919221615551, 4049.3116170250537, 4089.0390758171807, 1819.6087841114224, 1978.3570339639675, 2034.9389518314474, 2036.4399790057853, 2038.6941958706313, 890.5572971785748, 904.1410659873147, 935.4948327902993, 1010.282699283517, 1013.2400699475394, 20405.2858149967, 20830.479238019172, 20928.0, 21109.9445027748, 21222.25722099719, 842.2419822160105, 934.495372498843, 986.0386123529502, 1020.9030142136485, 1043.0768769638923, 8750.91249087501, 9119.407238529608, 10938.343699377903, 10976.890231097746, 11084.113270938467, 486155.0, 593408.0, 602221.0, 610446.0, 617283.0, 122411.0, 130987.0, 134378.0, 135558.32220838833, 139751.30124349517, 1002.8997100290059, 1032.808930347888, 1033.560736686905, 1036.8341065429495, 1040.557762950743, 14914.0, 16389.78737870372, 17911.641767164325, 18207.544811379823, 18221.45335639933, 35583.644163558034, 36214.0, 47407.0, 50632.24051639155, 58022.7098864503, 76771.23228767641, 77217.0, 77603.0, 78305.0, 79230.81153782814, 7810.687572497037, 7886.566238856689, 7932.881006785018, 8019.917311162918, 8155.592220389076, 11689.240199387013, 12211.572594959134, 12722.236665800081, 12830.743385132431, 12880.806787898002, 11131.499082541142, 11304.660860174208, 11414.94292528532, 11469.655910322703, 11488.310701357945, 10206.744831378977, 10870.184736144663, 11089.168312376443, 11111.38887361203, 11216.990470857661, 9209.907900921173, 9579.808403832023, 9777.85333219988, 11167.609133680282, 11456.109741892495, 7791.805204869924, 8173.34613230952, 8207.876881846896, 8265.545395003333, 8273.875891861506, 8377.790555236168, 10486.790264194826, 10691.946540267249, 10962.890371096506, 11125.499352529318], "value": 9442.310750142482, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.4870975964495, 1522.7715842623604, 1730.3857130718595, 1962.2347284559016, 1979.0698371765284, 7803.336716379101, 8824.0, 8839.204471597555, 9363.812723745521, 9386.249100071986, 8922.77693057674, 9000.594973226203, 9169.54152292386, 9172.770680732985, 9201.447913125217, 2431.744666809986, 2461.8276720629474, 2461.950760984779, 2471.159805666073, 2487.502499500098, 2177.3032629558547, 2427.757224277567, 2495.6880389951257, 2497.7127630322566, 2509.4855554611263, 2247.4044378239696, 2457.3242358351417, 2468.4075821802726, 2475.356407334097, 2484.9438988429847, 2443.1937460637946, 2452.8160387970797, 2460.90156393744, 2465.4822487277693, 2471.9629205561932, 2385.415573184581, 2411.44536756547, 2413.5655581995234, 2421.4309637235237, 2458.397692565333, 9086.409383390059, 9142.908570914338, 9170.724878253663, 9176.174144326977, 9198.724038278862, 5405.999890020319, 5547.72261386933, 5579.7489112990015, 5581.246531718207, 5592.245046918654, 3607.549056367954, 3618.2763447310645, 3653.1597732521404, 3702.129999450127, 3710.684591809699, 1056.6037735849056, 1064.9467526623637, 1067.2742535076145, 1074.08702602787, 1077.412810018534, 11307.886921130848, 12052.457639406248, 12123.93938030313, 12144.089193310625, 12167.330796806173, 4903.41159060915, 4913.557779799835, 5064.366954130734, 5072.797088116434, 5080.364954380702, 10342.069213770646, 10383.532741026673, 10390.324628899098, 10391.740206494898, 10416.166706663449, 5457.426970168154, 5541.196526503634, 5546.251256080458, 5584.190292407659, 5591.021571225019, 4585.220512512881, 4880.511948805091, 5033.345665063518, 5041.697498150123, 5046.571041461517, 4147.170565886835, 4182.079942412664, 4189.539150693421, 4225.302825033897, 4278.422412974271, 1162.9068675445055, 1179.2511755035443, 1329.9094742311213, 1342.1074985134776, 1374.6391072837819, 849.0363437498361, 892.9285657147412, 930.1024511346448, 940.3074465961242, 948.9572969216401, 5779.133130030529, 5880.676562789002, 6113.113598528277, 6283.560150789401, 6346.524010699216, 787.9330256928225, 993.2997236947934, 996.8405055191134, 1014.2545229256491, 1024.7489365105596, 3886.7473614214987, 3959.772470534086, 4009.1380353224195, 4057.8985525361513, 4059.512858456945, 9555.761105972406, 11050.944745276222, 11170.162237832195, 11192.888071119185, 11217.326960382403, 11136.832947505794, 11189.272697274651, 11190.776184476264, 11203.831942520868, 11254.38100904458, 8136.633851476698, 8527.019392769911, 8576.013758417737, 8589.699360522352, 8613.052564217931, 5762.654240745401, 5966.164736936746, 5998.310194327708, 6069.36271691466, 6073.271207455134, 10018.0, 10346.275760696679, 10489.842652360374, 10499.895001049892, 10501.949805019436, 9328.300377471582, 10564.471776411303, 10662.0, 10677.46612669379, 10825.945870270913, 6692.498062645223, 7036.19083805369, 7230.24082471354, 7335.7432489862595, 7397.001404810282, 8244.258016778518, 8674.219320261207, 8679.783005424915, 8776.385653004229, 8803.339749518684, 7693.230676932262, 7793.64928578204, 7827.217278272355, 7830.060392752906, 7924.20757924203, 7315.0, 7426.183119856703, 7475.289847464483, 7568.886466702894, 7715.57564333967, 7314.524555903849, 7366.410687145123, 7379.077615298088, 7385.778426646994, 7415.147258065392, 4873.756312184448, 5024.447310795883, 5096.031753966735, 5104.515071068243, 5122.385313762373, 4823.9517604824905, 4971.179755340473, 5011.649184557046, 5036.597072234139, 5242.318498595158], "value": 4734.045127569735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4821334983804, 317.55225132563083, 319.4122814022199, 321.4856230031949, 327.51527738946373, 5348.946510534894, 5405.783768649249, 5590.329160500741, 5597.552195824334, 5614.859628509279, 5357.794496238344, 5481.314835645544, 5490.478404551562, 5526.944730552693, 5575.721213939297, 3994.64048235658, 4070.5725898780497, 4148.751074935499, 4167.562405947378, 4173.0, 3409.573803274591, 3955.347367684343, 4030.5816510093855, 4166.791630427188, 4185.162967406515, 3443.8794642187527, 4051.554329023805, 4097.774622395767, 4108.746832216173, 4167.020580285096, 3092.979316825453, 3824.368979118442, 4151.8962025949595, 4155.39746736723, 4170.436991006206, 3526.982365088158, 3531.0642679689904, 3544.7416167260767, 3554.5556805399324, 3572.964270357289, 5020.0, 5149.433562308143, 5177.249298851683, 5202.895942081137, 5227.3465816772905, 4503.954960450419, 4580.312953057035, 4685.976570117162, 4691.9530804692195, 4715.292706094079, 5703.230063941398, 5768.192453056576, 5779.9422005779825, 5780.971095144498, 5814.447627475425, 3886.1644746379666, 3900.2979463696524, 3905.1994341159993, 3913.98043009786, 3936.9606303937167, 4917.975445101273, 6031.698415079229, 6060.696965151769, 6069.878602427971, 6149.938500614981, 3785.413260944558, 3935.9729739184345, 3968.2857085724268, 3979.7015223858325, 3984.820683069269, 3774.6602805747616, 3991.6806655467494, 3999.700022498266, 4006.959930400717, 4055.6755459563165, 4048.0, 4683.367745354401, 4690.413698287714, 4706.552877476634, 4747.905041899143, 5505.256790333334, 5843.2403787507355, 5857.163557869602, 5867.354590994987, 5903.734331955073, 1360.53741727813, 1380.7790753479394, 1381.896357773171, 1384.5569417786212, 1386.6671998720235, 757.3070640364116, 833.4123494742526, 836.3016880904391, 852.7825404521807, 903.3586153830854, 4280.587406155961, 5283.735813209324, 5315.468453154654, 5344.8663783404945, 5381.596380271495, 5340.19897015443, 5814.656572470762, 5839.299284085937, 5906.645601263938, 5911.76352945886, 4200.718780771894, 5121.20621303691, 5316.7669578777, 5331.173668081454, 5336.332958380202, 2849.971500285012, 2933.985330073336, 3093.7370323522305, 3098.2873938994157, 3134.49848024315, 4918.926216106761, 5614.775408983676, 6128.846778830476, 6166.475849552839, 6175.938240617536, 5205.55752761012, 5330.706811125426, 5377.4891385319115, 5718.342390625048, 6078.143272661842, 4687.0625874825855, 5534.1145416733125, 6142.57002009855, 6179.497303592052, 6196.597221180609, 4651.86044418668, 5104.591632669303, 5874.324452687995, 5881.823545293648, 5952.690408110208, 4750.888168249802, 5567.359753628384, 5709.3719690834805, 5829.318513483675, 5849.239598852122, 5359.355638165928, 5517.36550296705, 5542.115680668592, 5630.930123276565, 5862.472377486047, 3024.228821650465, 3200.535922291208, 3843.9039024024623, 3933.409988501633, 4016.1686011362503, 5049.974750126225, 5133.101707201299, 5165.044466773659, 5886.676232807236, 6011.579189456696, 4938.950610493849, 5854.502367298827, 5868.210195890294, 5889.882202355843, 5901.586888917906, 5498.625343664084, 5515.889682206413, 5882.823515294548, 5909.497692695997, 5928.762849485972, 5473.28847249855, 5741.425857414225, 5765.855853603525, 5776.855578610568, 5789.536837052941, 4935.975320123376, 5146.665466744649, 5260.894782104413, 5788.581797459481, 5865.266841644794, 5464.535514481155, 5563.9150365679925, 5704.971475142764, 5720.427957204246, 5753.453421924911], "value": 4165.306374823316, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.2595567009279, 671.3588522960576, 695.2387136085985, 735.2353552305602, 760.1524300405047, 15208.54374368768, 15234.923825380858, 15486.535403937873, 15599.766003509956, 15684.921575392107, 14246.358913848875, 14326.99711020229, 14395.712085758278, 14411.495597654084, 14419.495317663885, 753.6608526163221, 924.1267002682467, 931.6273490603745, 944.759086432962, 947.1286416496805, 936.9484678342689, 942.8821397325335, 944.0512285153445, 945.2579724915907, 949.2595775295247, 988.3032462114193, 991.990080099197, 992.3995982430633, 998.3610489286863, 1010.1615659003047, 964.2864280432465, 985.3250523391499, 985.6303886042734, 985.9408435493857, 987.9259055570789, 696.5507247825175, 698.183125742882, 708.9113860767404, 725.5755383100892, 744.0884915977938, 13733.931330343385, 14923.776143357858, 15011.549653510412, 15027.849721502755, 15051.172185529791, 9172.0, 11614.36121013344, 11986.88013119875, 12726.745465090646, 12834.614961551168, 9372.343935924488, 9412.823397075366, 9913.058259465412, 10101.393916365041, 10387.220958428148, 2888.24905524563, 3253.844885065815, 3342.8328583570724, 3365.326934613063, 3477.7217822574385, 67424.32575674278, 83915.0, 84522.57738711267, 86459.56770216172, 87175.56412217961, 9387.436753794795, 9480.952595237117, 9581.568829402555, 9641.035896410443, 10007.0, 21397.465063373227, 22125.225617103646, 22461.55076898453, 22529.32412027609, 22555.210567630053, 7380.0, 7441.181470038291, 7479.887801682979, 7522.548647081083, 7839.0, 3977.9801100994887, 4010.258102251093, 4020.4170395292517, 4027.516697996259, 4100.138970816162, 3434.6050204226835, 3525.1010992196825, 3550.076979985171, 3551.751377403557, 3564.518789963322, 553.4520824383911, 573.7360814025595, 579.1139556478595, 580.35870363248, 582.988340233193, 540.7972010496064, 577.6678409914316, 577.8945441411474, 591.3111225422335, 622.3403192615841, 8346.582670866432, 8388.203120703523, 8493.872591911126, 8518.020427650776, 8570.400071995025, 495.3535635994989, 562.3364429972589, 600.4355905448864, 606.6693651959692, 613.2518327640272, 3414.351273258073, 3945.447637330776, 4012.879613611596, 4015.6185162409524, 4083.6528895044253, 78637.4272514558, 97800.51099744455, 98380.0, 102061.97938020673, 103452.0, 90550.73623159342, 91543.54228228817, 91962.0, 92306.0, 92611.0, 81239.0, 81854.59072704718, 81854.9999999988, 82332.58833705913, 82388.58805706054, 7839.568823714751, 7853.960730196541, 7970.442069055111, 8050.154733752872, 8059.637316320897, 48363.75818121028, 48952.75523622359, 49772.751136244086, 50471.0, 50855.49144508508, 56070.43929560652, 63194.68402658141, 64046.797660117736, 64085.359146407936, 66515.33484665286, 9380.34337596389, 10956.945215273872, 11063.391513466837, 11188.552457901593, 11606.651800446, 12081.0, 12556.497740090294, 12643.557475488315, 12699.174553653984, 13284.136531125447, 11567.537298507965, 11591.594294199662, 11712.063034957353, 11921.463534141158, 12025.45885435175, 11691.240069395462, 11783.0, 11915.463804128662, 12084.0, 12618.747625047632, 11166.635881204804, 11240.213185076966, 11309.943450283025, 11329.886701132884, 11415.657530274106, 9382.76543086401, 9876.506174691092, 9972.650957216752, 10081.092701656886, 10579.682609521727, 9892.85160722604, 9922.542402430881, 10028.348157369748, 10179.338343007681, 10294.227932904912], "value": 6982.068724820997, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 121.0, 113.0, 116.0, 116.0, 117.0, 114.0, 165.0, 161.0, 116.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 117.0, 151.0, 201.0, 123.0, 144.0, 151.0, 151.0, 185.0, 118.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [265.0, 249.0, 236.0, 198.0, 196.0, 197.0, 194.0, 208.0, 196.0, 192.0], "value": 213.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 194.0, 50.0, 49.0, 68.0, 85.0, 164.0, 82.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 147.0, 81.0, 82.0, 86.0, 156.0, 96.0, 82.0, 127.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 107.0, 114.0, 134.0, 131.0, 90.0, 87.0, 89.0, 79.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 124.0, 148.0, 96.0, 100.0, 98.0, 150.0, 113.0, 94.0, 94.0], "value": 111.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 151.0, 142.0, 101.0, 92.0, 76.0, 144.0, 151.0, 95.0], "value": 114.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 63.0, 62.0, 62.0, 59.0, 59.0, 117.0, 61.0, 58.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 72.0, 80.0, 78.0, 69.0, 67.0, 71.0, 67.0, 66.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 91.0, 85.0, 88.0, 87.0, 101.0, 86.0, 87.0, 77.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 157.0, 148.0, 155.0, 150.0, 144.0, 150.0, 239.0, 141.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 169.0, 166.0, 166.0, 165.0, 168.0, 164.0, 191.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 64.0, 66.0, 67.0, 70.0, 66.0, 68.0, 64.0, 67.0], "value": 66.3, "unit": "score"}]}]} 15:04:50 INFO - Return code: 0 15:04:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:04:50 ERROR - # TBPL SUCCESS # 15:04:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:04:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:04:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:04:50 INFO - 2016-05-14 15:04:50.892 screenresolution[2271:44976] starting screenresolution argv=screenresolution get 15:04:50 INFO - 2016-05-14 15:04:50.895 screenresolution[2271:44976] Display 0: 1600x1200x32@60 15:04:50 INFO - 2016-05-14 15:04:50.901 screenresolution[2272:44979] starting screenresolution argv=screenresolution list 15:04:50 INFO - Available Modes on Display 0 15:04:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:04:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:04:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:04:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:04:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:04:51 INFO - Intel Iris: 15:04:51 INFO - Chipset Model: Intel Iris 15:04:51 INFO - Type: GPU 15:04:51 INFO - Bus: Built-In 15:04:51 INFO - VRAM (Dynamic, Max): 1536 MB 15:04:51 INFO - Vendor: Intel (0x8086) 15:04:51 INFO - Device ID: 0x0a2e 15:04:51 INFO - Revision ID: 0x0009 15:04:51 INFO - Displays: 15:04:51 INFO - Display: 15:04:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:04:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:04:51 INFO - Display Serial Number: 1600x1200 60 15:04:51 INFO - Main Display: Yes 15:04:51 INFO - Mirror: Off 15:04:51 INFO - Online: Yes 15:04:51 INFO - Rotation: Supported 15:04:51 INFO - Return code: 0 15:04:51 INFO - Running post-action listener: _resource_record_post_action 15:04:51 INFO - ##### 15:04:51 INFO - ##### Finished run-tests step (success) 15:04:51 INFO - ##### 15:04:51 INFO - Running post-run listener: _resource_record_post_run 15:04:51 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 389120; Write bytes: 692051456; Read time: 2; Write time: 1928 15:04:51 INFO - TinderboxPrint: CPU usage
54.7% 15:04:51 INFO - TinderboxPrint: I/O read bytes / time
389,120 / 2 15:04:51 INFO - TinderboxPrint: I/O write bytes / time
692,051,456 / 1,928 15:04:51 INFO - TinderboxPrint: CPU idle
2,192.4 (45.3%) 15:04:51 INFO - TinderboxPrint: CPU system
980.3 (20.2%) 15:04:51 INFO - TinderboxPrint: CPU user
1,672.2 (34.5%) 15:04:51 INFO - TinderboxPrint: Swap in / out
394,579,968 / 0 15:04:51 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 378049024; Write bytes: 372274688; Read time: 28263; Write time: 753 15:04:51 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 389120; Write bytes: 294815744; Read time: 2; Write time: 1109 15:04:51 INFO - Running post-run listener: _upload_blobber_files 15:04:51 INFO - Blob upload gear active. 15:04:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:04:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:04:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:52 INFO - (blobuploader) - INFO - Done attempting. 15:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:04:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:53 INFO - (blobuploader) - INFO - Done attempting. 15:04:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:04:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:04:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:04:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:04:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:04:55 INFO - (blobuploader) - INFO - Done attempting. 15:04:55 INFO - (blobuploader) - INFO - Iteration through files over. 15:04:55 INFO - Return code: 0 15:04:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:04:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:04:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5279be705ec9fd2d557150000f34a4f7e1b5f5d2e976549073a77070c42c2b3e9eb2bb3b4b3b5ac2d9d6bb80b0c736619913c2b45c7f25756a9f473a111c9627", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4a293ef99ac4ca97900af4a442adc43abbe956dc9544ed1da2b0207c5711c2a9a993f84f8b67b74cc80bfbbcb13db50f10e33613ef94e26d45ef7e2ff9b9467", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aed0fac219ca2f19ba362d1920b7db1e4ea9e0a1e6e895fa834b392d717c41e175f47943cf9824b3bf690ef6a386f8a9f3d59b8bcd9774ba6c22b19ff0c6cf71"} 15:04:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:04:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:04:55 INFO - Contents: 15:04:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5279be705ec9fd2d557150000f34a4f7e1b5f5d2e976549073a77070c42c2b3e9eb2bb3b4b3b5ac2d9d6bb80b0c736619913c2b45c7f25756a9f473a111c9627", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4a293ef99ac4ca97900af4a442adc43abbe956dc9544ed1da2b0207c5711c2a9a993f84f8b67b74cc80bfbbcb13db50f10e33613ef94e26d45ef7e2ff9b9467", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aed0fac219ca2f19ba362d1920b7db1e4ea9e0a1e6e895fa834b392d717c41e175f47943cf9824b3bf690ef6a386f8a9f3d59b8bcd9774ba6c22b19ff0c6cf71"} 15:04:55 INFO - Running post-run listener: copy_logs_to_upload_dir 15:04:55 INFO - Copying logs to upload dir... 15:04:55 INFO - mkdir: /builds/slave/test/build/upload/logs 15:04:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1332.663011 ========= master_lag: -0.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 12 secs) (at 2016-05-14 15:04:55.669792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 15:04:55.674229) ========= 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.IogFMdIyII/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.a6JyPtRkmf/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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/5279be705ec9fd2d557150000f34a4f7e1b5f5d2e976549073a77070c42c2b3e9eb2bb3b4b3b5ac2d9d6bb80b0c736619913c2b45c7f25756a9f473a111c9627", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4a293ef99ac4ca97900af4a442adc43abbe956dc9544ed1da2b0207c5711c2a9a993f84f8b67b74cc80bfbbcb13db50f10e33613ef94e26d45ef7e2ff9b9467", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aed0fac219ca2f19ba362d1920b7db1e4ea9e0a1e6e895fa834b392d717c41e175f47943cf9824b3bf690ef6a386f8a9f3d59b8bcd9774ba6c22b19ff0c6cf71"} build_url:https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011173 build_url: 'https://queue.taskcluster.net/v1/task/CTj8EiRNTQudEJ5oo0NLVw/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/5279be705ec9fd2d557150000f34a4f7e1b5f5d2e976549073a77070c42c2b3e9eb2bb3b4b3b5ac2d9d6bb80b0c736619913c2b45c7f25756a9f473a111c9627", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4a293ef99ac4ca97900af4a442adc43abbe956dc9544ed1da2b0207c5711c2a9a993f84f8b67b74cc80bfbbcb13db50f10e33613ef94e26d45ef7e2ff9b9467", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aed0fac219ca2f19ba362d1920b7db1e4ea9e0a1e6e895fa834b392d717c41e175f47943cf9824b3bf690ef6a386f8a9f3d59b8bcd9774ba6c22b19ff0c6cf71"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-14 15:04:55.704870) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 15:04:55.705192) ========= 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.IogFMdIyII/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.a6JyPtRkmf/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.005237 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-14 15:04:55.753510) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 15:04:55.756829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-14 15:04:55.757155) ========= ========= Total master_lag: -0.19 =========