builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0377 starttime: 1463507489.2 results: success (0) buildid: 20160517004009 builduid: ef91a013044b49f4abd91345e579e6b6 revision: 17724486e1591858eea09dc327475a25883854a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.198907) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.199413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.199723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.234909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.235190) ========= 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.nNNtznXVdH/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.IAvn0NZLhj/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-17 10:51:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-05-17 10:51:29 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105411 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.365873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.366166) ========= 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.nNNtznXVdH/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.IAvn0NZLhj/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.025780 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.414906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:29.415231) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 17724486e1591858eea09dc327475a25883854a4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nNNtznXVdH/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.IAvn0NZLhj/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-17 10:51:29,492 truncating revision to first 12 chars 2016-05-17 10:51:29,492 Setting DEBUG logging. 2016-05-17 10:51:29,492 attempt 1/10 2016-05-17 10:51:29,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/17724486e159?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 10:51:30,200 unpacking tar archive at: mozilla-aurora-17724486e159/testing/mozharness/ program finished with exit code 0 elapsedTime=0.963587 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:30.395701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:30.396019) ========= script_repo_revision: 17724486e1591858eea09dc327475a25883854a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:30.396471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:30.396767) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:51:30.410540) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 22 secs) (at 2016-05-17 10:51:30.410887) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nNNtznXVdH/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.IAvn0NZLhj/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:51:30 INFO - MultiFileLogger online at 20160517 10:51:30 in /builds/slave/test 10:51:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:51:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:30 INFO - {'append_to_log': False, 10:51:30 INFO - 'base_work_dir': '/builds/slave/test', 10:51:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:51:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:30 INFO - 'branch': 'Mozilla-Aurora', 10:51:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:30 INFO - 'config_files': ('talos/mac_config.py',), 10:51:30 INFO - 'default_actions': ('clobber', 10:51:30 INFO - 'read-buildbot-config', 10:51:30 INFO - 'download-and-extract', 10:51:30 INFO - 'populate-webroot', 10:51:30 INFO - 'create-virtualenv', 10:51:30 INFO - 'install', 10:51:30 INFO - 'run-tests'), 10:51:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:30 INFO - 'download_minidump_stackwalk': True, 10:51:30 INFO - 'download_symbols': 'ondemand', 10:51:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:51:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:51:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:51:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:51:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:30 INFO - 'installer_path': 'installer.exe', 10:51:30 INFO - 'log_level': 'info', 10:51:30 INFO - 'log_name': 'talos', 10:51:30 INFO - 'log_to_console': True, 10:51:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:51:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:51:30 INFO - 'opt_config_files': (), 10:51:30 INFO - 'pip_index': False, 10:51:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:51:30 INFO - 'cmd': ('bash', 10:51:30 INFO - '-c', 10:51:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:51:30 INFO - 'enabled': True, 10:51:30 INFO - 'halt_on_failure': False, 10:51:30 INFO - 'name': 'check_screen_resolution'},), 10:51:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:51:30 INFO - 'cmd': ('bash', 10:51:30 INFO - '-c', 10:51:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:51:30 INFO - 'enabled': True, 10:51:30 INFO - 'halt_on_failure': False, 10:51:30 INFO - 'name': 'check_screen_resolution'},), 10:51:30 INFO - 'run_cmd_checks_enabled': True, 10:51:30 INFO - 'sps_profile': False, 10:51:30 INFO - 'sps_profile_interval': 0, 10:51:30 INFO - 'suite': 'dromaeojs-e10s', 10:51:30 INFO - 'system_bits': '32', 10:51:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:30 INFO - 'title': 't-yosemite-r7-0377', 10:51:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:30 INFO - 'use_talos_json': True, 10:51:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:30 INFO - 'work_dir': 'build'} 10:51:30 INFO - ##### 10:51:30 INFO - ##### Running clobber step. 10:51:30 INFO - ##### 10:51:30 INFO - Running pre-action listener: _resource_record_pre_action 10:51:30 INFO - Running main action method: clobber 10:51:30 INFO - rmtree: /builds/slave/test/build 10:51:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:51:32 INFO - Running post-action listener: _resource_record_post_action 10:51:32 INFO - ##### 10:51:32 INFO - ##### Running read-buildbot-config step. 10:51:32 INFO - ##### 10:51:32 INFO - Running pre-action listener: _resource_record_pre_action 10:51:32 INFO - Running main action method: read_buildbot_config 10:51:32 INFO - Using buildbot properties: 10:51:32 INFO - { 10:51:32 INFO - "project": "", 10:51:32 INFO - "product": "firefox", 10:51:32 INFO - "script_repo_revision": "production", 10:51:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:51:32 INFO - "repository": "", 10:51:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:51:32 INFO - "buildid": "20160517004009", 10:51:32 INFO - "stage_platform": "macosx64", 10:51:32 INFO - "basedir": "/builds/slave/test", 10:51:32 INFO - "nightly_build": "True", 10:51:32 INFO - "buildnumber": 330, 10:51:32 INFO - "slavename": "t-yosemite-r7-0377", 10:51:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 10:51:32 INFO - "platform": "yosemite_r7", 10:51:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:51:32 INFO - "branch": "mozilla-aurora", 10:51:32 INFO - "repo_path": "releases/mozilla-aurora", 10:51:32 INFO - "revision": "17724486e1591858eea09dc327475a25883854a4", 10:51:32 INFO - "pgo_build": "False", 10:51:32 INFO - "builduid": "ef91a013044b49f4abd91345e579e6b6", 10:51:32 INFO - "slavebuilddir": "test" 10:51:32 INFO - } 10:51:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg. 10:51:32 INFO - Running post-action listener: _resource_record_post_action 10:51:32 INFO - ##### 10:51:32 INFO - ##### Running download-and-extract step. 10:51:32 INFO - ##### 10:51:32 INFO - Running pre-action listener: _resource_record_pre_action 10:51:32 INFO - Running main action method: download_and_extract 10:51:32 INFO - mkdir: /builds/slave/test/build/tests 10:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:32 INFO - https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 10:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json 10:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 10:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #1 10:52:03 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json: timed out 10:52:03 INFO - retry: attempt #1 caught exception: timed out 10:52:03 INFO - retry: Failed, sleeping 30 seconds before retrying 10:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json'}, attempt #2 10:52:34 INFO - Downloaded 1199 bytes. 10:52:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.mac.test_packages.json 10:52:34 INFO - Using the following test package requirements: 10:52:34 INFO - {u'common': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 10:52:34 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:52:34 INFO - u'firefox-48.0a2.en-US.mac.cppunittest.tests.zip'], 10:52:34 INFO - u'gtest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:52:34 INFO - u'firefox-48.0a2.en-US.mac.gtest.tests.zip'], 10:52:34 INFO - u'jittest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:52:34 INFO - u'jsshell-mac.zip'], 10:52:34 INFO - u'mochitest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:52:34 INFO - u'firefox-48.0a2.en-US.mac.mochitest.tests.zip'], 10:52:34 INFO - u'mozbase': [u'firefox-48.0a2.en-US.mac.common.tests.zip'], 10:52:34 INFO - u'reftest': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:52:34 INFO - u'firefox-48.0a2.en-US.mac.reftest.tests.zip'], 10:52:34 INFO - u'talos': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:52:34 INFO - u'firefox-48.0a2.en-US.mac.talos.tests.zip'], 10:52:34 INFO - u'web-platform': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:52:34 INFO - u'firefox-48.0a2.en-US.mac.web-platform.tests.zip'], 10:52:34 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.mac.common.tests.zip', 10:52:34 INFO - u'firefox-48.0a2.en-US.mac.xpcshell.tests.zip']} 10:52:34 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:52: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')]} 10:52:34 INFO - https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:52:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:52:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:52:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:52:53 INFO - Downloaded 18102489 bytes. 10:52:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:52:56 INFO - Return code: 0 10:52:56 INFO - Downloading packages: [u'firefox-48.0a2.en-US.mac.common.tests.zip', u'firefox-48.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:56 INFO - https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:52:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:52:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:52:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip 10:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:52:57 INFO - Downloaded 18102489 bytes. 10:52:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:52:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:53:00 INFO - Return code: 0 10:53: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')]} 10:53:00 INFO - https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:53:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 10:53:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip 10:53:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip 10:53:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:53:02 INFO - Downloaded 10840145 bytes. 10:53:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:53:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:53:02 INFO - Return code: 0 10:53:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:02 INFO - https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 10:53:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 10:53:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 10:53:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg 10:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg'}, attempt #1 10:53:05 INFO - Downloaded 114146064 bytes. 10:53:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 10:53:05 INFO - mkdir: /builds/slave/test/properties 10:53:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:05 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:05 INFO - Contents: 10:53:05 INFO - build_url:https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg 10:53:06 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg! 10:53:06 WARNING - No symbols_url found. Let minidump_stackwalk query for symbols. 10:53:06 INFO - Running post-action listener: _resource_record_post_action 10:53:06 INFO - Running post-action listener: set_extra_try_arguments 10:53:06 INFO - ##### 10:53:06 INFO - ##### Running populate-webroot step. 10:53:06 INFO - ##### 10:53:06 INFO - Running pre-action listener: _resource_record_pre_action 10:53:06 INFO - Running main action method: populate_webroot 10:53:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:06 INFO - '--tppagecycles', 10:53:06 INFO - '7'], 10:53:06 INFO - 'tests': ['tsvgm']}}, 10:53:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:53:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:53:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:53:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:06 INFO - 'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:06 INFO - 'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['damp', 'tps']}, 10:53:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:06 INFO - 'tests': ['damp', 'tps']}, 10:53:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['dromaeo_dom']}, 10:53:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['a11yr', 10:53:06 INFO - 'ts_paint', 10:53:06 INFO - 'tpaint', 10:53:06 INFO - 'sessionrestore', 10:53:06 INFO - 'sessionrestore_no_auto_restore', 10:53:06 INFO - 'tabpaint']}, 10:53:06 INFO - 'other-e10s': {'tests': ['a11yr', 10:53:06 INFO - 'ts_paint', 10:53:06 INFO - 'tpaint', 10:53:06 INFO - 'sessionrestore', 10:53:06 INFO - 'sessionrestore_no_auto_restore', 10:53:06 INFO - 'tabpaint']}, 10:53:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:53:06 INFO - 'ts_paint', 10:53:06 INFO - 'tpaint', 10:53:06 INFO - 'sessionrestore', 10:53:06 INFO - 'sessionrestore_no_auto_restore', 10:53:06 INFO - 'tabpaint']}, 10:53:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:53:06 INFO - 'ts_paint', 10:53:06 INFO - 'tpaint', 10:53:06 INFO - 'sessionrestore', 10:53:06 INFO - 'sessionrestore_no_auto_restore', 10:53:06 INFO - 'tabpaint']}, 10:53:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['a11yr', 10:53:06 INFO - 'ts_paint', 10:53:06 INFO - 'tpaint', 10:53:06 INFO - 'sessionrestore', 10:53:06 INFO - 'sessionrestore_no_auto_restore', 10:53:06 INFO - 'tabpaint']}, 10:53:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['a11yr', 10:53:06 INFO - 'ts_paint', 10:53:06 INFO - 'tpaint', 10:53:06 INFO - 'sessionrestore', 10:53:06 INFO - 'sessionrestore_no_auto_restore', 10:53:06 INFO - 'tabpaint']}, 10:53:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['tsvgx', 10:53:06 INFO - 'tsvgr_opacity', 10:53:06 INFO - 'tart', 10:53:06 INFO - 'tscrollx', 10:53:06 INFO - 'cart']}, 10:53:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:53:06 INFO - 'tsvgr_opacity', 10:53:06 INFO - 'tart', 10:53:06 INFO - 'tscrollx', 10:53:06 INFO - 'cart']}, 10:53:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:06 INFO - 'talos_options': ['--disable-e10s'], 10:53:06 INFO - 'tests': ['tp5o']}, 10:53:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:06 INFO - 'tests': ['tp5o']}, 10:53:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:06 INFO - 'talos_options': ['--disable-e10s', 10:53:06 INFO - '--xperf_path', 10:53:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:06 INFO - 'tests': ['tp5n']}, 10:53:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:06 INFO - 'talos_options': ['--xperf_path', 10:53:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:06 INFO - 'tests': ['tp5n']}}, 10:53:06 INFO - 'talos.zip': {'path': '', 10:53:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:06 INFO - Running post-action listener: _resource_record_post_action 10:53:06 INFO - ##### 10:53:06 INFO - ##### Running create-virtualenv step. 10:53:06 INFO - ##### 10:53:06 INFO - Running pre-action listener: _resource_record_pre_action 10:53:06 INFO - Running main action method: create_virtualenv 10:53:06 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:53:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:06 INFO - Using real prefix '/tools/python27' 10:53:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:07 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:10 INFO - Installing pip.................done. 10:53:10 INFO - Return code: 0 10:53:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 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 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:10 INFO - 'HOME': '/Users/cltbld', 10:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:10 INFO - 'LOGNAME': 'cltbld', 10:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:10 INFO - 'MOZ_NO_REMOTE': '1', 10:53:10 INFO - 'NO_EM_RESTART': '1', 10:53:10 INFO - 'PAGER': '/bin/cat', 10:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:10 INFO - 'PWD': '/builds/slave/test', 10:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:10 INFO - 'SHELL': '/bin/bash', 10:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:10 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:10 INFO - 'USER': 'cltbld', 10:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:10 INFO - 'XPC_FLAGS': '0x0', 10:53:10 INFO - 'XPC_SERVICE_NAME': '0', 10:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:53:10 INFO - Cleaning up... 10:53:10 INFO - Return code: 0 10:53:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:10 INFO - 'HOME': '/Users/cltbld', 10:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:10 INFO - 'LOGNAME': 'cltbld', 10:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:10 INFO - 'MOZ_NO_REMOTE': '1', 10:53:10 INFO - 'NO_EM_RESTART': '1', 10:53:10 INFO - 'PAGER': '/bin/cat', 10:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:10 INFO - 'PWD': '/builds/slave/test', 10:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:10 INFO - 'SHELL': '/bin/bash', 10:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:10 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:10 INFO - 'USER': 'cltbld', 10:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:10 INFO - 'XPC_FLAGS': '0x0', 10:53:10 INFO - 'XPC_SERVICE_NAME': '0', 10:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:10 INFO - Downloading/unpacking psutil>=0.7.1 10:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:13 INFO - Installing collected packages: psutil 10:53:13 INFO - Running setup.py install for psutil 10:53:14 INFO - building 'psutil._psutil_osx' extension 10:53:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:53:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:53:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:53:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:53:14 INFO - building 'psutil._psutil_posix' extension 10:53:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:53:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:53:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:53:14 INFO - ^ 10:53:14 INFO - 1 warning generated. 10:53:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:53:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:15 INFO - Successfully installed psutil 10:53:15 INFO - Cleaning up... 10:53:15 INFO - Return code: 0 10:53:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:53: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')]} 10:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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')]} 10:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:53: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 mozsystemmonitor==0.0.0 10:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:15 INFO - 'HOME': '/Users/cltbld', 10:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:15 INFO - 'LOGNAME': 'cltbld', 10:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:15 INFO - 'MOZ_NO_REMOTE': '1', 10:53:15 INFO - 'NO_EM_RESTART': '1', 10:53:15 INFO - 'PAGER': '/bin/cat', 10:53:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:15 INFO - 'PWD': '/builds/slave/test', 10:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:15 INFO - 'SHELL': '/bin/bash', 10:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:15 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:15 INFO - 'USER': 'cltbld', 10:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:15 INFO - 'XPC_FLAGS': '0x0', 10:53:15 INFO - 'XPC_SERVICE_NAME': '0', 10:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:53:17 INFO - Installing collected packages: mozsystemmonitor 10:53:17 INFO - Running setup.py install for mozsystemmonitor 10:53:18 INFO - Successfully installed mozsystemmonitor 10:53:18 INFO - Cleaning up... 10:53:18 INFO - Return code: 0 10:53:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:18 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 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:18 INFO - 'HOME': '/Users/cltbld', 10:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:18 INFO - 'LOGNAME': 'cltbld', 10:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:18 INFO - 'MOZ_NO_REMOTE': '1', 10:53:18 INFO - 'NO_EM_RESTART': '1', 10:53:18 INFO - 'PAGER': '/bin/cat', 10:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:18 INFO - 'PWD': '/builds/slave/test', 10:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:18 INFO - 'SHELL': '/bin/bash', 10:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:18 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:18 INFO - 'USER': 'cltbld', 10:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:18 INFO - 'XPC_FLAGS': '0x0', 10:53:18 INFO - 'XPC_SERVICE_NAME': '0', 10:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:18 INFO - Downloading/unpacking blobuploader==1.2.4 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:20 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:53:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:21 INFO - Downloading docopt-0.6.1.tar.gz 10:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:22 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:22 INFO - Running setup.py install for blobuploader 10:53:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:53:22 INFO - Running setup.py install for requests 10:53:22 INFO - Running setup.py install for docopt 10:53:22 INFO - Successfully installed blobuploader requests docopt 10:53:22 INFO - Cleaning up... 10:53:22 INFO - Return code: 0 10:53:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:22 INFO - 'HOME': '/Users/cltbld', 10:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:22 INFO - 'LOGNAME': 'cltbld', 10:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:22 INFO - 'MOZ_NO_REMOTE': '1', 10:53:22 INFO - 'NO_EM_RESTART': '1', 10:53:22 INFO - 'PAGER': '/bin/cat', 10:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:22 INFO - 'PWD': '/builds/slave/test', 10:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:22 INFO - 'SHELL': '/bin/bash', 10:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:22 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:22 INFO - 'USER': 'cltbld', 10:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:22 INFO - 'XPC_FLAGS': '0x0', 10:53:22 INFO - 'XPC_SERVICE_NAME': '0', 10:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:23 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-3YAjpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:23 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-h0Ba59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:23 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-9w7tU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:23 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-gregfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:23 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-DKVgAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:23 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-VWBvAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:23 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-oV7ydZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:23 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Wrtfzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-E7jAjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-SXsZ1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-bmZDiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-aATrji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-93vdQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-_6p3bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-vKxwpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-BfXEsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:24 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-YmlXKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:25 INFO - Running setup.py install for manifestparser 10:53:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:53:25 INFO - Running setup.py install for mozcrash 10:53:25 INFO - Running setup.py install for mozdebug 10:53:25 INFO - Running setup.py install for mozdevice 10:53:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:53:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:53:25 INFO - Running setup.py install for mozfile 10:53:25 INFO - Running setup.py install for mozhttpd 10:53:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:53:25 INFO - Running setup.py install for mozinfo 10:53:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Running setup.py install for mozInstall 10:53:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Running setup.py install for mozleak 10:53:26 INFO - Running setup.py install for mozlog 10:53:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Running setup.py install for moznetwork 10:53:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Running setup.py install for mozprocess 10:53:26 INFO - Running setup.py install for mozprofile 10:53:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:53:26 INFO - Running setup.py install for mozrunner 10:53:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:53:27 INFO - Running setup.py install for mozscreenshot 10:53:27 INFO - Running setup.py install for moztest 10:53:27 INFO - Running setup.py install for mozversion 10:53:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:53:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:27 INFO - Cleaning up... 10:53:27 INFO - Return code: 0 10:53:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:27 INFO - 'HOME': '/Users/cltbld', 10:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:27 INFO - 'LOGNAME': 'cltbld', 10:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:27 INFO - 'MOZ_NO_REMOTE': '1', 10:53:27 INFO - 'NO_EM_RESTART': '1', 10:53:27 INFO - 'PAGER': '/bin/cat', 10:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:27 INFO - 'PWD': '/builds/slave/test', 10:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:27 INFO - 'SHELL': '/bin/bash', 10:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:27 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:27 INFO - 'USER': 'cltbld', 10:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:27 INFO - 'XPC_FLAGS': '0x0', 10:53:27 INFO - 'XPC_SERVICE_NAME': '0', 10:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:27 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-HtCTIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-hLRGIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-DRTpOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-WP8l0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-zSHDgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-TAPkxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-SM3Lkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-gBpWPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-BlCClx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-3Q1LxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:28 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-DWnQsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ZVEysk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-BwNjda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-W7Ag73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-bYS4sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Hq2dzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:29 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-mZXiG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:53:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:32 INFO - Downloading blessings-1.6.tar.gz 10:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:32 INFO - Installing collected packages: blessings 10:53:32 INFO - Running setup.py install for blessings 10:53:32 INFO - Successfully installed blessings 10:53:32 INFO - Cleaning up... 10:53:32 INFO - Return code: 0 10:53:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:53:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:32 INFO - Reading from file tmpfile_stdout 10:53:32 INFO - Current package versions: 10:53:32 INFO - blessings == 1.6 10:53:32 INFO - blobuploader == 1.2.4 10:53:32 INFO - docopt == 0.6.1 10:53:32 INFO - manifestparser == 1.1 10:53:32 INFO - mozInstall == 1.12 10:53:32 INFO - mozcrash == 0.17 10:53:32 INFO - mozdebug == 0.1 10:53:32 INFO - mozdevice == 0.48 10:53:32 INFO - mozfile == 1.2 10:53:32 INFO - mozhttpd == 0.7 10:53:32 INFO - mozinfo == 0.9 10:53:32 INFO - mozleak == 0.1 10:53:32 INFO - mozlog == 3.1 10:53:32 INFO - moznetwork == 0.27 10:53:32 INFO - mozprocess == 0.22 10:53:32 INFO - mozprofile == 0.28 10:53:32 INFO - mozrunner == 6.11 10:53:32 INFO - mozscreenshot == 0.1 10:53:32 INFO - mozsystemmonitor == 0.0 10:53:32 INFO - moztest == 0.7 10:53:32 INFO - mozversion == 1.4 10:53:32 INFO - psutil == 3.1.1 10:53:32 INFO - requests == 1.2.3 10:53:32 INFO - wsgiref == 0.1.2 10:53:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:32 INFO - 'HOME': '/Users/cltbld', 10:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:32 INFO - 'LOGNAME': 'cltbld', 10:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:32 INFO - 'MOZ_NO_REMOTE': '1', 10:53:32 INFO - 'NO_EM_RESTART': '1', 10:53:32 INFO - 'PAGER': '/bin/cat', 10:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:32 INFO - 'PWD': '/builds/slave/test', 10:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:32 INFO - 'SHELL': '/bin/bash', 10:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:32 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:32 INFO - 'USER': 'cltbld', 10:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:32 INFO - 'XPC_FLAGS': '0x0', 10:53:32 INFO - 'XPC_SERVICE_NAME': '0', 10:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:53:33 INFO - Cleaning up... 10:53:33 INFO - Return code: 0 10:53:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:33 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 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:53:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:33 INFO - 'HOME': '/Users/cltbld', 10:53:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:33 INFO - 'LOGNAME': 'cltbld', 10:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:33 INFO - 'MOZ_NO_REMOTE': '1', 10:53:33 INFO - 'NO_EM_RESTART': '1', 10:53:33 INFO - 'PAGER': '/bin/cat', 10:53:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:33 INFO - 'PWD': '/builds/slave/test', 10:53:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:33 INFO - 'SHELL': '/bin/bash', 10:53:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:33 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:33 INFO - 'USER': 'cltbld', 10:53:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:33 INFO - 'XPC_FLAGS': '0x0', 10:53:33 INFO - 'XPC_SERVICE_NAME': '0', 10:53:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:33 INFO - Downloading/unpacking jsonschema 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:36 INFO - Downloading/unpacking functools32 (from jsonschema) 10:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:36 INFO - warning: no files found matching '*.txt' 10:53:36 INFO - no previously-included directories found matching 'build' 10:53:36 INFO - no previously-included directories found matching 'dist' 10:53:36 INFO - no previously-included directories found matching '.git*' 10:53:36 INFO - Installing collected packages: jsonschema, functools32 10:53:36 INFO - Running setup.py install for functools32 10:53:36 INFO - warning: no files found matching '*.txt' 10:53:36 INFO - no previously-included directories found matching 'build' 10:53:36 INFO - no previously-included directories found matching 'dist' 10:53:36 INFO - no previously-included directories found matching '.git*' 10:53:36 INFO - Successfully installed jsonschema functools32 10:53:36 INFO - Cleaning up... 10:53:37 INFO - Return code: 0 10:53:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:37 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 0x104423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104433420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b13d8a9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, '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.nNNtznXVdH/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.IAvn0NZLhj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:37 INFO - 'HOME': '/Users/cltbld', 10:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:37 INFO - 'LOGNAME': 'cltbld', 10:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:37 INFO - 'MOZ_NO_REMOTE': '1', 10:53:37 INFO - 'NO_EM_RESTART': '1', 10:53:37 INFO - 'PAGER': '/bin/cat', 10:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:37 INFO - 'PWD': '/builds/slave/test', 10:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:37 INFO - 'SHELL': '/bin/bash', 10:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:53:37 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:37 INFO - 'USER': 'cltbld', 10:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:37 INFO - 'XPC_FLAGS': '0x0', 10:53:37 INFO - 'XPC_SERVICE_NAME': '0', 10:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:37 INFO - Downloading/unpacking flake8 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53: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 10:53:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:53:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:53:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:53:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:41 INFO - no previously-included directories found matching 'docs/_build' 10:53:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:53:41 INFO - Running setup.py install for pep8 10:53:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:53:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:53:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:53:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:53:41 INFO - no previously-included directories found matching 'docs/_build' 10:53:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:53:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:53:41 INFO - Cleaning up... 10:53:41 INFO - Return code: 0 10:53:41 INFO - Running post-action listener: _resource_record_post_action 10:53:41 INFO - Running post-action listener: _start_resource_monitoring 10:53:41 INFO - Starting resource monitoring. 10:53:41 INFO - ##### 10:53:41 INFO - ##### Running install step. 10:53:41 INFO - ##### 10:53:41 INFO - Running pre-action listener: _resource_record_pre_action 10:53:41 INFO - Running main action method: install 10:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:42 INFO - Reading from file tmpfile_stdout 10:53:42 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:42 INFO - Reading from file tmpfile_stdout 10:53:42 INFO - Output received: 10:53:42 INFO - Usage: mozinstall [options] installer 10:53:42 INFO - Options: 10:53:42 INFO - -h, --help show this help message and exit 10:53:42 INFO - -d DEST, --destination=DEST 10:53:42 INFO - Directory to install application into. [default: 10:53:42 INFO - "/builds/slave/test"] 10:53:42 INFO - --app=APP Application being installed. [default: firefox] 10:53:42 INFO - mkdir: /builds/slave/test/build/application 10:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:54:14 INFO - Reading from file tmpfile_stdout 10:54:14 INFO - Output received: 10:54:14 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:54:14 INFO - Running post-action listener: _resource_record_post_action 10:54:14 INFO - ##### 10:54:14 INFO - ##### Running run-tests step. 10:54:14 INFO - ##### 10:54:14 INFO - Running pre-action listener: _resource_record_pre_action 10:54:14 INFO - Running main action method: run_tests 10:54:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:54:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:54:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:54:14 INFO - 2016-05-17 10:54:14.201 screenresolution[1650:8151] starting screenresolution argv=screenresolution get 10:54:14 INFO - 2016-05-17 10:54:14.204 screenresolution[1650:8151] Display 0: 1600x1200x32@60 10:54:14 INFO - 2016-05-17 10:54:14.210 screenresolution[1651:8153] starting screenresolution argv=screenresolution list 10:54:14 INFO - Available Modes on Display 0 10:54:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:54:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:54:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:54:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:54:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:54:14 INFO - Intel Iris: 10:54:14 INFO - Chipset Model: Intel Iris 10:54:14 INFO - Type: GPU 10:54:14 INFO - Bus: Built-In 10:54:14 INFO - VRAM (Dynamic, Max): 1536 MB 10:54:14 INFO - Vendor: Intel (0x8086) 10:54:14 INFO - Device ID: 0x0a2e 10:54:14 INFO - Revision ID: 0x0009 10:54:14 INFO - Displays: 10:54:14 INFO - Display: 10:54:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:54:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:54:14 INFO - Display Serial Number: 1600x1200 60 10:54:14 INFO - Main Display: Yes 10:54:14 INFO - Mirror: Off 10:54:14 INFO - Online: Yes 10:54:14 INFO - Rotation: Supported 10:54:14 INFO - Return code: 0 10:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:14 INFO - Python 2.7.3 10:54:14 INFO - Return code: 0 10:54:14 INFO - grabbing minidump binary from tooltool 10:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042c2e00>, '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 0x10412bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042bdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:54:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:54:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:14 INFO - Return code: 0 10:54:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:54:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:54:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:54:15 INFO - Return code: 0 10:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0377', '--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 10:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --title t-yosemite-r7-0377 --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 10:54:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNNtznXVdH/Render', 10:54:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:15 INFO - 'HOME': '/Users/cltbld', 10:54:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:15 INFO - 'LOGNAME': 'cltbld', 10:54:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:15 INFO - 'MOZ_NO_REMOTE': '1', 10:54:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:15 INFO - 'NO_EM_RESTART': '1', 10:54:15 INFO - 'PAGER': '/bin/cat', 10:54:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:15 INFO - 'PWD': '/builds/slave/test', 10:54:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:15 INFO - 'SHELL': '/bin/bash', 10:54:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAvn0NZLhj/Listeners', 10:54:15 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:54:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:15 INFO - 'USER': 'cltbld', 10:54:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:15 INFO - 'XPC_FLAGS': '0x0', 10:54:15 INFO - 'XPC_SERVICE_NAME': '0', 10:54:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--title', 't-yosemite-r7-0377', '--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 10:54:15 INFO - mozversion application_buildid: 20160517004009 10:54:15 INFO - mozversion application_changeset: 17724486e1591858eea09dc327475a25883854a4 10:54:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:54:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:15 INFO - mozversion application_name: Firefox 10:54:15 INFO - mozversion application_remotingname: firefox-dev 10:54:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:54:15 INFO - mozversion application_vendor: Mozilla 10:54:15 INFO - mozversion application_version: 48.0a2 10:54:15 INFO - mozversion platform_buildid: 20160517004009 10:54:15 INFO - mozversion platform_changeset: 17724486e1591858eea09dc327475a25883854a4 10:54:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:54:15 INFO - mozversion platform_version: 48.0a2 10:54:15 INFO - using testdate: 1463507655 10:54:15 INFO - actual date: 1463507655 10:54:15 INFO - starting webserver on 'localhost:49278' 10:54:15 INFO - SUITE-START | Running 2 tests 10:54:15 INFO - TEST-START | dromaeo_css 10:54:15 INFO - operating with platform_type : mac_ 10:54:15 INFO - Initialising browser for dromaeo_css test... 10:54:15 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpzq0yJu/profile http://localhost:49278/getInfo.html) 10:54:19 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 10:54:19 INFO - PROCESS | 1669 | colorDepth:24 10:54:19 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 10:54:19 INFO - PROCESS | 1669 | __metrics 10:54:19 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:54:19 INFO - TEST-INFO | 1669: exit 0 10:54:19 INFO - Browser initialized. 10:54:19 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:19 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpzq0yJu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:31 INFO - PROCESS | 1674 | RSS: Main: 221319168 10:54:31 INFO - PROCESS | 1674 | 10:55:21 INFO - PROCESS | 1674 | 1463507721476 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:57:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 10:57:34 INFO - PROCESS | 1674 | RSS: Main: 231067648 10:57:34 INFO - PROCESS | 1674 | 11:00:36 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 11:00:36 INFO - PROCESS | 1674 | RSS: Main: 242704384 11:00:36 INFO - PROCESS | 1674 | 11:03:38 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 11:03:39 INFO - PROCESS | 1674 | RSS: Main: 245010432 11:03:39 INFO - PROCESS | 1674 | 11:06:40 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 11:06:41 INFO - PROCESS | 1674 | RSS: Main: 246743040 11:06:41 INFO - PROCESS | 1674 | 11:09:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 11:09:44 INFO - PROCESS | 1674 | RSS: Main: 249573376 11:09:44 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 11:12:47 INFO - PROCESS | 1674 | RSS: Main: 250802176 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | __start_tp_report 11:12:47 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 11:12:47 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 11:12:47 INFO - PROCESS | 1674 | |i|pagename|runs| 11:12:47 INFO - PROCESS | 1674 | |0;dojo.html;3413.624501304856;3498.7375946803995;3505.316463289658;3544.113971507123;3576.749627526073;5708.800191993281;5856.033754430514;5856.502197313228;5873.972054890393;5874.236349274588;4893.314935908976;5806.361300256979;5861;5863.912041319383;5891.175235467038;5266.947330526684;5300.628955973074;5312.654677445973;5322.787088516455;5353.678779273237;5214.296070030536;5332.733363331838;5416.079266524681;5417.214503896952;5438.6736795792185;5356.491133342326;5402.37872644645;5412.4587541245955;5421.756020979045;5425.810096646618;5319.973400132974;5341.06531357013;5376.274202982587;5408.513233808976;5438.755256013489;5190.2214667800135;5199.220116982483;5257.316548848626;5306.575473962073;5345.545628621572;5070.72111033893;5278;5736.942630573724;5772.422757724236;5782.074868021096;5764.16419619157;6180.721867515973;6242.001279795257;6256.96871515644;6276.435120839101;6133.815985520441;6190.597611155261;6217.378262173746;6219.564630475868;6277.686115694197;5991.221141251609;6006.339302676702;6019.057517326159;6019.608725432833;6040;6262.185915830913;6338.0771946574705;6350.174477317919;6351.809445716636;6373.7131829066875;5224.798296391851;6166.599171053867;6183.5671502994355;6201.844953876189;6212.968935155295;6286.025666021774;6291.622502649856;6295.992641177481;6303.810885673437;6316.778912738032;6139.154842350747;6191.442770150708;6230.59501132425;6304.464120549713;6356.491480681534;6276.340984196685;6278.46633036197;6280.497560195174;6290.779822706183;6293.653849038347;4942.159832828428;4984.77568509418;4992.201247800334;4998.600111991032;5019.698818070928;4379.1460665170625;4450.777461126931;4493.505714371417;4512.593866551961;4545.977270113628;5833.387494313036;5895;5950.761969521171;5966.970165149147;5972.313183983897;6267.4045965633195;6282.246130464374;6298.086777417248;6308;6314.305426403092;5803.82588522345;5916.1421593868645;5973.104034394789;6003.549733769984;6006.4594186522545;4853.907870729057;5454.59090568201;5459.344878614512;5481.561475081984;5482.39693633708;6249.437550620466;6458.741650333934;6470.708818103102;6488.480921526172;6504.902426463606;6192.2569291683485;6231.688415579112;6283.2460104787715;6290.905636415366;6319.115323854756;6410.711517981609;6469.417752402306;6473.449756770728;6486.935130648633;6511.804645860631;6250.3749625037135;6265.498760099273;6312.4634406076;6331.683415829282;6349.460295874902;6143.174139895698;6225.564210505402;6226.501879849692;6241.906371404523;6305.085762564494;6223;6323.6838158090995;6339.5562310637815;6340.524460665376;6342.682865856781;6115.205023346936;6345.1434056401795;6347.96826015867;6353.96823015882;6375.6812159392775;5074.8835256243565;5082.923756143735;6000.369961154016;6054.84862878414;6161.4146656067605;6237.282712488122;6259.654174352536;6261.68691565429;6277.403646653561;6286.214223222098;6004.309504406874;6084.087386892002;6093.329733729375;6131.662758548323;6155.045967874987 11:12:47 INFO - PROCESS | 1674 | |1;ext.html;487.5660662010809;534.3801190618883;538.2518299563607;543.1309904153358;546.9635041596175;32357.83821080897;40452.39321410181;40454.59545404545;40488.987775305635;40678.59321406785;41209.58790412095;41684.37473437901;42347.729568112925;42477.57522424775;42492;9732.805343893118;9804.068613481708;10009.29934904557;10036;10066.29535932485;8527.275181609539;9834.901650983506;9877.913429522747;9887.55506002228;9973.50132493376;9846.113849753521;9896.851547226797;9914.008599140065;9952.303338766289;9984.600615975389;9839;9903.30676852617;9969.55137018836;9973.90026099737;9982.9500852496;9871.259655525793;9974.900250997469;9982.151517121054;10001.749956251078;10032;40598.59401406007;40698;40736.18527629461;40740.38889416661;40869.182616347505;2730.563109902426;3098.2409309719264;3144.584936778459;3147.07161387389;3167.857446414917;25684.743152568422;26674.866625666942;26718.73281267182;27174.77713502897;27506.312342191606;2691.609716591103;2701.540738074532;2728.5361488546796;2794.9938022311953;2900.260433589421;307475;318502;353390;354616;357147.21426392964;36932.81533592315;37835.05412364658;37959.62040379616;38033.80983095122;38127;68246.29384265334;72209.2779072213;73535.63232183912;74046;74223.25776742272;14871.776923346159;17598.912005440146;17619.295228190986;17651.73522397165;17683.73474397885;12925.676858078623;13273.93363033198;13277.535286264934;13348.199108053548;13361.73276534464;19596.020198989994;19624.607507849763;19855.503612409517;19915.302964396466;20428.897855510924;7662.310392064741;8131.878021829677;8135.3491720662205;8141.51150930946;8223.05434874985;789.0413148025177;965.6620182935916;1025.5128813813528;1040.7450174707244;1125.3248051169232;26089;29872.55191172134;30320.54519182214;31003.534946975815;31074.53388199179;1034.234666346898;1114.4761961877905;1121.870984836738;1165.2076587920296;1250.6373151786063;15258;15308.693826123415;15870.285837137357;16681.582960426087;17201.827981720275;585623;597024;600530;606276;607835;63120;65022;65158.67420662866;65215;65356.01965970514;1510.3731951240113;1526.4123312524757;1529.021426287177;1531.7855500229978;1533.4939469974881;31134.377312453173;31394;31490.370192596478;32026.039218823473;32384;56632.15051774309;61436.07845882226;63394;63775.68112159595;63890.36109638844;483672;485745.57127214136;491107;491722;491756.54121730593;35038.64961350456;41814.37278440765;43579.34630980601;44115;45323.77338113288;44794;47448;49134;49158.75420623017;49276.75361623169;34745.826270868485;38763.2247355057;39738.006549836486;39946.40080398738;40089.39865902072;37928.810355948044;38813;38977;39527.80236098801;40074.79962600285;37688.43467348047;39035.80482097571;39468.80265598654;39805.80097099496;39935.20129597334;29636.85181574078;32626.51060234146;34906.77826276068;34934.65065349416;35053;24200;24921.626175607744;26036.21891343263;26200.344991374604;26328.868355658866 11:12:47 INFO - PROCESS | 1674 | |2;jquery.html;394.8223299515219;398.37455195343284;399.70022483137654;405.50123348281613;406.37418375701424;15025.32386042628;16385.09881956492;20135.99320033998;20353.491162720922;20468.69296960545;16338.264778084986;16576.58558536037;17504.562385940357;19931;20713.585728285463;5883.764649414018;6076.361981991893;6172.629642221481;6183.165272688197;6195.845103872394;5878.470937615613;6050.485708714765;6104.9389506105035;6135.631862088267;6148.508119350441;5781.335146458169;6059.848503787396;6101.603395779282;6103.908441373383;6104.664243466607;5766.682832444214;6000.75996960121;6055.12200730896;6058.545609079315;6136.079588061782;5836.037053886103;5847.8245652630485;6005.6396616203165;6039.788607398764;6063.454289113957;24338;24629.13798017061;24763.63799991;24835.87582062096;25023.62464563033;1996.4709352021725;2116.0795054151495;2227.9554408911895;2304.6197377432704;2323.117215458132;9732.270079744048;9806.607735690635;9829.311948163631;12472.690367511372;14171.078879872879;1721.3803030908862;1757.578181236507;1786.2734280644645;1803.513051476094;1836.0727832444663;90278;114917;122634.99999999911;123702;124236.37881810624;11739.530418783153;11958.940205298917;12017.459214335377;12025.098117641212;12090.516379344728;14849.554513364616;15204;15230;15271.541853744406;15325.386984520494;7628.8938103974615;8650.697225597074;9019.098090191059;9035.45787252767;9117.225035872025;7306.671199796022;9025.368224224241;9027.593758280893;9089.50007749567;9125.269978401711;4652.720836749806;4697.436307643036;4748.952510474851;4762.78567464465;4774.641901857374;1751.5358430016056;1991.2333751505776;2018.7981201879988;2045.3045964371888;2066.8346532277383;922.5802259971697;924.3437159616748;1020.7805321855689;1083.030687534652;1089.9455027248605;16722.331106755835;19915.10382032812;20342.79657203409;20520.692189617166;20776.896115519325;940.7224868663624;992.4839083676592;992.5483904823288;1025.179856115105;1047.3506426015767;10738.838917416246;10834.241603087708;10889.965453281926;10941.015308622262;10963.342199468058;604379;636828;640184;647404;648531;127236.36381818217;127523;128803.71196288105;130567.04149437766;130569.69430305765;1025.6564051042985;1027.4759872465097;1039.0700323210835;1039.3140527251978;1039.729670285716;17826.286948521913;17999.370022049166;18000.90999544994;18138.27446902162;18146.092695364914;51753.7412312936;51780;53980.460195399115;54127.723919758646;54529.45470545402;63623;75029.62485187539;77417;80047.59976200081;80237.59881200557;8303.169683031649;8310.750677479686;8408.2432581068;8412;8448.873266900879;9002.50486223264;11814.468348924147;12317.568885088978;12393.566225182076;12709.428075736429;10228.693139205836;10748;10752.731181720519;11129.944350278522;11165.665030049111;10654.786904261717;10658.62694805678;10664.520096595827;10756.912373298097;10837.837432438677;11161.49773260189;11261.71845703864;11297.43512824372;11362.715932101764;11395.943020284845;8065.838683226185;8109.75670729879;8303.629901066257;8347.54088525137;8452.32381409498;8211.05572859129;10162.136218421518;10989;11289.661310160709;11297.661070167907 11:12:47 INFO - PROCESS | 1674 | |3;mootools.html;1390.499420208725;1583.9208039598018;1655.6440365321453;1815.5824160443099;1944.7471828662271;7873.094594121678;8484.236418722314;8686.739397818068;8872.866906996393;8879.91120088799;7667.3866090712745;7703.730369437071;8470.703525376613;8595;8687.348448866329;2215.9113635454564;2251.0883092347626;2419.7822196002357;2489.800815934721;2491.389609545664;2476.3437689012426;2478.578641630927;2522.041624182808;2527.064985955199;2529.544681957247;2440.5973014452684;2451.767082127195;2470.283617750859;2483.255023492954;2496.6879140107485;2441.7680320369536;2455.6930383701947;2458.8032957363366;2479.7892179164614;2490.4272017436;2487.2413913756295;2508.3102146909564;2513.6229565565127;2520.243926821946;2537.7208507064206;8693.652253909837;8814.911850881474;8831.646734130627;8832.514211718353;8865.601047952858;5421.864453388657;5437.510624043815;5466.535344495723;5525.198846167324;5593.8321850344555;3552.8934131975825;3585.623509531488;3640.8725694600826;3666.120131168527;3683.1528748387755;1026.8870424253325;1065.2543219746208;1065.6696424108475;1065.9200559958035;1067.524951396629;11688.240264382874;11715.941420292844;11755.64733058001;11948.28310301376;11986.88013119875;4854.902901941941;4894.853154405302;4974.27872958419;4989.351384320015;5002.89994200114;10226.59093636261;10250.231232657581;10261.589536418609;10266.127379172705;10269.435181064964;5379.596530260246;5421.756020979065;5495.752691128829;5503.3120859892515;5550.833474995676;4450.488193857748;4827.61379089672;4900.068986892479;4949.876253093629;5015.523525265094;4098.344264917659;4135.684016950518;4155.231282212801;4175.895602609899;4198.5591512891315;1185.6620863053988;1187.8871507206802;1203.1397550751255;1258.6790368456168;1346.8249127613544;737.5206116024627;935.6818681648136;952.1288021460425;963.2486660404895;971.8833739951251;5809.767609295665;5924.348321684612;5962.165296858443;5992.670403127782;6075.481447622097;459.38671873049185;469.9013207226452;488.1969160730649;488.82646660435034;492.5911493460419;3851.9422208666892;3879.670228030649;3927.4411732406948;3929.0766669832565;3949.8025098745525;9187;10408;10792.352458852494;10870.456477176109;10892.292001019909;10639.787204256027;10667.83998240027;10708.03627673513;10712.517936692868;10725.892741072645;7951.602419878983;8252.587370631445;8436.28291595209;8450.746477605682;8462.19609137131;5826.475617194473;5826.679532625577;5935.317438494629;6034.69826508664;6035.78874739382;9329.440233586007;9336.626534938527;9423.057694230522;9423.434593924387;9448.858267126136;9403;9726.805463890823;9826.950865245628;9837.114659680663;9853.408795472295;6778.42383397397;7225.819354516179;7386.926130738624;7444.181140074696;7566.432517561095;8065.9596702016115;8100.513969161869;8126.837463250584;8171.836563268583;8195.918040819515;7156.069710937545;7309.451791115581;7316.085489313836;7397.593132377556;7428.294312040348;7065.717371305091;7092;7163.641817909188;7205.747798827016;7243.384312333511;6803.93196068033;6819.318068193141;6888.276730943379;6898.2756810536175;6924.4460443165435;4797.472278049481;4807.062622788522;4812.807487700453;4857.441394239708;4918.163912135017;4838.927416088691;4873.731944743073;4927.1377508935075;4950.009998000486;5056.241563765465 11:12:47 INFO - PROCESS | 1674 | |4;prototype.html;311.39589196957905;324.56994482310944;330.84284964641796;331.6401704150996;335.6006352440594;6943.583384996891;6951.791446256614;6952.60947810438;6957.095577574914;7045.154581450221;6934.3065693430635;6940.167179938402;6948.617826019567;6953.37419632233;6967.30326967303;4799.016201678656;4912.803487860499;5094.617903657222;5102.056119617864;5105.897882042357;5025.698458092526;5077.771500282478;5081.59347252219;5090.465501122384;5092.185250359943;5019.347484826967;5034.043531728978;5034.597232221432;5042.218456139304;5064.493550644943;5049.318342023835;5050.823221187259;5056.710538812616;5076;5102.260172275;3896.201278737852;4010.8796736097966;4336.956630433719;4342.761148136851;4348.804303806304;6366.427021568081;6556.246031706367;6625.4037136657935;6714.899276510856;6742.797716068526;4309.482862056542;4839.975800121012;4861.951380486185;5913.733881975279;5921.526277897801;7380.261973802631;7393.852122957511;7396.112466504;7409.555426674417;7409.777706668809;4680.549029800773;4688.578027977464;4689.601383882374;4692.671512994092;4694.2723877799;5749.683767392792;6717.09319241901;7693.230676932318;7776.416768742367;7795.259450352264;4608.792604332813;4774.570288674036;4778.617710583145;4792.448868380181;4807;4817.807287708522;4855.781489832966;4868.513148685103;4885.364902562644;4888.804447822047;5919.852003699942;5923.229980102559;5923.466887980103;5932.466078052996;5934.851628709317;7389.334959853639;7392.223816499298;7392.889106663404;7398.556086634819;7431.628418579049;1678.1106013812698;1695.6778212139654;1697.9660406791795;1702.2339947023888;1706.453934740871;1040.7450174707094;1063.324788759128;1078.1213311151387;1080.6109800471825;1091.1325496230515;6333.398327158912;6822.658867056627;6853.286678330417;6873.896891546631;6876.724931002704;7406.333429991327;7642.847143057219;7652.081750190013;7665.080190377191;7721.7683469496005;7012.9298707013295;7021.543599666005;7050.4007159391;7051.083359163378;7058.11773528309;4077.4903137107863;4110.630043296118;4128.958710412858;4130.54563997966;4136.73111247768;8174.509529428254;8179.754607361789;8196.262336389753;8205.71280005197;8209.58952052395;7741.07107147146;8068.152843951418;8079.03051633796;8094.838103237902;8100.270975612223;7281.890771638324;8169.918300817035;8184.427090103635;8195;8205.835883282181;7806.41451891099;7810.258025487569;7814.33578145864;7818.569978651229;7828.882566761389;7329.706811727685;7569.432292577969;7658.6170691464085;7667.961660191663;7700.268474494914;8174.918250817415;8177.67289308421;8178.5092894426525;8181.100078991425;8191.017077950684;4780.378550788375;4814.927776083291;4822.397200349957;4823.879403014953;4833.10587541306;7682.500637458771;7710.92289077102;7735.4198435118715;7735.497192682683;7754.418418618739;7224;7437.256274372519;7458.8508229834015;7465.92534074674;7472.738454154296;5410.513053825174;6041.18444010053;7464.141623713343;7470.738524151629;7473.252674732484;5399.541039011728;6199.814005579839;7124.333561517215;7260.782176534501;7286.48994570375;7468.365188958782;7480;7481.064866891638;7489.176190619137;7494.288042635941;6966.442684585119;7193.4604904631315;7212.675429605785;7291.718726573169;7332.376747976482 11:12:47 INFO - PROCESS | 1674 | |5;yui.html;617.8887800195965;667.576089183369;675.1348529667654;689.1144878830702;752.9247075292471;13321.134126281784;14137.515560866115;14690.559283221508;14849.777253341208;14944.85055149448;13531.98510111743;13697.726045479085;14033.50882719105;14055.226962517057;14067.648308792286;607.854115012396;884.5842454046588;887.4808237181256;908.8227795579865;917.2295271971543;898.1961144775422;904.1275169461468;923.2429407885537;930.8882934047924;932.1331162019319;920.9309301802358;927.4759760735196;955.2262667239523;976.998576459128;977.5356705564835;918.0681608167715;923.4736200365794;930.8743319651862;963.6145541783272;968.1045033344128;682.5358756045887;695.2491309385852;695.766918082443;718.3498933465222;721.3543878229008;14577.854221457756;14584.489542866055;14748.3363248653;14815.333310001075;14819.18494482803;11608.770584074702;11928.761424771455;12466.563670271587;12638.178518396275;12842.101052926299;10019.74950626233;10020.34867733595;10106.898931010743;10126.746831329203;10253.487325633689;3467.7225821934185;3468.6357932417236;3554.662307080823;3589.623089575583;3722.5346831646043;72746.63626681885;73913;75173.62413187954;75415.62292188559;75670.24329756742;9136.363183633677;9416.340856140005;9453.810923781486;9565.521723913776;9714.611415543299;21002.264920727703;21310.680339794915;21331.14675412997;21338.35984920455;21575.35273941784;7226.6386680665755;7448.031755871702;7491.737789177353;7521.586312752851;7545.962270188614;3385.9830700846337;4019.376996565537;4048.6558642515715;4174.478190226222;4222.9577704223175;3560.359135355609;3611.4041183204477;3616.3309787689363;3618.4029635109914;3627.3289441453417;652.8270008447765;655.8130932684257;662.559398000334;668.1881513960561;673.8787018336747;542.9185622156708;546.4508169289838;582.118091091996;585.9003969325225;612.9908051379233;8012.719554815553;8182.959085204536;8216.465929714668;8284.958575207205;8554.315654747605;571.6998575747766;581.5028150930893;598.60791181776;619.7923695562038;631.1101347100566;3787.5833658297565;3882.126521532689;3903.902402439962;3922.5096862892137;4022.597740225954;80332;84140.57929710312;86063;86787;86963;68768;69982.65008674924;70788.2921170792;71050;71907.92138117933;63012;64022;64062.35937640657;64164.35835641584;65106;7659.387249019954;7732.884006740016;7782.338501227459;7788;7895.526268423913;43822.78088609537;44590.108197835216;45292.77353613211;45411.31883021823;45491.772541137085;51335.48664513307;58953.5261618463;59125.70437147787;59593.7020314913;59826.70086649539;9903.059209375098;10048.648297309559;10069.446180460145;10093.444860532447;10108.646197383056;10693.572257109628;10792.244542881923;10958.890411095786;10981.560737570408;11540.076793856639;10117.696469105938;10170.135538479311;10337.37975721459;10359.430231337048;10607;9727.9027209727;10041.548130334299;10103;10106.747331316481;10314.793704126025;9802.705918822447;10029.097381235724;10078.596856125672;10119.139873110867;10384.065434110966;8726.214640682369;8807.207351338411;8819.823603528022;9019.594118264562;9166.724998250063;7876.330511906552;8310.792230194293;8382.790430239293;8548.931383577054;9047.230985366317 11:12:47 INFO - PROCESS | 1674 | __end_tp_report 11:12:47 INFO - PROCESS | 1674 | __start_cc_report 11:12:47 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,415 11:12:47 INFO - PROCESS | 1674 | __end_cc_report 11:12:47 INFO - PROCESS | 1674 | __startTimestamp1463508767257__endTimestamp 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | ------- Summary: start ------- 11:12:47 INFO - PROCESS | 1674 | Number of tests: 6 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5821.14 Median:6084.09 stddev:647.80 (10.6%) stddev-sans-first:621.65 11:12:47 INFO - PROCESS | 1674 | Values: 3413.6 3498.7 3505.3 3544.1 3576.7 5708.8 5856.0 5856.5 5874.0 5874.2 4893.3 5806.4 5861.0 5863.9 5891.2 5266.9 5300.6 5312.7 5322.8 5353.7 5214.3 5332.7 5416.1 5417.2 5438.7 5356.5 5402.4 5412.5 5421.8 5425.8 5320.0 5341.1 5376.3 5408.5 5438.8 5190.2 5199.2 5257.3 5306.6 5345.5 5070.7 5278.0 5736.9 5772.4 5782.1 5764.2 6180.7 6242.0 6257.0 6276.4 6133.8 6190.6 6217.4 6219.6 6277.7 5991.2 6006.3 6019.1 6019.6 6040.0 6262.2 6338.1 6350.2 6351.8 6373.7 5224.8 6166.6 6183.6 6201.8 6213.0 6286.0 6291.6 6296.0 6303.8 6316.8 6139.2 6191.4 6230.6 6304.5 6356.5 6276.3 6278.5 6280.5 6290.8 6293.7 4942.2 4984.8 4992.2 4998.6 5019.7 4379.1 4450.8 4493.5 4512.6 4546.0 5833.4 5895.0 5950.8 5967.0 5972.3 6267.4 6282.2 6298.1 6308.0 6314.3 5803.8 5916.1 5973.1 6003.5 6006.5 4853.9 5454.6 5459.3 5481.6 5482.4 6249.4 6458.7 6470.7 6488.5 6504.9 6192.3 6231.7 6283.2 6290.9 6319.1 6410.7 6469.4 6473.4 6486.9 6511.8 6250.4 6265.5 6312.5 6331.7 6349.5 6143.2 6225.6 6226.5 6241.9 6305.1 6223.0 6323.7 6339.6 6340.5 6342.7 6115.2 6345.1 6348.0 6354.0 6375.7 5074.9 5082.9 6000.4 6054.8 6161.4 6237.3 6259.7 6261.7 6277.4 6286.2 6004.3 6084.1 6093.3 6131.7 6155.0 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:63127.84 Median:39006.40 stddev:129900.50 (333.0%) stddev-sans-first:130179.76 11:12:47 INFO - PROCESS | 1674 | Values: 487.6 534.4 538.3 543.1 547.0 32357.8 40452.4 40454.6 40489.0 40678.6 41209.6 41684.4 42347.7 42477.6 42492.0 9732.8 9804.1 10009.3 10036.0 10066.3 8527.3 9834.9 9877.9 9887.6 9973.5 9846.1 9896.9 9914.0 9952.3 9984.6 9839.0 9903.3 9969.6 9973.9 9983.0 9871.3 9974.9 9982.2 10001.7 10032.0 40598.6 40698.0 40736.2 40740.4 40869.2 2730.6 3098.2 3144.6 3147.1 3167.9 25684.7 26674.9 26718.7 27174.8 27506.3 2691.6 2701.5 2728.5 2795.0 2900.3 307475.0 318502.0 353390.0 354616.0 357147.2 36932.8 37835.1 37959.6 38033.8 38127.0 68246.3 72209.3 73535.6 74046.0 74223.3 14871.8 17598.9 17619.3 17651.7 17683.7 12925.7 13273.9 13277.5 13348.2 13361.7 19596.0 19624.6 19855.5 19915.3 20428.9 7662.3 8131.9 8135.3 8141.5 8223.1 789.0 965.7 1025.5 1040.7 1125.3 26089.0 29872.6 30320.5 31003.5 31074.5 1034.2 1114.5 1121.9 1165.2 1250.6 15258.0 15308.7 15870.3 16681.6 17201.8 585623.0 597024.0 600530.0 606276.0 607835.0 63120.0 65022.0 65158.7 65215.0 65356.0 1510.4 1526.4 1529.0 1531.8 1533.5 31134.4 31394.0 31490.4 32026.0 32384.0 56632.2 61436.1 63394.0 63775.7 63890.4 483672.0 485745.6 491107.0 491722.0 491756.5 35038.6 41814.4 43579.3 44115.0 45323.8 44794.0 47448.0 49134.0 49158.8 49276.8 34745.8 38763.2 39738.0 39946.4 40089.4 37928.8 38813.0 38977.0 39527.8 40074.8 37688.4 39035.8 39468.8 39805.8 39935.2 29636.9 32626.5 34906.8 34934.7 35053.0 24200.0 24921.6 26036.2 26200.3 26328.9 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:35820.36 Median:2172.02 stddev:105732.42 (4867.9%) stddev-sans-first:105995.57 11:12:47 INFO - PROCESS | 1674 | Values: 394.8 398.4 399.7 405.5 406.4 15025.3 16385.1 20136.0 20353.5 20468.7 16338.3 16576.6 17504.6 19931.0 20713.6 5883.8 6076.4 6172.6 6183.2 6195.8 5878.5 6050.5 6104.9 6135.6 6148.5 5781.3 6059.8 6101.6 6103.9 6104.7 5766.7 6000.8 6055.1 6058.5 6136.1 5836.0 5847.8 6005.6 6039.8 6063.5 24338.0 24629.1 24763.6 24835.9 25023.6 1996.5 2116.1 2228.0 2304.6 2323.1 9732.3 9806.6 9829.3 12472.7 14171.1 1721.4 1757.6 1786.3 1803.5 1836.1 90278.0 114917.0 122635.0 123702.0 124236.4 11739.5 11958.9 12017.5 12025.1 12090.5 14849.6 15204.0 15230.0 15271.5 15325.4 7628.9 8650.7 9019.1 9035.5 9117.2 7306.7 9025.4 9027.6 9089.5 9125.3 4652.7 4697.4 4749.0 4762.8 4774.6 1751.5 1991.2 2018.8 2045.3 2066.8 922.6 924.3 1020.8 1083.0 1089.9 16722.3 19915.1 20342.8 20520.7 20776.9 940.7 992.5 992.5 1025.2 1047.4 10738.8 10834.2 10890.0 10941.0 10963.3 604379.0 636828.0 640184.0 647404.0 648531.0 127236.4 127523.0 128803.7 130567.0 130569.7 1025.7 1027.5 1039.1 1039.3 1039.7 17826.3 17999.4 18000.9 18138.3 18146.1 51753.7 51780.0 53980.5 54127.7 54529.5 63623.0 75029.6 77417.0 80047.6 80237.6 8303.2 8310.8 8408.2 8412.0 8448.9 9002.5 11814.5 12317.6 12393.6 12709.4 10228.7 10748.0 10752.7 11129.9 11165.7 10654.8 10658.6 10664.5 10756.9 10837.8 11161.5 11261.7 11297.4 11362.7 11395.9 8065.8 8109.8 8303.6 8347.5 8452.3 8211.1 10162.1 10989.0 11289.7 11297.7 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5687.11 Median:2709.86 stddev:3148.51 (116.2%) stddev-sans-first:3140.78 11:12:47 INFO - PROCESS | 1674 | Values: 1390.5 1583.9 1655.6 1815.6 1944.7 7873.1 8484.2 8686.7 8872.9 8879.9 7667.4 7703.7 8470.7 8595.0 8687.3 2215.9 2251.1 2419.8 2489.8 2491.4 2476.3 2478.6 2522.0 2527.1 2529.5 2440.6 2451.8 2470.3 2483.3 2496.7 2441.8 2455.7 2458.8 2479.8 2490.4 2487.2 2508.3 2513.6 2520.2 2537.7 8693.7 8814.9 8831.6 8832.5 8865.6 5421.9 5437.5 5466.5 5525.2 5593.8 3552.9 3585.6 3640.9 3666.1 3683.2 1026.9 1065.3 1065.7 1065.9 1067.5 11688.2 11715.9 11755.6 11948.3 11986.9 4854.9 4894.9 4974.3 4989.4 5002.9 10226.6 10250.2 10261.6 10266.1 10269.4 5379.6 5421.8 5495.8 5503.3 5550.8 4450.5 4827.6 4900.1 4949.9 5015.5 4098.3 4135.7 4155.2 4175.9 4198.6 1185.7 1187.9 1203.1 1258.7 1346.8 737.5 935.7 952.1 963.2 971.9 5809.8 5924.3 5962.2 5992.7 6075.5 459.4 469.9 488.2 488.8 492.6 3851.9 3879.7 3927.4 3929.1 3949.8 9187.0 10408.0 10792.4 10870.5 10892.3 10639.8 10667.8 10708.0 10712.5 10725.9 7951.6 8252.6 8436.3 8450.7 8462.2 5826.5 5826.7 5935.3 6034.7 6035.8 9329.4 9336.6 9423.1 9423.4 9448.9 9403.0 9726.8 9827.0 9837.1 9853.4 6778.4 7225.8 7386.9 7444.2 7566.4 8066.0 8100.5 8126.8 8171.8 8195.9 7156.1 7309.5 7316.1 7397.6 7428.3 7065.7 7092.0 7163.6 7205.7 7243.4 6803.9 6819.3 6888.3 6898.3 6924.4 4797.5 4807.1 4812.8 4857.4 4918.2 4838.9 4873.7 4927.1 4950.0 5056.2 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:6019.77 Median:6905.52 stddev:1975.04 (28.6%) stddev-sans-first:1933.55 11:12:47 INFO - PROCESS | 1674 | Values: 311.4 324.6 330.8 331.6 335.6 6943.6 6951.8 6952.6 6957.1 7045.2 6934.3 6940.2 6948.6 6953.4 6967.3 4799.0 4912.8 5094.6 5102.1 5105.9 5025.7 5077.8 5081.6 5090.5 5092.2 5019.3 5034.0 5034.6 5042.2 5064.5 5049.3 5050.8 5056.7 5076.0 5102.3 3896.2 4010.9 4337.0 4342.8 4348.8 6366.4 6556.2 6625.4 6714.9 6742.8 4309.5 4840.0 4862.0 5913.7 5921.5 7380.3 7393.9 7396.1 7409.6 7409.8 4680.5 4688.6 4689.6 4692.7 4694.3 5749.7 6717.1 7693.2 7776.4 7795.3 4608.8 4774.6 4778.6 4792.4 4807.0 4817.8 4855.8 4868.5 4885.4 4888.8 5919.9 5923.2 5923.5 5932.5 5934.9 7389.3 7392.2 7392.9 7398.6 7431.6 1678.1 1695.7 1698.0 1702.2 1706.5 1040.7 1063.3 1078.1 1080.6 1091.1 6333.4 6822.7 6853.3 6873.9 6876.7 7406.3 7642.8 7652.1 7665.1 7721.8 7012.9 7021.5 7050.4 7051.1 7058.1 4077.5 4110.6 4129.0 4130.5 4136.7 8174.5 8179.8 8196.3 8205.7 8209.6 7741.1 8068.2 8079.0 8094.8 8100.3 7281.9 8169.9 8184.4 8195.0 8205.8 7806.4 7810.3 7814.3 7818.6 7828.9 7329.7 7569.4 7658.6 7668.0 7700.3 8174.9 8177.7 8178.5 8181.1 8191.0 4780.4 4814.9 4822.4 4823.9 4833.1 7682.5 7710.9 7735.4 7735.5 7754.4 7224.0 7437.3 7458.9 7465.9 7472.7 5410.5 6041.2 7464.1 7470.7 7473.3 5399.5 6199.8 7124.3 7260.8 7286.5 7468.4 7480.0 7481.1 7489.2 7494.3 6966.4 7193.5 7212.7 7291.7 7332.4 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:16863.04 Median:615.44 stddev:23229.76 (3774.5%) stddev-sans-first:23262.90 11:12:47 INFO - PROCESS | 1674 | Values: 617.9 667.6 675.1 689.1 752.9 13321.1 14137.5 14690.6 14849.8 14944.9 13532.0 13697.7 14033.5 14055.2 14067.6 607.9 884.6 887.5 908.8 917.2 898.2 904.1 923.2 930.9 932.1 920.9 927.5 955.2 977.0 977.5 918.1 923.5 930.9 963.6 968.1 682.5 695.2 695.8 718.3 721.4 14577.9 14584.5 14748.3 14815.3 14819.2 11608.8 11928.8 12466.6 12638.2 12842.1 10019.7 10020.3 10106.9 10126.7 10253.5 3467.7 3468.6 3554.7 3589.6 3722.5 72746.6 73913.0 75173.6 75415.6 75670.2 9136.4 9416.3 9453.8 9565.5 9714.6 21002.3 21310.7 21331.1 21338.4 21575.4 7226.6 7448.0 7491.7 7521.6 7546.0 3386.0 4019.4 4048.7 4174.5 4223.0 3560.4 3611.4 3616.3 3618.4 3627.3 652.8 655.8 662.6 668.2 673.9 542.9 546.5 582.1 585.9 613.0 8012.7 8183.0 8216.5 8285.0 8554.3 571.7 581.5 598.6 619.8 631.1 3787.6 3882.1 3903.9 3922.5 4022.6 80332.0 84140.6 86063.0 86787.0 86963.0 68768.0 69982.7 70788.3 71050.0 71907.9 63012.0 64022.0 64062.4 64164.4 65106.0 7659.4 7732.9 7782.3 7788.0 7895.5 43822.8 44590.1 45292.8 45411.3 45491.8 51335.5 58953.5 59125.7 59593.7 59826.7 9903.1 10048.6 10069.4 10093.4 10108.6 10693.6 10792.2 10958.9 10981.6 11540.1 10117.7 10170.1 10337.4 10359.4 10607.0 9727.9 10041.5 10103.0 10106.7 10314.8 9802.7 10029.1 10078.6 10119.1 10384.1 8726.2 8807.2 8819.8 9019.6 9166.7 7876.3 8310.8 8382.8 8548.9 9047.2 11:12:47 INFO - PROCESS | 1674 | -------- Summary: end -------- 11:12:47 INFO - PROCESS | 1674 | 11:12:47 INFO - TEST-INFO | 1674: exit 0 11:12:47 INFO - TEST-OK | dromaeo_css | took 1111960ms 11:12:47 INFO - TEST-START | kraken 11:12:47 INFO - operating with platform_type : mac_ 11:12:47 INFO - Initialising browser for kraken test... 11:12:47 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmphWFNLB/profile http://localhost:49278/getInfo.html) 11:12:50 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 11:12:50 INFO - PROCESS | 1682 | colorDepth:24 11:12:50 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 11:12:50 INFO - PROCESS | 1682 | __metrics 11:12:50 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 11:12:51 INFO - TEST-INFO | 1682: exit 0 11:12:51 INFO - Browser initialized. 11:12:51 INFO - Running cycle 1/1 for kraken test... 11:12:51 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmphWFNLB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:03 INFO - PROCESS | 1686 | RSS: Main: 221396992 11:13:03 INFO - PROCESS | 1686 | 11:13:06 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:06 INFO - PROCESS | 1686 | RSS: Main: 233164800 11:13:06 INFO - PROCESS | 1686 | 11:13:09 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 11:13:10 INFO - PROCESS | 1686 | RSS: Main: 241913856 11:13:10 INFO - PROCESS | 1686 | 11:13:13 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 11:13:14 INFO - PROCESS | 1686 | RSS: Main: 246063104 11:13:14 INFO - PROCESS | 1686 | 11:13:16 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 11:13:16 INFO - PROCESS | 1686 | RSS: Main: 247734272 11:13:16 INFO - PROCESS | 1686 | 11:13:18 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:19 INFO - PROCESS | 1686 | RSS: Main: 247472128 11:13:19 INFO - PROCESS | 1686 | 11:13:22 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:23 INFO - PROCESS | 1686 | RSS: Main: 248168448 11:13:23 INFO - PROCESS | 1686 | 11:13:26 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:26 INFO - PROCESS | 1686 | RSS: Main: 248406016 11:13:26 INFO - PROCESS | 1686 | 11:13:30 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 11:13:30 INFO - PROCESS | 1686 | RSS: Main: 248537088 11:13:30 INFO - PROCESS | 1686 | 11:13:32 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:32 INFO - PROCESS | 1686 | RSS: Main: 247771136 11:13:32 INFO - PROCESS | 1686 | 11:13:34 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:35 INFO - PROCESS | 1686 | RSS: Main: 247660544 11:13:35 INFO - PROCESS | 1686 | 11:13:37 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:38 INFO - PROCESS | 1686 | RSS: Main: 248025088 11:13:38 INFO - PROCESS | 1686 | 11:13:40 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:13:41 INFO - PROCESS | 1686 | RSS: Main: 248025088 11:13:41 INFO - PROCESS | 1686 | 11:13:44 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:13:45 INFO - PROCESS | 1686 | RSS: Main: 248745984 11:13:45 INFO - PROCESS | 1686 | 11:13:46 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 11:13:47 INFO - PROCESS | 1686 | RSS: Main: 249823232 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | __start_tp_report 11:13:47 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 11:13:47 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 11:13:47 INFO - PROCESS | 1686 | |i|pagename|runs| 11:13:47 INFO - PROCESS | 1686 | |0;ai-astar;115;120;109;117;120;119;107;116;117;116 11:13:47 INFO - PROCESS | 1686 | |1;audio-beat-detection;172;158;184;189;154;140;120;155;154;124 11:13:47 INFO - PROCESS | 1686 | |2;audio-dft;195;234;217;200;196;197;194;197;198;194 11:13:47 INFO - PROCESS | 1686 | |3;audio-fft;64;76;80;144;57;60;54;61;132;56 11:13:47 INFO - PROCESS | 1686 | |4;audio-oscillator;79;84;127;76;79;79;116;104;112;160 11:13:47 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;135;121;90;89;134;87;91;88;82;131 11:13:47 INFO - PROCESS | 1686 | |6;imaging-darkroom;102;145;97;96;135;150;146;97;114;151 11:13:47 INFO - PROCESS | 1686 | |7;imaging-desaturate;99;100;96;147;146;140;144;143;93;89 11:13:47 INFO - PROCESS | 1686 | |8;json-parse-financial;61;65;66;66;66;64;64;80;61;59 11:13:47 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;64;71;68;77;77;75;73;70;84;98 11:13:47 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;83;80;80;82;82;80;82;82;85;83 11:13:47 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;127;127;132;123;152;147;129;135;184;141 11:13:47 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;170;166;168;175;215;184;164;171;165;164 11:13:47 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;67;68;68;67;66;68;69;66;70;66 11:13:47 INFO - PROCESS | 1686 | __end_tp_report 11:13:47 INFO - PROCESS | 1686 | __start_cc_report 11:13:47 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,1077 11:13:47 INFO - PROCESS | 1686 | __end_cc_report 11:13:47 INFO - PROCESS | 1686 | __startTimestamp1463508827020__endTimestamp 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | ------- Summary: start ------- 11:13:47 INFO - PROCESS | 1686 | Number of tests: 14 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:115.60 Median:117.00 stddev:4.38 (3.7%) stddev-sans-first:4.64 11:13:47 INFO - PROCESS | 1686 | Values: 115.0 120.0 109.0 117.0 120.0 119.0 107.0 116.0 117.0 116.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:155.00 Median:156.50 stddev:22.87 (14.6%) stddev-sans-first:23.42 11:13:47 INFO - PROCESS | 1686 | Values: 172.0 158.0 184.0 189.0 154.0 140.0 120.0 155.0 154.0 124.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:202.20 Median:197.50 stddev:13.05 (6.6%) stddev-sans-first:13.57 11:13:47 INFO - PROCESS | 1686 | Values: 195.0 234.0 217.0 200.0 196.0 197.0 194.0 197.0 198.0 194.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:78.40 Median:60.50 stddev:32.64 (54.0%) stddev-sans-first:34.20 11:13:47 INFO - PROCESS | 1686 | Values: 64.0 76.0 80.0 144.0 57.0 60.0 54.0 61.0 132.0 56.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:77.50 stddev:27.64 (35.7%) stddev-sans-first:28.08 11:13:47 INFO - PROCESS | 1686 | Values: 79.0 84.0 127.0 76.0 79.0 79.0 116.0 104.0 112.0 160.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:104.80 Median:87.50 stddev:22.34 (25.5%) stddev-sans-first:20.85 11:13:47 INFO - PROCESS | 1686 | Values: 135.0 121.0 90.0 89.0 134.0 87.0 91.0 88.0 82.0 131.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:123.30 Median:150.50 stddev:24.20 (16.1%) stddev-sans-first:24.41 11:13:47 INFO - PROCESS | 1686 | Values: 102.0 145.0 97.0 96.0 135.0 150.0 146.0 97.0 114.0 151.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:119.70 Median:118.00 stddev:25.85 (21.9%) stddev-sans-first:26.32 11:13:47 INFO - PROCESS | 1686 | Values: 99.0 100.0 96.0 147.0 146.0 140.0 144.0 143.0 93.0 89.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:5.75 (8.8%) stddev-sans-first:5.89 11:13:47 INFO - PROCESS | 1686 | Values: 61.0 65.0 66.0 66.0 66.0 64.0 64.0 80.0 61.0 59.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:75.70 Median:76.00 stddev:9.59 (12.6%) stddev-sans-first:9.19 11:13:47 INFO - PROCESS | 1686 | Values: 64.0 71.0 68.0 77.0 77.0 75.0 73.0 70.0 84.0 98.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.60 (1.9%) stddev-sans-first:1.64 11:13:47 INFO - PROCESS | 1686 | Values: 83.0 80.0 80.0 82.0 82.0 80.0 82.0 82.0 85.0 83.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:138.00 stddev:18.15 (13.2%) stddev-sans-first:18.66 11:13:47 INFO - PROCESS | 1686 | Values: 127.0 127.0 132.0 123.0 152.0 147.0 129.0 135.0 184.0 141.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:170.50 stddev:15.59 (9.1%) stddev-sans-first:16.46 11:13:47 INFO - PROCESS | 1686 | Values: 170.0 166.0 168.0 175.0 215.0 184.0 164.0 171.0 165.0 164.0 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 11:13:47 INFO - PROCESS | 1686 | Values: 67.0 68.0 68.0 67.0 66.0 68.0 69.0 66.0 70.0 66.0 11:13:47 INFO - PROCESS | 1686 | -------- Summary: end -------- 11:13:47 INFO - PROCESS | 1686 | 11:13:47 INFO - TEST-INFO | 1686: exit 0 11:13:47 INFO - TEST-OK | kraken | took 59984ms 11:13:47 INFO - SUITE-END | took 1171s 11:13:48 INFO - Completed test suite (00:19:32) 11:13:48 INFO - javascript benchmark 11:13:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3413.624501304856, 3498.7375946803995, 3505.316463289658, 3544.113971507123, 3576.749627526073, 5708.800191993281, 5856.033754430514, 5856.502197313228, 5873.972054890393, 5874.236349274588, 4893.314935908976, 5806.361300256979, 5861.0, 5863.912041319383, 5891.175235467038, 5266.947330526684, 5300.628955973074, 5312.654677445973, 5322.787088516455, 5353.678779273237, 5214.296070030536, 5332.733363331838, 5416.079266524681, 5417.214503896952, 5438.6736795792185, 5356.491133342326, 5402.37872644645, 5412.4587541245955, 5421.756020979045, 5425.810096646618, 5319.973400132974, 5341.06531357013, 5376.274202982587, 5408.513233808976, 5438.755256013489, 5190.2214667800135, 5199.220116982483, 5257.316548848626, 5306.575473962073, 5345.545628621572, 5070.72111033893, 5278.0, 5736.942630573724, 5772.422757724236, 5782.074868021096, 5764.16419619157, 6180.721867515973, 6242.001279795257, 6256.96871515644, 6276.435120839101, 6133.815985520441, 6190.597611155261, 6217.378262173746, 6219.564630475868, 6277.686115694197, 5991.221141251609, 6006.339302676702, 6019.057517326159, 6019.608725432833, 6040.0, 6262.185915830913, 6338.0771946574705, 6350.174477317919, 6351.809445716636, 6373.7131829066875, 5224.798296391851, 6166.599171053867, 6183.5671502994355, 6201.844953876189, 6212.968935155295, 6286.025666021774, 6291.622502649856, 6295.992641177481, 6303.810885673437, 6316.778912738032, 6139.154842350747, 6191.442770150708, 6230.59501132425, 6304.464120549713, 6356.491480681534, 6276.340984196685, 6278.46633036197, 6280.497560195174, 6290.779822706183, 6293.653849038347, 4942.159832828428, 4984.77568509418, 4992.201247800334, 4998.600111991032, 5019.698818070928, 4379.1460665170625, 4450.777461126931, 4493.505714371417, 4512.593866551961, 4545.977270113628, 5833.387494313036, 5895.0, 5950.761969521171, 5966.970165149147, 5972.313183983897, 6267.4045965633195, 6282.246130464374, 6298.086777417248, 6308.0, 6314.305426403092, 5803.82588522345, 5916.1421593868645, 5973.104034394789, 6003.549733769984, 6006.4594186522545, 4853.907870729057, 5454.59090568201, 5459.344878614512, 5481.561475081984, 5482.39693633708, 6249.437550620466, 6458.741650333934, 6470.708818103102, 6488.480921526172, 6504.902426463606, 6192.2569291683485, 6231.688415579112, 6283.2460104787715, 6290.905636415366, 6319.115323854756, 6410.711517981609, 6469.417752402306, 6473.449756770728, 6486.935130648633, 6511.804645860631, 6250.3749625037135, 6265.498760099273, 6312.4634406076, 6331.683415829282, 6349.460295874902, 6143.174139895698, 6225.564210505402, 6226.501879849692, 6241.906371404523, 6305.085762564494, 6223.0, 6323.6838158090995, 6339.5562310637815, 6340.524460665376, 6342.682865856781, 6115.205023346936, 6345.1434056401795, 6347.96826015867, 6353.96823015882, 6375.6812159392775, 5074.8835256243565, 5082.923756143735, 6000.369961154016, 6054.84862878414, 6161.4146656067605, 6237.282712488122, 6259.654174352536, 6261.68691565429, 6277.403646653561, 6286.214223222098, 6004.309504406874, 6084.087386892002, 6093.329733729375, 6131.662758548323, 6155.045967874987], "value": 5781.41043838863, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.5660662010809, 534.3801190618883, 538.2518299563607, 543.1309904153358, 546.9635041596175, 32357.83821080897, 40452.39321410181, 40454.59545404545, 40488.987775305635, 40678.59321406785, 41209.58790412095, 41684.37473437901, 42347.729568112925, 42477.57522424775, 42492.0, 9732.805343893118, 9804.068613481708, 10009.29934904557, 10036.0, 10066.29535932485, 8527.275181609539, 9834.901650983506, 9877.913429522747, 9887.55506002228, 9973.50132493376, 9846.113849753521, 9896.851547226797, 9914.008599140065, 9952.303338766289, 9984.600615975389, 9839.0, 9903.30676852617, 9969.55137018836, 9973.90026099737, 9982.9500852496, 9871.259655525793, 9974.900250997469, 9982.151517121054, 10001.749956251078, 10032.0, 40598.59401406007, 40698.0, 40736.18527629461, 40740.38889416661, 40869.182616347505, 2730.563109902426, 3098.2409309719264, 3144.584936778459, 3147.07161387389, 3167.857446414917, 25684.743152568422, 26674.866625666942, 26718.73281267182, 27174.77713502897, 27506.312342191606, 2691.609716591103, 2701.540738074532, 2728.5361488546796, 2794.9938022311953, 2900.260433589421, 307475.0, 318502.0, 353390.0, 354616.0, 357147.21426392964, 36932.81533592315, 37835.05412364658, 37959.62040379616, 38033.80983095122, 38127.0, 68246.29384265334, 72209.2779072213, 73535.63232183912, 74046.0, 74223.25776742272, 14871.776923346159, 17598.912005440146, 17619.295228190986, 17651.73522397165, 17683.73474397885, 12925.676858078623, 13273.93363033198, 13277.535286264934, 13348.199108053548, 13361.73276534464, 19596.020198989994, 19624.607507849763, 19855.503612409517, 19915.302964396466, 20428.897855510924, 7662.310392064741, 8131.878021829677, 8135.3491720662205, 8141.51150930946, 8223.05434874985, 789.0413148025177, 965.6620182935916, 1025.5128813813528, 1040.7450174707244, 1125.3248051169232, 26089.0, 29872.55191172134, 30320.54519182214, 31003.534946975815, 31074.53388199179, 1034.234666346898, 1114.4761961877905, 1121.870984836738, 1165.2076587920296, 1250.6373151786063, 15258.0, 15308.693826123415, 15870.285837137357, 16681.582960426087, 17201.827981720275, 585623.0, 597024.0, 600530.0, 606276.0, 607835.0, 63120.0, 65022.0, 65158.67420662866, 65215.0, 65356.01965970514, 1510.3731951240113, 1526.4123312524757, 1529.021426287177, 1531.7855500229978, 1533.4939469974881, 31134.377312453173, 31394.0, 31490.370192596478, 32026.039218823473, 32384.0, 56632.15051774309, 61436.07845882226, 63394.0, 63775.68112159595, 63890.36109638844, 483672.0, 485745.57127214136, 491107.0, 491722.0, 491756.54121730593, 35038.64961350456, 41814.37278440765, 43579.34630980601, 44115.0, 45323.77338113288, 44794.0, 47448.0, 49134.0, 49158.75420623017, 49276.75361623169, 34745.826270868485, 38763.2247355057, 39738.006549836486, 39946.40080398738, 40089.39865902072, 37928.810355948044, 38813.0, 38977.0, 39527.80236098801, 40074.79962600285, 37688.43467348047, 39035.80482097571, 39468.80265598654, 39805.80097099496, 39935.20129597334, 29636.85181574078, 32626.51060234146, 34906.77826276068, 34934.65065349416, 35053.0, 24200.0, 24921.626175607744, 26036.21891343263, 26200.344991374604, 26328.868355658866], "value": 20071.375663986357, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.8223299515219, 398.37455195343284, 399.70022483137654, 405.50123348281613, 406.37418375701424, 15025.32386042628, 16385.09881956492, 20135.99320033998, 20353.491162720922, 20468.69296960545, 16338.264778084986, 16576.58558536037, 17504.562385940357, 19931.0, 20713.585728285463, 5883.764649414018, 6076.361981991893, 6172.629642221481, 6183.165272688197, 6195.845103872394, 5878.470937615613, 6050.485708714765, 6104.9389506105035, 6135.631862088267, 6148.508119350441, 5781.335146458169, 6059.848503787396, 6101.603395779282, 6103.908441373383, 6104.664243466607, 5766.682832444214, 6000.75996960121, 6055.12200730896, 6058.545609079315, 6136.079588061782, 5836.037053886103, 5847.8245652630485, 6005.6396616203165, 6039.788607398764, 6063.454289113957, 24338.0, 24629.13798017061, 24763.63799991, 24835.87582062096, 25023.62464563033, 1996.4709352021725, 2116.0795054151495, 2227.9554408911895, 2304.6197377432704, 2323.117215458132, 9732.270079744048, 9806.607735690635, 9829.311948163631, 12472.690367511372, 14171.078879872879, 1721.3803030908862, 1757.578181236507, 1786.2734280644645, 1803.513051476094, 1836.0727832444663, 90278.0, 114917.0, 122634.99999999911, 123702.0, 124236.37881810624, 11739.530418783153, 11958.940205298917, 12017.459214335377, 12025.098117641212, 12090.516379344728, 14849.554513364616, 15204.0, 15230.0, 15271.541853744406, 15325.386984520494, 7628.8938103974615, 8650.697225597074, 9019.098090191059, 9035.45787252767, 9117.225035872025, 7306.671199796022, 9025.368224224241, 9027.593758280893, 9089.50007749567, 9125.269978401711, 4652.720836749806, 4697.436307643036, 4748.952510474851, 4762.78567464465, 4774.641901857374, 1751.5358430016056, 1991.2333751505776, 2018.7981201879988, 2045.3045964371888, 2066.8346532277383, 922.5802259971697, 924.3437159616748, 1020.7805321855689, 1083.030687534652, 1089.9455027248605, 16722.331106755835, 19915.10382032812, 20342.79657203409, 20520.692189617166, 20776.896115519325, 940.7224868663624, 992.4839083676592, 992.5483904823288, 1025.179856115105, 1047.3506426015767, 10738.838917416246, 10834.241603087708, 10889.965453281926, 10941.015308622262, 10963.342199468058, 604379.0, 636828.0, 640184.0, 647404.0, 648531.0, 127236.36381818217, 127523.0, 128803.71196288105, 130567.04149437766, 130569.69430305765, 1025.6564051042985, 1027.4759872465097, 1039.0700323210835, 1039.3140527251978, 1039.729670285716, 17826.286948521913, 17999.370022049166, 18000.90999544994, 18138.27446902162, 18146.092695364914, 51753.7412312936, 51780.0, 53980.460195399115, 54127.723919758646, 54529.45470545402, 63623.0, 75029.62485187539, 77417.0, 80047.59976200081, 80237.59881200557, 8303.169683031649, 8310.750677479686, 8408.2432581068, 8412.0, 8448.873266900879, 9002.50486223264, 11814.468348924147, 12317.568885088978, 12393.566225182076, 12709.428075736429, 10228.693139205836, 10748.0, 10752.731181720519, 11129.944350278522, 11165.665030049111, 10654.786904261717, 10658.62694805678, 10664.520096595827, 10756.912373298097, 10837.837432438677, 11161.49773260189, 11261.71845703864, 11297.43512824372, 11362.715932101764, 11395.943020284845, 8065.838683226185, 8109.75670729879, 8303.629901066257, 8347.54088525137, 8452.32381409498, 8211.05572859129, 10162.136218421518, 10989.0, 11289.661310160709, 11297.661070167907], "value": 9622.137387750117, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.499420208725, 1583.9208039598018, 1655.6440365321453, 1815.5824160443099, 1944.7471828662271, 7873.094594121678, 8484.236418722314, 8686.739397818068, 8872.866906996393, 8879.91120088799, 7667.3866090712745, 7703.730369437071, 8470.703525376613, 8595.0, 8687.348448866329, 2215.9113635454564, 2251.0883092347626, 2419.7822196002357, 2489.800815934721, 2491.389609545664, 2476.3437689012426, 2478.578641630927, 2522.041624182808, 2527.064985955199, 2529.544681957247, 2440.5973014452684, 2451.767082127195, 2470.283617750859, 2483.255023492954, 2496.6879140107485, 2441.7680320369536, 2455.6930383701947, 2458.8032957363366, 2479.7892179164614, 2490.4272017436, 2487.2413913756295, 2508.3102146909564, 2513.6229565565127, 2520.243926821946, 2537.7208507064206, 8693.652253909837, 8814.911850881474, 8831.646734130627, 8832.514211718353, 8865.601047952858, 5421.864453388657, 5437.510624043815, 5466.535344495723, 5525.198846167324, 5593.8321850344555, 3552.8934131975825, 3585.623509531488, 3640.8725694600826, 3666.120131168527, 3683.1528748387755, 1026.8870424253325, 1065.2543219746208, 1065.6696424108475, 1065.9200559958035, 1067.524951396629, 11688.240264382874, 11715.941420292844, 11755.64733058001, 11948.28310301376, 11986.88013119875, 4854.902901941941, 4894.853154405302, 4974.27872958419, 4989.351384320015, 5002.89994200114, 10226.59093636261, 10250.231232657581, 10261.589536418609, 10266.127379172705, 10269.435181064964, 5379.596530260246, 5421.756020979065, 5495.752691128829, 5503.3120859892515, 5550.833474995676, 4450.488193857748, 4827.61379089672, 4900.068986892479, 4949.876253093629, 5015.523525265094, 4098.344264917659, 4135.684016950518, 4155.231282212801, 4175.895602609899, 4198.5591512891315, 1185.6620863053988, 1187.8871507206802, 1203.1397550751255, 1258.6790368456168, 1346.8249127613544, 737.5206116024627, 935.6818681648136, 952.1288021460425, 963.2486660404895, 971.8833739951251, 5809.767609295665, 5924.348321684612, 5962.165296858443, 5992.670403127782, 6075.481447622097, 459.38671873049185, 469.9013207226452, 488.1969160730649, 488.82646660435034, 492.5911493460419, 3851.9422208666892, 3879.670228030649, 3927.4411732406948, 3929.0766669832565, 3949.8025098745525, 9187.0, 10408.0, 10792.352458852494, 10870.456477176109, 10892.292001019909, 10639.787204256027, 10667.83998240027, 10708.03627673513, 10712.517936692868, 10725.892741072645, 7951.602419878983, 8252.587370631445, 8436.28291595209, 8450.746477605682, 8462.19609137131, 5826.475617194473, 5826.679532625577, 5935.317438494629, 6034.69826508664, 6035.78874739382, 9329.440233586007, 9336.626534938527, 9423.057694230522, 9423.434593924387, 9448.858267126136, 9403.0, 9726.805463890823, 9826.950865245628, 9837.114659680663, 9853.408795472295, 6778.42383397397, 7225.819354516179, 7386.926130738624, 7444.181140074696, 7566.432517561095, 8065.9596702016115, 8100.513969161869, 8126.837463250584, 8171.836563268583, 8195.918040819515, 7156.069710937545, 7309.451791115581, 7316.085489313836, 7397.593132377556, 7428.294312040348, 7065.717371305091, 7092.0, 7163.641817909188, 7205.747798827016, 7243.384312333511, 6803.93196068033, 6819.318068193141, 6888.276730943379, 6898.2756810536175, 6924.4460443165435, 4797.472278049481, 4807.062622788522, 4812.807487700453, 4857.441394239708, 4918.163912135017, 4838.927416088691, 4873.731944743073, 4927.1377508935075, 4950.009998000486, 5056.241563765465], "value": 4531.7912353816755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.39589196957905, 324.56994482310944, 330.84284964641796, 331.6401704150996, 335.6006352440594, 6943.583384996891, 6951.791446256614, 6952.60947810438, 6957.095577574914, 7045.154581450221, 6934.3065693430635, 6940.167179938402, 6948.617826019567, 6953.37419632233, 6967.30326967303, 4799.016201678656, 4912.803487860499, 5094.617903657222, 5102.056119617864, 5105.897882042357, 5025.698458092526, 5077.771500282478, 5081.59347252219, 5090.465501122384, 5092.185250359943, 5019.347484826967, 5034.043531728978, 5034.597232221432, 5042.218456139304, 5064.493550644943, 5049.318342023835, 5050.823221187259, 5056.710538812616, 5076.0, 5102.260172275, 3896.201278737852, 4010.8796736097966, 4336.956630433719, 4342.761148136851, 4348.804303806304, 6366.427021568081, 6556.246031706367, 6625.4037136657935, 6714.899276510856, 6742.797716068526, 4309.482862056542, 4839.975800121012, 4861.951380486185, 5913.733881975279, 5921.526277897801, 7380.261973802631, 7393.852122957511, 7396.112466504, 7409.555426674417, 7409.777706668809, 4680.549029800773, 4688.578027977464, 4689.601383882374, 4692.671512994092, 4694.2723877799, 5749.683767392792, 6717.09319241901, 7693.230676932318, 7776.416768742367, 7795.259450352264, 4608.792604332813, 4774.570288674036, 4778.617710583145, 4792.448868380181, 4807.0, 4817.807287708522, 4855.781489832966, 4868.513148685103, 4885.364902562644, 4888.804447822047, 5919.852003699942, 5923.229980102559, 5923.466887980103, 5932.466078052996, 5934.851628709317, 7389.334959853639, 7392.223816499298, 7392.889106663404, 7398.556086634819, 7431.628418579049, 1678.1106013812698, 1695.6778212139654, 1697.9660406791795, 1702.2339947023888, 1706.453934740871, 1040.7450174707094, 1063.324788759128, 1078.1213311151387, 1080.6109800471825, 1091.1325496230515, 6333.398327158912, 6822.658867056627, 6853.286678330417, 6873.896891546631, 6876.724931002704, 7406.333429991327, 7642.847143057219, 7652.081750190013, 7665.080190377191, 7721.7683469496005, 7012.9298707013295, 7021.543599666005, 7050.4007159391, 7051.083359163378, 7058.11773528309, 4077.4903137107863, 4110.630043296118, 4128.958710412858, 4130.54563997966, 4136.73111247768, 8174.509529428254, 8179.754607361789, 8196.262336389753, 8205.71280005197, 8209.58952052395, 7741.07107147146, 8068.152843951418, 8079.03051633796, 8094.838103237902, 8100.270975612223, 7281.890771638324, 8169.918300817035, 8184.427090103635, 8195.0, 8205.835883282181, 7806.41451891099, 7810.258025487569, 7814.33578145864, 7818.569978651229, 7828.882566761389, 7329.706811727685, 7569.432292577969, 7658.6170691464085, 7667.961660191663, 7700.268474494914, 8174.918250817415, 8177.67289308421, 8178.5092894426525, 8181.100078991425, 8191.017077950684, 4780.378550788375, 4814.927776083291, 4822.397200349957, 4823.879403014953, 4833.10587541306, 7682.500637458771, 7710.92289077102, 7735.4198435118715, 7735.497192682683, 7754.418418618739, 7224.0, 7437.256274372519, 7458.8508229834015, 7465.92534074674, 7472.738454154296, 5410.513053825174, 6041.18444010053, 7464.141623713343, 7470.738524151629, 7473.252674732484, 5399.541039011728, 6199.814005579839, 7124.333561517215, 7260.782176534501, 7286.48994570375, 7468.365188958782, 7480.0, 7481.064866891638, 7489.176190619137, 7494.288042635941, 6966.442684585119, 7193.4604904631315, 7212.675429605785, 7291.718726573169, 7332.376747976482], "value": 5353.944138816582, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.8887800195965, 667.576089183369, 675.1348529667654, 689.1144878830702, 752.9247075292471, 13321.134126281784, 14137.515560866115, 14690.559283221508, 14849.777253341208, 14944.85055149448, 13531.98510111743, 13697.726045479085, 14033.50882719105, 14055.226962517057, 14067.648308792286, 607.854115012396, 884.5842454046588, 887.4808237181256, 908.8227795579865, 917.2295271971543, 898.1961144775422, 904.1275169461468, 923.2429407885537, 930.8882934047924, 932.1331162019319, 920.9309301802358, 927.4759760735196, 955.2262667239523, 976.998576459128, 977.5356705564835, 918.0681608167715, 923.4736200365794, 930.8743319651862, 963.6145541783272, 968.1045033344128, 682.5358756045887, 695.2491309385852, 695.766918082443, 718.3498933465222, 721.3543878229008, 14577.854221457756, 14584.489542866055, 14748.3363248653, 14815.333310001075, 14819.18494482803, 11608.770584074702, 11928.761424771455, 12466.563670271587, 12638.178518396275, 12842.101052926299, 10019.74950626233, 10020.34867733595, 10106.898931010743, 10126.746831329203, 10253.487325633689, 3467.7225821934185, 3468.6357932417236, 3554.662307080823, 3589.623089575583, 3722.5346831646043, 72746.63626681885, 73913.0, 75173.62413187954, 75415.62292188559, 75670.24329756742, 9136.363183633677, 9416.340856140005, 9453.810923781486, 9565.521723913776, 9714.611415543299, 21002.264920727703, 21310.680339794915, 21331.14675412997, 21338.35984920455, 21575.35273941784, 7226.6386680665755, 7448.031755871702, 7491.737789177353, 7521.586312752851, 7545.962270188614, 3385.9830700846337, 4019.376996565537, 4048.6558642515715, 4174.478190226222, 4222.9577704223175, 3560.359135355609, 3611.4041183204477, 3616.3309787689363, 3618.4029635109914, 3627.3289441453417, 652.8270008447765, 655.8130932684257, 662.559398000334, 668.1881513960561, 673.8787018336747, 542.9185622156708, 546.4508169289838, 582.118091091996, 585.9003969325225, 612.9908051379233, 8012.719554815553, 8182.959085204536, 8216.465929714668, 8284.958575207205, 8554.315654747605, 571.6998575747766, 581.5028150930893, 598.60791181776, 619.7923695562038, 631.1101347100566, 3787.5833658297565, 3882.126521532689, 3903.902402439962, 3922.5096862892137, 4022.597740225954, 80332.0, 84140.57929710312, 86063.0, 86787.0, 86963.0, 68768.0, 69982.65008674924, 70788.2921170792, 71050.0, 71907.92138117933, 63012.0, 64022.0, 64062.35937640657, 64164.35835641584, 65106.0, 7659.387249019954, 7732.884006740016, 7782.338501227459, 7788.0, 7895.526268423913, 43822.78088609537, 44590.108197835216, 45292.77353613211, 45411.31883021823, 45491.772541137085, 51335.48664513307, 58953.5261618463, 59125.70437147787, 59593.7020314913, 59826.70086649539, 9903.059209375098, 10048.648297309559, 10069.446180460145, 10093.444860532447, 10108.646197383056, 10693.572257109628, 10792.244542881923, 10958.890411095786, 10981.560737570408, 11540.076793856639, 10117.696469105938, 10170.135538479311, 10337.37975721459, 10359.430231337048, 10607.0, 9727.9027209727, 10041.548130334299, 10103.0, 10106.747331316481, 10314.793704126025, 9802.705918822447, 10029.097381235724, 10078.596856125672, 10119.139873110867, 10384.065434110966, 8726.214640682369, 8807.207351338411, 8819.823603528022, 9019.594118264562, 9166.724998250063, 7876.330511906552, 8310.792230194293, 8382.790430239293, 8548.931383577054, 9047.230985366317], "value": 6613.51255190987, "unit": "score"}], "name": "dromaeo_css", "value": 7508.43301047023, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 109.0, 117.0, 120.0, 119.0, 107.0, 116.0, 117.0, 116.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 158.0, 184.0, 189.0, 154.0, 140.0, 120.0, 155.0, 154.0, 124.0], "value": 155.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 234.0, 217.0, 200.0, 196.0, 197.0, 194.0, 197.0, 198.0, 194.0], "value": 202.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 76.0, 80.0, 144.0, 57.0, 60.0, 54.0, 61.0, 132.0, 56.0], "value": 78.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 127.0, 76.0, 79.0, 79.0, 116.0, 104.0, 112.0, 160.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 121.0, 90.0, 89.0, 134.0, 87.0, 91.0, 88.0, 82.0, 131.0], "value": 104.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 145.0, 97.0, 96.0, 135.0, 150.0, 146.0, 97.0, 114.0, 151.0], "value": 123.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 96.0, 147.0, 146.0, 140.0, 144.0, 143.0, 93.0, 89.0], "value": 119.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 66.0, 66.0, 66.0, 64.0, 64.0, 80.0, 61.0, 59.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 68.0, 77.0, 77.0, 75.0, 73.0, 70.0, 84.0, 98.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 80.0, 82.0, 82.0, 80.0, 82.0, 82.0, 85.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 132.0, 123.0, 152.0, 147.0, 129.0, 135.0, 184.0, 141.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 168.0, 175.0, 215.0, 184.0, 164.0, 171.0, 165.0, 164.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 66.0, 68.0, 69.0, 66.0, 70.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1604.8000000000002, "alertThreshold": 2.0}]} 11:13:48 INFO - Return code: 0 11:13:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:13:48 ERROR - # TBPL SUCCESS # 11:13:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:13:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:13:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:13:48 INFO - 2016-05-17 11:13:48.346 screenresolution[1691:11027] starting screenresolution argv=screenresolution get 11:13:48 INFO - 2016-05-17 11:13:48.349 screenresolution[1691:11027] Display 0: 1600x1200x32@60 11:13:48 INFO - 2016-05-17 11:13:48.355 screenresolution[1692:11030] starting screenresolution argv=screenresolution list 11:13:48 INFO - Available Modes on Display 0 11:13:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:13:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:13:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:13:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:13:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:13:48 INFO - Intel Iris: 11:13:48 INFO - Chipset Model: Intel Iris 11:13:48 INFO - Type: GPU 11:13:48 INFO - Bus: Built-In 11:13:48 INFO - VRAM (Dynamic, Max): 1536 MB 11:13:48 INFO - Vendor: Intel (0x8086) 11:13:48 INFO - Device ID: 0x0a2e 11:13:48 INFO - Revision ID: 0x0009 11:13:48 INFO - Displays: 11:13:48 INFO - Display: 11:13:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:13:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:13:48 INFO - Display Serial Number: 1600x1200 60 11:13:48 INFO - Main Display: Yes 11:13:48 INFO - Mirror: Off 11:13:48 INFO - Online: Yes 11:13:48 INFO - Rotation: Supported 11:13:48 INFO - Return code: 0 11:13:48 INFO - Running post-action listener: _resource_record_post_action 11:13:48 INFO - Running post-run listener: _resource_record_post_run 11:13:49 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 31366656; Write bytes: 654729728; Read time: 194; Write time: 1900 11:13:49 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 352932352; Write bytes: 347010560; Read time: 27889; Write time: 740 11:13:49 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29584896; Write bytes: 297925632; Read time: 180; Write time: 1130 11:13:49 INFO - Running post-run listener: _upload_blobber_files 11:13:49 INFO - Blob upload gear active. 11:13:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:13:49 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 11:13:49 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:13:49 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:13:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:13:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:13:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:13:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:51 INFO - (blobuploader) - INFO - Done attempting. 11:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:52 INFO - (blobuploader) - INFO - Done attempting. 11:13:52 INFO - (blobuploader) - INFO - Iteration through files over. 11:13:52 INFO - Return code: 0 11:13:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:13:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:13:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69b84538b53edb021f662e6eed79eee0124cdee09770b6821ae428babcf1ab5899d09b98d1a563f3660b78040d42d9d7aa4fa94abb03fda1a4396300fcdb7f24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51d9667e768f4033a04f7b74c4b4449570d7fd352c9282592480d83f1182dbeb185704cd28d5faea2f90f30eba074cadbf66914238f824b1337d72382bf0bb2f"} 11:13:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:13:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:13:52 INFO - Contents: 11:13:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69b84538b53edb021f662e6eed79eee0124cdee09770b6821ae428babcf1ab5899d09b98d1a563f3660b78040d42d9d7aa4fa94abb03fda1a4396300fcdb7f24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51d9667e768f4033a04f7b74c4b4449570d7fd352c9282592480d83f1182dbeb185704cd28d5faea2f90f30eba074cadbf66914238f824b1337d72382bf0bb2f"} 11:13:52 INFO - Running post-run listener: copy_logs_to_upload_dir 11:13:52 INFO - Copying logs to upload dir... 11:13:52 INFO - mkdir: /builds/slave/test/build/upload/logs 11:13:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1342.270290 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 22 secs) (at 2016-05-17 11:13:52.723099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:13:52.726918) ========= 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.nNNtznXVdH/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.IAvn0NZLhj/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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/Mozilla-Aurora/sha512/69b84538b53edb021f662e6eed79eee0124cdee09770b6821ae428babcf1ab5899d09b98d1a563f3660b78040d42d9d7aa4fa94abb03fda1a4396300fcdb7f24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51d9667e768f4033a04f7b74c4b4449570d7fd352c9282592480d83f1182dbeb185704cd28d5faea2f90f30eba074cadbf66914238f824b1337d72382bf0bb2f"} build_url:https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/DXX_clYaTMGMU4sb9zK0Dg/artifacts/public/build/firefox-48.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69b84538b53edb021f662e6eed79eee0124cdee09770b6821ae428babcf1ab5899d09b98d1a563f3660b78040d42d9d7aa4fa94abb03fda1a4396300fcdb7f24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51d9667e768f4033a04f7b74c4b4449570d7fd352c9282592480d83f1182dbeb185704cd28d5faea2f90f30eba074cadbf66914238f824b1337d72382bf0bb2f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:13:52.755317) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:13:52.755657) ========= 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.nNNtznXVdH/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.IAvn0NZLhj/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.004663 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:13:52.804305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:13:52.804630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:13:52.804967) ========= ========= Total master_lag: 0.17 =========