builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0054 starttime: 1461153394.82 results: success (0) buildid: 20160420025138 builduid: 3bb49e3aa94a4d0a96badb2f0439b956 revision: f05a1242fb29023bd7ebc492897ed3d6907733c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:34.821485) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:34.822037) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:34.822322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:34.840945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:34.841232) ========= 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.nfn1awkn84/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.wddJi05ByA/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-20 04:56:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.24M=0.001s 2016-04-20 04:56:34 (8.24 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119820 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:34.978225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:34.978546) ========= 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.nfn1awkn84/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.wddJi05ByA/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.020459 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:35.027267) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 04:56:35.027620) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f05a1242fb29023bd7ebc492897ed3d6907733c7 --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 f05a1242fb29023bd7ebc492897ed3d6907733c7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nfn1awkn84/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.wddJi05ByA/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-20 04:56:35,129 truncating revision to first 12 chars 2016-04-20 04:56:35,129 Setting DEBUG logging. 2016-04-20 04:56:35,129 attempt 1/10 2016-04-20 04:56:35,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f05a1242fb29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 04:56:35,889 unpacking tar archive at: mozilla-central-f05a1242fb29/testing/mozharness/ program finished with exit code 0 elapsedTime=1.010930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 04:56:36.057508) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:36.058130) ========= script_repo_revision: f05a1242fb29023bd7ebc492897ed3d6907733c7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:36.058552) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:36.058842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 04:56:36.073399) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-20 04:56:36.073885) ========= /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.nfn1awkn84/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.wddJi05ByA/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:56:36 INFO - MultiFileLogger online at 20160420 04:56:36 in /builds/slave/test 04:56:36 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 04:56:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:36 INFO - {'append_to_log': False, 04:56:36 INFO - 'base_work_dir': '/builds/slave/test', 04:56:36 INFO - 'blob_upload_branch': 'Firefox', 04:56:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:36 INFO - 'branch': 'Firefox', 04:56:36 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:36 INFO - 'config_files': ('talos/mac_config.py',), 04:56:36 INFO - 'default_actions': ('clobber', 04:56:36 INFO - 'read-buildbot-config', 04:56:36 INFO - 'download-and-extract', 04:56:36 INFO - 'populate-webroot', 04:56:36 INFO - 'create-virtualenv', 04:56:36 INFO - 'install', 04:56:36 INFO - 'run-tests'), 04:56:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:36 INFO - 'download_minidump_stackwalk': True, 04:56:36 INFO - 'download_symbols': 'ondemand', 04:56:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:36 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:36 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:36 INFO - 'installer_path': 'installer.exe', 04:56:36 INFO - 'log_level': 'info', 04:56:36 INFO - 'log_name': 'talos', 04:56:36 INFO - 'log_to_console': True, 04:56:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:56:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:56:36 INFO - 'opt_config_files': (), 04:56:36 INFO - 'pip_index': False, 04:56:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:56:36 INFO - 'cmd': ('bash', 04:56:36 INFO - '-c', 04:56:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:56:36 INFO - 'enabled': True, 04:56:36 INFO - 'halt_on_failure': False, 04:56:36 INFO - 'name': 'check_screen_resolution'},), 04:56:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:56:36 INFO - 'cmd': ('bash', 04:56:36 INFO - '-c', 04:56:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:56:36 INFO - 'enabled': True, 04:56:36 INFO - 'halt_on_failure': False, 04:56:36 INFO - 'name': 'check_screen_resolution'},), 04:56:36 INFO - 'run_cmd_checks_enabled': True, 04:56:36 INFO - 'sps_profile': False, 04:56:36 INFO - 'sps_profile_interval': 0, 04:56:36 INFO - 'suite': 'dromaeojs-e10s', 04:56:36 INFO - 'system_bits': '32', 04:56:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:36 INFO - 'title': 't-yosemite-r7-0054', 04:56:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:36 INFO - 'use_talos_json': True, 04:56:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:36 INFO - 'work_dir': 'build'} 04:56:36 INFO - ##### 04:56:36 INFO - ##### Running clobber step. 04:56:36 INFO - ##### 04:56:36 INFO - Running pre-action listener: _resource_record_pre_action 04:56:36 INFO - Running main action method: clobber 04:56:36 INFO - rmtree: /builds/slave/test/build 04:56:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:37 INFO - Running post-action listener: _resource_record_post_action 04:56:37 INFO - ##### 04:56:37 INFO - ##### Running read-buildbot-config step. 04:56:37 INFO - ##### 04:56:37 INFO - Running pre-action listener: _resource_record_pre_action 04:56:37 INFO - Running main action method: read_buildbot_config 04:56:37 INFO - Using buildbot properties: 04:56:37 INFO - { 04:56:37 INFO - "project": "", 04:56:37 INFO - "product": "firefox", 04:56:37 INFO - "script_repo_revision": "production", 04:56:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:56:37 INFO - "repository": "", 04:56:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:56:37 INFO - "buildid": "20160420025138", 04:56:37 INFO - "pgo_build": "False", 04:56:37 INFO - "basedir": "/builds/slave/test", 04:56:37 INFO - "buildnumber": 246, 04:56:37 INFO - "slavename": "t-yosemite-r7-0054", 04:56:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:56:37 INFO - "platform": "yosemite_r7", 04:56:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:56:37 INFO - "branch": "mozilla-central", 04:56:37 INFO - "repo_path": "mozilla-central", 04:56:37 INFO - "revision": "f05a1242fb29023bd7ebc492897ed3d6907733c7", 04:56:37 INFO - "stage_platform": "macosx64", 04:56:37 INFO - "builduid": "3bb49e3aa94a4d0a96badb2f0439b956", 04:56:37 INFO - "slavebuilddir": "test" 04:56:37 INFO - } 04:56:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:56:37 INFO - Running post-action listener: _resource_record_post_action 04:56:37 INFO - ##### 04:56:37 INFO - ##### Running download-and-extract step. 04:56:37 INFO - ##### 04:56:37 INFO - Running pre-action listener: _resource_record_pre_action 04:56:37 INFO - Running main action method: download_and_extract 04:56:37 INFO - mkdir: /builds/slave/test/build/tests 04:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:37 INFO - https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 04:56:38 INFO - Downloaded 1199 bytes. 04:56:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:56:38 INFO - Using the following test package requirements: 04:56:38 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:56:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:38 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:56:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:38 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:56:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:38 INFO - u'jsshell-mac.zip'], 04:56:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:38 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:56:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:56:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:38 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:56:38 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:38 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:56:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:38 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:56:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:56:38 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:56:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:38 INFO - https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:56:40 INFO - Downloaded 18096123 bytes. 04:56:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:56:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:56:43 INFO - Return code: 0 04:56:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:56: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')]} 04:56:43 INFO - https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:56:44 INFO - Downloaded 18096123 bytes. 04:56:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:56:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:56:48 INFO - Return code: 0 04:56: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')]} 04:56:48 INFO - https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:56:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:56:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:56:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:56:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:56:49 INFO - Downloaded 10845952 bytes. 04:56:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:56:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:56:49 INFO - Return code: 0 04:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:49 INFO - https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 04:56:53 INFO - Downloaded 110048181 bytes. 04:56:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:56:53 INFO - mkdir: /builds/slave/test/properties 04:56:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:53 INFO - Contents: 04:56:53 INFO - build_url:https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:56:55 INFO - Running post-action listener: _resource_record_post_action 04:56:55 INFO - Running post-action listener: set_extra_try_arguments 04:56:55 INFO - ##### 04:56:55 INFO - ##### Running populate-webroot step. 04:56:55 INFO - ##### 04:56:55 INFO - Running pre-action listener: _resource_record_pre_action 04:56:55 INFO - Running main action method: populate_webroot 04:56:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:55 INFO - '--tppagecycles', 04:56:55 INFO - '7'], 04:56:55 INFO - 'tests': ['tsvgm']}}, 04:56:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['damp', 'tps']}, 04:56:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:55 INFO - 'tests': ['damp', 'tps']}, 04:56:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['dromaeo_dom']}, 04:56:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['a11yr', 04:56:55 INFO - 'ts_paint', 04:56:55 INFO - 'tpaint', 04:56:55 INFO - 'sessionrestore', 04:56:55 INFO - 'sessionrestore_no_auto_restore', 04:56:55 INFO - 'tabpaint']}, 04:56:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:55 INFO - 'ts_paint', 04:56:55 INFO - 'tpaint', 04:56:55 INFO - 'sessionrestore', 04:56:55 INFO - 'sessionrestore_no_auto_restore', 04:56:55 INFO - 'tabpaint']}, 04:56:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:56:55 INFO - 'ts_paint', 04:56:55 INFO - 'tpaint', 04:56:55 INFO - 'sessionrestore', 04:56:55 INFO - 'sessionrestore_no_auto_restore', 04:56:55 INFO - 'tabpaint']}, 04:56:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:56:55 INFO - 'ts_paint', 04:56:55 INFO - 'tpaint', 04:56:55 INFO - 'sessionrestore', 04:56:55 INFO - 'sessionrestore_no_auto_restore', 04:56:55 INFO - 'tabpaint']}, 04:56:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['a11yr', 04:56:55 INFO - 'ts_paint', 04:56:55 INFO - 'tpaint', 04:56:55 INFO - 'sessionrestore', 04:56:55 INFO - 'sessionrestore_no_auto_restore', 04:56:55 INFO - 'tabpaint']}, 04:56:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['a11yr', 04:56:55 INFO - 'ts_paint', 04:56:55 INFO - 'tpaint', 04:56:55 INFO - 'sessionrestore', 04:56:55 INFO - 'sessionrestore_no_auto_restore', 04:56:55 INFO - 'tabpaint']}, 04:56:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['tsvgx', 04:56:55 INFO - 'tsvgr_opacity', 04:56:55 INFO - 'tart', 04:56:55 INFO - 'tscrollx', 04:56:55 INFO - 'cart']}, 04:56:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:55 INFO - 'tsvgr_opacity', 04:56:55 INFO - 'tart', 04:56:55 INFO - 'tscrollx', 04:56:55 INFO - 'cart']}, 04:56:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-e10s'], 04:56:55 INFO - 'tests': ['tp5o']}, 04:56:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:55 INFO - 'tests': ['tp5o']}, 04:56:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:55 INFO - 'talos_options': ['--disable-e10s', 04:56:55 INFO - '--xperf_path', 04:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:55 INFO - 'tests': ['tp5n']}, 04:56:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:55 INFO - 'talos_options': ['--xperf_path', 04:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:55 INFO - 'tests': ['tp5n']}}, 04:56:55 INFO - 'talos.zip': {'path': '', 04:56:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:55 INFO - Running post-action listener: _resource_record_post_action 04:56:55 INFO - ##### 04:56:55 INFO - ##### Running create-virtualenv step. 04:56:55 INFO - ##### 04:56:55 INFO - Running pre-action listener: _resource_record_pre_action 04:56:55 INFO - Running main action method: create_virtualenv 04:56:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:55 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 04:56:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:56:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:55 INFO - Using real prefix '/tools/python27' 04:56:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:58 INFO - Installing pip.................done. 04:56:58 INFO - Return code: 0 04:56:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:58 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 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:56:58 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 04:56:58 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 04:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:58 INFO - 'HOME': '/Users/cltbld', 04:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:58 INFO - 'LOGNAME': 'cltbld', 04:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:58 INFO - 'MOZ_NO_REMOTE': '1', 04:56:58 INFO - 'NO_EM_RESTART': '1', 04:56:58 INFO - 'PAGER': '/bin/cat', 04:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:58 INFO - 'PWD': '/builds/slave/test', 04:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:58 INFO - 'SHELL': '/bin/bash', 04:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:56:58 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:58 INFO - 'USER': 'cltbld', 04:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:58 INFO - 'XPC_FLAGS': '0x0', 04:56:58 INFO - 'XPC_SERVICE_NAME': '0', 04:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:59 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 04:56:59 INFO - Cleaning up... 04:56:59 INFO - Return code: 0 04:56:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:56: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')]} 04:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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')]} 04:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:59 INFO - 'HOME': '/Users/cltbld', 04:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:59 INFO - 'LOGNAME': 'cltbld', 04:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:59 INFO - 'MOZ_NO_REMOTE': '1', 04:56:59 INFO - 'NO_EM_RESTART': '1', 04:56:59 INFO - 'PAGER': '/bin/cat', 04:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:59 INFO - 'PWD': '/builds/slave/test', 04:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:59 INFO - 'SHELL': '/bin/bash', 04:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:56:59 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:59 INFO - 'USER': 'cltbld', 04:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:59 INFO - 'XPC_FLAGS': '0x0', 04:56:59 INFO - 'XPC_SERVICE_NAME': '0', 04:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:59 INFO - Downloading/unpacking psutil>=0.7.1 04:56:59 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 04:56:59 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 04:56:59 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 04:56:59 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 04:56:59 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 04:56:59 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 04:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:02 INFO - Installing collected packages: psutil 04:57:02 INFO - Running setup.py install for psutil 04:57:02 INFO - building 'psutil._psutil_osx' extension 04:57:02 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 04:57:02 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 04:57:02 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 04:57:02 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 04:57:02 INFO - building 'psutil._psutil_posix' extension 04:57:02 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 04:57:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:57:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:57:02 INFO - ^ 04:57:02 INFO - 1 warning generated. 04:57:02 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 04:57:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:03 INFO - Successfully installed psutil 04:57:03 INFO - Cleaning up... 04:57:03 INFO - Return code: 0 04:57:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:57:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:03 INFO - 'HOME': '/Users/cltbld', 04:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:03 INFO - 'LOGNAME': 'cltbld', 04:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:03 INFO - 'MOZ_NO_REMOTE': '1', 04:57:03 INFO - 'NO_EM_RESTART': '1', 04:57:03 INFO - 'PAGER': '/bin/cat', 04:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:03 INFO - 'PWD': '/builds/slave/test', 04:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:03 INFO - 'SHELL': '/bin/bash', 04:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:57:03 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:03 INFO - 'USER': 'cltbld', 04:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:03 INFO - 'XPC_FLAGS': '0x0', 04:57:03 INFO - 'XPC_SERVICE_NAME': '0', 04:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:57:05 INFO - Installing collected packages: mozsystemmonitor 04:57:05 INFO - Running setup.py install for mozsystemmonitor 04:57:06 INFO - Successfully installed mozsystemmonitor 04:57:06 INFO - Cleaning up... 04:57:06 INFO - Return code: 0 04:57:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57:06 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')]} 04:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:06 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')]} 04:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:06 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 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:57:06 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 04:57:06 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 04:57:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:57:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:06 INFO - 'HOME': '/Users/cltbld', 04:57:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:06 INFO - 'LOGNAME': 'cltbld', 04:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:06 INFO - 'MOZ_NO_REMOTE': '1', 04:57:06 INFO - 'NO_EM_RESTART': '1', 04:57:06 INFO - 'PAGER': '/bin/cat', 04:57:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:06 INFO - 'PWD': '/builds/slave/test', 04:57:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:06 INFO - 'SHELL': '/bin/bash', 04:57:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:57:06 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:57:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:06 INFO - 'USER': 'cltbld', 04:57:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:06 INFO - 'XPC_FLAGS': '0x0', 04:57:06 INFO - 'XPC_SERVICE_NAME': '0', 04:57:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:09 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 04:57:09 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 04:57:09 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 04:57:09 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 04:57:09 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 04:57:09 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 04:57:10 INFO - Downloading docopt-0.6.1.tar.gz 04:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:10 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:10 INFO - Running setup.py install for blobuploader 04:57:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:57:10 INFO - Running setup.py install for requests 04:57:10 INFO - Running setup.py install for docopt 04:57:10 INFO - Successfully installed blobuploader requests docopt 04:57:10 INFO - Cleaning up... 04:57:10 INFO - Return code: 0 04:57:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:10 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 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:57:10 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 04:57:10 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 04:57:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:57:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:10 INFO - 'HOME': '/Users/cltbld', 04:57:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:10 INFO - 'LOGNAME': 'cltbld', 04:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:10 INFO - 'MOZ_NO_REMOTE': '1', 04:57:10 INFO - 'NO_EM_RESTART': '1', 04:57:10 INFO - 'PAGER': '/bin/cat', 04:57:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:10 INFO - 'PWD': '/builds/slave/test', 04:57:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:10 INFO - 'SHELL': '/bin/bash', 04:57:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:57:10 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:57:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:10 INFO - 'USER': 'cltbld', 04:57:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:10 INFO - 'XPC_FLAGS': '0x0', 04:57:10 INFO - 'XPC_SERVICE_NAME': '0', 04:57:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-QQVf4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-CrIIQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-pWiTZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4EtNr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-32J9x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Gadwwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-EG6zK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:11 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-p12Xfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-8MIYjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-vF4wre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-BFv1gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-T995D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-bKIZJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-dY7Sjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-7z7dBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-lLrvEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:12 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-cELjdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:13 INFO - Running setup.py install for manifestparser 04:57:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:13 INFO - Running setup.py install for mozcrash 04:57:13 INFO - Running setup.py install for mozdebug 04:57:13 INFO - Running setup.py install for mozdevice 04:57:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:57:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:13 INFO - Running setup.py install for mozfile 04:57:13 INFO - Running setup.py install for mozhttpd 04:57:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:13 INFO - Running setup.py install for mozinfo 04:57:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Running setup.py install for mozInstall 04:57:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Running setup.py install for mozleak 04:57:14 INFO - Running setup.py install for mozlog 04:57:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Running setup.py install for moznetwork 04:57:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Running setup.py install for mozprocess 04:57:14 INFO - Running setup.py install for mozprofile 04:57:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:14 INFO - Running setup.py install for mozrunner 04:57:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:15 INFO - Running setup.py install for mozscreenshot 04:57:15 INFO - Running setup.py install for moztest 04:57:15 INFO - Running setup.py install for mozversion 04:57:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:57:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:15 INFO - Cleaning up... 04:57:15 INFO - Return code: 0 04:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:15 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 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:57:15 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 04:57:15 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 04:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:15 INFO - 'HOME': '/Users/cltbld', 04:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:15 INFO - 'LOGNAME': 'cltbld', 04:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:15 INFO - 'MOZ_NO_REMOTE': '1', 04:57:15 INFO - 'NO_EM_RESTART': '1', 04:57:15 INFO - 'PAGER': '/bin/cat', 04:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:15 INFO - 'PWD': '/builds/slave/test', 04:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:15 INFO - 'SHELL': '/bin/bash', 04:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:57:15 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:15 INFO - 'USER': 'cltbld', 04:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:15 INFO - 'XPC_FLAGS': '0x0', 04:57:15 INFO - 'XPC_SERVICE_NAME': '0', 04:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:15 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-uRz6Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:15 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)) 04:57:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:15 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-pIf9F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:16 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)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-ApRWWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:16 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)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-SnyLmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:16 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)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-LVAWxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:16 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)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Hfinq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:16 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)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-hzL6Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:16 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)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-jj62CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:16 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)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-RXuqFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:16 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)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-UXy3rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:16 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-3OcIO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:17 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)) 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-7GbUgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-r7GhHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:17 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)) 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-ycq7VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-mJRgz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:17 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)) 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-zH4toV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:17 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)) 04:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:17 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-kS2m0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:17 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)) 04:57:17 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)) 04:57:17 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)) 04:57:17 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)) 04:57:17 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)) 04:57:17 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)) 04:57:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:20 INFO - Downloading blessings-1.6.tar.gz 04:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:20 INFO - Installing collected packages: blessings 04:57:20 INFO - Running setup.py install for blessings 04:57:20 INFO - Successfully installed blessings 04:57:20 INFO - Cleaning up... 04:57:20 INFO - Return code: 0 04:57:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:20 INFO - Reading from file tmpfile_stdout 04:57:20 INFO - Current package versions: 04:57:20 INFO - blessings == 1.6 04:57:20 INFO - blobuploader == 1.2.4 04:57:20 INFO - docopt == 0.6.1 04:57:20 INFO - manifestparser == 1.1 04:57:20 INFO - mozInstall == 1.12 04:57:20 INFO - mozcrash == 0.17 04:57:20 INFO - mozdebug == 0.1 04:57:20 INFO - mozdevice == 0.48 04:57:20 INFO - mozfile == 1.2 04:57:20 INFO - mozhttpd == 0.7 04:57:20 INFO - mozinfo == 0.9 04:57:20 INFO - mozleak == 0.1 04:57:20 INFO - mozlog == 3.1 04:57:20 INFO - moznetwork == 0.27 04:57:20 INFO - mozprocess == 0.22 04:57:20 INFO - mozprofile == 0.28 04:57:20 INFO - mozrunner == 6.11 04:57:20 INFO - mozscreenshot == 0.1 04:57:20 INFO - mozsystemmonitor == 0.0 04:57:20 INFO - moztest == 0.7 04:57:20 INFO - mozversion == 1.4 04:57:20 INFO - psutil == 3.1.1 04:57:20 INFO - requests == 1.2.3 04:57:20 INFO - wsgiref == 0.1.2 04:57:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:20 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 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:57:20 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 04:57:20 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 04:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:20 INFO - 'HOME': '/Users/cltbld', 04:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:20 INFO - 'LOGNAME': 'cltbld', 04:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:20 INFO - 'MOZ_NO_REMOTE': '1', 04:57:20 INFO - 'NO_EM_RESTART': '1', 04:57:20 INFO - 'PAGER': '/bin/cat', 04:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:20 INFO - 'PWD': '/builds/slave/test', 04:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:20 INFO - 'SHELL': '/bin/bash', 04:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:57:20 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:20 INFO - 'USER': 'cltbld', 04:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:20 INFO - 'XPC_FLAGS': '0x0', 04:57:20 INFO - 'XPC_SERVICE_NAME': '0', 04:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 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)) 04:57:20 INFO - Cleaning up... 04:57:21 INFO - Return code: 0 04:57:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:21 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 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:57:21 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 04:57:21 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 04:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:21 INFO - 'HOME': '/Users/cltbld', 04:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:21 INFO - 'LOGNAME': 'cltbld', 04:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:21 INFO - 'MOZ_NO_REMOTE': '1', 04:57:21 INFO - 'NO_EM_RESTART': '1', 04:57:21 INFO - 'PAGER': '/bin/cat', 04:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:21 INFO - 'PWD': '/builds/slave/test', 04:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:21 INFO - 'SHELL': '/bin/bash', 04:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:57:21 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:21 INFO - 'USER': 'cltbld', 04:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:21 INFO - 'XPC_FLAGS': '0x0', 04:57:21 INFO - 'XPC_SERVICE_NAME': '0', 04:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:21 INFO - Downloading/unpacking jsonschema 04:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:23 INFO - Downloading/unpacking functools32 (from jsonschema) 04:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:24 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:24 INFO - warning: no files found matching '*.txt' 04:57:24 INFO - no previously-included directories found matching 'build' 04:57:24 INFO - no previously-included directories found matching 'dist' 04:57:24 INFO - no previously-included directories found matching '.git*' 04:57:24 INFO - Installing collected packages: jsonschema, functools32 04:57:24 INFO - Running setup.py install for functools32 04:57:24 INFO - warning: no files found matching '*.txt' 04:57:24 INFO - no previously-included directories found matching 'build' 04:57:24 INFO - no previously-included directories found matching 'dist' 04:57:24 INFO - no previously-included directories found matching '.git*' 04:57:24 INFO - Successfully installed jsonschema functools32 04:57:24 INFO - Cleaning up... 04:57:24 INFO - Return code: 0 04:57:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3d0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f982b560f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, '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.nfn1awkn84/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.wddJi05ByA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:24 INFO - 'HOME': '/Users/cltbld', 04:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:24 INFO - 'LOGNAME': 'cltbld', 04:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:24 INFO - 'MOZ_NO_REMOTE': '1', 04:57:24 INFO - 'NO_EM_RESTART': '1', 04:57:24 INFO - 'PAGER': '/bin/cat', 04:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:24 INFO - 'PWD': '/builds/slave/test', 04:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:24 INFO - 'SHELL': '/bin/bash', 04:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:57:24 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:24 INFO - 'USER': 'cltbld', 04:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:24 INFO - 'XPC_FLAGS': '0x0', 04:57:24 INFO - 'XPC_SERVICE_NAME': '0', 04:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:24 INFO - Downloading/unpacking flake8 04:57:24 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 04:57:24 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 04:57:24 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 04:57:24 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 04:57:24 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 04:57:24 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 04:57:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:57:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:57:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:28 INFO - no previously-included directories found matching 'docs/_build' 04:57:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:57:28 INFO - Running setup.py install for pep8 04:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:57:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:57:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:57:28 INFO - no previously-included directories found matching 'docs/_build' 04:57:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:57:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:57:28 INFO - Cleaning up... 04:57:28 INFO - Return code: 0 04:57:28 INFO - Running post-action listener: _resource_record_post_action 04:57:28 INFO - Running post-action listener: _start_resource_monitoring 04:57:28 INFO - Starting resource monitoring. 04:57:28 INFO - ##### 04:57:28 INFO - ##### Running install step. 04:57:28 INFO - ##### 04:57:28 INFO - Running pre-action listener: _resource_record_pre_action 04:57:28 INFO - Running main action method: install 04:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:29 INFO - Reading from file tmpfile_stdout 04:57:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:57:29 INFO - Reading from file tmpfile_stdout 04:57:29 INFO - Output received: 04:57:29 INFO - Usage: mozinstall [options] installer 04:57:29 INFO - Options: 04:57:29 INFO - -h, --help show this help message and exit 04:57:29 INFO - -d DEST, --destination=DEST 04:57:29 INFO - Directory to install application into. [default: 04:57:29 INFO - "/builds/slave/test"] 04:57:29 INFO - --app=APP Application being installed. [default: firefox] 04:57:29 INFO - mkdir: /builds/slave/test/build/application 04:57:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:58:02 INFO - Reading from file tmpfile_stdout 04:58:02 INFO - Output received: 04:58:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:58:02 INFO - Running post-action listener: _resource_record_post_action 04:58:02 INFO - ##### 04:58:02 INFO - ##### Running run-tests step. 04:58:02 INFO - ##### 04:58:02 INFO - Running pre-action listener: _resource_record_pre_action 04:58:02 INFO - Running main action method: run_tests 04:58:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:02 INFO - 2016-04-20 04:58:02.908 screenresolution[2505:28639] starting screenresolution argv=screenresolution get 04:58:02 INFO - 2016-04-20 04:58:02.911 screenresolution[2505:28639] Display 0: 1600x1200x32@60 04:58:02 INFO - 2016-04-20 04:58:02.917 screenresolution[2506:28642] starting screenresolution argv=screenresolution list 04:58:02 INFO - Available Modes on Display 0 04:58:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:03 INFO - Intel Iris: 04:58:03 INFO - Chipset Model: Intel Iris 04:58:03 INFO - Type: GPU 04:58:03 INFO - Bus: Built-In 04:58:03 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:03 INFO - Vendor: Intel (0x8086) 04:58:03 INFO - Device ID: 0x0a2e 04:58:03 INFO - Revision ID: 0x0009 04:58:03 INFO - Displays: 04:58:03 INFO - Display: 04:58:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:03 INFO - Display Serial Number: 1600x1200 60 04:58:03 INFO - Main Display: Yes 04:58:03 INFO - Mirror: Off 04:58:03 INFO - Online: Yes 04:58:03 INFO - Rotation: Supported 04:58:03 INFO - Return code: 0 04:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:03 INFO - Python 2.7.3 04:58:03 INFO - Return code: 0 04:58:03 INFO - grabbing minidump binary from tooltool 04:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:03 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b25fe00>, '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 0x10b0c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b25ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:03 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 04:58:03 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 04:58:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:03 INFO - Return code: 0 04:58:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:58:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:58:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:58:04 INFO - Return code: 0 04:58:04 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/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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 04:58:04 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/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --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 04:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nfn1awkn84/Render', 04:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:04 INFO - 'HOME': '/Users/cltbld', 04:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:04 INFO - 'LOGNAME': 'cltbld', 04:58:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:04 INFO - 'MOZ_NO_REMOTE': '1', 04:58:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:04 INFO - 'NO_EM_RESTART': '1', 04:58:04 INFO - 'PAGER': '/bin/cat', 04:58:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:04 INFO - 'PWD': '/builds/slave/test', 04:58:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:04 INFO - 'SHELL': '/bin/bash', 04:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wddJi05ByA/Listeners', 04:58:04 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:04 INFO - 'USER': 'cltbld', 04:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:04 INFO - 'XPC_FLAGS': '0x0', 04:58:04 INFO - 'XPC_SERVICE_NAME': '0', 04:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:04 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/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--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 04:58:04 INFO - mozversion application_buildid: 20160420025138 04:58:04 INFO - mozversion application_changeset: f05a1242fb29023bd7ebc492897ed3d6907733c7 04:58:04 INFO - mozversion application_display_name: Nightly 04:58:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:04 INFO - mozversion application_name: Firefox 04:58:04 INFO - mozversion application_remotingname: firefox 04:58:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:58:04 INFO - mozversion application_vendor: Mozilla 04:58:04 INFO - mozversion application_version: 48.0a1 04:58:04 INFO - mozversion platform_buildid: 20160420025138 04:58:04 INFO - mozversion platform_changeset: f05a1242fb29023bd7ebc492897ed3d6907733c7 04:58:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:58:04 INFO - mozversion platform_version: 48.0a1 04:58:04 INFO - using testdate: 1461153484 04:58:04 INFO - actual date: 1461153484 04:58:04 INFO - starting webserver on 'localhost:61909' 04:58:04 INFO - SUITE-START | Running 2 tests 04:58:04 INFO - TEST-START | dromaeo_css 04:58:04 INFO - operating with platform_type : mac_ 04:58:04 INFO - Initialising browser for dromaeo_css test... 04:58:04 INFO - TEST-INFO | started process 2524 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpzhshk2/profile http://localhost:61909/getInfo.html) 04:58:07 INFO - PROCESS | 2524 | __metrics Screen width/height:1600/1200 04:58:07 INFO - PROCESS | 2524 | colorDepth:24 04:58:07 INFO - PROCESS | 2524 | Browser inner width/height: 1024/689 04:58:07 INFO - PROCESS | 2524 | __metrics 04:58:07 ERROR - PROCESS | 2524 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 04:58:08 INFO - TEST-INFO | 2524: exit 0 04:58:08 INFO - Browser initialized. 04:58:08 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:08 INFO - TEST-INFO | started process 2527 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpzhshk2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:20 INFO - PROCESS | 2527 | RSS: Main: 247898112 04:58:20 INFO - PROCESS | 2527 | 04:59:10 INFO - PROCESS | 2527 | 1461153550024 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:01:20 INFO - PROCESS | 2527 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61909/tests/dromaeo/cssquery-ext.html) 05:01:21 INFO - PROCESS | 2527 | RSS: Main: 260403200 05:01:21 INFO - PROCESS | 2527 | 05:04:24 INFO - PROCESS | 2527 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-ext.html (next: http://localhost:61909/tests/dromaeo/cssquery-jquery.html) 05:04:24 INFO - PROCESS | 2527 | RSS: Main: 272076800 05:04:24 INFO - PROCESS | 2527 | 05:07:26 INFO - PROCESS | 2527 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61909/tests/dromaeo/cssquery-mootools.html) 05:07:27 INFO - PROCESS | 2527 | RSS: Main: 274124800 05:07:27 INFO - PROCESS | 2527 | 05:10:28 INFO - PROCESS | 2527 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61909/tests/dromaeo/cssquery-prototype.html) 05:10:29 INFO - PROCESS | 2527 | RSS: Main: 275656704 05:10:29 INFO - PROCESS | 2527 | 05:13:32 INFO - PROCESS | 2527 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61909/tests/dromaeo/cssquery-yui.html) 05:13:32 INFO - PROCESS | 2527 | RSS: Main: 278511616 05:13:32 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | Cycle 1(1): loaded http://localhost:61909/tests/dromaeo/cssquery-yui.html (next: http://localhost:61909/tests/dromaeo/cssquery-dojo.html) 05:16:35 INFO - PROCESS | 2527 | RSS: Main: 279744512 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | __start_tp_report 05:16:35 INFO - PROCESS | 2527 | _x_x_mozilla_page_load 05:16:35 INFO - PROCESS | 2527 | _x_x_mozilla_page_load_details 05:16:35 INFO - PROCESS | 2527 | |i|pagename|runs| 05:16:35 INFO - PROCESS | 2527 | |0;dojo.html;2971.004713421004;3438.192024874155;3507.508948747174;3511.139770756165;3554.4490603956365;5784.334801497824;5799.594028418007;5814.447627475393;5838.124281357798;5842.47417732404;5730.255066841305;5816.825495235139;5905.881882362351;5991.610545314563;5997.790077347294;5278.340207474056;5357.919631205535;5391.919121213185;5407.810726624569;5426.104692725715;78.98624106836549;5295.549878260334;5346.812861549846;5381;5463.3717122530825;4583.899864032642;5248.317718696564;5333.599980001477;5353.116735738598;5368.114261146906;4417.646588272931;5265.157574788054;5427.457254274541;5432.185172224198;5434.402215756264;4572.171131547374;5254.106801843695;5289.7619607117385;5345.919811202835;5368.570514358842;5694.373618901917;5781.219535362714;5784.392638772911;5859.736311865933;5885.411458854081;6128.258691089316;6163.198784158076;6249.2813326467585;6279.591826531261;6287.308396076428;6263.373662633746;6290.465310448617;6301.991681331011;6305.432511073979;6313.116163737081;5986.102084687288;6005.279366476007;6010.549208809357;6042.244719410118;6052.394760524;6239.78160764371;6284.717187726564;6347.174867267226;6363.459105975951;6420.711068001951;6229.96885015572;6293.087502312139;6294.653794041372;6304.432601065926;6317.46301564363;6264.154339164245;6328.810135695937;6330.968345158245;6355.809325720235;6363.840903977345;6107.15847211733;6214.130021796952;6233.2208473940755;6280.5603607747935;6303.117563541108;6163.630182188993;6171.166892469549;6248.062790581449;6252.155958945576;6271.592346497463;4277.101808620162;4949.257611358325;5011.599072074226;5014.2979982802435;5014.749262536859;4447.555244475527;4451.888702782391;4521.186186486399;4555.157295900269;4586.197415452282;5960.37416071315;5964.910526342108;5967.671778052162;5999.700014999233;6012.278526576752;6289.433950944437;6292.528060395397;6292.842678933063;6311.053341998737;6330.430261276507;5796.3913789052385;5974.820755377345;6061.787837425669;6102.962496375627;6104.816855494342;5464.18037294409;5505.843772807675;5534.308211473566;5556.722163891789;5564.33228012641;6289.308176100717;6510.967445162839;6511.479081673455;6530.8040758777315;6537.182852143482;6230.813075607739;6307.7476900925285;6323;6345.460635846005;6348.428641422294;6433.388828061326;6465.418112369721;6491.967540162269;6513.218413790375;6514.511411644051;6161.137440758387;6192.659403732838;6243.469305109116;6257.4681152102585;6271.216097987752;6216.067589861376;6302.842428939313;6304.905426418699;6310.368963103653;6332.430081292706;6054.091886217103;6223.595466294676;6271.78048768291;6283.497320214463;6299.559030867796;6134.325224225421;6154.861350650144;6210.068489726577;6225.221847269091;6286.5599408041;5068.9239661405845;5977.043673012297;6050.122732203894;6114.144019837316;6216.036514340284;6013.278406591237;6227.50179985591;6234.189555357774;6263.467605253604;6278.717457714322;6038.4867286279405;6111.834843226386;6132.233470816148;6151.907721384272;6156.29202641702 05:16:35 INFO - PROCESS | 2527 | |1;ext.html;478.69841999540284;529.1982646290869;532.3425569421765;572.5333852909881;577.7948828166002;30139.547906781387;38150.42774358383;38240.42639360412;38248.23503529928;38270.61729382709;40505.59494405055;40573.797131014304;40761.59238407615;40989.18021639565;41087.178256434854;9431.151196392324;9548.28387870909;9575;9651.758706032335;9657.565409556586;9451.432914025147;9460.24318054554;9498.240140788721;9608;9623.374480658735;9468.33721639482;9477.383970041925;9589.993050729678;9619.759506012371;9619.80760384792;9381;9496.192823610001;9585.472798996052;9641.662541811073;9642.71071867845;9478.90521094787;9491.90508094924;9562.808743825153;9612.279079069098;9612.471314077722;32523;32950.02299862016;37615.247695045946;37666.43500347497;37745.81127094347;2711.7288271172924;2961.570572267031;2980.0388010380184;3279.3277378137423;3314.3537010283003;25616.743832561624;26249.73750262492;26367.73632263672;26854.060107896326;27778.583321250197;2380.8928598213124;2650.562657161566;2708.8645567721537;2747.4367754610257;2795.0636536760207;354826;357752.2112389447;359861.2006939975;360701;361205;58025.12962305569;58428.83142337215;58429.70785146047;58490.4150958485;58498.83002339929;66389.33610663928;66471.66764166148;67683.66158169178;68137.97793033108;68309.65845170742;16765.497035088967;16928.984260944137;16978.066206358522;16985.065821379696;16997.40509082201;12868.742625147632;12883.613491595268;13017.804732929013;13042.54351097707;13074.673133171556;19087.904560477386;19234.80765192358;19299;19344.70982935257;19717.014149292478;8240.670373185125;8380.748577542683;8446.831063378699;8456.957715211385;8489.490630562186;939.3518472254123;1003.713941526676;1054.7310435838965;1112.5327362507767;1121.4224674292745;26222.688865556647;29550.704492954796;29793.25516862096;29969.700302997127;30106.54840177399;1048.496721573649;1068.9358638481715;1077.671310250381;1174.9190744515067;1204.3921364977853;15167;15429.459968901034;15467.071975681494;15513;15531.45639902598;639084.8045759834;639573;646711;650999;652846;48113.5188648116;53989.73005134949;55740.88518229694;57186.85626287451;57996;1430.7853821926585;1474.9852501475063;1487.2935355705954;1489.2553723138215;1523.1850959736487;27125.50809705485;28522.859085637174;29159.85420072886;29272.56091158592;29888;43858;50497.24254136264;50980.74509627428;51169;51413.22880156726;416311;419072.80927190336;420088;420778;421412;25459.796245684425;25871;26166.86916565405;26627;26754.59868102019;45737.77131114323;46008.769956151344;46332.30501542412;46819.76590117028;47233.76383118062;36920.26159476849;38185.80907095447;38515.807420962716;38540;38759.80620096994;37093;37275.81362093172;37597.81201093977;38089.6191038086;38355;32037.519437208928;37234;37315.440268395454;37908;38303.04242393962;31556;33660.99017029493;33679.32641347208;33795.4930676045;33867.4919876207;23498.64752028755;24353.756462435147;24574.631380529663;24660.630090548297;24706 05:16:35 INFO - PROCESS | 2527 | |2;jquery.html;342.8628548580567;386.67948954320997;395.53327074052606;410.9691773117015;415.04125470163905;17506.212220450077;18855.245790168377;18880.62238755224;20439;20706.482337941557;17056.573585660364;19923.90038049808;20395.878226697525;20806.375808725763;21011.264605738765;5573.6098473106895;5806.535477161828;5893.674521575234;5988.401159883999;6076.3316035236085;4988.301637770715;5054.9494505054845;5941.792037278696;5956.642601443906;6017.879642407149;4626.398568186131;5478.91781623276;5842.44496772808;5899.941000590004;5925.822225333247;5532.972335138339;5623.465770751793;5639.577031722617;5678.545716342724;5737.627054241482;5618.101103823368;5661.377248502661;5681.630694004876;5699.544036477072;5716.514096301819;23491.987634223882;24711.752882471304;25348.619770703455;25539.23382298534;25787.871060644764;2036.694495825623;2080.2615071649648;2164.1343462614923;2340.6254999200046;2496.2760799368343;9939.403635781804;10026.19790416765;10271.332363396356;11057.778844423066;14879.256037198096;1689.4171510828867;1766.5230387795223;1778.9021603811784;1788.5707430216785;1810.4749622609427;110287;117435;117903.41048294789;119867.80132198654;120151;10073.791145062492;11098.2786118902;11509.76980460386;11609.477573509212;11827.704307392212;14613.26933653313;14622.341994610268;14874.851251487564;15100.187977442778;15181.089134651957;7125.82185445368;8510.31917446615;8660.95669521661;8740.781480462912;8917.910820891837;6391.42477177047;8554.957225213833;8616.698415555426;8803.339749518684;8837.248833849195;4543.1822271990695;4653.7207767534055;4655.138799322136;4691.296305554194;4713.198756211452;1748.2482532511142;2001.5296405344732;2027.7059826325394;2040.8163265306193;2058;784.9489783164076;869.443556124081;937.8077494113827;993.4684943555163;1050.4537640427088;19508.21967121299;19883.701744473845;20169.49576260576;20273.290434835006;20617.793822061587;917.9127982841619;935.9485228312508;950.467738066671;963.6386355116831;981.4798156976814;9019.819603608023;10618.36289822613;10637.468126593794;10659.89340106589;10664.200184986157;624558;634116;639169;643632;645170;102655;110980;117652.82347176419;117881.41059294649;134464.30706684236;984.886738025122;999.4602914426129;1007.969760907174;1008.455434065611;1012.1982870490539;14888.776668349767;15328.233588320762;17740.019367269273;18001.279948802425;18377.80544264672;42146;43106;50446.24330635117;51279.743601281756;51460;73331.63334183295;73491.5905045699;73543;75007.49985000379;75829.6208518954;7845.490043147177;7871.48835325702;7927.286544210818;8019.679212831421;8091.55496447701;10650.147988161083;11478.598249061242;12198.085143614442;12217.572384966483;12300.938495307466;10226.181905447695;10394.844077338998;10773.299735517166;11084;11122.61070862516;10509.684709458728;10603.310784798963;10784.245102842726;10889.836652450062;10970.945145274223;11098.2786118902;11281.984621384116;11432.82850757256;11433.371164586028;11479.655610331703;6896.172459304916;7345.595992220479;7385.446091543048;7801.3368863644955;8366.372522060992;7913.881291780743;9721.611135554498;10790.406527640742;10853;11173.106151507698 05:16:35 INFO - PROCESS | 2527 | |3;mootools.html;1521.634807646165;1590.00624609619;1838.604699989503;1933.8936358500287;1944.6013567218722;8004.319632831216;8546.14538546146;8553.572321383921;8790.6923257686;8797.07630698777;8573.314134869212;8616;8659.177378149066;8715.128487151282;8719.08449612791;2442.584760590704;2449.448874003353;2449.7672721091467;2482.416632091457;2490.651308816758;2431.805455563551;2455.8894849731805;2489.614109812973;2495.663085483455;2497.6003839385703;2459.0901366494422;2462.569050416179;2475.195561442529;2496.0639760089966;2496.6629505016863;2429.7122525061745;2436.8537887726793;2436.9878150609134;2457.5453541094867;2476.578981573137;2314.895829687668;2418.129473389596;2423.4062654649547;2460.3972026853357;2477.2939712182124;8719.476831390073;8795.912040879573;8846.292296616255;8846.380753347268;8861.645534178626;5264;5380.112281473591;5465.453454654543;5488.368837583689;5499.120140777456;3529.876454324112;3549.361114999299;3555.466679997995;3556.822158892045;3612.6929211017095;1026.9024442677933;1040.921930855189;1041.4844651897283;1054.6256079091966;1057.143713591993;10822.538957240751;10899.455027248607;11640.243384180087;11707.76584468306;11759.823602645967;4749.501302363271;4807.759612019455;4825.662203645781;4935.333729946483;4986.326845875833;9954.850677239847;9974.650887218913;9986.700398988041;9989.350692204984;9997.200223982209;5272.182811664198;5283.286756287929;5316.0962636351915;5332.173513105475;5355.062863998784;4387.583179597997;4774.498677638868;4843.927341089887;4906.975465122723;4943.703377797344;4027.436158937751;4033.7579745214794;4100.302948498763;4113.382992551082;4145.709800313949;1347.4946894914408;1366.794980752895;1370.9725805483833;1371.437670745478;1379.7861331493634;796.1004065406054;822.8847961285425;852.820907609409;868.4311775786744;872.419840805857;5556.861078473071;5598.944010559923;5948.702564871825;6008.489278411296;6128.233970753656;779.3103103753219;863.3136656358084;899.5547204133995;936.8501039833594;979.5983646704817;3686.4286035664513;3861.7489863158803;3910.4720862683744;3931.9606803931592;3932.7640341579595;10198.286119971679;10500.264981451377;10639.787204255872;10668.679939601825;10739.248252622398;10344;10448.895511044791;10625.521851516545;10643.201759868041;10650.627228046982;8072.152423995513;8143.226393492727;8207.425480216447;8234.794130146794;8241.50550966944;5650.434956504481;5904.61619994699;5939.2575928009;6034.517238620988;6039.667818270037;9689.70930872075;9934.45360505179;9943.154831839374;10007.749806254902;10020.448875311637;9797.853032204664;9874.753131171778;9918.454485003394;10010.799784004425;10174.949125254327;6070.939290607037;6116.908246376397;7490.213527579525;7535.397168226638;7645.770626881203;8225.712100076707;8269.503829770232;8283.337333013224;8303.169683031649;8353.039400469024;7288.416926645961;7388;7460.589667568119;7468.626568671436;7520.435967302365;7182.748603798842;7282.45381596393;7336.926630733625;7359.705611775683;7375.373093286916;6718.328167183243;6720.294369091371;6748.966255168692;6767.1879374475375;6811.284815094542;4753.334533165429;4770.260609605517;4837.129316723023;4863.148948933852;5004.974975125101;4356.346548017823;4465.7767111644935;4645.3032045193495;4679.485256621837;4726.19654658702 05:16:35 INFO - PROCESS | 2527 | |4;prototype.html;319.6372117646471;326.05444211785823;334.5450187744668;335.41637550661846;338.70025027850346;5160.535551800337;5324.893502129955;5447.564194864412;6009.969950150248;6049.153118563405;5212.452692467293;5424.725189580456;6270.739215607892;6351.460125889305;6401.967990160043;4065.87802365928;4263.786810659462;4281.336392859112;4736.4789873114105;4778.116048531033;4613.976930115345;4714.882127946812;4740.810367585293;4744.217204161309;4753.1919573672385;3919.962029427188;4063.207674503473;4623.930641040387;4675.275332323478;4718.315844202589;4473.015936493983;4738.739369334685;4746.501617330199;4762.833300834489;4765.617970788485;3874.4769456123345;4021.959780402217;4070.287699652549;4071.1043570414463;4074.2258970795456;6051.576389652726;6068.939310606882;6073.635581865058;6125.263589210578;6139.2325959255095;4817.710937343735;5480.780768769245;5488.204210389471;5499.670019798785;5521.199426083235;6585.197232625551;6607.438367738748;6655.900161497581;6716.429103526206;6765.458763298924;4428.357888106207;4471.552844715502;4472.105578884204;4479.3057076153245;4507.797149128297;5331.840044798662;6165.876682466371;7107.872536084106;7129.394001509878;7145.785626431215;4131.814068366931;4256.7445953242905;4539.7049191802425;4549.931751023737;4568.954310456919;4103.179364127186;4609.193391156601;4610.492845786961;4636.4436267647425;4651.62786977041;4543.704659197141;5354.30394048779;5410.48600382963;5494.697791621499;5497.587680923947;6379.617222966544;6531.216254049545;6792.218894827158;6795.2185498667295;6828.590284582841;1518.476125736619;1573.9291731871865;1596.9600759981092;1610.7503336982786;1613.9515814525582;918.4672889723944;926.6015613286216;998.1964518562481;1058.5659879449388;1064.1805809526777;5192.49506583055;5714.485696287271;6231.501479881598;6275.560710750204;6290.087937249074;6065.575409721366;6629.86740265192;6703.195616526048;6952.756653517103;7031.929680703128;5401.648892821954;5945.316288626776;5995.250593675791;6231.1959618172;6291.842703932438;3197.4244635965283;3227.306129182237;3328.3676101541114;3361.798292102482;3653.6529029742132;6985.965070174617;7216.9792458111815;7223.2415596361625;7262.818429539198;7289.063905491082;5887.381824908323;6470.223573171155;6658.86682266352;7191.928080719126;7206.56760594366;5999.580029398075;6820.522563420612;6931.504658323;7092.893606595905;7294.525855819355;6227.906581401192;6404.551681382445;6612.710521448272;6896.827579310558;6909.689063992032;6387.169667943138;6556.18047744032;6868.038474613458;6884.380405763505;6937.479689023243;5644.576656750843;6215.471684906834;6945.20130185015;7198;7246.96376518114;4579.381783459324;4583.289590113538;4589.10512450069;4594.793234304398;4597.793099310606;5550.47270509301;6052.455279024733;6251.218597675291;6448.677566121582;6556.803295901131;5846.532277417881;5974.1934838796205;6348.682565871781;6400.263969643364;6763.898541521783;5917.704114794157;6476.902846457401;6517.9348206517325;6730.125083739083;6790.490713196431;6538.1827271591055;6557.770478033246;6573.1783527059115;6574.638394888327;6587.505937054644;6710.698018589078;6719.428848547928;6725.4283385910785;6755.966220168868;6790.388865002174;6214.751409943732;6553.773914780882;6585.868282634225;6630.867382652416;6658.467322614082 05:16:35 INFO - PROCESS | 2527 | |5;yui.html;588.5644622978991;589.3605438099659;595.6515438468494;596.3410431473222;654.8624788794353;14690.412383504647;14749;15269.541913742578;15276.007059541136;15276.38894444221;13644.72710545791;13645.658858528517;14103.647408814784;14129.36417861196;14172.433102675906;658.5554750543364;891.8171774786153;901.256463417683;948.7722946492827;951.633621055895;918.2883265469248;937.704623043739;939.4363381970832;947.0813311088233;951.1059603972244;908.6637943960711;936.2977766674994;980.8626792249091;990.3315262197988;991.1971303244395;937.3251259093441;946.3375637054055;954.766082309835;981.1415011864618;986.1223511075149;696.2271878215178;714.5926821711627;724.7535837815168;729.941604671625;732.3994324653786;14591.635209119751;14754.336054877449;14964.102153870803;15137.167455789928;15215.31531081104;12589.874101258962;12633.431495582721;12651.493940242379;12685.23888566689;12895.29075900825;9883;9886.703398898044;10019.348742331726;10445.9477702611;10685.41230232337;3521.5421995140723;3613.295407395559;3860.131470419133;3876.8061596920043;4004.0390306326562;83332.58333708292;84083;84204.15795842024;84452.73320900192;86701;9377.484238366955;9442.858357124649;9444.338896277195;9565.091316324939;9624.03759624046;21085.789142108384;21106;21131.577368452545;21155.576888462143;21206.93965301729;6942.51402401827;7047;7101.396381307543;7156.177039640404;7297.416206703557;3145.6225252969334;3843.865464708722;3845.288621605012;3848.749831260959;3850.2492014057552;3079.260977365461;3537.911552211215;3582.390993531106;3640.6177351378255;3641.9453708194396;534.9277847490539;628.5160426471591;635.139386131794;646.812424396929;648.6529706606942;521.2962500624127;590.3270271890049;591.588845752198;609.6037575575912;614.563659801537;6427.325130861286;7584.014078169803;7721.961390193125;8127.959360203161;8140.185981401931;576.7981206577664;578.6614830324223;595.4968051996057;599.6881621556853;600.9038553831366;3165.3714547939358;3655.5613326401003;3873.9612603874166;3927.548331941863;4079.0822065035723;83356.58321708474;91194;91335;91439;93858.53070734603;69773.65113174402;75329;76502.6174869122;77643;78829;51214.719632009495;51898;62582;64387.356126439074;67746;8114.675412983414;8132.146124656826;8152.551609661526;8259.917400825914;8369.288610468178;33794.831025844716;43958.78020609877;44323.556764431945;44363;45004.87487812831;42485;60956.695216523636;62165.13504594869;63531;64134.679326603065;10487.528061237415;10640.733981650521;10847.349159050482;10923.563057477611;11755.294682319089;11911.166218364631;11992.280463172237;12026.458809353775;12158.209716368408;12431.564895228623;11168.944155279496;11175.72060698489;11364.829527556927;11488;11505.367204803817;11149.442527873736;11365.829512557484;11483.196176267915;11582.478788454371;11696.473658685209;10682.946585267024;10976.54499277937;11096.445177741241;11350.886491134983;11634.53461861516;8998.910010899806;9272.490013049348;9306;9820.4107753535;10067.647632332833;7408.8147796303365;8829.293656507592;8965.148310910454;9476.85784713216;9597.9040209597 05:16:35 INFO - PROCESS | 2527 | __end_tp_report 05:16:35 INFO - PROCESS | 2527 | __start_cc_report 05:16:35 INFO - PROCESS | 2527 | _x_x_mozilla_cycle_collect,392 05:16:35 INFO - PROCESS | 2527 | __end_cc_report 05:16:35 INFO - PROCESS | 2527 | __startTimestamp1461154595355__endTimestamp 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | ------- Summary: start ------- 05:16:35 INFO - PROCESS | 2527 | Number of tests: 6 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | [#0] dojo.html Cycles:165 Average:5808.08 Median:6114.14 stddev:806.99 (13.2%) stddev-sans-first:778.17 05:16:35 INFO - PROCESS | 2527 | Values: 2971.0 3438.2 3507.5 3511.1 3554.4 5784.3 5799.6 5814.4 5838.1 5842.5 5730.3 5816.8 5905.9 5991.6 5997.8 5278.3 5357.9 5391.9 5407.8 5426.1 79.0 5295.5 5346.8 5381.0 5463.4 4583.9 5248.3 5333.6 5353.1 5368.1 4417.6 5265.2 5427.5 5432.2 5434.4 4572.2 5254.1 5289.8 5345.9 5368.6 5694.4 5781.2 5784.4 5859.7 5885.4 6128.3 6163.2 6249.3 6279.6 6287.3 6263.4 6290.5 6302.0 6305.4 6313.1 5986.1 6005.3 6010.5 6042.2 6052.4 6239.8 6284.7 6347.2 6363.5 6420.7 6230.0 6293.1 6294.7 6304.4 6317.5 6264.2 6328.8 6331.0 6355.8 6363.8 6107.2 6214.1 6233.2 6280.6 6303.1 6163.6 6171.2 6248.1 6252.2 6271.6 4277.1 4949.3 5011.6 5014.3 5014.7 4447.6 4451.9 4521.2 4555.2 4586.2 5960.4 5964.9 5967.7 5999.7 6012.3 6289.4 6292.5 6292.8 6311.1 6330.4 5796.4 5974.8 6061.8 6103.0 6104.8 5464.2 5505.8 5534.3 5556.7 5564.3 6289.3 6511.0 6511.5 6530.8 6537.2 6230.8 6307.7 6323.0 6345.5 6348.4 6433.4 6465.4 6492.0 6513.2 6514.5 6161.1 6192.7 6243.5 6257.5 6271.2 6216.1 6302.8 6304.9 6310.4 6332.4 6054.1 6223.6 6271.8 6283.5 6299.6 6134.3 6154.9 6210.1 6225.2 6286.6 5068.9 5977.0 6050.1 6114.1 6216.0 6013.3 6227.5 6234.2 6263.5 6278.7 6038.5 6111.8 6132.2 6151.9 6156.3 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | [#1] ext.html Cycles:180 Average:61811.33 Median:37706.12 stddev:131054.95 (347.6%) stddev-sans-first:131341.69 05:16:35 INFO - PROCESS | 2527 | Values: 478.7 529.2 532.3 572.5 577.8 30139.5 38150.4 38240.4 38248.2 38270.6 40505.6 40573.8 40761.6 40989.2 41087.2 9431.2 9548.3 9575.0 9651.8 9657.6 9451.4 9460.2 9498.2 9608.0 9623.4 9468.3 9477.4 9590.0 9619.8 9619.8 9381.0 9496.2 9585.5 9641.7 9642.7 9478.9 9491.9 9562.8 9612.3 9612.5 32523.0 32950.0 37615.2 37666.4 37745.8 2711.7 2961.6 2980.0 3279.3 3314.4 25616.7 26249.7 26367.7 26854.1 27778.6 2380.9 2650.6 2708.9 2747.4 2795.1 354826.0 357752.2 359861.2 360701.0 361205.0 58025.1 58428.8 58429.7 58490.4 58498.8 66389.3 66471.7 67683.7 68138.0 68309.7 16765.5 16929.0 16978.1 16985.1 16997.4 12868.7 12883.6 13017.8 13042.5 13074.7 19087.9 19234.8 19299.0 19344.7 19717.0 8240.7 8380.7 8446.8 8457.0 8489.5 939.4 1003.7 1054.7 1112.5 1121.4 26222.7 29550.7 29793.3 29969.7 30106.5 1048.5 1068.9 1077.7 1174.9 1204.4 15167.0 15429.5 15467.1 15513.0 15531.5 639084.8 639573.0 646711.0 650999.0 652846.0 48113.5 53989.7 55740.9 57186.9 57996.0 1430.8 1475.0 1487.3 1489.3 1523.2 27125.5 28522.9 29159.9 29272.6 29888.0 43858.0 50497.2 50980.7 51169.0 51413.2 416311.0 419072.8 420088.0 420778.0 421412.0 25459.8 25871.0 26166.9 26627.0 26754.6 45737.8 46008.8 46332.3 46819.8 47233.8 36920.3 38185.8 38515.8 38540.0 38759.8 37093.0 37275.8 37597.8 38089.6 38355.0 32037.5 37234.0 37315.4 37908.0 38303.0 31556.0 33661.0 33679.3 33795.5 33867.5 23498.6 24353.8 24574.6 24660.6 24706.0 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | [#2] jquery.html Cycles:180 Average:35301.59 Median:13604.01 stddev:105753.31 (777.4%) stddev-sans-first:106017.40 05:16:35 INFO - PROCESS | 2527 | Values: 342.9 386.7 395.5 411.0 415.0 17506.2 18855.2 18880.6 20439.0 20706.5 17056.6 19923.9 20395.9 20806.4 21011.3 5573.6 5806.5 5893.7 5988.4 6076.3 4988.3 5054.9 5941.8 5956.6 6017.9 4626.4 5478.9 5842.4 5899.9 5925.8 5533.0 5623.5 5639.6 5678.5 5737.6 5618.1 5661.4 5681.6 5699.5 5716.5 23492.0 24711.8 25348.6 25539.2 25787.9 2036.7 2080.3 2164.1 2340.6 2496.3 9939.4 10026.2 10271.3 11057.8 14879.3 1689.4 1766.5 1778.9 1788.6 1810.5 110287.0 117435.0 117903.4 119867.8 120151.0 10073.8 11098.3 11509.8 11609.5 11827.7 14613.3 14622.3 14874.9 15100.2 15181.1 7125.8 8510.3 8661.0 8740.8 8917.9 6391.4 8555.0 8616.7 8803.3 8837.2 4543.2 4653.7 4655.1 4691.3 4713.2 1748.2 2001.5 2027.7 2040.8 2058.0 784.9 869.4 937.8 993.5 1050.5 19508.2 19883.7 20169.5 20273.3 20617.8 917.9 935.9 950.5 963.6 981.5 9019.8 10618.4 10637.5 10659.9 10664.2 624558.0 634116.0 639169.0 643632.0 645170.0 102655.0 110980.0 117652.8 117881.4 134464.3 984.9 999.5 1008.0 1008.5 1012.2 14888.8 15328.2 17740.0 18001.3 18377.8 42146.0 43106.0 50446.2 51279.7 51460.0 73331.6 73491.6 73543.0 75007.5 75829.6 7845.5 7871.5 7927.3 8019.7 8091.6 10650.1 11478.6 12198.1 12217.6 12300.9 10226.2 10394.8 10773.3 11084.0 11122.6 10509.7 10603.3 10784.2 10889.8 10970.9 11098.3 11282.0 11432.8 11433.4 11479.7 6896.2 7345.6 7385.4 7801.3 8366.4 7913.9 9721.6 10790.4 10853.0 11173.1 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | [#3] mootools.html Cycles:180 Average:5680.40 Median:4939.52 stddev:3134.18 (63.5%) stddev-sans-first:3127.39 05:16:35 INFO - PROCESS | 2527 | Values: 1521.6 1590.0 1838.6 1933.9 1944.6 8004.3 8546.1 8553.6 8790.7 8797.1 8573.3 8616.0 8659.2 8715.1 8719.1 2442.6 2449.4 2449.8 2482.4 2490.7 2431.8 2455.9 2489.6 2495.7 2497.6 2459.1 2462.6 2475.2 2496.1 2496.7 2429.7 2436.9 2437.0 2457.5 2476.6 2314.9 2418.1 2423.4 2460.4 2477.3 8719.5 8795.9 8846.3 8846.4 8861.6 5264.0 5380.1 5465.5 5488.4 5499.1 3529.9 3549.4 3555.5 3556.8 3612.7 1026.9 1040.9 1041.5 1054.6 1057.1 10822.5 10899.5 11640.2 11707.8 11759.8 4749.5 4807.8 4825.7 4935.3 4986.3 9954.9 9974.7 9986.7 9989.4 9997.2 5272.2 5283.3 5316.1 5332.2 5355.1 4387.6 4774.5 4843.9 4907.0 4943.7 4027.4 4033.8 4100.3 4113.4 4145.7 1347.5 1366.8 1371.0 1371.4 1379.8 796.1 822.9 852.8 868.4 872.4 5556.9 5598.9 5948.7 6008.5 6128.2 779.3 863.3 899.6 936.9 979.6 3686.4 3861.7 3910.5 3932.0 3932.8 10198.3 10500.3 10639.8 10668.7 10739.2 10344.0 10448.9 10625.5 10643.2 10650.6 8072.2 8143.2 8207.4 8234.8 8241.5 5650.4 5904.6 5939.3 6034.5 6039.7 9689.7 9934.5 9943.2 10007.7 10020.4 9797.9 9874.8 9918.5 10010.8 10174.9 6070.9 6116.9 7490.2 7535.4 7645.8 8225.7 8269.5 8283.3 8303.2 8353.0 7288.4 7388.0 7460.6 7468.6 7520.4 7182.7 7282.5 7336.9 7359.7 7375.4 6718.3 6720.3 6749.0 6767.2 6811.3 4753.3 4770.3 4837.1 4863.1 5005.0 4356.3 4465.8 4645.3 4679.5 4726.2 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | [#4] prototype.html Cycles:180 Average:5352.99 Median:6029.56 stddev:1682.90 (27.9%) stddev-sans-first:1644.67 05:16:35 INFO - PROCESS | 2527 | Values: 319.6 326.1 334.5 335.4 338.7 5160.5 5324.9 5447.6 6010.0 6049.2 5212.5 5424.7 6270.7 6351.5 6402.0 4065.9 4263.8 4281.3 4736.5 4778.1 4614.0 4714.9 4740.8 4744.2 4753.2 3920.0 4063.2 4623.9 4675.3 4718.3 4473.0 4738.7 4746.5 4762.8 4765.6 3874.5 4022.0 4070.3 4071.1 4074.2 6051.6 6068.9 6073.6 6125.3 6139.2 4817.7 5480.8 5488.2 5499.7 5521.2 6585.2 6607.4 6655.9 6716.4 6765.5 4428.4 4471.6 4472.1 4479.3 4507.8 5331.8 6165.9 7107.9 7129.4 7145.8 4131.8 4256.7 4539.7 4549.9 4569.0 4103.2 4609.2 4610.5 4636.4 4651.6 4543.7 5354.3 5410.5 5494.7 5497.6 6379.6 6531.2 6792.2 6795.2 6828.6 1518.5 1573.9 1597.0 1610.8 1614.0 918.5 926.6 998.2 1058.6 1064.2 5192.5 5714.5 6231.5 6275.6 6290.1 6065.6 6629.9 6703.2 6952.8 7031.9 5401.6 5945.3 5995.3 6231.2 6291.8 3197.4 3227.3 3328.4 3361.8 3653.7 6986.0 7217.0 7223.2 7262.8 7289.1 5887.4 6470.2 6658.9 7191.9 7206.6 5999.6 6820.5 6931.5 7092.9 7294.5 6227.9 6404.6 6612.7 6896.8 6909.7 6387.2 6556.2 6868.0 6884.4 6937.5 5644.6 6215.5 6945.2 7198.0 7247.0 4579.4 4583.3 4589.1 4594.8 4597.8 5550.5 6052.5 6251.2 6448.7 6556.8 5846.5 5974.2 6348.7 6400.3 6763.9 5917.7 6476.9 6517.9 6730.1 6790.5 6538.2 6557.8 6573.2 6574.6 6587.5 6710.7 6719.4 6725.4 6756.0 6790.4 6214.8 6553.8 6585.9 6630.9 6658.5 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - PROCESS | 2527 | [#5] yui.html Cycles:180 Average:17448.76 Median:595.57 stddev:24496.00 (4113.0%) stddev-sans-first:24532.00 05:16:35 INFO - PROCESS | 2527 | Values: 588.6 589.4 595.7 596.3 654.9 14690.4 14749.0 15269.5 15276.0 15276.4 13644.7 13645.7 14103.6 14129.4 14172.4 658.6 891.8 901.3 948.8 951.6 918.3 937.7 939.4 947.1 951.1 908.7 936.3 980.9 990.3 991.2 937.3 946.3 954.8 981.1 986.1 696.2 714.6 724.8 729.9 732.4 14591.6 14754.3 14964.1 15137.2 15215.3 12589.9 12633.4 12651.5 12685.2 12895.3 9883.0 9886.7 10019.3 10445.9 10685.4 3521.5 3613.3 3860.1 3876.8 4004.0 83332.6 84083.0 84204.2 84452.7 86701.0 9377.5 9442.9 9444.3 9565.1 9624.0 21085.8 21106.0 21131.6 21155.6 21206.9 6942.5 7047.0 7101.4 7156.2 7297.4 3145.6 3843.9 3845.3 3848.7 3850.2 3079.3 3537.9 3582.4 3640.6 3641.9 534.9 628.5 635.1 646.8 648.7 521.3 590.3 591.6 609.6 614.6 6427.3 7584.0 7722.0 8128.0 8140.2 576.8 578.7 595.5 599.7 600.9 3165.4 3655.6 3874.0 3927.5 4079.1 83356.6 91194.0 91335.0 91439.0 93858.5 69773.7 75329.0 76502.6 77643.0 78829.0 51214.7 51898.0 62582.0 64387.4 67746.0 8114.7 8132.1 8152.6 8259.9 8369.3 33794.8 43958.8 44323.6 44363.0 45004.9 42485.0 60956.7 62165.1 63531.0 64134.7 10487.5 10640.7 10847.3 10923.6 11755.3 11911.2 11992.3 12026.5 12158.2 12431.6 11168.9 11175.7 11364.8 11488.0 11505.4 11149.4 11365.8 11483.2 11582.5 11696.5 10682.9 10976.5 11096.4 11350.9 11634.5 8998.9 9272.5 9306.0 9820.4 10067.6 7408.8 8829.3 8965.1 9476.9 9597.9 05:16:35 INFO - PROCESS | 2527 | -------- Summary: end -------- 05:16:35 INFO - PROCESS | 2527 | 05:16:35 INFO - TEST-INFO | 2527: exit 0 05:16:35 INFO - TEST-OK | dromaeo_css | took 1111238ms 05:16:35 INFO - TEST-START | kraken 05:16:35 INFO - operating with platform_type : mac_ 05:16:35 INFO - Initialising browser for kraken test... 05:16:35 INFO - TEST-INFO | started process 2531 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpZqRyUf/profile http://localhost:61909/getInfo.html) 05:16:39 INFO - PROCESS | 2531 | __metrics Screen width/height:1600/1200 05:16:39 INFO - PROCESS | 2531 | colorDepth:24 05:16:39 INFO - PROCESS | 2531 | Browser inner width/height: 1024/689 05:16:39 INFO - PROCESS | 2531 | __metrics 05:16:39 ERROR - PROCESS | 2531 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:16:39 INFO - TEST-INFO | 2531: exit 0 05:16:39 INFO - Browser initialized. 05:16:39 INFO - Running cycle 1/1 for kraken test... 05:16:39 INFO - TEST-INFO | started process 2534 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpZqRyUf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:51 INFO - PROCESS | 2534 | RSS: Main: 248258560 05:16:51 INFO - PROCESS | 2534 | 05:16:54 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61909/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:55 INFO - PROCESS | 2534 | RSS: Main: 260599808 05:16:55 INFO - PROCESS | 2534 | 05:16:58 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61909/tests/kraken/driver.html?testName=audio-dft) 05:16:59 INFO - PROCESS | 2534 | RSS: Main: 269488128 05:16:59 INFO - PROCESS | 2534 | 05:17:02 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61909/tests/kraken/driver.html?testName=audio-fft) 05:17:03 INFO - PROCESS | 2534 | RSS: Main: 272543744 05:17:03 INFO - PROCESS | 2534 | 05:17:05 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61909/tests/kraken/driver.html?testName=audio-oscillator) 05:17:05 INFO - PROCESS | 2534 | RSS: Main: 273424384 05:17:05 INFO - PROCESS | 2534 | 05:17:08 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61909/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:08 INFO - PROCESS | 2534 | RSS: Main: 273973248 05:17:08 INFO - PROCESS | 2534 | 05:17:11 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61909/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:12 INFO - PROCESS | 2534 | RSS: Main: 275136512 05:17:12 INFO - PROCESS | 2534 | 05:17:15 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61909/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:15 INFO - PROCESS | 2534 | RSS: Main: 275320832 05:17:15 INFO - PROCESS | 2534 | 05:17:18 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61909/tests/kraken/driver.html?testName=json-parse-financial) 05:17:19 INFO - PROCESS | 2534 | RSS: Main: 275685376 05:17:19 INFO - PROCESS | 2534 | 05:17:20 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61909/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:21 INFO - PROCESS | 2534 | RSS: Main: 275300352 05:17:21 INFO - PROCESS | 2534 | 05:17:23 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:23 INFO - PROCESS | 2534 | RSS: Main: 275456000 05:17:23 INFO - PROCESS | 2534 | 05:17:26 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:26 INFO - PROCESS | 2534 | RSS: Main: 275922944 05:17:26 INFO - PROCESS | 2534 | 05:17:29 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:30 INFO - PROCESS | 2534 | RSS: Main: 276004864 05:17:30 INFO - PROCESS | 2534 | 05:17:33 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:33 INFO - PROCESS | 2534 | RSS: Main: 275730432 05:17:33 INFO - PROCESS | 2534 | 05:17:35 INFO - PROCESS | 2534 | Cycle 1(1): loaded http://localhost:61909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61909/tests/kraken/driver.html?testName=ai-astar) 05:17:36 INFO - PROCESS | 2534 | RSS: Main: 277065728 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | __start_tp_report 05:17:36 INFO - PROCESS | 2534 | _x_x_mozilla_page_load 05:17:36 INFO - PROCESS | 2534 | _x_x_mozilla_page_load_details 05:17:36 INFO - PROCESS | 2534 | |i|pagename|runs| 05:17:36 INFO - PROCESS | 2534 | |0;ai-astar;116;111;116;116;116;128;117;116;115;115 05:17:36 INFO - PROCESS | 2534 | |1;audio-beat-detection;154;121;149;167;122;144;125;157;156;121 05:17:36 INFO - PROCESS | 2534 | |2;audio-dft;201;204;215;247;249;199;199;259;274;199 05:17:36 INFO - PROCESS | 2534 | |3;audio-fft;64;74;76;148;68;80;80;98;126;57 05:17:36 INFO - PROCESS | 2534 | |4;audio-oscillator;83;113;174;111;82;81;126;77;79;122 05:17:36 INFO - PROCESS | 2534 | |5;imaging-gaussian-blur;90;86;90;88;89;86;90;87;90;87 05:17:36 INFO - PROCESS | 2534 | |6;imaging-darkroom;139;107;150;99;134;151;95;95;95;95 05:17:36 INFO - PROCESS | 2534 | |7;imaging-desaturate;75;150;148;91;91;94;91;93;91;91 05:17:36 INFO - PROCESS | 2534 | |8;json-parse-financial;62;62;62;60;66;61;60;77;62;61 05:17:36 INFO - PROCESS | 2534 | |9;json-stringify-tinderbox;63;64;65;72;68;73;70;66;66;66 05:17:36 INFO - PROCESS | 2534 | |10;stanford-crypto-aes;85;84;77;84;83;88;76;90;109;109 05:17:36 INFO - PROCESS | 2534 | |11;stanford-crypto-ccm;154;138;137;182;163;155;131;151;202;173 05:17:36 INFO - PROCESS | 2534 | |12;stanford-crypto-pbkdf2;170;170;180;173;173;172;167;168;169;168 05:17:36 INFO - PROCESS | 2534 | |13;stanford-crypto-sha256-iterative;76;97;103;105;97;62;79;103;72;67 05:17:36 INFO - PROCESS | 2534 | __end_tp_report 05:17:36 INFO - PROCESS | 2534 | __start_cc_report 05:17:36 INFO - PROCESS | 2534 | _x_x_mozilla_cycle_collect,1028 05:17:36 INFO - PROCESS | 2534 | __end_cc_report 05:17:36 INFO - PROCESS | 2534 | __startTimestamp1461154656017__endTimestamp 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | ------- Summary: start ------- 05:17:36 INFO - PROCESS | 2534 | Number of tests: 14 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#0] ai-astar Cycles:10 Average:116.60 Median:116.00 stddev:4.33 (3.7%) stddev-sans-first:4.58 05:17:36 INFO - PROCESS | 2534 | Values: 116.0 111.0 116.0 116.0 116.0 128.0 117.0 116.0 115.0 115.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#1] audio-beat-detection Cycles:10 Average:141.60 Median:151.50 stddev:17.68 (11.7%) stddev-sans-first:18.17 05:17:36 INFO - PROCESS | 2534 | Values: 154.0 121.0 149.0 167.0 122.0 144.0 125.0 157.0 156.0 121.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#2] audio-dft Cycles:10 Average:224.60 Median:231.00 stddev:29.36 (12.7%) stddev-sans-first:29.88 05:17:36 INFO - PROCESS | 2534 | Values: 201.0 204.0 215.0 247.0 249.0 199.0 199.0 259.0 274.0 199.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#3] audio-fft Cycles:10 Average:87.10 Median:75.00 stddev:28.95 (38.6%) stddev-sans-first:29.47 05:17:36 INFO - PROCESS | 2534 | Values: 64.0 74.0 76.0 148.0 68.0 80.0 80.0 98.0 126.0 57.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:78.00 stddev:30.98 (39.7%) stddev-sans-first:31.84 05:17:36 INFO - PROCESS | 2534 | Values: 83.0 113.0 174.0 111.0 82.0 81.0 126.0 77.0 79.0 122.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.50 stddev:1.70 (1.9%) stddev-sans-first:1.69 05:17:36 INFO - PROCESS | 2534 | Values: 90.0 86.0 90.0 88.0 89.0 86.0 90.0 87.0 90.0 87.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#6] imaging-darkroom Cycles:10 Average:116.00 Median:95.00 stddev:24.42 (25.7%) stddev-sans-first:24.44 05:17:36 INFO - PROCESS | 2534 | Values: 139.0 107.0 150.0 99.0 134.0 151.0 95.0 95.0 95.0 95.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:91.00 stddev:25.60 (28.1%) stddev-sans-first:25.29 05:17:36 INFO - PROCESS | 2534 | Values: 75.0 150.0 148.0 91.0 91.0 94.0 91.0 93.0 91.0 91.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:62.00 stddev:5.10 (8.2%) stddev-sans-first:5.39 05:17:36 INFO - PROCESS | 2534 | Values: 62.0 62.0 62.0 60.0 66.0 61.0 60.0 77.0 62.0 61.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:3.37 (5.0%) stddev-sans-first:3.19 05:17:36 INFO - PROCESS | 2534 | Values: 63.0 64.0 65.0 72.0 68.0 73.0 70.0 66.0 66.0 66.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:84.00 stddev:11.62 (13.8%) stddev-sans-first:12.25 05:17:36 INFO - PROCESS | 2534 | Values: 85.0 84.0 77.0 84.0 83.0 88.0 76.0 90.0 109.0 109.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#11] stanford-crypto-ccm Cycles:10 Average:158.60 Median:159.00 stddev:22.12 (13.9%) stddev-sans-first:23.40 05:17:36 INFO - PROCESS | 2534 | Values: 154.0 138.0 137.0 182.0 163.0 155.0 131.0 151.0 202.0 173.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.00 stddev:3.80 (2.2%) stddev-sans-first:4.01 05:17:36 INFO - PROCESS | 2534 | Values: 170.0 170.0 180.0 173.0 173.0 172.0 167.0 168.0 169.0 168.0 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - PROCESS | 2534 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.10 Median:74.00 stddev:16.54 (22.4%) stddev-sans-first:17.14 05:17:36 INFO - PROCESS | 2534 | Values: 76.0 97.0 103.0 105.0 97.0 62.0 79.0 103.0 72.0 67.0 05:17:36 INFO - PROCESS | 2534 | -------- Summary: end -------- 05:17:36 INFO - PROCESS | 2534 | 05:17:36 INFO - TEST-INFO | 2534: exit 0 05:17:36 INFO - TEST-OK | kraken | took 61035ms 05:17:36 INFO - SUITE-END | took 1172s 05:17:37 INFO - Completed test suite (00:19:32) 05:17:37 INFO - javascript benchmark 05:17:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2971.004713421004, 3438.192024874155, 3507.508948747174, 3511.139770756165, 3554.4490603956365, 5784.334801497824, 5799.594028418007, 5814.447627475393, 5838.124281357798, 5842.47417732404, 5730.255066841305, 5816.825495235139, 5905.881882362351, 5991.610545314563, 5997.790077347294, 5278.340207474056, 5357.919631205535, 5391.919121213185, 5407.810726624569, 5426.104692725715, 78.98624106836549, 5295.549878260334, 5346.812861549846, 5381.0, 5463.3717122530825, 4583.899864032642, 5248.317718696564, 5333.599980001477, 5353.116735738598, 5368.114261146906, 4417.646588272931, 5265.157574788054, 5427.457254274541, 5432.185172224198, 5434.402215756264, 4572.171131547374, 5254.106801843695, 5289.7619607117385, 5345.919811202835, 5368.570514358842, 5694.373618901917, 5781.219535362714, 5784.392638772911, 5859.736311865933, 5885.411458854081, 6128.258691089316, 6163.198784158076, 6249.2813326467585, 6279.591826531261, 6287.308396076428, 6263.373662633746, 6290.465310448617, 6301.991681331011, 6305.432511073979, 6313.116163737081, 5986.102084687288, 6005.279366476007, 6010.549208809357, 6042.244719410118, 6052.394760524, 6239.78160764371, 6284.717187726564, 6347.174867267226, 6363.459105975951, 6420.711068001951, 6229.96885015572, 6293.087502312139, 6294.653794041372, 6304.432601065926, 6317.46301564363, 6264.154339164245, 6328.810135695937, 6330.968345158245, 6355.809325720235, 6363.840903977345, 6107.15847211733, 6214.130021796952, 6233.2208473940755, 6280.5603607747935, 6303.117563541108, 6163.630182188993, 6171.166892469549, 6248.062790581449, 6252.155958945576, 6271.592346497463, 4277.101808620162, 4949.257611358325, 5011.599072074226, 5014.2979982802435, 5014.749262536859, 4447.555244475527, 4451.888702782391, 4521.186186486399, 4555.157295900269, 4586.197415452282, 5960.37416071315, 5964.910526342108, 5967.671778052162, 5999.700014999233, 6012.278526576752, 6289.433950944437, 6292.528060395397, 6292.842678933063, 6311.053341998737, 6330.430261276507, 5796.3913789052385, 5974.820755377345, 6061.787837425669, 6102.962496375627, 6104.816855494342, 5464.18037294409, 5505.843772807675, 5534.308211473566, 5556.722163891789, 5564.33228012641, 6289.308176100717, 6510.967445162839, 6511.479081673455, 6530.8040758777315, 6537.182852143482, 6230.813075607739, 6307.7476900925285, 6323.0, 6345.460635846005, 6348.428641422294, 6433.388828061326, 6465.418112369721, 6491.967540162269, 6513.218413790375, 6514.511411644051, 6161.137440758387, 6192.659403732838, 6243.469305109116, 6257.4681152102585, 6271.216097987752, 6216.067589861376, 6302.842428939313, 6304.905426418699, 6310.368963103653, 6332.430081292706, 6054.091886217103, 6223.595466294676, 6271.78048768291, 6283.497320214463, 6299.559030867796, 6134.325224225421, 6154.861350650144, 6210.068489726577, 6225.221847269091, 6286.5599408041, 5068.9239661405845, 5977.043673012297, 6050.122732203894, 6114.144019837316, 6216.036514340284, 6013.278406591237, 6227.50179985591, 6234.189555357774, 6263.467605253604, 6278.717457714322, 6038.4867286279405, 6111.834843226386, 6132.233470816148, 6151.907721384272, 6156.29202641702], "value": 5757.978601788876, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.69841999540284, 529.1982646290869, 532.3425569421765, 572.5333852909881, 577.7948828166002, 30139.547906781387, 38150.42774358383, 38240.42639360412, 38248.23503529928, 38270.61729382709, 40505.59494405055, 40573.797131014304, 40761.59238407615, 40989.18021639565, 41087.178256434854, 9431.151196392324, 9548.28387870909, 9575.0, 9651.758706032335, 9657.565409556586, 9451.432914025147, 9460.24318054554, 9498.240140788721, 9608.0, 9623.374480658735, 9468.33721639482, 9477.383970041925, 9589.993050729678, 9619.759506012371, 9619.80760384792, 9381.0, 9496.192823610001, 9585.472798996052, 9641.662541811073, 9642.71071867845, 9478.90521094787, 9491.90508094924, 9562.808743825153, 9612.279079069098, 9612.471314077722, 32523.0, 32950.02299862016, 37615.247695045946, 37666.43500347497, 37745.81127094347, 2711.7288271172924, 2961.570572267031, 2980.0388010380184, 3279.3277378137423, 3314.3537010283003, 25616.743832561624, 26249.73750262492, 26367.73632263672, 26854.060107896326, 27778.583321250197, 2380.8928598213124, 2650.562657161566, 2708.8645567721537, 2747.4367754610257, 2795.0636536760207, 354826.0, 357752.2112389447, 359861.2006939975, 360701.0, 361205.0, 58025.12962305569, 58428.83142337215, 58429.70785146047, 58490.4150958485, 58498.83002339929, 66389.33610663928, 66471.66764166148, 67683.66158169178, 68137.97793033108, 68309.65845170742, 16765.497035088967, 16928.984260944137, 16978.066206358522, 16985.065821379696, 16997.40509082201, 12868.742625147632, 12883.613491595268, 13017.804732929013, 13042.54351097707, 13074.673133171556, 19087.904560477386, 19234.80765192358, 19299.0, 19344.70982935257, 19717.014149292478, 8240.670373185125, 8380.748577542683, 8446.831063378699, 8456.957715211385, 8489.490630562186, 939.3518472254123, 1003.713941526676, 1054.7310435838965, 1112.5327362507767, 1121.4224674292745, 26222.688865556647, 29550.704492954796, 29793.25516862096, 29969.700302997127, 30106.54840177399, 1048.496721573649, 1068.9358638481715, 1077.671310250381, 1174.9190744515067, 1204.3921364977853, 15167.0, 15429.459968901034, 15467.071975681494, 15513.0, 15531.45639902598, 639084.8045759834, 639573.0, 646711.0, 650999.0, 652846.0, 48113.5188648116, 53989.73005134949, 55740.88518229694, 57186.85626287451, 57996.0, 1430.7853821926585, 1474.9852501475063, 1487.2935355705954, 1489.2553723138215, 1523.1850959736487, 27125.50809705485, 28522.859085637174, 29159.85420072886, 29272.56091158592, 29888.0, 43858.0, 50497.24254136264, 50980.74509627428, 51169.0, 51413.22880156726, 416311.0, 419072.80927190336, 420088.0, 420778.0, 421412.0, 25459.796245684425, 25871.0, 26166.86916565405, 26627.0, 26754.59868102019, 45737.77131114323, 46008.769956151344, 46332.30501542412, 46819.76590117028, 47233.76383118062, 36920.26159476849, 38185.80907095447, 38515.807420962716, 38540.0, 38759.80620096994, 37093.0, 37275.81362093172, 37597.81201093977, 38089.6191038086, 38355.0, 32037.519437208928, 37234.0, 37315.440268395454, 37908.0, 38303.04242393962, 31556.0, 33660.99017029493, 33679.32641347208, 33795.4930676045, 33867.4919876207, 23498.64752028755, 24353.756462435147, 24574.631380529663, 24660.630090548297, 24706.0], "value": 19355.66020321866, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.8628548580567, 386.67948954320997, 395.53327074052606, 410.9691773117015, 415.04125470163905, 17506.212220450077, 18855.245790168377, 18880.62238755224, 20439.0, 20706.482337941557, 17056.573585660364, 19923.90038049808, 20395.878226697525, 20806.375808725763, 21011.264605738765, 5573.6098473106895, 5806.535477161828, 5893.674521575234, 5988.401159883999, 6076.3316035236085, 4988.301637770715, 5054.9494505054845, 5941.792037278696, 5956.642601443906, 6017.879642407149, 4626.398568186131, 5478.91781623276, 5842.44496772808, 5899.941000590004, 5925.822225333247, 5532.972335138339, 5623.465770751793, 5639.577031722617, 5678.545716342724, 5737.627054241482, 5618.101103823368, 5661.377248502661, 5681.630694004876, 5699.544036477072, 5716.514096301819, 23491.987634223882, 24711.752882471304, 25348.619770703455, 25539.23382298534, 25787.871060644764, 2036.694495825623, 2080.2615071649648, 2164.1343462614923, 2340.6254999200046, 2496.2760799368343, 9939.403635781804, 10026.19790416765, 10271.332363396356, 11057.778844423066, 14879.256037198096, 1689.4171510828867, 1766.5230387795223, 1778.9021603811784, 1788.5707430216785, 1810.4749622609427, 110287.0, 117435.0, 117903.41048294789, 119867.80132198654, 120151.0, 10073.791145062492, 11098.2786118902, 11509.76980460386, 11609.477573509212, 11827.704307392212, 14613.26933653313, 14622.341994610268, 14874.851251487564, 15100.187977442778, 15181.089134651957, 7125.82185445368, 8510.31917446615, 8660.95669521661, 8740.781480462912, 8917.910820891837, 6391.42477177047, 8554.957225213833, 8616.698415555426, 8803.339749518684, 8837.248833849195, 4543.1822271990695, 4653.7207767534055, 4655.138799322136, 4691.296305554194, 4713.198756211452, 1748.2482532511142, 2001.5296405344732, 2027.7059826325394, 2040.8163265306193, 2058.0, 784.9489783164076, 869.443556124081, 937.8077494113827, 993.4684943555163, 1050.4537640427088, 19508.21967121299, 19883.701744473845, 20169.49576260576, 20273.290434835006, 20617.793822061587, 917.9127982841619, 935.9485228312508, 950.467738066671, 963.6386355116831, 981.4798156976814, 9019.819603608023, 10618.36289822613, 10637.468126593794, 10659.89340106589, 10664.200184986157, 624558.0, 634116.0, 639169.0, 643632.0, 645170.0, 102655.0, 110980.0, 117652.82347176419, 117881.41059294649, 134464.30706684236, 984.886738025122, 999.4602914426129, 1007.969760907174, 1008.455434065611, 1012.1982870490539, 14888.776668349767, 15328.233588320762, 17740.019367269273, 18001.279948802425, 18377.80544264672, 42146.0, 43106.0, 50446.24330635117, 51279.743601281756, 51460.0, 73331.63334183295, 73491.5905045699, 73543.0, 75007.49985000379, 75829.6208518954, 7845.490043147177, 7871.48835325702, 7927.286544210818, 8019.679212831421, 8091.55496447701, 10650.147988161083, 11478.598249061242, 12198.085143614442, 12217.572384966483, 12300.938495307466, 10226.181905447695, 10394.844077338998, 10773.299735517166, 11084.0, 11122.61070862516, 10509.684709458728, 10603.310784798963, 10784.245102842726, 10889.836652450062, 10970.945145274223, 11098.2786118902, 11281.984621384116, 11432.82850757256, 11433.371164586028, 11479.655610331703, 6896.172459304916, 7345.595992220479, 7385.446091543048, 7801.3368863644955, 8366.372522060992, 7913.881291780743, 9721.611135554498, 10790.406527640742, 10853.0, 11173.106151507698], "value": 9356.233323677658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.634807646165, 1590.00624609619, 1838.604699989503, 1933.8936358500287, 1944.6013567218722, 8004.319632831216, 8546.14538546146, 8553.572321383921, 8790.6923257686, 8797.07630698777, 8573.314134869212, 8616.0, 8659.177378149066, 8715.128487151282, 8719.08449612791, 2442.584760590704, 2449.448874003353, 2449.7672721091467, 2482.416632091457, 2490.651308816758, 2431.805455563551, 2455.8894849731805, 2489.614109812973, 2495.663085483455, 2497.6003839385703, 2459.0901366494422, 2462.569050416179, 2475.195561442529, 2496.0639760089966, 2496.6629505016863, 2429.7122525061745, 2436.8537887726793, 2436.9878150609134, 2457.5453541094867, 2476.578981573137, 2314.895829687668, 2418.129473389596, 2423.4062654649547, 2460.3972026853357, 2477.2939712182124, 8719.476831390073, 8795.912040879573, 8846.292296616255, 8846.380753347268, 8861.645534178626, 5264.0, 5380.112281473591, 5465.453454654543, 5488.368837583689, 5499.120140777456, 3529.876454324112, 3549.361114999299, 3555.466679997995, 3556.822158892045, 3612.6929211017095, 1026.9024442677933, 1040.921930855189, 1041.4844651897283, 1054.6256079091966, 1057.143713591993, 10822.538957240751, 10899.455027248607, 11640.243384180087, 11707.76584468306, 11759.823602645967, 4749.501302363271, 4807.759612019455, 4825.662203645781, 4935.333729946483, 4986.326845875833, 9954.850677239847, 9974.650887218913, 9986.700398988041, 9989.350692204984, 9997.200223982209, 5272.182811664198, 5283.286756287929, 5316.0962636351915, 5332.173513105475, 5355.062863998784, 4387.583179597997, 4774.498677638868, 4843.927341089887, 4906.975465122723, 4943.703377797344, 4027.436158937751, 4033.7579745214794, 4100.302948498763, 4113.382992551082, 4145.709800313949, 1347.4946894914408, 1366.794980752895, 1370.9725805483833, 1371.437670745478, 1379.7861331493634, 796.1004065406054, 822.8847961285425, 852.820907609409, 868.4311775786744, 872.419840805857, 5556.861078473071, 5598.944010559923, 5948.702564871825, 6008.489278411296, 6128.233970753656, 779.3103103753219, 863.3136656358084, 899.5547204133995, 936.8501039833594, 979.5983646704817, 3686.4286035664513, 3861.7489863158803, 3910.4720862683744, 3931.9606803931592, 3932.7640341579595, 10198.286119971679, 10500.264981451377, 10639.787204255872, 10668.679939601825, 10739.248252622398, 10344.0, 10448.895511044791, 10625.521851516545, 10643.201759868041, 10650.627228046982, 8072.152423995513, 8143.226393492727, 8207.425480216447, 8234.794130146794, 8241.50550966944, 5650.434956504481, 5904.61619994699, 5939.2575928009, 6034.517238620988, 6039.667818270037, 9689.70930872075, 9934.45360505179, 9943.154831839374, 10007.749806254902, 10020.448875311637, 9797.853032204664, 9874.753131171778, 9918.454485003394, 10010.799784004425, 10174.949125254327, 6070.939290607037, 6116.908246376397, 7490.213527579525, 7535.397168226638, 7645.770626881203, 8225.712100076707, 8269.503829770232, 8283.337333013224, 8303.169683031649, 8353.039400469024, 7288.416926645961, 7388.0, 7460.589667568119, 7468.626568671436, 7520.435967302365, 7182.748603798842, 7282.45381596393, 7336.926630733625, 7359.705611775683, 7375.373093286916, 6718.328167183243, 6720.294369091371, 6748.966255168692, 6767.1879374475375, 6811.284815094542, 4753.334533165429, 4770.260609605517, 4837.129316723023, 4863.148948933852, 5004.974975125101, 4356.346548017823, 4465.7767111644935, 4645.3032045193495, 4679.485256621837, 4726.19654658702], "value": 4593.348061314096, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.6372117646471, 326.05444211785823, 334.5450187744668, 335.41637550661846, 338.70025027850346, 5160.535551800337, 5324.893502129955, 5447.564194864412, 6009.969950150248, 6049.153118563405, 5212.452692467293, 5424.725189580456, 6270.739215607892, 6351.460125889305, 6401.967990160043, 4065.87802365928, 4263.786810659462, 4281.336392859112, 4736.4789873114105, 4778.116048531033, 4613.976930115345, 4714.882127946812, 4740.810367585293, 4744.217204161309, 4753.1919573672385, 3919.962029427188, 4063.207674503473, 4623.930641040387, 4675.275332323478, 4718.315844202589, 4473.015936493983, 4738.739369334685, 4746.501617330199, 4762.833300834489, 4765.617970788485, 3874.4769456123345, 4021.959780402217, 4070.287699652549, 4071.1043570414463, 4074.2258970795456, 6051.576389652726, 6068.939310606882, 6073.635581865058, 6125.263589210578, 6139.2325959255095, 4817.710937343735, 5480.780768769245, 5488.204210389471, 5499.670019798785, 5521.199426083235, 6585.197232625551, 6607.438367738748, 6655.900161497581, 6716.429103526206, 6765.458763298924, 4428.357888106207, 4471.552844715502, 4472.105578884204, 4479.3057076153245, 4507.797149128297, 5331.840044798662, 6165.876682466371, 7107.872536084106, 7129.394001509878, 7145.785626431215, 4131.814068366931, 4256.7445953242905, 4539.7049191802425, 4549.931751023737, 4568.954310456919, 4103.179364127186, 4609.193391156601, 4610.492845786961, 4636.4436267647425, 4651.62786977041, 4543.704659197141, 5354.30394048779, 5410.48600382963, 5494.697791621499, 5497.587680923947, 6379.617222966544, 6531.216254049545, 6792.218894827158, 6795.2185498667295, 6828.590284582841, 1518.476125736619, 1573.9291731871865, 1596.9600759981092, 1610.7503336982786, 1613.9515814525582, 918.4672889723944, 926.6015613286216, 998.1964518562481, 1058.5659879449388, 1064.1805809526777, 5192.49506583055, 5714.485696287271, 6231.501479881598, 6275.560710750204, 6290.087937249074, 6065.575409721366, 6629.86740265192, 6703.195616526048, 6952.756653517103, 7031.929680703128, 5401.648892821954, 5945.316288626776, 5995.250593675791, 6231.1959618172, 6291.842703932438, 3197.4244635965283, 3227.306129182237, 3328.3676101541114, 3361.798292102482, 3653.6529029742132, 6985.965070174617, 7216.9792458111815, 7223.2415596361625, 7262.818429539198, 7289.063905491082, 5887.381824908323, 6470.223573171155, 6658.86682266352, 7191.928080719126, 7206.56760594366, 5999.580029398075, 6820.522563420612, 6931.504658323, 7092.893606595905, 7294.525855819355, 6227.906581401192, 6404.551681382445, 6612.710521448272, 6896.827579310558, 6909.689063992032, 6387.169667943138, 6556.18047744032, 6868.038474613458, 6884.380405763505, 6937.479689023243, 5644.576656750843, 6215.471684906834, 6945.20130185015, 7198.0, 7246.96376518114, 4579.381783459324, 4583.289590113538, 4589.10512450069, 4594.793234304398, 4597.793099310606, 5550.47270509301, 6052.455279024733, 6251.218597675291, 6448.677566121582, 6556.803295901131, 5846.532277417881, 5974.1934838796205, 6348.682565871781, 6400.263969643364, 6763.898541521783, 5917.704114794157, 6476.902846457401, 6517.9348206517325, 6730.125083739083, 6790.490713196431, 6538.1827271591055, 6557.770478033246, 6573.1783527059115, 6574.638394888327, 6587.505937054644, 6710.698018589078, 6719.428848547928, 6725.4283385910785, 6755.966220168868, 6790.388865002174, 6214.751409943732, 6553.773914780882, 6585.868282634225, 6630.867382652416, 6658.467322614082], "value": 4804.106368153292, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5644622978991, 589.3605438099659, 595.6515438468494, 596.3410431473222, 654.8624788794353, 14690.412383504647, 14749.0, 15269.541913742578, 15276.007059541136, 15276.38894444221, 13644.72710545791, 13645.658858528517, 14103.647408814784, 14129.36417861196, 14172.433102675906, 658.5554750543364, 891.8171774786153, 901.256463417683, 948.7722946492827, 951.633621055895, 918.2883265469248, 937.704623043739, 939.4363381970832, 947.0813311088233, 951.1059603972244, 908.6637943960711, 936.2977766674994, 980.8626792249091, 990.3315262197988, 991.1971303244395, 937.3251259093441, 946.3375637054055, 954.766082309835, 981.1415011864618, 986.1223511075149, 696.2271878215178, 714.5926821711627, 724.7535837815168, 729.941604671625, 732.3994324653786, 14591.635209119751, 14754.336054877449, 14964.102153870803, 15137.167455789928, 15215.31531081104, 12589.874101258962, 12633.431495582721, 12651.493940242379, 12685.23888566689, 12895.29075900825, 9883.0, 9886.703398898044, 10019.348742331726, 10445.9477702611, 10685.41230232337, 3521.5421995140723, 3613.295407395559, 3860.131470419133, 3876.8061596920043, 4004.0390306326562, 83332.58333708292, 84083.0, 84204.15795842024, 84452.73320900192, 86701.0, 9377.484238366955, 9442.858357124649, 9444.338896277195, 9565.091316324939, 9624.03759624046, 21085.789142108384, 21106.0, 21131.577368452545, 21155.576888462143, 21206.93965301729, 6942.51402401827, 7047.0, 7101.396381307543, 7156.177039640404, 7297.416206703557, 3145.6225252969334, 3843.865464708722, 3845.288621605012, 3848.749831260959, 3850.2492014057552, 3079.260977365461, 3537.911552211215, 3582.390993531106, 3640.6177351378255, 3641.9453708194396, 534.9277847490539, 628.5160426471591, 635.139386131794, 646.812424396929, 648.6529706606942, 521.2962500624127, 590.3270271890049, 591.588845752198, 609.6037575575912, 614.563659801537, 6427.325130861286, 7584.014078169803, 7721.961390193125, 8127.959360203161, 8140.185981401931, 576.7981206577664, 578.6614830324223, 595.4968051996057, 599.6881621556853, 600.9038553831366, 3165.3714547939358, 3655.5613326401003, 3873.9612603874166, 3927.548331941863, 4079.0822065035723, 83356.58321708474, 91194.0, 91335.0, 91439.0, 93858.53070734603, 69773.65113174402, 75329.0, 76502.6174869122, 77643.0, 78829.0, 51214.719632009495, 51898.0, 62582.0, 64387.356126439074, 67746.0, 8114.675412983414, 8132.146124656826, 8152.551609661526, 8259.917400825914, 8369.288610468178, 33794.831025844716, 43958.78020609877, 44323.556764431945, 44363.0, 45004.87487812831, 42485.0, 60956.695216523636, 62165.13504594869, 63531.0, 64134.679326603065, 10487.528061237415, 10640.733981650521, 10847.349159050482, 10923.563057477611, 11755.294682319089, 11911.166218364631, 11992.280463172237, 12026.458809353775, 12158.209716368408, 12431.564895228623, 11168.944155279496, 11175.72060698489, 11364.829527556927, 11488.0, 11505.367204803817, 11149.442527873736, 11365.829512557484, 11483.196176267915, 11582.478788454371, 11696.473658685209, 10682.946585267024, 10976.54499277937, 11096.445177741241, 11350.886491134983, 11634.53461861516, 8998.910010899806, 9272.490013049348, 9306.0, 9820.4107753535, 10067.647632332833, 7408.8147796303365, 8829.293656507592, 8965.148310910454, 9476.85784713216, 9597.9040209597], "value": 6729.699009781601, "unit": "score"}], "name": "dromaeo_css", "value": 7328.118380982056, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 116.0, 116.0, 116.0, 128.0, 117.0, 116.0, 115.0, 115.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 149.0, 167.0, 122.0, 144.0, 125.0, 157.0, 156.0, 121.0], "value": 141.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 204.0, 215.0, 247.0, 249.0, 199.0, 199.0, 259.0, 274.0, 199.0], "value": 224.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 76.0, 148.0, 68.0, 80.0, 80.0, 98.0, 126.0, 57.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 113.0, 174.0, 111.0, 82.0, 81.0, 126.0, 77.0, 79.0, 122.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 88.0, 89.0, 86.0, 90.0, 87.0, 90.0, 87.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 107.0, 150.0, 99.0, 134.0, 151.0, 95.0, 95.0, 95.0, 95.0], "value": 116.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 150.0, 148.0, 91.0, 91.0, 94.0, 91.0, 93.0, 91.0, 91.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 60.0, 66.0, 61.0, 60.0, 77.0, 62.0, 61.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 72.0, 68.0, 73.0, 70.0, 66.0, 66.0, 66.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 77.0, 84.0, 83.0, 88.0, 76.0, 90.0, 109.0, 109.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 138.0, 137.0, 182.0, 163.0, 155.0, 131.0, 151.0, 202.0, 173.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 180.0, 173.0, 173.0, 172.0, 167.0, 168.0, 169.0, 168.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 97.0, 103.0, 105.0, 97.0, 62.0, 79.0, 103.0, 72.0, 67.0], "value": 86.1, "unit": "score"}], "name": "kraken", "value": 1615.2999999999997, "alertThreshold": 2.0}]} 05:17:37 INFO - Return code: 0 05:17:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:17:37 ERROR - # TBPL SUCCESS # 05:17:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:37 INFO - 2016-04-20 05:17:37.328 screenresolution[2539:31134] starting screenresolution argv=screenresolution get 05:17:37 INFO - 2016-04-20 05:17:37.331 screenresolution[2539:31134] Display 0: 1600x1200x32@60 05:17:37 INFO - 2016-04-20 05:17:37.338 screenresolution[2540:31137] starting screenresolution argv=screenresolution list 05:17:37 INFO - Available Modes on Display 0 05:17:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:37 INFO - Intel Iris: 05:17:37 INFO - Chipset Model: Intel Iris 05:17:37 INFO - Type: GPU 05:17:37 INFO - Bus: Built-In 05:17:37 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:37 INFO - Vendor: Intel (0x8086) 05:17:37 INFO - Device ID: 0x0a2e 05:17:37 INFO - Revision ID: 0x0009 05:17:37 INFO - Displays: 05:17:37 INFO - Display: 05:17:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:37 INFO - Display Serial Number: 1600x1200 60 05:17:37 INFO - Main Display: Yes 05:17:37 INFO - Mirror: Off 05:17:37 INFO - Online: Yes 05:17:37 INFO - Rotation: Supported 05:17:37 INFO - Return code: 0 05:17:37 INFO - Running post-action listener: _resource_record_post_action 05:17:37 INFO - Running post-run listener: _resource_record_post_run 05:17:38 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 40960; Write bytes: 694525952; Read time: 1; Write time: 2734 05:17:38 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395311616; Write bytes: 397795840; Read time: 29897; Write time: 725 05:17:38 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 40960; Write bytes: 295882240; Read time: 1; Write time: 2006 05:17:38 INFO - Running post-run listener: _upload_blobber_files 05:17:38 INFO - Blob upload gear active. 05:17:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:17:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:17:39 INFO - (blobuploader) - INFO - Open directory for files ... 05:17:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:17:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:39 INFO - (blobuploader) - INFO - Done attempting. 05:17:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:17:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:17:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:17:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:17:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:17:40 INFO - (blobuploader) - INFO - Done attempting. 05:17:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:17:40 INFO - Return code: 0 05:17:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:17:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:17:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ffe730ba96622d9b04f886f874ae0a2e35a4f87adf253279b9a68df04ce2d0a10fd67d5e59b9a8ee3fd53af0f3718f65b84d10b0b42de4b1da2581ba736a66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eeea2ae83f71e5e8316cf4520272c7a9db10f22e03001d12191642499add271f248d8959326a144de8df6b488ea1ff0ff75f35adb00fc2319ba264480838b0d"} 05:17:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:17:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:17:40 INFO - Contents: 05:17:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ffe730ba96622d9b04f886f874ae0a2e35a4f87adf253279b9a68df04ce2d0a10fd67d5e59b9a8ee3fd53af0f3718f65b84d10b0b42de4b1da2581ba736a66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eeea2ae83f71e5e8316cf4520272c7a9db10f22e03001d12191642499add271f248d8959326a144de8df6b488ea1ff0ff75f35adb00fc2319ba264480838b0d"} 05:17:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:17:40 INFO - Copying logs to upload dir... 05:17:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:17:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.700691 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-20 05:17:40.817958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 05:17:40.821436) ========= 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.nfn1awkn84/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.wddJi05ByA/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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/c5ffe730ba96622d9b04f886f874ae0a2e35a4f87adf253279b9a68df04ce2d0a10fd67d5e59b9a8ee3fd53af0f3718f65b84d10b0b42de4b1da2581ba736a66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eeea2ae83f71e5e8316cf4520272c7a9db10f22e03001d12191642499add271f248d8959326a144de8df6b488ea1ff0ff75f35adb00fc2319ba264480838b0d"} build_url:https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010925 build_url: 'https://queue.taskcluster.net/v1/task/N93ceuS9S-26CElRUwFzow/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ffe730ba96622d9b04f886f874ae0a2e35a4f87adf253279b9a68df04ce2d0a10fd67d5e59b9a8ee3fd53af0f3718f65b84d10b0b42de4b1da2581ba736a66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9eeea2ae83f71e5e8316cf4520272c7a9db10f22e03001d12191642499add271f248d8959326a144de8df6b488ea1ff0ff75f35adb00fc2319ba264480838b0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 05:17:40.850033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:17:40.850405) ========= 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.nfn1awkn84/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.wddJi05ByA/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.004792 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 05:17:40.898588) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 05:17:40.898937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 05:17:40.899266) ========= ========= Total master_lag: 0.17 =========