builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0095 starttime: 1468833258.09 results: success (0) buildid: 20160718000754 builduid: ec3b42f4c50140929997961397293eb7 revision: 0fbdcd21fad76a00328e67875c6f40dc219235f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:18.085484) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:18.086034) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:18.086359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:18.145656) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:18.146081) ========= 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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-07-18 02:14:18-- 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% 145M=0s 2016-07-18 02:14:18 (145 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131211 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:18.304066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:18.304389) ========= 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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.027913 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:18.352716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 02:14:18.353093) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0fbdcd21fad76a00328e67875c6f40dc219235f4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0fbdcd21fad76a00328e67875c6f40dc219235f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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-07-18 02:14:18,425 truncating revision to first 12 chars 2016-07-18 02:14:18,425 Setting DEBUG logging. 2016-07-18 02:14:18,425 attempt 1/10 2016-07-18 02:14:18,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0fbdcd21fad7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 02:14:19,388 unpacking tar archive at: mozilla-central-0fbdcd21fad7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.243498 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 02:14:19.619315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:19.619692) ========= script_repo_revision: 0fbdcd21fad76a00328e67875c6f40dc219235f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:19.620170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:19.620473) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 02:14:19.640697) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2016-07-18 02:14:19.641040) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:14:19 INFO - MultiFileLogger online at 20160718 02:14:19 in /builds/slave/test 02:14:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:14:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:14:19 INFO - {'append_to_log': False, 02:14:19 INFO - 'base_work_dir': '/builds/slave/test', 02:14:19 INFO - 'blob_upload_branch': 'Firefox', 02:14:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:14:19 INFO - 'branch': 'Firefox', 02:14:19 INFO - 'buildbot_json_path': 'buildprops.json', 02:14:19 INFO - 'config_files': ('talos/mac_config.py',), 02:14:19 INFO - 'default_actions': ('clobber', 02:14:19 INFO - 'read-buildbot-config', 02:14:19 INFO - 'download-and-extract', 02:14:19 INFO - 'populate-webroot', 02:14:19 INFO - 'create-virtualenv', 02:14:19 INFO - 'install', 02:14:19 INFO - 'run-tests'), 02:14:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:14:19 INFO - 'download_minidump_stackwalk': True, 02:14:19 INFO - 'download_symbols': 'ondemand', 02:14:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:14:19 INFO - 'tooltool.py': '/tools/tooltool.py', 02:14:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:14:19 INFO - '/tools/misc-python/virtualenv.py')}, 02:14:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:14:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:14:19 INFO - 'installer_path': 'installer.exe', 02:14:19 INFO - 'log_level': 'info', 02:14:19 INFO - 'log_name': 'talos', 02:14:19 INFO - 'log_to_console': True, 02:14:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:14:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:14:19 INFO - 'opt_config_files': (), 02:14:19 INFO - 'pip_index': False, 02:14:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:14:19 INFO - 'cmd': ('bash', 02:14:19 INFO - '-c', 02:14:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:14:19 INFO - 'enabled': True, 02:14:19 INFO - 'halt_on_failure': False, 02:14:19 INFO - 'name': 'check_screen_resolution'},), 02:14:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:14:19 INFO - 'cmd': ('bash', 02:14:19 INFO - '-c', 02:14:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:14:19 INFO - 'enabled': True, 02:14:19 INFO - 'halt_on_failure': False, 02:14:19 INFO - 'name': 'check_screen_resolution'},), 02:14:19 INFO - 'run_cmd_checks_enabled': True, 02:14:19 INFO - 'sps_profile': False, 02:14:19 INFO - 'sps_profile_interval': 0, 02:14:19 INFO - 'suite': 'dromaeojs-e10s', 02:14:19 INFO - 'system_bits': '32', 02:14:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:14:19 INFO - 'title': 't-yosemite-r7-0095', 02:14:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:14:19 INFO - 'use_talos_json': True, 02:14:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:14:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:14:19 INFO - 'work_dir': 'build'} 02:14:19 INFO - ##### 02:14:19 INFO - ##### Running clobber step. 02:14:19 INFO - ##### 02:14:19 INFO - Running pre-action listener: _resource_record_pre_action 02:14:19 INFO - Running main action method: clobber 02:14:19 INFO - rmtree: /builds/slave/test/build 02:14:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:14:21 INFO - Running post-action listener: _resource_record_post_action 02:14:21 INFO - ##### 02:14:21 INFO - ##### Finished clobber step (success) 02:14:21 INFO - ##### 02:14:21 INFO - ##### 02:14:21 INFO - ##### Running read-buildbot-config step. 02:14:21 INFO - ##### 02:14:21 INFO - Running pre-action listener: _resource_record_pre_action 02:14:21 INFO - Running main action method: read_buildbot_config 02:14:21 INFO - Using buildbot properties: 02:14:21 INFO - { 02:14:21 INFO - "project": "", 02:14:21 INFO - "product": "firefox", 02:14:21 INFO - "script_repo_revision": "production", 02:14:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:14:21 INFO - "repository": "", 02:14:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:14:21 INFO - "buildid": "20160718000754", 02:14:21 INFO - "pgo_build": "False", 02:14:21 INFO - "basedir": "/builds/slave/test", 02:14:21 INFO - "buildnumber": 263, 02:14:21 INFO - "slavename": "t-yosemite-r7-0095", 02:14:21 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:14:21 INFO - "platform": "yosemite_r7", 02:14:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:14:21 INFO - "branch": "mozilla-central", 02:14:21 INFO - "repo_path": "mozilla-central", 02:14:21 INFO - "revision": "0fbdcd21fad76a00328e67875c6f40dc219235f4", 02:14:21 INFO - "stage_platform": "macosx64", 02:14:21 INFO - "builduid": "ec3b42f4c50140929997961397293eb7", 02:14:21 INFO - "slavebuilddir": "test" 02:14:21 INFO - } 02:14:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 02:14:21 INFO - Running post-action listener: _resource_record_post_action 02:14:21 INFO - ##### 02:14:21 INFO - ##### Finished read-buildbot-config step (success) 02:14:21 INFO - ##### 02:14:21 INFO - ##### 02:14:21 INFO - ##### Running download-and-extract step. 02:14:21 INFO - ##### 02:14:21 INFO - Running pre-action listener: _resource_record_pre_action 02:14:21 INFO - Running main action method: download_and_extract 02:14:21 INFO - mkdir: /builds/slave/test/build/tests 02:14:21 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')]} 02:14:21 INFO - https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:14:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 02:14:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 02:14:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 02:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 02:14:51 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 02:14:51 INFO - retry: attempt #1 caught exception: timed out 02:14:51 INFO - retry: Failed, sleeping 30 seconds before retrying 02:15:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 02:15:23 INFO - Downloaded 1199 bytes. 02:15:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 02:15:23 INFO - Using the following test package requirements: 02:15:23 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 02:15:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:15:23 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 02:15:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:15:23 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 02:15:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:15:23 INFO - u'jsshell-mac.zip'], 02:15:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:15:23 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 02:15:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 02:15:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:15:23 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 02:15:23 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:15:23 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 02:15:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:15:23 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 02:15:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:15:23 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 02:15:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:15:23 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')]} 02:15:23 INFO - https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:15:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:15:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:15:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:15:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:15:25 INFO - Downloaded 18835899 bytes. 02:15:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:15:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:15:28 INFO - Return code: 0 02:15:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:15:28 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')]} 02:15:28 INFO - https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:15:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:15:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:15:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:15:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:15:29 INFO - Downloaded 18835899 bytes. 02:15:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:15:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:15:33 INFO - Return code: 0 02:15: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')]} 02:15:33 INFO - https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:15:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:15:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:15:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:15:34 INFO - Downloaded 14403317 bytes. 02:15:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:15:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:15:34 INFO - Return code: 0 02:15: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')]} 02:15:34 INFO - https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 02:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 02:15:37 INFO - Downloaded 112769557 bytes. 02:15:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:15:37 INFO - mkdir: /builds/slave/test/properties 02:15:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:15:37 INFO - Writing to file /builds/slave/test/properties/build_url 02:15:37 INFO - Contents: 02:15:37 INFO - build_url:https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:15:39 INFO - Running post-action listener: _resource_record_post_action 02:15:39 INFO - Running post-action listener: set_extra_try_arguments 02:15:39 INFO - ##### 02:15:39 INFO - ##### Finished download-and-extract step (success) 02:15:39 INFO - ##### 02:15:39 INFO - ##### 02:15:39 INFO - ##### Running populate-webroot step. 02:15:39 INFO - ##### 02:15:39 INFO - Running pre-action listener: _resource_record_pre_action 02:15:39 INFO - Running main action method: populate_webroot 02:15:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:15:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:15:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:15:39 INFO - '--tppagecycles', 02:15:39 INFO - '7'], 02:15:39 INFO - 'tests': ['tsvgm']}}, 02:15:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:15:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:15:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:15:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:15:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:39 INFO - 'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:15:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:39 INFO - 'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['damp', 'tps']}, 02:15:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:39 INFO - 'tests': ['damp', 'tps']}, 02:15:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['dromaeo_dom']}, 02:15:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:15:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['basic_compositor_video']}, 02:15:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:15:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['a11yr', 02:15:39 INFO - 'ts_paint', 02:15:39 INFO - 'tpaint', 02:15:39 INFO - 'sessionrestore', 02:15:39 INFO - 'sessionrestore_no_auto_restore', 02:15:39 INFO - 'tabpaint']}, 02:15:39 INFO - 'other-e10s': {'tests': ['a11yr', 02:15:39 INFO - 'ts_paint', 02:15:39 INFO - 'tpaint', 02:15:39 INFO - 'sessionrestore', 02:15:39 INFO - 'sessionrestore_no_auto_restore', 02:15:39 INFO - 'tabpaint']}, 02:15:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:15:39 INFO - 'ts_paint', 02:15:39 INFO - 'tpaint', 02:15:39 INFO - 'sessionrestore', 02:15:39 INFO - 'sessionrestore_no_auto_restore', 02:15:39 INFO - 'tabpaint']}, 02:15:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:15:39 INFO - 'ts_paint', 02:15:39 INFO - 'tpaint', 02:15:39 INFO - 'sessionrestore', 02:15:39 INFO - 'sessionrestore_no_auto_restore', 02:15:39 INFO - 'tabpaint']}, 02:15:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['a11yr', 02:15:39 INFO - 'ts_paint', 02:15:39 INFO - 'tpaint', 02:15:39 INFO - 'sessionrestore', 02:15:39 INFO - 'sessionrestore_no_auto_restore', 02:15:39 INFO - 'tabpaint']}, 02:15:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['a11yr', 02:15:39 INFO - 'ts_paint', 02:15:39 INFO - 'tpaint', 02:15:39 INFO - 'sessionrestore', 02:15:39 INFO - 'sessionrestore_no_auto_restore', 02:15:39 INFO - 'tabpaint']}, 02:15:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['tsvgx', 02:15:39 INFO - 'tsvgr_opacity', 02:15:39 INFO - 'tart', 02:15:39 INFO - 'tscrollx', 02:15:39 INFO - 'cart']}, 02:15:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:15:39 INFO - 'tsvgr_opacity', 02:15:39 INFO - 'tart', 02:15:39 INFO - 'tscrollx', 02:15:39 INFO - 'cart']}, 02:15:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:39 INFO - 'talos_options': ['--disable-e10s'], 02:15:39 INFO - 'tests': ['tp5o']}, 02:15:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:39 INFO - 'tests': ['tp5o']}, 02:15:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:39 INFO - 'talos_options': ['--disable-e10s', 02:15:39 INFO - '--xperf_path', 02:15:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:39 INFO - 'tests': ['tp5n']}, 02:15:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:15:39 INFO - 'talos_options': ['--xperf_path', 02:15:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:15:39 INFO - 'tests': ['tp5n']}}, 02:15:39 INFO - 'talos.zip': {'path': '', 02:15:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:15:39 INFO - Running post-action listener: _resource_record_post_action 02:15:39 INFO - ##### 02:15:39 INFO - ##### Finished populate-webroot step (success) 02:15:39 INFO - ##### 02:15:39 INFO - ##### 02:15:39 INFO - ##### Running create-virtualenv step. 02:15:39 INFO - ##### 02:15:39 INFO - Running pre-action listener: _resource_record_pre_action 02:15:39 INFO - Running main action method: create_virtualenv 02:15:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:15:39 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 02:15:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:15:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:15:39 INFO - Using real prefix '/tools/python27' 02:15:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:15:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:15:43 INFO - Installing pip.................done. 02:15:43 INFO - Return code: 0 02:15:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:15:43 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')]} 02:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:43 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')]} 02:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:43 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 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:15:43 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 02:15:43 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 02:15:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:15:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:43 INFO - 'HOME': '/Users/cltbld', 02:15:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:43 INFO - 'LOGNAME': 'cltbld', 02:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:43 INFO - 'MOZ_NO_REMOTE': '1', 02:15:43 INFO - 'NO_EM_RESTART': '1', 02:15:43 INFO - 'PAGER': '/bin/cat', 02:15:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:43 INFO - 'PWD': '/builds/slave/test', 02:15:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:43 INFO - 'SHELL': '/bin/bash', 02:15:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:15:43 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:15:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:43 INFO - 'USER': 'cltbld', 02:15:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:43 INFO - 'XPC_FLAGS': '0x0', 02:15:43 INFO - 'XPC_SERVICE_NAME': '0', 02:15:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:43 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 02:15:43 INFO - Cleaning up... 02:15:43 INFO - Return code: 0 02:15:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:15:43 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')]} 02:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:43 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')]} 02:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:15:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:15:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:43 INFO - 'HOME': '/Users/cltbld', 02:15:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:43 INFO - 'LOGNAME': 'cltbld', 02:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:43 INFO - 'MOZ_NO_REMOTE': '1', 02:15:43 INFO - 'NO_EM_RESTART': '1', 02:15:43 INFO - 'PAGER': '/bin/cat', 02:15:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:43 INFO - 'PWD': '/builds/slave/test', 02:15:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:43 INFO - 'SHELL': '/bin/bash', 02:15:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:15:43 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:15:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:43 INFO - 'USER': 'cltbld', 02:15:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:43 INFO - 'XPC_FLAGS': '0x0', 02:15:43 INFO - 'XPC_SERVICE_NAME': '0', 02:15:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:43 INFO - Downloading/unpacking psutil>=3.1.1 02:15:43 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 02:15:43 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 02:15:43 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 02:15:43 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 02:15:43 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 02:15:43 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 02:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:15:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:47 INFO - Installing collected packages: psutil 02:15:47 INFO - Running setup.py install for psutil 02:15:47 INFO - building 'psutil._psutil_osx' extension 02:15:47 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 02:15:47 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 02:15:47 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 02:15:47 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 02:15:47 INFO - building 'psutil._psutil_posix' extension 02:15:47 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 02:15:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:15:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:15:48 INFO - ^ 02:15:48 INFO - 1 warning generated. 02:15:48 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 02:15:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:15:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:15:48 INFO - Successfully installed psutil 02:15:48 INFO - Cleaning up... 02:15:48 INFO - Return code: 0 02:15:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:15:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:15:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:15:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:48 INFO - 'HOME': '/Users/cltbld', 02:15:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:48 INFO - 'LOGNAME': 'cltbld', 02:15:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:48 INFO - 'MOZ_NO_REMOTE': '1', 02:15:48 INFO - 'NO_EM_RESTART': '1', 02:15:48 INFO - 'PAGER': '/bin/cat', 02:15:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:48 INFO - 'PWD': '/builds/slave/test', 02:15:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:48 INFO - 'SHELL': '/bin/bash', 02:15:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:15:48 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:15:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:48 INFO - 'USER': 'cltbld', 02:15:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:48 INFO - 'XPC_FLAGS': '0x0', 02:15:48 INFO - 'XPC_SERVICE_NAME': '0', 02:15:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:15:48 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 02:15:48 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 02:15:48 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 02:15:48 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 02:15:48 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 02:15:48 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 02:15:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:15:51 INFO - Installing collected packages: mozsystemmonitor 02:15:51 INFO - Running setup.py install for mozsystemmonitor 02:15:51 INFO - Successfully installed mozsystemmonitor 02:15:51 INFO - Cleaning up... 02:15:51 INFO - Return code: 0 02:15:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:15:51 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')]} 02:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:51 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')]} 02:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:51 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:15:51 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==2.5.1'] in /builds/slave/test/build 02:15:51 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==2.5.1 02:15:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:15:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:51 INFO - 'HOME': '/Users/cltbld', 02:15:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:51 INFO - 'LOGNAME': 'cltbld', 02:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:51 INFO - 'MOZ_NO_REMOTE': '1', 02:15:51 INFO - 'NO_EM_RESTART': '1', 02:15:51 INFO - 'PAGER': '/bin/cat', 02:15:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:51 INFO - 'PWD': '/builds/slave/test', 02:15:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:51 INFO - 'SHELL': '/bin/bash', 02:15:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:15:51 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:15:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:51 INFO - 'USER': 'cltbld', 02:15:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:51 INFO - 'XPC_FLAGS': '0x0', 02:15:51 INFO - 'XPC_SERVICE_NAME': '0', 02:15:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:51 INFO - Downloading/unpacking jsonschema==2.5.1 02:15:51 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 02:15:51 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 02:15:51 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 02:15:51 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 02:15:51 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 02:15:51 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 02:15:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:15:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:54 INFO - Downloading functools32-3.2.3-2.tar.gz 02:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:15:54 INFO - warning: no files found matching '*.txt' 02:15:54 INFO - no previously-included directories found matching 'build' 02:15:54 INFO - no previously-included directories found matching 'dist' 02:15:54 INFO - no previously-included directories found matching '.git*' 02:15:54 INFO - Installing collected packages: jsonschema, functools32 02:15:54 INFO - Running setup.py install for functools32 02:15:54 INFO - warning: no files found matching '*.txt' 02:15:54 INFO - no previously-included directories found matching 'build' 02:15:54 INFO - no previously-included directories found matching 'dist' 02:15:54 INFO - no previously-included directories found matching '.git*' 02:15:54 INFO - Successfully installed jsonschema functools32 02:15:54 INFO - Cleaning up... 02:15:54 INFO - Return code: 0 02:15:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:54 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 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:15:54 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 02:15:54 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 02:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:54 INFO - 'HOME': '/Users/cltbld', 02:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:54 INFO - 'LOGNAME': 'cltbld', 02:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:54 INFO - 'MOZ_NO_REMOTE': '1', 02:15:54 INFO - 'NO_EM_RESTART': '1', 02:15:54 INFO - 'PAGER': '/bin/cat', 02:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:54 INFO - 'PWD': '/builds/slave/test', 02:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:54 INFO - 'SHELL': '/bin/bash', 02:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:15:54 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:54 INFO - 'USER': 'cltbld', 02:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:54 INFO - 'XPC_FLAGS': '0x0', 02:15:54 INFO - 'XPC_SERVICE_NAME': '0', 02:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:15:55 INFO - Downloading/unpacking blobuploader==1.2.4 02:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:15:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:15:57 INFO - Downloading blobuploader-1.2.4.tar.gz 02:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:15:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:15:57 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 02:15:57 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 02:15:57 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 02:15:57 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 02:15:57 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 02:15:57 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 02:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:15:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:15:58 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 02:15:58 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 02:15:58 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 02:15:58 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 02:15:58 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 02:15:58 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 02:15:58 INFO - Downloading docopt-0.6.1.tar.gz 02:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:15:58 INFO - Installing collected packages: blobuploader, requests, docopt 02:15:58 INFO - Running setup.py install for blobuploader 02:15:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:15:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:15:59 INFO - Running setup.py install for requests 02:15:59 INFO - Running setup.py install for docopt 02:15:59 INFO - Successfully installed blobuploader requests docopt 02:15:59 INFO - Cleaning up... 02:15:59 INFO - Return code: 0 02:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:15:59 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 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:15:59 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 02:15:59 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 02:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:15:59 INFO - 'HOME': '/Users/cltbld', 02:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:15:59 INFO - 'LOGNAME': 'cltbld', 02:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:15:59 INFO - 'MOZ_NO_REMOTE': '1', 02:15:59 INFO - 'NO_EM_RESTART': '1', 02:15:59 INFO - 'PAGER': '/bin/cat', 02:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:15:59 INFO - 'PWD': '/builds/slave/test', 02:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:15:59 INFO - 'SHELL': '/bin/bash', 02:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:15:59 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:15:59 INFO - 'USER': 'cltbld', 02:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:15:59 INFO - 'XPC_FLAGS': '0x0', 02:15:59 INFO - 'XPC_SERVICE_NAME': '0', 02:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-8M7aR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-aSDtC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-UtTn8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-jnJ6UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-upechs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-NDRfNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-oKSTRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-fWFXCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-DWmfOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:16:00 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-IEZzeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:16:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-L2ipc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:16:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ppxN1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:16:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Saq5lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:16:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-TApAk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-ZueHSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:16:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-Tju2ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:16:01 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-UAar5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:16:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:16:01 INFO - Running setup.py install for manifestparser 02:16:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:16:01 INFO - Running setup.py install for mozcrash 02:16:02 INFO - Running setup.py install for mozdebug 02:16:02 INFO - Running setup.py install for mozdevice 02:16:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:16:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:16:02 INFO - Running setup.py install for mozfile 02:16:02 INFO - Running setup.py install for mozhttpd 02:16:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:16:02 INFO - Running setup.py install for mozinfo 02:16:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:16:02 INFO - Running setup.py install for mozInstall 02:16:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:16:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:16:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:16:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:16:02 INFO - Running setup.py install for mozleak 02:16:03 INFO - Running setup.py install for mozlog 02:16:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:16:03 INFO - Running setup.py install for moznetwork 02:16:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:16:03 INFO - Running setup.py install for mozprocess 02:16:03 INFO - Running setup.py install for mozprofile 02:16:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:16:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:16:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:16:03 INFO - Running setup.py install for mozrunner 02:16:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:16:03 INFO - Running setup.py install for mozscreenshot 02:16:04 INFO - Running setup.py install for moztest 02:16:04 INFO - Running setup.py install for mozversion 02:16:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:16:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:16:04 INFO - Cleaning up... 02:16:04 INFO - Return code: 0 02:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:04 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 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:16:04 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 02:16:04 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 02:16:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:16:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:04 INFO - 'HOME': '/Users/cltbld', 02:16:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:04 INFO - 'LOGNAME': 'cltbld', 02:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:04 INFO - 'MOZ_NO_REMOTE': '1', 02:16:04 INFO - 'NO_EM_RESTART': '1', 02:16:04 INFO - 'PAGER': '/bin/cat', 02:16:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:04 INFO - 'PWD': '/builds/slave/test', 02:16:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:04 INFO - 'SHELL': '/bin/bash', 02:16:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:16:04 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:16:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:04 INFO - 'USER': 'cltbld', 02:16:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:04 INFO - 'XPC_FLAGS': '0x0', 02:16:04 INFO - 'XPC_SERVICE_NAME': '0', 02:16:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:16:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-NM5JBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:16:04 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)) 02:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:16:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-udYyKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:16:04 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)) 02:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:16:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QSUCG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:16:04 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)) 02:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:16:04 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-q9690t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:16:05 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-HcIy1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:16:05 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-JOaER7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:16:05 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-_tWFoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:16:05 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-GeNOv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:16:05 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-RLfWC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:16:05 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-eNPvQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-9yDnem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:16:05 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-vgEIyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:16:05 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-kMdCRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:16:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-NKP9dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-cs7rpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:16:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-QYQyvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:16:06 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)) 02:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:16:06 INFO - Running setup.py (path:/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/pip-fTxiNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:16:06 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)) 02:16:06 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)) 02:16:06 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)) 02:16:06 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)) 02:16:06 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)) 02:16:06 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)) 02:16:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:16:06 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 02:16:06 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 02:16:06 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 02:16:06 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 02:16:06 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 02:16:06 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 02:16:08 INFO - Downloading blessings-1.6.tar.gz 02:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:16:09 INFO - Installing collected packages: blessings 02:16:09 INFO - Running setup.py install for blessings 02:16:09 INFO - Successfully installed blessings 02:16:09 INFO - Cleaning up... 02:16:09 INFO - Return code: 0 02:16:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:09 INFO - Reading from file tmpfile_stdout 02:16:09 INFO - Current package versions: 02:16:09 INFO - blessings == 1.6 02:16:09 INFO - blobuploader == 1.2.4 02:16:09 INFO - docopt == 0.6.1 02:16:09 INFO - functools32 == 3.2.3-2 02:16:09 INFO - jsonschema == 2.5.1 02:16:09 INFO - manifestparser == 1.1 02:16:09 INFO - mozInstall == 1.12 02:16:09 INFO - mozcrash == 0.17 02:16:09 INFO - mozdebug == 0.1 02:16:09 INFO - mozdevice == 0.48 02:16:09 INFO - mozfile == 1.2 02:16:09 INFO - mozhttpd == 0.7 02:16:09 INFO - mozinfo == 0.9 02:16:09 INFO - mozleak == 0.1 02:16:09 INFO - mozlog == 3.2 02:16:09 INFO - moznetwork == 0.27 02:16:09 INFO - mozprocess == 0.23 02:16:09 INFO - mozprofile == 0.28 02:16:09 INFO - mozrunner == 6.12 02:16:09 INFO - mozscreenshot == 0.1 02:16:09 INFO - mozsystemmonitor == 0.3 02:16:09 INFO - moztest == 0.7 02:16:09 INFO - mozversion == 1.4 02:16:09 INFO - psutil == 3.1.1 02:16:09 INFO - requests == 1.2.3 02:16:09 INFO - wsgiref == 0.1.2 02:16:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:09 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 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:16:09 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 02:16:09 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 02:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:09 INFO - 'HOME': '/Users/cltbld', 02:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:09 INFO - 'LOGNAME': 'cltbld', 02:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:09 INFO - 'MOZ_NO_REMOTE': '1', 02:16:09 INFO - 'NO_EM_RESTART': '1', 02:16:09 INFO - 'PAGER': '/bin/cat', 02:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:09 INFO - 'PWD': '/builds/slave/test', 02:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:09 INFO - 'SHELL': '/bin/bash', 02:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:16:09 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:09 INFO - 'USER': 'cltbld', 02:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:09 INFO - 'XPC_FLAGS': '0x0', 02:16:09 INFO - 'XPC_SERVICE_NAME': '0', 02:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 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)) 02:16:09 INFO - Cleaning up... 02:16:09 INFO - Return code: 0 02:16:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:16:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024aba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102540618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d10da03c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, '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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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 02:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:09 INFO - 'HOME': '/Users/cltbld', 02:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:09 INFO - 'LOGNAME': 'cltbld', 02:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:09 INFO - 'MOZ_NO_REMOTE': '1', 02:16:09 INFO - 'NO_EM_RESTART': '1', 02:16:09 INFO - 'PAGER': '/bin/cat', 02:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:09 INFO - 'PWD': '/builds/slave/test', 02:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:09 INFO - 'SHELL': '/bin/bash', 02:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:16:09 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:09 INFO - 'USER': 'cltbld', 02:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:09 INFO - 'XPC_FLAGS': '0x0', 02:16:09 INFO - 'XPC_SERVICE_NAME': '0', 02:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:16:10 INFO - Cleaning up... 02:16:10 INFO - Return code: 0 02:16:10 INFO - Running post-action listener: _resource_record_post_action 02:16:10 INFO - Running post-action listener: _start_resource_monitoring 02:16:10 INFO - Starting resource monitoring. 02:16:10 INFO - ##### 02:16:10 INFO - ##### Finished create-virtualenv step (success) 02:16:10 INFO - ##### 02:16:10 INFO - ##### 02:16:10 INFO - ##### Running install step. 02:16:10 INFO - ##### 02:16:10 INFO - Running pre-action listener: _resource_record_pre_action 02:16:10 INFO - Running main action method: install 02:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:10 INFO - Reading from file tmpfile_stdout 02:16:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:16:10 INFO - Reading from file tmpfile_stdout 02:16:10 INFO - Output received: 02:16:10 INFO - Usage: mozinstall [options] installer 02:16:10 INFO - Options: 02:16:10 INFO - -h, --help show this help message and exit 02:16:10 INFO - -d DEST, --destination=DEST 02:16:10 INFO - Directory to install application into. [default: 02:16:10 INFO - "/builds/slave/test"] 02:16:10 INFO - --app=APP Application being installed. [default: firefox] 02:16:10 INFO - mkdir: /builds/slave/test/build/application 02:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:16:45 INFO - Reading from file tmpfile_stdout 02:16:45 INFO - Output received: 02:16:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:16:45 INFO - Running post-action listener: _resource_record_post_action 02:16:45 INFO - ##### 02:16:45 INFO - ##### Finished install step (success) 02:16:45 INFO - ##### 02:16:45 INFO - ##### 02:16:45 INFO - ##### Running run-tests step. 02:16:45 INFO - ##### 02:16:45 INFO - Running pre-action listener: _resource_record_pre_action 02:16:45 INFO - Running main action method: run_tests 02:16:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:16:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:16:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:16:45 INFO - 2016-07-18 02:16:45.066 screenresolution[1649:8351] starting screenresolution argv=screenresolution get 02:16:45 INFO - 2016-07-18 02:16:45.069 screenresolution[1649:8351] Display 0: 1600x1200x32@60 02:16:45 INFO - 2016-07-18 02:16:45.074 screenresolution[1650:8353] starting screenresolution argv=screenresolution list 02:16:45 INFO - Available Modes on Display 0 02:16:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:16:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:16:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:16:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:16:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:16:45 INFO - Intel Iris: 02:16:45 INFO - Chipset Model: Intel Iris 02:16:45 INFO - Type: GPU 02:16:45 INFO - Bus: Built-In 02:16:45 INFO - VRAM (Dynamic, Max): 1536 MB 02:16:45 INFO - Vendor: Intel (0x8086) 02:16:45 INFO - Device ID: 0x0a2e 02:16:45 INFO - Revision ID: 0x0009 02:16:45 INFO - Displays: 02:16:45 INFO - Display: 02:16:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:16:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:16:45 INFO - Display Serial Number: 1600x1200 60 02:16:45 INFO - Main Display: Yes 02:16:45 INFO - Mirror: Off 02:16:45 INFO - Online: Yes 02:16:45 INFO - Rotation: Supported 02:16:45 INFO - Return code: 0 02:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:16:45 INFO - Python 2.7.3 02:16:45 INFO - Return code: 0 02:16:45 INFO - grabbing minidump binary from tooltool 02:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:16:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10240fd30>, '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 0x102174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102407b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:16:45 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 02:16:45 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 02:16:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:16:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:16:45 INFO - Return code: 0 02:16:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:16:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:16:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:16:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:16:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 02:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0095 --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 02:16:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SWzSVmSQsO/Render', 02:16:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:16:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:16:45 INFO - 'HOME': '/Users/cltbld', 02:16:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:16:45 INFO - 'LOGNAME': 'cltbld', 02:16:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:16:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:45 INFO - 'MOZ_NO_REMOTE': '1', 02:16:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:16:45 INFO - 'NO_EM_RESTART': '1', 02:16:45 INFO - 'PAGER': '/bin/cat', 02:16:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:45 INFO - 'PWD': '/builds/slave/test', 02:16:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:16:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:16:45 INFO - 'SHELL': '/bin/bash', 02:16:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Hqjd2PG7DR/Listeners', 02:16:45 INFO - 'TMPDIR': '/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/', 02:16:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:16:45 INFO - 'USER': 'cltbld', 02:16:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:16:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:45 INFO - 'XPC_FLAGS': '0x0', 02:16:45 INFO - 'XPC_SERVICE_NAME': '0', 02:16:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:16:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0095', '--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 02:16:45 INFO - mozversion application_buildid: 20160718000754 02:16:45 INFO - mozversion application_changeset: 0fbdcd21fad76a00328e67875c6f40dc219235f4 02:16:45 INFO - mozversion application_display_name: Nightly 02:16:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:16:45 INFO - mozversion application_name: Firefox 02:16:45 INFO - mozversion application_remotingname: firefox 02:16:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:16:45 INFO - mozversion application_vendor: Mozilla 02:16:45 INFO - mozversion application_version: 50.0a1 02:16:45 INFO - mozversion platform_buildid: 20160718000754 02:16:45 INFO - mozversion platform_changeset: 0fbdcd21fad76a00328e67875c6f40dc219235f4 02:16:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:16:45 INFO - mozversion platform_version: 50.0a1 02:16:45 INFO - using testdate: 1468833405 02:16:45 INFO - actual date: 1468833405 02:16:45 INFO - starting webserver on 'localhost:49272' 02:16:45 INFO - SUITE-START | Running 2 tests 02:16:45 INFO - TEST-START | dromaeo_css 02:16:45 INFO - operating with platform_type : mac_ 02:16:45 INFO - Initialising browser for dromaeo_css test... 02:16:45 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp4uvYlx/profile http://localhost:49272/getInfo.html) 02:16:48 INFO - PROCESS | 1660 | JavaScript error: , line 0: uncaught exception: undefined 02:16:48 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 02:16:48 INFO - PROCESS | 1660 | colorDepth:24 02:16:48 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 02:16:48 INFO - PROCESS | 1660 | __metrics 02:16:48 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:16:49 INFO - TEST-INFO | 1660: exit 0 02:16:49 INFO - Browser initialized. 02:16:49 INFO - Running cycle 1/1 for dromaeo_css test... 02:16:49 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp4uvYlx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:17:01 INFO - PROCESS | 1664 | RSS: Main: 255680512 02:17:01 INFO - PROCESS | 1664 | 02:17:51 INFO - PROCESS | 1664 | 1468833471317 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] 02:20:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 02:20:03 INFO - PROCESS | 1664 | RSS: Main: 268861440 02:20:03 INFO - PROCESS | 1664 | 02:23:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 02:23:06 INFO - PROCESS | 1664 | RSS: Main: 276848640 02:23:06 INFO - PROCESS | 1664 | 02:26:08 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 02:26:09 INFO - PROCESS | 1664 | RSS: Main: 281354240 02:26:09 INFO - PROCESS | 1664 | 02:29:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 02:29:11 INFO - PROCESS | 1664 | RSS: Main: 280649728 02:29:11 INFO - PROCESS | 1664 | 02:32:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 02:32:15 INFO - PROCESS | 1664 | RSS: Main: 284323840 02:32:15 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 02:35:17 INFO - PROCESS | 1664 | RSS: Main: 284262400 02:35:17 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | __start_tp_report 02:35:17 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 02:35:17 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 02:35:17 INFO - PROCESS | 1664 | |i|pagename|runs| 02:35:17 INFO - PROCESS | 1664 | |0;dojo.html;2707.998040724931;2817.1407720645193;3423.948640770389;3433.3949353179155;3474.444088945769;5954.4640982311585;5957.7021148942595;5971.223740913675;5983.880322393549;5986.580939334249;5764.106563482667;5896.938551060807;5915.290165180174;5940.465358117768;6019.7893073742425;5282.630215884889;5315.096433606277;5332.653377530448;5454.563634909197;5457.481539253785;4926.483918502431;5448.91826622599;5460;5524.14375771756;5532.889342213153;5214.947850521503;5371.731413429352;5375.247465354853;5383.084875571162;5428.131498960187;5385.976664433745;5388.407275199725;5390.865228369283;5392.78428862849;5394.91907621386;5294.973525132388;5328.307320048408;5350.170723537858;5362.758675859595;5382.838514844521;5042.697438153686;5595.132754423071;5864;6018.368071352533;6041.184440100618;6166.784162554289;6248.3751624837605;6262.185915830913;6267.2165979252595;6273.654948977804;6168.660723660197;6197.752089916398;6253.468455181315;6305.968470157666;6306.432421082125;6006.069059295816;6055.545834062463;6063.363346848606;6074.635521868702;6106.755729770804;6371.778014835451;6457.1605691260775;6466.644334561644;6470.191226096738;6483.546151769425;5604.215409842625;6181.381861813783;6184.567080304426;6243.719032643542;6263.404976527314;6275.246031785633;6287.402696743802;6310.0534919761485;6310.684465776692;6345.841353966188;5157.948420515821;5307.203919412119;6147.477464415485;6200.534959878028;6214.316425193225;6111;6221.160143380585;6223.284322302993;6247.843803904939;6258.624482531062;4968.652194346361;4978.029284289529;4995.150824359867;5013.373328333958;5027.245913112989;4443.800028998703;4477.104579084196;4488.820447182076;4506.143832671782;4528.320751887243;5675.716214189274;5874.765009399662;5875.089361149029;5890.1164825276555;5962.672053037125;6186.783462578788;6273.498120150377;6273.843153921097;6292.339304373067;6296.433321001132;6027.035674292092;6046.848828779316;6058.303295121029;6060.636361818305;6067.332593414721;5471.699056551848;5564.304461942257;5577.9163312550345;5618.297712785902;5657.236273103161;6470;6506.284308726036;6512.185976753;6517.348265173445;6522.119513865568;6281.214848143982;6316.652584107735;6321.715522801393;6322.525810564134;6326.6836658165985;5765.4522820332;5928.347881733092;6130.865789828896;6274.560780745304;6391.616503009835;6190.288116866618;6232.158658581034;6235.438810507076;6244.094606282155;6255.124282600531;5353.384360798403;6289.308176100717;6292.811215663537;6294.402031806971;6297.4017468340435;6106.725197366218;6109.404666050415;6150.10823430609;6177.876442471035;6238.157848690369;4743.501932297059;6164.660943647963;6166.475849552839;6219.689015549295;6288.874222515616;5161.716105614228;5296.285001524745;6016.338202797776;6139.57023008403;6167.660778657038;5131.409887862944;6095.329513753572;6176.4441200292185;6225.408586184305;6231.283402408781;6095.542834287535;6104.336245366014;6113.358097399709;6138.109974053827;6144.849302744004 02:35:17 INFO - PROCESS | 1664 | |1;ext.html;498.098441820305;529.6054439442615;538.466917751426;538.5234067849954;541.3098299667923;32834.34331313372;41693.791531042305;41760.95597610061;41776.79111604441;41904.79047604765;42560.574394256124;42940.785296073474;42978.71063868089;43040.3543946841;43385.13229735404;9513.33406661534;9603.2317414607;9656.275779316544;9701.660441884536;9715.90284097157;9659.227261819073;9721.513924303792;9750.317477776558;9756.902430975706;9808.26438017148;9658.227341812673;9664.75838104046;9732.65935692251;9736.805263894717;9737.902620973806;9745.805083898318;9758.658446954323;9776.657816976407;9780.90219097807;9805.31362804604;9628.3260171788;9643.855342169873;9666.130048295618;9666.516674166263;9701.90298097017;39546.209075818326;40003.39994900079;40151.79544613666;40341.193176136316;40443;3407.4037043517287;3449.499822525745;3478.47822826578;3555.1467647764607;4210.831566737327;31260;32222;32398.190045248823;32415.027549173563;32819.83590082034;3288.52316414121;3313.8343082845763;3323.3187196624635;3375.9156021099425;3423.760336776427;371706;376567;376718;378353;380020;33893.49159762605;34786.30427391438;58897.411025889196;59057.704711477025;59314;34039.31921361559;34809.47785783215;34812.43344049524;35240.11899702528;35310.11724706903;14235.644108897153;14373.353199106064;14693.706125877423;14702.191379474018;14764.557063288119;12492.125551211328;12552.81170782439;12559;12562.497500100077;12572.182808117443;7654.502457340255;7677.923220767832;7690.538567685957;7700.807479813049;7744.961275193701;3195.5685982392542;3197.8560964756175;3216.694414030663;3222.8066316021113;3266.7876588021704;978.8874279457812;1010.8635334229932;1044.8171569975225;1068.0974576482859;1114.9797934889648;30214.814296984958;30535.8473207637;30763.077107686804;31228.375432491222;31415.84292078525;1044.383813550009;1063.4098075568133;1111.261011427408;1158.2760774515928;1173.8884805943421;13787.690169433889;15232.974021399872;15517.689646207013;15729.68540629204;15751.054936703835;671790;673487;674389;680241;681701;58292.708536457045;59398.70300648469;60015.39984600098;60050;60224.69887650534;1441.2937660546465;1442.0626592714818;1461.189040082743;1466.65533599604;1467.8605532474398;30205.546916795825;30246.395072098876;30334.84832575823;30741;30999.845000775753;50768.74615626898;51212;51226.975460491325;51412.74293628508;51540.22689659583;558681.2065939645;559013;566783;576674;577850;22861.08555657755;26372.736272637027;26821.597676035264;27151.321216969733;27293.454130917667;48394.758026209645;49079;49561.00877982492;49775;50289;40341.79829100953;40465.39301910415;40478.392824107075;40940;41942.790286048374;33666.326673465905;40541.1891762169;40625;40712.3893141609;40967;39264.6073539261;39269.2146157081;40165;40184.1963160741;41775.16449670929;33224;35306.64693353033;36191.09522261859;36416.45375319319;36687.816560917025;26341.86829065919;26512.337191570365;26539.33651658724;26584.734152658224;26797.464050718485 02:35:17 INFO - PROCESS | 1664 | |2;jquery.html;383.9404892241703;385.46035550229675;389.1264112068406;391.01358205868144;410.58325799313684;20407.59184816303;20609;21414.715117092986;21571.67642485362;21657.35027949162;20187.798122018776;20660.276890308844;20712.585748285062;20749.481262968435;20750.377488675327;5553.222548843165;5730.68481233532;5842.094475356326;5873.853153671171;5909.054551271797;5542.307211598551;5807.448292412235;5899.675517846516;5900.88198236035;5915.911261331062;5895.55783316253;5904.439078287556;5956.672383018932;5982.222311099551;5988.790392336269;5856.326522449909;5926.703664816763;5967.940320596782;5983.551233657449;6023.337432882401;5792.913106303409;5804.361520232771;5922.733476993546;5942.851428714317;5943.286805583358;13066.934665326708;13234.205947643171;13327.466901323935;24987;25373.604451755145;2198.208644887839;2224.610693128696;2261.4467677955545;2594.8313359631566;2653.3764565327133;9525.952370238174;9622.903770962272;9799.608015679365;9940.055694708992;10117.38679846942;1860.7301941218582;1893.7064754963003;1921.2507122222344;1932.2657390191778;1939.8254157125784;107687;130731;130958;131618;131653;11222.943885280521;11605.419729013516;11702.648920532398;11706.590269340531;11715.824262636068;14436.422543098159;14508.492202773063;14534.563963080913;14571.41714331436;14591.635209119857;8500.234978851933;8509.70216042448;8516.361272904556;8552.588822844285;8629.654813807503;7015.649217539102;7493.092024723815;8028.839423211503;8597.742067737978;8656.88241018412;3779.244151169777;4457.420535330386;4503.144402563503;4527.864164075083;4578.839740609063;1632.2491653839368;1940.8835469871854;1958.4320547041484;1960.4412742368356;1973.58554703511;821.5141458187576;852.6674596907211;870.6212797433137;886.5655828643918;899.9280057595507;20612.175512979313;21200.257990970244;21200.445757062436;21341.03965321564;21343.78656213418;940.6237504998055;953.880764904387;977.1938151025432;1005.2762011351815;1066.7919755647729;9118.544072796467;10247;11110.666679999613;11136.665900023012;11170.609028683957;519823;560445;597554;609213;622557;99583.50624740635;125409.11886321713;140374.5962540382;142909.8563521548;144195.55804442032;952.8713623660717;958.3100167879255;974.770928831724;1011.5498603121688;1017.6946915925192;18331.633367332845;18557;18799.812001879807;18944.242230311185;19061;41162.79418602888;47486.81282967815;53308;54738.7156770595;58003.4199657998;79474.96053738939;81341.59329203553;82504;83082.58458707668;83104.58447707722;7788.805279868048;7994.5203287802915;8191.467554608931;8264.628091735765;8376;9123.452592844451;12463.127581069239;13117.934410327887;13525;13746.93126534361;8876.378653494194;11525.423728813357;11584.073274138218;11586.36275004849;11621.070314375;10619.575216991543;10975.615853445091;11043.889561104286;11552.249103808226;11726.706832328919;10724.571017159225;10769;11737.88262117368;11798.705032374259;11837.585684501;8128.593570321342;8207.95896020516;8301.916980830356;8308.750737477885;8454.450460720034;11172.106231501622;11274.210805243554;11453.541858325907;11563.30620162793;11622.418879056182 02:35:17 INFO - PROCESS | 1664 | |3;mootools.html;1557.875369970402;1593.6254980079682;1842.889426634402;1934.5550523379623;1945.1927450108205;8072.798180045502;8679;8714.782130446727;9120.589573469186;9165.220956218722;8742.95628521858;8789.824203515926;8925.330600204978;8934.687285944994;8947.82104357914;2035;2374.655674927139;2385.964210536835;2394.461246219604;2404.7354790972977;2336.9298921032396;2398.640203969401;2399.9760002400017;2400.1839374612628;2409.7469765674614;2360.5868972929757;2372.51363470489;2378.3221781792195;2378.6907701998803;2407.4944261705064;2312.491251924591;2372.9169479068237;2380.964280537963;2386.6181410974245;2395.7843794058444;2354.776296251853;2377.476955069882;2378.3340664613934;2385.6063749481314;2387.3554140382175;9002.414843035182;9058.501782401965;9065.22945549629;9079.682211122645;9120.589573469144;4677.134730074947;5364.195370694388;5440.4287549807495;5521.723913804293;5690.40250773667;3068.324968506925;3502.7197824174004;3592.910177245564;3661.6155303692994;3668.211334563082;1085.16442339399;1093.5297821936565;1096.5942601237514;1096.7313008312935;1116.319045382316;11614.245074070159;11856.822147667792;11890.524379024828;11897.643070707893;11998.280103193749;4046.8785936421955;4685.273782563708;4690.953090469052;4772.757218917353;4903.141950158708;10017.348872323422;10082.69751907444;10088.69733907984;10095.899041009643;10134.847977280348;4633.745144017044;5376.596755243294;5394.568434525228;5398.163284690879;5417.322834645669;4427.22523558376;4685.672002959828;4919.335889654851;4929.433115191727;4952.158133117378;4012.779297138627;4024.4566983457444;4103.938440923389;4141.420201171838;4144.026153853842;1296.1769276509485;1319.4524272426836;1324.3312127375614;1330.8735670111323;1334.6986687979143;954.7040417470606;965.9082387173207;968.864358989742;972.1445128287062;996.1333639733479;5934.43622855828;5970.791022314285;6060.636361818305;6160.876782464416;6210.441060304594;443.0363958390488;444.7376048131618;449.3933190193278;451.4334510189691;461.54076693689325;4013.377926421351;4132.834686612502;4141.151064031867;4209.052963083282;4218.49378074633;9174.403663761968;10337.0696637303;10789.514471848786;10790.08284295828;10815.83776243357;10132.544035518273;10714.25000249975;10729.302595331435;10740.570377184982;10741.462926853626;7921.683132674743;8139.552324622203;8190.50856948585;8192.877106843402;8205.138460461685;6042.637441753509;6203.503719702323;6239.689665170184;6257.155284036597;6279.340669229665;10030.448325341884;10039.749006274902;10252.743681408025;10264.127549158406;10342.638007669695;9902.207823373968;10338;10366.118879895294;10526;10543.472826358804;6229.096780966644;7744.728934487266;7763.14605393395;7764.456488045783;7856.214378562098;8513.36149788756;8561.14388561139;8567.528785916835;8570.871436928326;8635.179657932485;7533.1336896257635;7664.501807382725;7727.49771264866;7752.224777522429;7796.376289896908;7467;7474.402047836269;7533.6233188339265;7610.315071643578;7647.655855486628;7097.822554435974;7145.4998150128995;7148.142222933281;7150.892736609059;7196.784096477114;4991.475895031114;5085.669431486942;5112.795488180431;5191.8182863599595;5205.687658740488;5165.173572228426;5206.140986737146;5227.2420499028185;5259.263703081649;5311.415744268204 02:35:17 INFO - PROCESS | 1664 | |4;prototype.html;278.20710973724886;284.8447596060148;318.6638096807867;321.33323354040374;324.2817159990623;4670.953290467094;5423.511883930445;5443.1835224716315;5673.489385955263;5738.684372359518;5619.466150715675;5661.1508273758955;5666.433356664332;5671.177679236508;5686;3640.690541303986;4043.251998380309;4306.332518459643;4316.223079845627;4358.169568781103;3619.963800361989;4128.690348223895;4333.696641235099;4361.171377438277;4391.824327026915;3343.3647606954723;3603.1892824114625;4219.11398606293;4236.724612900151;4282.528921818597;4279.550647182032;4293.166510103332;4310.159518893785;4327.783610819478;4328.870133895988;3367.804429427567;3480.477928310748;3719.758215715997;3743.2887751327435;3755.286495565834;4402.3176407656865;5038.823641172541;5413.621046526745;5429.37118864343;5450.291462109901;4001.659858911996;4826.203676393391;4863.854084377439;4866.294387313855;4875.58557522611;4610.423697037871;5449.618526703132;5660.801871934463;5877.382874798127;6031.974564324031;3528.894133176009;3948.657456464787;3981.243563722883;4017.31705610047;4018.799060046986;6246.500279977637;6268.404501572343;6284.968575157141;6333.923233050393;6346.87306253877;3953.723239373274;4023.195360927826;4051.2910240707756;4053.3919912012843;4072.6538244248977;3593.2274560969518;3973.4039894016128;4107.466029416157;4115.753054816721;4221.936670949938;4569.263679801654;4776.164171270014;4792.860676257057;4822.831200907952;4838.903221935541;5718.370979192286;5957.970210149008;5963.880722385528;5968.1942937703725;5975.910361344583;1408.3240044778358;1444.685336343943;1456.8106146201137;1458.0886945658963;1464.6411629150925;809.9389799362735;964.7925695975399;972.2367941166292;999.0109791306554;1005.9949700251452;4082.8976176432197;4282.822223888394;4524.163029839425;4633.536646335339;4719.221328480831;4333.609975102256;4649.930251046237;5167.612429067835;5227.686338819607;5254.978387427244;4203.26442872496;4691.296305554194;4722.693024953367;4788.467690339127;4793.7536240577;2601.66178396811;2776.9305767355977;2779.5691667791525;2783.399545261442;2792.5392310268985;4331;4715.41057367829;4818.831340903122;5383;5514.338279406416;4770.76146192689;4892.975535122373;4922.286268491049;4990;5310.468953104659;4933.9506604933495;5161.5870730341485;5385.676859388449;5405.567554595702;5439.646422982572;4538.77599976016;5142.382914050338;5146.511081447256;5213.852952350477;5249.6062795289745;4521.886952826206;4615.746133962664;4925.852224433273;5094.847154585368;5106.489351065013;5265.763040663102;5323.787048518016;5341.4925582069645;5348.58262560414;5370.838874833761;3718.4980027695915;3724;3732.2535492900984;3733.5706393765063;3735.4957080793747;4657.743824089707;5115.5396014358885;5191.534021339833;5923.763049478145;6083.7832433512585;5754.424557544212;5923.911141332797;6047.304559975659;6099.3290738017895;6111.694415279308;4800.879978000438;5035.949640503548;5481.616286859881;5872.882542349214;6099.8780024398375;5274.762635681327;5728.398518155534;5837.562182836219;5895.528357731457;5934.584579079423;5248.343957005374;5553.9444605555045;6022.397760223943;6082.36135205797;6121.908171377522;4902.583280421204;5576.414476479911;5840.269966254218;5911.852203694942;5937.614055086406 02:35:17 INFO - PROCESS | 1664 | |5;yui.html;739.7558805594155;756.1946526948799;775.9757120600809;785.0344076785552;840.8444437779008;14527.346269417874;14923.925380373097;14957.027793193434;15172.696546069086;15176.31706573204;13327;14618.780718289234;14653.340599673014;14695.779563306533;14701.117932924006;881.3962435731528;898.074982767747;901.9729408117735;907.9319051071196;910.0580898769774;884.7655371326604;895.2614093372994;899.8020435504178;903.3676426501443;904.4528060523387;942.8821397325335;960.7982323712029;964.28642804325;964.3779762053472;964.4840010594334;913.7487191022522;917.9036201198845;951.857221416786;952.5713428956997;955.3455882720359;683.043738765727;694.0526181761909;716.3266529462289;717.4941666125369;718.7556230881473;13983.930080349635;14949.925250373679;15261.313240904186;15575.610609734735;16011.759823602539;14618.684318411288;14972.925135374362;15009.099454032794;15031.323590438456;15090.17004064776;12002.759944801142;12131.454084566216;12155.574554890536;12173.391330433444;12251.825380629823;3921.117748506563;3926.8429262829454;3928.508936382952;3945.230680017398;4070.267351876661;116487.41756291164;117744;119426.99999999913;119822;120590;11329.716757080974;11348.03541698965;11363.431828408546;11374.31754094757;11374.601888933848;22190.778092219192;22334;22736.317910462712;22784.430389240402;22785;8148.22591853773;8159.207936539527;8287.544185069759;8326.167383261625;8411.83176336482;4611.469680986663;4709.105269998689;4718.95281047192;4819.228923372314;4871.853844384604;3606.693431058337;3708.4437334399518;3720.739548231652;3721.7953012584567;3724.1620635356826;684.5276759036249;695.6591270277528;733.7941415301686;734.2767374136471;754.3776384482713;560.5599604310596;599.8410421238375;654.9181352330959;676.8713944350558;736.0615215600046;9654.903450965401;9799.461029643295;9825.213982881352;9837.606495740234;10079.042490963348;581.982540523785;594.3284088979426;632.339205530222;636.885450461692;650.3174405576995;4785.138675038526;4862.164332233038;4867.1969125093965;4886.3403440535785;4906.971989368233;101770;146548;161821.38178618063;168321;172051.27948720602;126993;146366;147431;147848.8683122417;149596;102456.46315305277;116331;118901;128103;130444;9927.305088643725;9957.103860652576;10149.391036537536;10197.031282028196;10302.278840481395;61484.46288842815;66090.33909660841;66763.99562019818;68068.6596567014;68437;67378.66310668415;91849.54075229849;96863.51568242113;101017;103595;13493.122947008413;13608.591742247749;13942.093763905314;13944.372503237175;14209.50266740659;15058.397664093753;15136.965833250411;15255.160966146525;15382.384704612137;15424;13940.79088813689;14060.929695351459;14181.787273191117;14287.499937502138;14420.495282665475;11482.483288252215;13956.232407217294;13968.441262349392;14238.359273832495;14425.49510767118;14019.29903504841;14061.226632535308;14116.735691088204;14173.574792756233;14646.267686615414;9528.428294302365;11376.772464550828;11612;11661.76676466449;11728.179027467995;11231.494582743959;11441.656750297505;11705.531778729097;11723.882761172279;11754.29474231549 02:35:17 INFO - PROCESS | 1664 | __end_tp_report 02:35:17 INFO - PROCESS | 1664 | __start_cc_report 02:35:17 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,434 02:35:17 INFO - PROCESS | 1664 | __end_cc_report 02:35:17 INFO - PROCESS | 1664 | __startTimestamp1468834517862__endTimestamp 02:35:17 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | ------- Summary: start ------- 02:35:17 INFO - PROCESS | 1664 | Number of tests: 6 02:35:17 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5800.87 Median:6063.36 stddev:674.88 (11.1%) stddev-sans-first:631.83 02:35:17 INFO - PROCESS | 1664 | Values: 2708.0 2817.1 3423.9 3433.4 3474.4 5954.5 5957.7 5971.2 5983.9 5986.6 5764.1 5896.9 5915.3 5940.5 6019.8 5282.6 5315.1 5332.7 5454.6 5457.5 4926.5 5448.9 5460.0 5524.1 5532.9 5214.9 5371.7 5375.2 5383.1 5428.1 5386.0 5388.4 5390.9 5392.8 5394.9 5295.0 5328.3 5350.2 5362.8 5382.8 5042.7 5595.1 5864.0 6018.4 6041.2 6166.8 6248.4 6262.2 6267.2 6273.7 6168.7 6197.8 6253.5 6306.0 6306.4 6006.1 6055.5 6063.4 6074.6 6106.8 6371.8 6457.2 6466.6 6470.2 6483.5 5604.2 6181.4 6184.6 6243.7 6263.4 6275.2 6287.4 6310.1 6310.7 6345.8 5157.9 5307.2 6147.5 6200.5 6214.3 6111.0 6221.2 6223.3 6247.8 6258.6 4968.7 4978.0 4995.2 5013.4 5027.2 4443.8 4477.1 4488.8 4506.1 4528.3 5675.7 5874.8 5875.1 5890.1 5962.7 6186.8 6273.5 6273.8 6292.3 6296.4 6027.0 6046.8 6058.3 6060.6 6067.3 5471.7 5564.3 5577.9 5618.3 5657.2 6470.0 6506.3 6512.2 6517.3 6522.1 6281.2 6316.7 6321.7 6322.5 6326.7 5765.5 5928.3 6130.9 6274.6 6391.6 6190.3 6232.2 6235.4 6244.1 6255.1 5353.4 6289.3 6292.8 6294.4 6297.4 6106.7 6109.4 6150.1 6177.9 6238.2 4743.5 6164.7 6166.5 6219.7 6288.9 5161.7 5296.3 6016.3 6139.6 6167.7 5131.4 6095.3 6176.4 6225.4 6231.3 6095.5 6104.3 6113.4 6138.1 6144.8 02:35:17 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:66751.03 Median:40077.60 stddev:148589.53 (370.8%) stddev-sans-first:148923.10 02:35:17 INFO - PROCESS | 1664 | Values: 498.1 529.6 538.5 538.5 541.3 32834.3 41693.8 41761.0 41776.8 41904.8 42560.6 42940.8 42978.7 43040.4 43385.1 9513.3 9603.2 9656.3 9701.7 9715.9 9659.2 9721.5 9750.3 9756.9 9808.3 9658.2 9664.8 9732.7 9736.8 9737.9 9745.8 9758.7 9776.7 9780.9 9805.3 9628.3 9643.9 9666.1 9666.5 9701.9 39546.2 40003.4 40151.8 40341.2 40443.0 3407.4 3449.5 3478.5 3555.1 4210.8 31260.0 32222.0 32398.2 32415.0 32819.8 3288.5 3313.8 3323.3 3375.9 3423.8 371706.0 376567.0 376718.0 378353.0 380020.0 33893.5 34786.3 58897.4 59057.7 59314.0 34039.3 34809.5 34812.4 35240.1 35310.1 14235.6 14373.4 14693.7 14702.2 14764.6 12492.1 12552.8 12559.0 12562.5 12572.2 7654.5 7677.9 7690.5 7700.8 7745.0 3195.6 3197.9 3216.7 3222.8 3266.8 978.9 1010.9 1044.8 1068.1 1115.0 30214.8 30535.8 30763.1 31228.4 31415.8 1044.4 1063.4 1111.3 1158.3 1173.9 13787.7 15233.0 15517.7 15729.7 15751.1 671790.0 673487.0 674389.0 680241.0 681701.0 58292.7 59398.7 60015.4 60050.0 60224.7 1441.3 1442.1 1461.2 1466.7 1467.9 30205.5 30246.4 30334.8 30741.0 30999.8 50768.7 51212.0 51227.0 51412.7 51540.2 558681.2 559013.0 566783.0 576674.0 577850.0 22861.1 26372.7 26821.6 27151.3 27293.5 48394.8 49079.0 49561.0 49775.0 50289.0 40341.8 40465.4 40478.4 40940.0 41942.8 33666.3 40541.2 40625.0 40712.4 40967.0 39264.6 39269.2 40165.0 40184.2 41775.2 33224.0 35306.6 36191.1 36416.5 36687.8 26341.9 26512.3 26539.3 26584.7 26797.5 02:35:17 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:34759.86 Median:3216.31 stddev:97882.75 (3043.3%) stddev-sans-first:98123.30 02:35:17 INFO - PROCESS | 1664 | Values: 383.9 385.5 389.1 391.0 410.6 20407.6 20609.0 21414.7 21571.7 21657.4 20187.8 20660.3 20712.6 20749.5 20750.4 5553.2 5730.7 5842.1 5873.9 5909.1 5542.3 5807.4 5899.7 5900.9 5915.9 5895.6 5904.4 5956.7 5982.2 5988.8 5856.3 5926.7 5967.9 5983.6 6023.3 5792.9 5804.4 5922.7 5942.9 5943.3 13066.9 13234.2 13327.5 24987.0 25373.6 2198.2 2224.6 2261.4 2594.8 2653.4 9526.0 9622.9 9799.6 9940.1 10117.4 1860.7 1893.7 1921.3 1932.3 1939.8 107687.0 130731.0 130958.0 131618.0 131653.0 11222.9 11605.4 11702.6 11706.6 11715.8 14436.4 14508.5 14534.6 14571.4 14591.6 8500.2 8509.7 8516.4 8552.6 8629.7 7015.6 7493.1 8028.8 8597.7 8656.9 3779.2 4457.4 4503.1 4527.9 4578.8 1632.2 1940.9 1958.4 1960.4 1973.6 821.5 852.7 870.6 886.6 899.9 20612.2 21200.3 21200.4 21341.0 21343.8 940.6 953.9 977.2 1005.3 1066.8 9118.5 10247.0 11110.7 11136.7 11170.6 519823.0 560445.0 597554.0 609213.0 622557.0 99583.5 125409.1 140374.6 142909.9 144195.6 952.9 958.3 974.8 1011.5 1017.7 18331.6 18557.0 18799.8 18944.2 19061.0 41162.8 47486.8 53308.0 54738.7 58003.4 79475.0 81341.6 82504.0 83082.6 83104.6 7788.8 7994.5 8191.5 8264.6 8376.0 9123.5 12463.1 13117.9 13525.0 13746.9 8876.4 11525.4 11584.1 11586.4 11621.1 10619.6 10975.6 11043.9 11552.2 11726.7 10724.6 10769.0 11737.9 11798.7 11837.6 8128.6 8208.0 8301.9 8308.8 8454.5 11172.1 11274.2 11453.5 11563.3 11622.4 02:35:17 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5791.07 Median:4655.44 stddev:3248.74 (69.8%) stddev-sans-first:3242.28 02:35:17 INFO - PROCESS | 1664 | Values: 1557.9 1593.6 1842.9 1934.6 1945.2 8072.8 8679.0 8714.8 9120.6 9165.2 8743.0 8789.8 8925.3 8934.7 8947.8 2035.0 2374.7 2386.0 2394.5 2404.7 2336.9 2398.6 2400.0 2400.2 2409.7 2360.6 2372.5 2378.3 2378.7 2407.5 2312.5 2372.9 2381.0 2386.6 2395.8 2354.8 2377.5 2378.3 2385.6 2387.4 9002.4 9058.5 9065.2 9079.7 9120.6 4677.1 5364.2 5440.4 5521.7 5690.4 3068.3 3502.7 3592.9 3661.6 3668.2 1085.2 1093.5 1096.6 1096.7 1116.3 11614.2 11856.8 11890.5 11897.6 11998.3 4046.9 4685.3 4691.0 4772.8 4903.1 10017.3 10082.7 10088.7 10095.9 10134.8 4633.7 5376.6 5394.6 5398.2 5417.3 4427.2 4685.7 4919.3 4929.4 4952.2 4012.8 4024.5 4103.9 4141.4 4144.0 1296.2 1319.5 1324.3 1330.9 1334.7 954.7 965.9 968.9 972.1 996.1 5934.4 5970.8 6060.6 6160.9 6210.4 443.0 444.7 449.4 451.4 461.5 4013.4 4132.8 4141.2 4209.1 4218.5 9174.4 10337.1 10789.5 10790.1 10815.8 10132.5 10714.3 10729.3 10740.6 10741.5 7921.7 8139.6 8190.5 8192.9 8205.1 6042.6 6203.5 6239.7 6257.2 6279.3 10030.4 10039.7 10252.7 10264.1 10342.6 9902.2 10338.0 10366.1 10526.0 10543.5 6229.1 7744.7 7763.1 7764.5 7856.2 8513.4 8561.1 8567.5 8570.9 8635.2 7533.1 7664.5 7727.5 7752.2 7796.4 7467.0 7474.4 7533.6 7610.3 7647.7 7097.8 7145.5 7148.1 7150.9 7196.8 4991.5 5085.7 5112.8 5191.8 5205.7 5165.2 5206.1 5227.2 5259.3 5311.4 02:35:17 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4531.03 Median:4832.55 stddev:1375.43 (28.5%) stddev-sans-first:1341.74 02:35:17 INFO - PROCESS | 1664 | Values: 278.2 284.8 318.7 321.3 324.3 4671.0 5423.5 5443.2 5673.5 5738.7 5619.5 5661.2 5666.4 5671.2 5686.0 3640.7 4043.3 4306.3 4316.2 4358.2 3620.0 4128.7 4333.7 4361.2 4391.8 3343.4 3603.2 4219.1 4236.7 4282.5 4279.6 4293.2 4310.2 4327.8 4328.9 3367.8 3480.5 3719.8 3743.3 3755.3 4402.3 5038.8 5413.6 5429.4 5450.3 4001.7 4826.2 4863.9 4866.3 4875.6 4610.4 5449.6 5660.8 5877.4 6032.0 3528.9 3948.7 3981.2 4017.3 4018.8 6246.5 6268.4 6285.0 6333.9 6346.9 3953.7 4023.2 4051.3 4053.4 4072.7 3593.2 3973.4 4107.5 4115.8 4221.9 4569.3 4776.2 4792.9 4822.8 4838.9 5718.4 5958.0 5963.9 5968.2 5975.9 1408.3 1444.7 1456.8 1458.1 1464.6 809.9 964.8 972.2 999.0 1006.0 4082.9 4282.8 4524.2 4633.5 4719.2 4333.6 4649.9 5167.6 5227.7 5255.0 4203.3 4691.3 4722.7 4788.5 4793.8 2601.7 2776.9 2779.6 2783.4 2792.5 4331.0 4715.4 4818.8 5383.0 5514.3 4770.8 4893.0 4922.3 4990.0 5310.5 4934.0 5161.6 5385.7 5405.6 5439.6 4538.8 5142.4 5146.5 5213.9 5249.6 4521.9 4615.7 4925.9 5094.8 5106.5 5265.8 5323.8 5341.5 5348.6 5370.8 3718.5 3724.0 3732.3 3733.6 3735.5 4657.7 5115.5 5191.5 5923.8 6083.8 5754.4 5923.9 6047.3 6099.3 6111.7 4800.9 5035.9 5481.6 5872.9 6099.9 5274.8 5728.4 5837.6 5895.5 5934.6 5248.3 5553.9 6022.4 6082.4 6121.9 4902.6 5576.4 5840.3 5911.9 5937.6 02:35:17 INFO - PROCESS | 1664 | 02:35:17 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:26169.98 Median:22262.39 stddev:42285.95 (189.9%) stddev-sans-first:42361.47 02:35:17 INFO - PROCESS | 1664 | Values: 739.8 756.2 776.0 785.0 840.8 14527.3 14923.9 14957.0 15172.7 15176.3 13327.0 14618.8 14653.3 14695.8 14701.1 881.4 898.1 902.0 907.9 910.1 884.8 895.3 899.8 903.4 904.5 942.9 960.8 964.3 964.4 964.5 913.7 917.9 951.9 952.6 955.3 683.0 694.1 716.3 717.5 718.8 13983.9 14949.9 15261.3 15575.6 16011.8 14618.7 14972.9 15009.1 15031.3 15090.2 12002.8 12131.5 12155.6 12173.4 12251.8 3921.1 3926.8 3928.5 3945.2 4070.3 116487.4 117744.0 119427.0 119822.0 120590.0 11329.7 11348.0 11363.4 11374.3 11374.6 22190.8 22334.0 22736.3 22784.4 22785.0 8148.2 8159.2 8287.5 8326.2 8411.8 4611.5 4709.1 4719.0 4819.2 4871.9 3606.7 3708.4 3720.7 3721.8 3724.2 684.5 695.7 733.8 734.3 754.4 560.6 599.8 654.9 676.9 736.1 9654.9 9799.5 9825.2 9837.6 10079.0 582.0 594.3 632.3 636.9 650.3 4785.1 4862.2 4867.2 4886.3 4907.0 101770.0 146548.0 161821.4 168321.0 172051.3 126993.0 146366.0 147431.0 147848.9 149596.0 102456.5 116331.0 118901.0 128103.0 130444.0 9927.3 9957.1 10149.4 10197.0 10302.3 61484.5 66090.3 66764.0 68068.7 68437.0 67378.7 91849.5 96863.5 101017.0 103595.0 13493.1 13608.6 13942.1 13944.4 14209.5 15058.4 15137.0 15255.2 15382.4 15424.0 13940.8 14060.9 14181.8 14287.5 14420.5 11482.5 13956.2 13968.4 14238.4 14425.5 14019.3 14061.2 14116.7 14173.6 14646.3 9528.4 11376.8 11612.0 11661.8 11728.2 11231.5 11441.7 11705.5 11723.9 11754.3 02:35:17 INFO - PROCESS | 1664 | -------- Summary: end -------- 02:35:17 INFO - PROCESS | 1664 | 02:35:18 INFO - TEST-INFO | 1664: exit 0 02:35:18 INFO - TEST-OK | dromaeo_css | took 1112852ms 02:35:18 INFO - TEST-START | kraken 02:35:18 INFO - operating with platform_type : mac_ 02:35:18 INFO - Initialising browser for kraken test... 02:35:18 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp8K__Sq/profile http://localhost:49272/getInfo.html) 02:35:20 INFO - PROCESS | 1672 | JavaScript error: , line 0: uncaught exception: undefined 02:35:21 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 02:35:21 INFO - PROCESS | 1672 | colorDepth:24 02:35:21 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 02:35:21 INFO - PROCESS | 1672 | __metrics 02:35:21 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:35:22 INFO - TEST-INFO | 1672: exit 0 02:35:22 INFO - Browser initialized. 02:35:22 INFO - Running cycle 1/1 for kraken test... 02:35:22 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/tmp8K__Sq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:34 INFO - PROCESS | 1674 | RSS: Main: 255807488 02:35:34 INFO - PROCESS | 1674 | 02:35:37 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 02:35:37 INFO - PROCESS | 1674 | RSS: Main: 268734464 02:35:37 INFO - PROCESS | 1674 | 02:35:40 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 02:35:41 INFO - PROCESS | 1674 | RSS: Main: 272388096 02:35:41 INFO - PROCESS | 1674 | 02:35:44 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 02:35:45 INFO - PROCESS | 1674 | RSS: Main: 273088512 02:35:45 INFO - PROCESS | 1674 | 02:35:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 02:35:47 INFO - PROCESS | 1674 | RSS: Main: 274112512 02:35:47 INFO - PROCESS | 1674 | 02:35:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:35:50 INFO - PROCESS | 1674 | RSS: Main: 274857984 02:35:50 INFO - PROCESS | 1674 | 02:35:53 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 02:35:53 INFO - PROCESS | 1674 | RSS: Main: 274931712 02:35:53 INFO - PROCESS | 1674 | 02:35:56 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 02:35:57 INFO - PROCESS | 1674 | RSS: Main: 275058688 02:35:57 INFO - PROCESS | 1674 | 02:36:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 02:36:00 INFO - PROCESS | 1674 | RSS: Main: 275152896 02:36:00 INFO - PROCESS | 1674 | 02:36:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:36:02 INFO - PROCESS | 1674 | RSS: Main: 275300352 02:36:02 INFO - PROCESS | 1674 | 02:36:05 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:36:05 INFO - PROCESS | 1674 | RSS: Main: 275521536 02:36:05 INFO - PROCESS | 1674 | 02:36:07 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:36:08 INFO - PROCESS | 1674 | RSS: Main: 275333120 02:36:08 INFO - PROCESS | 1674 | 02:36:11 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:36:12 INFO - PROCESS | 1674 | RSS: Main: 275595264 02:36:12 INFO - PROCESS | 1674 | 02:36:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:36:15 INFO - PROCESS | 1674 | RSS: Main: 275218432 02:36:15 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 02:36:17 INFO - PROCESS | 1674 | RSS: Main: 276410368 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | __start_tp_report 02:36:17 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 02:36:17 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 02:36:17 INFO - PROCESS | 1674 | |i|pagename|runs| 02:36:17 INFO - PROCESS | 1674 | |0;ai-astar;109;148;84;165;173;170;114;118;116;118 02:36:17 INFO - PROCESS | 1674 | |1;audio-beat-detection;143;114;131;153;109;132;129;112;194;110 02:36:17 INFO - PROCESS | 1674 | |2;audio-dft;197;198;203;219;210;201;193;201;195;197 02:36:17 INFO - PROCESS | 1674 | |3;audio-fft;73;107;100;183;63;59;59;60;128;56 02:36:17 INFO - PROCESS | 1674 | |4;audio-oscillator;69;104;126;72;71;81;113;69;76;148 02:36:17 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;90;87;89;87;129;86;90;88;90;86 02:36:17 INFO - PROCESS | 1674 | |6;imaging-darkroom;95;98;95;98;97;96;121;102;95;95 02:36:17 INFO - PROCESS | 1674 | |7;imaging-desaturate;92;94;89;91;93;92;90;95;98;93 02:36:17 INFO - PROCESS | 1674 | |8;json-parse-financial;54;54;56;54;55;57;66;72;72;79 02:36:17 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;68;76;97;107;85;77;79;82;98;100 02:36:17 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;85;101;104;92;73;101;102;98;73;95 02:36:17 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;139;152;156;159;148;147;137;135;168;127 02:36:17 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;170;170;170;224;185;163;168;167;169;169 02:36:17 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;65;84;82;82;83;67;65;68;67;67 02:36:17 INFO - PROCESS | 1674 | __end_tp_report 02:36:17 INFO - PROCESS | 1674 | __start_cc_report 02:36:17 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1138 02:36:17 INFO - PROCESS | 1674 | __end_cc_report 02:36:17 INFO - PROCESS | 1674 | __startTimestamp1468834577837__endTimestamp 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | ------- Summary: start ------- 02:36:17 INFO - PROCESS | 1674 | Number of tests: 14 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:131.50 Median:156.50 stddev:30.32 (19.4%) stddev-sans-first:31.04 02:36:17 INFO - PROCESS | 1674 | Values: 109.0 148.0 84.0 165.0 173.0 170.0 114.0 118.0 116.0 118.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:131.50 stddev:26.14 (19.9%) stddev-sans-first:27.46 02:36:17 INFO - PROCESS | 1674 | Values: 143.0 114.0 131.0 153.0 109.0 132.0 129.0 112.0 194.0 110.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:201.40 Median:201.00 stddev:7.81 (3.9%) stddev-sans-first:8.12 02:36:17 INFO - PROCESS | 1674 | Values: 197.0 198.0 203.0 219.0 210.0 201.0 193.0 201.0 195.0 197.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:88.80 Median:59.00 stddev:41.45 (70.3%) stddev-sans-first:43.57 02:36:17 INFO - PROCESS | 1674 | Values: 73.0 107.0 100.0 183.0 63.0 59.0 59.0 60.0 128.0 56.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:70.00 stddev:28.18 (40.3%) stddev-sans-first:28.53 02:36:17 INFO - PROCESS | 1674 | Values: 69.0 104.0 126.0 72.0 71.0 81.0 113.0 69.0 76.0 148.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:88.50 stddev:13.03 (14.7%) stddev-sans-first:13.79 02:36:17 INFO - PROCESS | 1674 | Values: 90.0 87.0 89.0 87.0 129.0 86.0 90.0 88.0 90.0 86.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:95.50 stddev:7.97 (8.3%) stddev-sans-first:8.31 02:36:17 INFO - PROCESS | 1674 | Values: 95.0 98.0 95.0 98.0 97.0 96.0 121.0 102.0 95.0 95.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:93.00 stddev:2.58 (2.8%) stddev-sans-first:2.73 02:36:17 INFO - PROCESS | 1674 | Values: 92.0 94.0 89.0 91.0 93.0 92.0 90.0 95.0 98.0 93.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:61.50 stddev:9.47 (15.4%) stddev-sans-first:9.60 02:36:17 INFO - PROCESS | 1674 | Values: 54.0 54.0 56.0 54.0 55.0 57.0 66.0 72.0 72.0 79.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:86.90 Median:80.50 stddev:12.76 (15.8%) stddev-sans-first:11.55 02:36:17 INFO - PROCESS | 1674 | Values: 68.0 76.0 97.0 107.0 85.0 77.0 79.0 82.0 98.0 100.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:79.00 stddev:11.64 (14.7%) stddev-sans-first:12.04 02:36:17 INFO - PROCESS | 1674 | Values: 85.0 101.0 104.0 92.0 73.0 101.0 102.0 98.0 73.0 95.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:146.80 Median:150.00 stddev:12.47 (8.3%) stddev-sans-first:12.90 02:36:17 INFO - PROCESS | 1674 | Values: 139.0 152.0 156.0 159.0 148.0 147.0 137.0 135.0 168.0 127.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:170.00 stddev:17.96 (10.6%) stddev-sans-first:18.94 02:36:17 INFO - PROCESS | 1674 | Values: 170.0 170.0 170.0 224.0 185.0 163.0 168.0 167.0 169.0 169.0 02:36:17 INFO - PROCESS | 1674 | 02:36:17 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:75.00 stddev:8.46 (11.3%) stddev-sans-first:8.46 02:36:17 INFO - PROCESS | 1674 | Values: 65.0 84.0 82.0 82.0 83.0 67.0 65.0 68.0 67.0 67.0 02:36:17 INFO - PROCESS | 1674 | -------- Summary: end -------- 02:36:17 INFO - PROCESS | 1674 | 02:36:18 INFO - TEST-INFO | 1674: exit 0 02:36:18 INFO - TEST-OK | kraken | took 60295ms 02:36:18 INFO - SUITE-END | took 1173s 02:36:19 INFO - Completed test suite (00:19:33) 02:36:19 INFO - javascript benchmark 02:36:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7358.625157805989, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2707.998040724931, 2817.1407720645193, 3423.948640770389, 3433.3949353179155, 3474.444088945769, 5954.4640982311585, 5957.7021148942595, 5971.223740913675, 5983.880322393549, 5986.580939334249, 5764.106563482667, 5896.938551060807, 5915.290165180174, 5940.465358117768, 6019.7893073742425, 5282.630215884889, 5315.096433606277, 5332.653377530448, 5454.563634909197, 5457.481539253785, 4926.483918502431, 5448.91826622599, 5460.0, 5524.14375771756, 5532.889342213153, 5214.947850521503, 5371.731413429352, 5375.247465354853, 5383.084875571162, 5428.131498960187, 5385.976664433745, 5388.407275199725, 5390.865228369283, 5392.78428862849, 5394.91907621386, 5294.973525132388, 5328.307320048408, 5350.170723537858, 5362.758675859595, 5382.838514844521, 5042.697438153686, 5595.132754423071, 5864.0, 6018.368071352533, 6041.184440100618, 6166.784162554289, 6248.3751624837605, 6262.185915830913, 6267.2165979252595, 6273.654948977804, 6168.660723660197, 6197.752089916398, 6253.468455181315, 6305.968470157666, 6306.432421082125, 6006.069059295816, 6055.545834062463, 6063.363346848606, 6074.635521868702, 6106.755729770804, 6371.778014835451, 6457.1605691260775, 6466.644334561644, 6470.191226096738, 6483.546151769425, 5604.215409842625, 6181.381861813783, 6184.567080304426, 6243.719032643542, 6263.404976527314, 6275.246031785633, 6287.402696743802, 6310.0534919761485, 6310.684465776692, 6345.841353966188, 5157.948420515821, 5307.203919412119, 6147.477464415485, 6200.534959878028, 6214.316425193225, 6111.0, 6221.160143380585, 6223.284322302993, 6247.843803904939, 6258.624482531062, 4968.652194346361, 4978.029284289529, 4995.150824359867, 5013.373328333958, 5027.245913112989, 4443.800028998703, 4477.104579084196, 4488.820447182076, 4506.143832671782, 4528.320751887243, 5675.716214189274, 5874.765009399662, 5875.089361149029, 5890.1164825276555, 5962.672053037125, 6186.783462578788, 6273.498120150377, 6273.843153921097, 6292.339304373067, 6296.433321001132, 6027.035674292092, 6046.848828779316, 6058.303295121029, 6060.636361818305, 6067.332593414721, 5471.699056551848, 5564.304461942257, 5577.9163312550345, 5618.297712785902, 5657.236273103161, 6470.0, 6506.284308726036, 6512.185976753, 6517.348265173445, 6522.119513865568, 6281.214848143982, 6316.652584107735, 6321.715522801393, 6322.525810564134, 6326.6836658165985, 5765.4522820332, 5928.347881733092, 6130.865789828896, 6274.560780745304, 6391.616503009835, 6190.288116866618, 6232.158658581034, 6235.438810507076, 6244.094606282155, 6255.124282600531, 5353.384360798403, 6289.308176100717, 6292.811215663537, 6294.402031806971, 6297.4017468340435, 6106.725197366218, 6109.404666050415, 6150.10823430609, 6177.876442471035, 6238.157848690369, 4743.501932297059, 6164.660943647963, 6166.475849552839, 6219.689015549295, 6288.874222515616, 5161.716105614228, 5296.285001524745, 6016.338202797776, 6139.57023008403, 6167.660778657038, 5131.409887862944, 6095.329513753572, 6176.4441200292185, 6225.408586184305, 6231.283402408781, 6095.542834287535, 6104.336245366014, 6113.358097399709, 6138.109974053827, 6144.849302744004], "value": 5756.9494484830475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.098441820305, 529.6054439442615, 538.466917751426, 538.5234067849954, 541.3098299667923, 32834.34331313372, 41693.791531042305, 41760.95597610061, 41776.79111604441, 41904.79047604765, 42560.574394256124, 42940.785296073474, 42978.71063868089, 43040.3543946841, 43385.13229735404, 9513.33406661534, 9603.2317414607, 9656.275779316544, 9701.660441884536, 9715.90284097157, 9659.227261819073, 9721.513924303792, 9750.317477776558, 9756.902430975706, 9808.26438017148, 9658.227341812673, 9664.75838104046, 9732.65935692251, 9736.805263894717, 9737.902620973806, 9745.805083898318, 9758.658446954323, 9776.657816976407, 9780.90219097807, 9805.31362804604, 9628.3260171788, 9643.855342169873, 9666.130048295618, 9666.516674166263, 9701.90298097017, 39546.209075818326, 40003.39994900079, 40151.79544613666, 40341.193176136316, 40443.0, 3407.4037043517287, 3449.499822525745, 3478.47822826578, 3555.1467647764607, 4210.831566737327, 31260.0, 32222.0, 32398.190045248823, 32415.027549173563, 32819.83590082034, 3288.52316414121, 3313.8343082845763, 3323.3187196624635, 3375.9156021099425, 3423.760336776427, 371706.0, 376567.0, 376718.0, 378353.0, 380020.0, 33893.49159762605, 34786.30427391438, 58897.411025889196, 59057.704711477025, 59314.0, 34039.31921361559, 34809.47785783215, 34812.43344049524, 35240.11899702528, 35310.11724706903, 14235.644108897153, 14373.353199106064, 14693.706125877423, 14702.191379474018, 14764.557063288119, 12492.125551211328, 12552.81170782439, 12559.0, 12562.497500100077, 12572.182808117443, 7654.502457340255, 7677.923220767832, 7690.538567685957, 7700.807479813049, 7744.961275193701, 3195.5685982392542, 3197.8560964756175, 3216.694414030663, 3222.8066316021113, 3266.7876588021704, 978.8874279457812, 1010.8635334229932, 1044.8171569975225, 1068.0974576482859, 1114.9797934889648, 30214.814296984958, 30535.8473207637, 30763.077107686804, 31228.375432491222, 31415.84292078525, 1044.383813550009, 1063.4098075568133, 1111.261011427408, 1158.2760774515928, 1173.8884805943421, 13787.690169433889, 15232.974021399872, 15517.689646207013, 15729.68540629204, 15751.054936703835, 671790.0, 673487.0, 674389.0, 680241.0, 681701.0, 58292.708536457045, 59398.70300648469, 60015.39984600098, 60050.0, 60224.69887650534, 1441.2937660546465, 1442.0626592714818, 1461.189040082743, 1466.65533599604, 1467.8605532474398, 30205.546916795825, 30246.395072098876, 30334.84832575823, 30741.0, 30999.845000775753, 50768.74615626898, 51212.0, 51226.975460491325, 51412.74293628508, 51540.22689659583, 558681.2065939645, 559013.0, 566783.0, 576674.0, 577850.0, 22861.08555657755, 26372.736272637027, 26821.597676035264, 27151.321216969733, 27293.454130917667, 48394.758026209645, 49079.0, 49561.00877982492, 49775.0, 50289.0, 40341.79829100953, 40465.39301910415, 40478.392824107075, 40940.0, 41942.790286048374, 33666.326673465905, 40541.1891762169, 40625.0, 40712.3893141609, 40967.0, 39264.6073539261, 39269.2146157081, 40165.0, 40184.1963160741, 41775.16449670929, 33224.0, 35306.64693353033, 36191.09522261859, 36416.45375319319, 36687.816560917025, 26341.86829065919, 26512.337191570365, 26539.33651658724, 26584.734152658224, 26797.464050718485], "value": 18838.41930486267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9404892241703, 385.46035550229675, 389.1264112068406, 391.01358205868144, 410.58325799313684, 20407.59184816303, 20609.0, 21414.715117092986, 21571.67642485362, 21657.35027949162, 20187.798122018776, 20660.276890308844, 20712.585748285062, 20749.481262968435, 20750.377488675327, 5553.222548843165, 5730.68481233532, 5842.094475356326, 5873.853153671171, 5909.054551271797, 5542.307211598551, 5807.448292412235, 5899.675517846516, 5900.88198236035, 5915.911261331062, 5895.55783316253, 5904.439078287556, 5956.672383018932, 5982.222311099551, 5988.790392336269, 5856.326522449909, 5926.703664816763, 5967.940320596782, 5983.551233657449, 6023.337432882401, 5792.913106303409, 5804.361520232771, 5922.733476993546, 5942.851428714317, 5943.286805583358, 13066.934665326708, 13234.205947643171, 13327.466901323935, 24987.0, 25373.604451755145, 2198.208644887839, 2224.610693128696, 2261.4467677955545, 2594.8313359631566, 2653.3764565327133, 9525.952370238174, 9622.903770962272, 9799.608015679365, 9940.055694708992, 10117.38679846942, 1860.7301941218582, 1893.7064754963003, 1921.2507122222344, 1932.2657390191778, 1939.8254157125784, 107687.0, 130731.0, 130958.0, 131618.0, 131653.0, 11222.943885280521, 11605.419729013516, 11702.648920532398, 11706.590269340531, 11715.824262636068, 14436.422543098159, 14508.492202773063, 14534.563963080913, 14571.41714331436, 14591.635209119857, 8500.234978851933, 8509.70216042448, 8516.361272904556, 8552.588822844285, 8629.654813807503, 7015.649217539102, 7493.092024723815, 8028.839423211503, 8597.742067737978, 8656.88241018412, 3779.244151169777, 4457.420535330386, 4503.144402563503, 4527.864164075083, 4578.839740609063, 1632.2491653839368, 1940.8835469871854, 1958.4320547041484, 1960.4412742368356, 1973.58554703511, 821.5141458187576, 852.6674596907211, 870.6212797433137, 886.5655828643918, 899.9280057595507, 20612.175512979313, 21200.257990970244, 21200.445757062436, 21341.03965321564, 21343.78656213418, 940.6237504998055, 953.880764904387, 977.1938151025432, 1005.2762011351815, 1066.7919755647729, 9118.544072796467, 10247.0, 11110.666679999613, 11136.665900023012, 11170.609028683957, 519823.0, 560445.0, 597554.0, 609213.0, 622557.0, 99583.50624740635, 125409.11886321713, 140374.5962540382, 142909.8563521548, 144195.55804442032, 952.8713623660717, 958.3100167879255, 974.770928831724, 1011.5498603121688, 1017.6946915925192, 18331.633367332845, 18557.0, 18799.812001879807, 18944.242230311185, 19061.0, 41162.79418602888, 47486.81282967815, 53308.0, 54738.7156770595, 58003.4199657998, 79474.96053738939, 81341.59329203553, 82504.0, 83082.58458707668, 83104.58447707722, 7788.805279868048, 7994.5203287802915, 8191.467554608931, 8264.628091735765, 8376.0, 9123.452592844451, 12463.127581069239, 13117.934410327887, 13525.0, 13746.93126534361, 8876.378653494194, 11525.423728813357, 11584.073274138218, 11586.36275004849, 11621.070314375, 10619.575216991543, 10975.615853445091, 11043.889561104286, 11552.249103808226, 11726.706832328919, 10724.571017159225, 10769.0, 11737.88262117368, 11798.705032374259, 11837.585684501, 8128.593570321342, 8207.95896020516, 8301.916980830356, 8308.750737477885, 8454.450460720034, 11172.106231501622, 11274.210805243554, 11453.541858325907, 11563.30620162793, 11622.418879056182], "value": 9523.645114235162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.875369970402, 1593.6254980079682, 1842.889426634402, 1934.5550523379623, 1945.1927450108205, 8072.798180045502, 8679.0, 8714.782130446727, 9120.589573469186, 9165.220956218722, 8742.95628521858, 8789.824203515926, 8925.330600204978, 8934.687285944994, 8947.82104357914, 2035.0, 2374.655674927139, 2385.964210536835, 2394.461246219604, 2404.7354790972977, 2336.9298921032396, 2398.640203969401, 2399.9760002400017, 2400.1839374612628, 2409.7469765674614, 2360.5868972929757, 2372.51363470489, 2378.3221781792195, 2378.6907701998803, 2407.4944261705064, 2312.491251924591, 2372.9169479068237, 2380.964280537963, 2386.6181410974245, 2395.7843794058444, 2354.776296251853, 2377.476955069882, 2378.3340664613934, 2385.6063749481314, 2387.3554140382175, 9002.414843035182, 9058.501782401965, 9065.22945549629, 9079.682211122645, 9120.589573469144, 4677.134730074947, 5364.195370694388, 5440.4287549807495, 5521.723913804293, 5690.40250773667, 3068.324968506925, 3502.7197824174004, 3592.910177245564, 3661.6155303692994, 3668.211334563082, 1085.16442339399, 1093.5297821936565, 1096.5942601237514, 1096.7313008312935, 1116.319045382316, 11614.245074070159, 11856.822147667792, 11890.524379024828, 11897.643070707893, 11998.280103193749, 4046.8785936421955, 4685.273782563708, 4690.953090469052, 4772.757218917353, 4903.141950158708, 10017.348872323422, 10082.69751907444, 10088.69733907984, 10095.899041009643, 10134.847977280348, 4633.745144017044, 5376.596755243294, 5394.568434525228, 5398.163284690879, 5417.322834645669, 4427.22523558376, 4685.672002959828, 4919.335889654851, 4929.433115191727, 4952.158133117378, 4012.779297138627, 4024.4566983457444, 4103.938440923389, 4141.420201171838, 4144.026153853842, 1296.1769276509485, 1319.4524272426836, 1324.3312127375614, 1330.8735670111323, 1334.6986687979143, 954.7040417470606, 965.9082387173207, 968.864358989742, 972.1445128287062, 996.1333639733479, 5934.43622855828, 5970.791022314285, 6060.636361818305, 6160.876782464416, 6210.441060304594, 443.0363958390488, 444.7376048131618, 449.3933190193278, 451.4334510189691, 461.54076693689325, 4013.377926421351, 4132.834686612502, 4141.151064031867, 4209.052963083282, 4218.49378074633, 9174.403663761968, 10337.0696637303, 10789.514471848786, 10790.08284295828, 10815.83776243357, 10132.544035518273, 10714.25000249975, 10729.302595331435, 10740.570377184982, 10741.462926853626, 7921.683132674743, 8139.552324622203, 8190.50856948585, 8192.877106843402, 8205.138460461685, 6042.637441753509, 6203.503719702323, 6239.689665170184, 6257.155284036597, 6279.340669229665, 10030.448325341884, 10039.749006274902, 10252.743681408025, 10264.127549158406, 10342.638007669695, 9902.207823373968, 10338.0, 10366.118879895294, 10526.0, 10543.472826358804, 6229.096780966644, 7744.728934487266, 7763.14605393395, 7764.456488045783, 7856.214378562098, 8513.36149788756, 8561.14388561139, 8567.528785916835, 8570.871436928326, 8635.179657932485, 7533.1336896257635, 7664.501807382725, 7727.49771264866, 7752.224777522429, 7796.376289896908, 7467.0, 7474.402047836269, 7533.6233188339265, 7610.315071643578, 7647.655855486628, 7097.822554435974, 7145.4998150128995, 7148.142222933281, 7150.892736609059, 7196.784096477114, 4991.475895031114, 5085.669431486942, 5112.795488180431, 5191.8182863599595, 5205.687658740488, 5165.173572228426, 5206.140986737146, 5227.2420499028185, 5259.263703081649, 5311.415744268204], "value": 4586.876817974393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.20710973724886, 284.8447596060148, 318.6638096807867, 321.33323354040374, 324.2817159990623, 4670.953290467094, 5423.511883930445, 5443.1835224716315, 5673.489385955263, 5738.684372359518, 5619.466150715675, 5661.1508273758955, 5666.433356664332, 5671.177679236508, 5686.0, 3640.690541303986, 4043.251998380309, 4306.332518459643, 4316.223079845627, 4358.169568781103, 3619.963800361989, 4128.690348223895, 4333.696641235099, 4361.171377438277, 4391.824327026915, 3343.3647606954723, 3603.1892824114625, 4219.11398606293, 4236.724612900151, 4282.528921818597, 4279.550647182032, 4293.166510103332, 4310.159518893785, 4327.783610819478, 4328.870133895988, 3367.804429427567, 3480.477928310748, 3719.758215715997, 3743.2887751327435, 3755.286495565834, 4402.3176407656865, 5038.823641172541, 5413.621046526745, 5429.37118864343, 5450.291462109901, 4001.659858911996, 4826.203676393391, 4863.854084377439, 4866.294387313855, 4875.58557522611, 4610.423697037871, 5449.618526703132, 5660.801871934463, 5877.382874798127, 6031.974564324031, 3528.894133176009, 3948.657456464787, 3981.243563722883, 4017.31705610047, 4018.799060046986, 6246.500279977637, 6268.404501572343, 6284.968575157141, 6333.923233050393, 6346.87306253877, 3953.723239373274, 4023.195360927826, 4051.2910240707756, 4053.3919912012843, 4072.6538244248977, 3593.2274560969518, 3973.4039894016128, 4107.466029416157, 4115.753054816721, 4221.936670949938, 4569.263679801654, 4776.164171270014, 4792.860676257057, 4822.831200907952, 4838.903221935541, 5718.370979192286, 5957.970210149008, 5963.880722385528, 5968.1942937703725, 5975.910361344583, 1408.3240044778358, 1444.685336343943, 1456.8106146201137, 1458.0886945658963, 1464.6411629150925, 809.9389799362735, 964.7925695975399, 972.2367941166292, 999.0109791306554, 1005.9949700251452, 4082.8976176432197, 4282.822223888394, 4524.163029839425, 4633.536646335339, 4719.221328480831, 4333.609975102256, 4649.930251046237, 5167.612429067835, 5227.686338819607, 5254.978387427244, 4203.26442872496, 4691.296305554194, 4722.693024953367, 4788.467690339127, 4793.7536240577, 2601.66178396811, 2776.9305767355977, 2779.5691667791525, 2783.399545261442, 2792.5392310268985, 4331.0, 4715.41057367829, 4818.831340903122, 5383.0, 5514.338279406416, 4770.76146192689, 4892.975535122373, 4922.286268491049, 4990.0, 5310.468953104659, 4933.9506604933495, 5161.5870730341485, 5385.676859388449, 5405.567554595702, 5439.646422982572, 4538.77599976016, 5142.382914050338, 5146.511081447256, 5213.852952350477, 5249.6062795289745, 4521.886952826206, 4615.746133962664, 4925.852224433273, 5094.847154585368, 5106.489351065013, 5265.763040663102, 5323.787048518016, 5341.4925582069645, 5348.58262560414, 5370.838874833761, 3718.4980027695915, 3724.0, 3732.2535492900984, 3733.5706393765063, 3735.4957080793747, 4657.743824089707, 5115.5396014358885, 5191.534021339833, 5923.763049478145, 6083.7832433512585, 5754.424557544212, 5923.911141332797, 6047.304559975659, 6099.3290738017895, 6111.694415279308, 4800.879978000438, 5035.949640503548, 5481.616286859881, 5872.882542349214, 6099.8780024398375, 5274.762635681327, 5728.398518155534, 5837.562182836219, 5895.528357731457, 5934.584579079423, 5248.343957005374, 5553.9444605555045, 6022.397760223943, 6082.36135205797, 6121.908171377522, 4902.583280421204, 5576.414476479911, 5840.269966254218, 5911.852203694942, 5937.614055086406], "value": 4103.033502281921, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7558805594155, 756.1946526948799, 775.9757120600809, 785.0344076785552, 840.8444437779008, 14527.346269417874, 14923.925380373097, 14957.027793193434, 15172.696546069086, 15176.31706573204, 13327.0, 14618.780718289234, 14653.340599673014, 14695.779563306533, 14701.117932924006, 881.3962435731528, 898.074982767747, 901.9729408117735, 907.9319051071196, 910.0580898769774, 884.7655371326604, 895.2614093372994, 899.8020435504178, 903.3676426501443, 904.4528060523387, 942.8821397325335, 960.7982323712029, 964.28642804325, 964.3779762053472, 964.4840010594334, 913.7487191022522, 917.9036201198845, 951.857221416786, 952.5713428956997, 955.3455882720359, 683.043738765727, 694.0526181761909, 716.3266529462289, 717.4941666125369, 718.7556230881473, 13983.930080349635, 14949.925250373679, 15261.313240904186, 15575.610609734735, 16011.759823602539, 14618.684318411288, 14972.925135374362, 15009.099454032794, 15031.323590438456, 15090.17004064776, 12002.759944801142, 12131.454084566216, 12155.574554890536, 12173.391330433444, 12251.825380629823, 3921.117748506563, 3926.8429262829454, 3928.508936382952, 3945.230680017398, 4070.267351876661, 116487.41756291164, 117744.0, 119426.99999999913, 119822.0, 120590.0, 11329.716757080974, 11348.03541698965, 11363.431828408546, 11374.31754094757, 11374.601888933848, 22190.778092219192, 22334.0, 22736.317910462712, 22784.430389240402, 22785.0, 8148.22591853773, 8159.207936539527, 8287.544185069759, 8326.167383261625, 8411.83176336482, 4611.469680986663, 4709.105269998689, 4718.95281047192, 4819.228923372314, 4871.853844384604, 3606.693431058337, 3708.4437334399518, 3720.739548231652, 3721.7953012584567, 3724.1620635356826, 684.5276759036249, 695.6591270277528, 733.7941415301686, 734.2767374136471, 754.3776384482713, 560.5599604310596, 599.8410421238375, 654.9181352330959, 676.8713944350558, 736.0615215600046, 9654.903450965401, 9799.461029643295, 9825.213982881352, 9837.606495740234, 10079.042490963348, 581.982540523785, 594.3284088979426, 632.339205530222, 636.885450461692, 650.3174405576995, 4785.138675038526, 4862.164332233038, 4867.1969125093965, 4886.3403440535785, 4906.971989368233, 101770.0, 146548.0, 161821.38178618063, 168321.0, 172051.27948720602, 126993.0, 146366.0, 147431.0, 147848.8683122417, 149596.0, 102456.46315305277, 116331.0, 118901.0, 128103.0, 130444.0, 9927.305088643725, 9957.103860652576, 10149.391036537536, 10197.031282028196, 10302.278840481395, 61484.46288842815, 66090.33909660841, 66763.99562019818, 68068.6596567014, 68437.0, 67378.66310668415, 91849.54075229849, 96863.51568242113, 101017.0, 103595.0, 13493.122947008413, 13608.591742247749, 13942.093763905314, 13944.372503237175, 14209.50266740659, 15058.397664093753, 15136.965833250411, 15255.160966146525, 15382.384704612137, 15424.0, 13940.79088813689, 14060.929695351459, 14181.787273191117, 14287.499937502138, 14420.495282665475, 11482.483288252215, 13956.232407217294, 13968.441262349392, 14238.359273832495, 14425.49510767118, 14019.29903504841, 14061.226632535308, 14116.735691088204, 14173.574792756233, 14646.267686615414, 9528.428294302365, 11376.772464550828, 11612.0, 11661.76676466449, 11728.179027467995, 11231.494582743959, 11441.656750297505, 11705.531778729097, 11723.882761172279, 11754.29474231549], "value": 8167.218804196183, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 148.0, 84.0, 165.0, 173.0, 170.0, 114.0, 118.0, 116.0, 118.0], "value": 131.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 131.0, 153.0, 109.0, 132.0, 129.0, 112.0, 194.0, 110.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 198.0, 203.0, 219.0, 210.0, 201.0, 193.0, 201.0, 195.0, 197.0], "value": 201.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 107.0, 100.0, 183.0, 63.0, 59.0, 59.0, 60.0, 128.0, 56.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 104.0, 126.0, 72.0, 71.0, 81.0, 113.0, 69.0, 76.0, 148.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 129.0, 86.0, 90.0, 88.0, 90.0, 86.0], "value": 92.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 95.0, 98.0, 97.0, 96.0, 121.0, 102.0, 95.0, 95.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 89.0, 91.0, 93.0, 92.0, 90.0, 95.0, 98.0, 93.0], "value": 92.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 54.0, 55.0, 57.0, 66.0, 72.0, 72.0, 79.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 97.0, 107.0, 85.0, 77.0, 79.0, 82.0, 98.0, 100.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 101.0, 104.0, 92.0, 73.0, 101.0, 102.0, 98.0, 73.0, 95.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 152.0, 156.0, 159.0, 148.0, 147.0, 137.0, 135.0, 168.0, 127.0], "value": 146.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 170.0, 224.0, 185.0, 163.0, 168.0, 167.0, 169.0, 169.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 84.0, 82.0, 82.0, 83.0, 67.0, 65.0, 68.0, 67.0, 67.0], "value": 73.0, "unit": "score"}]}]} 02:36:19 INFO - Return code: 0 02:36:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:36:19 ERROR - # TBPL SUCCESS # 02:36:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:36:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:36:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:36:19 INFO - 2016-07-18 02:36:19.186 screenresolution[1679:11017] starting screenresolution argv=screenresolution get 02:36:19 INFO - 2016-07-18 02:36:19.189 screenresolution[1679:11017] Display 0: 1600x1200x32@60 02:36:19 INFO - 2016-07-18 02:36:19.195 screenresolution[1680:11020] starting screenresolution argv=screenresolution list 02:36:19 INFO - Available Modes on Display 0 02:36:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:36:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:36:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:36:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:36:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:36:19 INFO - Intel Iris: 02:36:19 INFO - Chipset Model: Intel Iris 02:36:19 INFO - Type: GPU 02:36:19 INFO - Bus: Built-In 02:36:19 INFO - VRAM (Dynamic, Max): 1536 MB 02:36:19 INFO - Vendor: Intel (0x8086) 02:36:19 INFO - Device ID: 0x0a2e 02:36:19 INFO - Revision ID: 0x0009 02:36:19 INFO - Displays: 02:36:19 INFO - Display: 02:36:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:36:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:36:19 INFO - Display Serial Number: 1600x1200 60 02:36:19 INFO - Main Display: Yes 02:36:19 INFO - Mirror: Off 02:36:19 INFO - Online: Yes 02:36:19 INFO - Rotation: Supported 02:36:19 INFO - Return code: 0 02:36:19 INFO - Running post-action listener: _resource_record_post_action 02:36:19 INFO - ##### 02:36:19 INFO - ##### Finished run-tests step (success) 02:36:19 INFO - ##### 02:36:19 INFO - Running post-run listener: _resource_record_post_run 02:36:19 INFO - Total resource usage - Wall time: 1208s; CPU: 55.0%; Read bytes: 32701952; Write bytes: 707070976; Read time: 322; Write time: 2094 02:36:19 INFO - TinderboxPrint: CPU usage
54.5% 02:36:19 INFO - TinderboxPrint: I/O read bytes / time
32,701,952 / 322 02:36:19 INFO - TinderboxPrint: I/O write bytes / time
707,070,976 / 2,094 02:36:19 INFO - TinderboxPrint: CPU idle
2,197.6 (45.5%) 02:36:19 INFO - TinderboxPrint: CPU system
977.8 (20.2%) 02:36:19 INFO - TinderboxPrint: CPU user
1,658.3 (34.3%) 02:36:19 INFO - TinderboxPrint: Swap in / out
435,793,920 / 0 02:36:19 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 386302464; Write bytes: 380958720; Read time: 29028; Write time: 712 02:36:19 INFO - run-tests - Wall time: 1174s; CPU: 55.0%; Read bytes: 31780352; Write bytes: 296739840; Read time: 309; Write time: 1330 02:36:19 INFO - Running post-run listener: _upload_blobber_files 02:36:19 INFO - Blob upload gear active. 02:36:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:36:19 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 02:36:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:36:20 INFO - (blobuploader) - INFO - Open directory for files ... 02:36:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:36:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:21 INFO - (blobuploader) - INFO - Done attempting. 02:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:36:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:22 INFO - (blobuploader) - INFO - Done attempting. 02:36:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:36:25 INFO - (blobuploader) - INFO - Done attempting. 02:36:25 INFO - (blobuploader) - INFO - Iteration through files over. 02:36:25 INFO - Return code: 0 02:36:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:36:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:36:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd3799bffa068ce776750e464996a8731d1ac946ff1f48d2819ef7d4fa241e377570f5725b9cf29d0c221affe770bb225dad71e44a2e582cbbaed6329c2bda0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6535921e1219f0ada5c305c3da39190d4b6402d2a7c9ca1cff412e384d6f8f0be62c6ec9d4232151054bc9cbe65cca7b42d7d23b888528de42c520feab8408c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b54ef4803e3d5f5e4d903a385a69e233f35042ac2533cb554549b38ab448deb28bf65beaadb7d0e6f499f0402caa1a4be28339494b1cfa9527eeffeff24c8d3b"} 02:36:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:36:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:36:25 INFO - Contents: 02:36:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd3799bffa068ce776750e464996a8731d1ac946ff1f48d2819ef7d4fa241e377570f5725b9cf29d0c221affe770bb225dad71e44a2e582cbbaed6329c2bda0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6535921e1219f0ada5c305c3da39190d4b6402d2a7c9ca1cff412e384d6f8f0be62c6ec9d4232151054bc9cbe65cca7b42d7d23b888528de42c520feab8408c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b54ef4803e3d5f5e4d903a385a69e233f35042ac2533cb554549b38ab448deb28bf65beaadb7d0e6f499f0402caa1a4be28339494b1cfa9527eeffeff24c8d3b"} 02:36:25 INFO - Running post-run listener: copy_logs_to_upload_dir 02:36:25 INFO - Copying logs to upload dir... 02:36:25 INFO - mkdir: /builds/slave/test/build/upload/logs 02:36:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1325.429053 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2016-07-18 02:36:25.121396) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 02:36:25.125258) ========= 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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd3799bffa068ce776750e464996a8731d1ac946ff1f48d2819ef7d4fa241e377570f5725b9cf29d0c221affe770bb225dad71e44a2e582cbbaed6329c2bda0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6535921e1219f0ada5c305c3da39190d4b6402d2a7c9ca1cff412e384d6f8f0be62c6ec9d4232151054bc9cbe65cca7b42d7d23b888528de42c520feab8408c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b54ef4803e3d5f5e4d903a385a69e233f35042ac2533cb554549b38ab448deb28bf65beaadb7d0e6f499f0402caa1a4be28339494b1cfa9527eeffeff24c8d3b"} build_url:https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/b7weYYveTQ25TYjtnmpKoA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fd3799bffa068ce776750e464996a8731d1ac946ff1f48d2819ef7d4fa241e377570f5725b9cf29d0c221affe770bb225dad71e44a2e582cbbaed6329c2bda0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6535921e1219f0ada5c305c3da39190d4b6402d2a7c9ca1cff412e384d6f8f0be62c6ec9d4232151054bc9cbe65cca7b42d7d23b888528de42c520feab8408c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b54ef4803e3d5f5e4d903a385a69e233f35042ac2533cb554549b38ab448deb28bf65beaadb7d0e6f499f0402caa1a4be28339494b1cfa9527eeffeff24c8d3b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 02:36:25.159048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:36:25.159408) ========= 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.SWzSVmSQsO/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.Hqjd2PG7DR/Listeners TMPDIR=/var/folders/7n/1rclx_kx36b2p57w818tgqh000000w/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.005034 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:36:25.210291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 02:36:25.210830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 02:36:25.211362) ========= ========= Total master_lag: 0.19 =========