builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0370 starttime: 1469444602.89 results: success (0) buildid: 20160725015529 builduid: 7e02ace4dd9847cab657ff55c8b108f3 revision: 59caf5ec41614bf5de43d45f41a1decee29a869d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:22.891316) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:22.891795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:22.892095) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:22.917277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:22.917678) ========= 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.22RdLovuFq/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.kRFASrJJJN/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-25 04:03:22-- 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% 17.8M=0.001s 2016-07-25 04:03:23 (17.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.049936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.050248) ========= 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.22RdLovuFq/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.kRFASrJJJN/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.025278 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.098633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.098986) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 59caf5ec41614bf5de43d45f41a1decee29a869d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 59caf5ec41614bf5de43d45f41a1decee29a869d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.22RdLovuFq/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.kRFASrJJJN/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-25 04:03:23,181 truncating revision to first 12 chars 2016-07-25 04:03:23,181 Setting DEBUG logging. 2016-07-25 04:03:23,181 attempt 1/10 2016-07-25 04:03:23,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/59caf5ec4161?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-25 04:03:23,495 unpacking tar archive at: mozilla-beta-59caf5ec4161/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568118 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.688695) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.689012) ========= script_repo_revision: 59caf5ec41614bf5de43d45f41a1decee29a869d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.689395) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.689659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-25 04:03:23.707911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-25 04:03:23.708301) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.22RdLovuFq/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.kRFASrJJJN/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:03:23 INFO - MultiFileLogger online at 20160725 04:03:23 in /builds/slave/test 04:03:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:03:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:03:23 INFO - {'append_to_log': False, 04:03:23 INFO - 'base_work_dir': '/builds/slave/test', 04:03:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:03:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:03:23 INFO - 'branch': 'Mozilla-Beta', 04:03:23 INFO - 'buildbot_json_path': 'buildprops.json', 04:03:23 INFO - 'config_files': ('talos/mac_config.py',), 04:03:23 INFO - 'default_actions': ('clobber', 04:03:23 INFO - 'read-buildbot-config', 04:03:23 INFO - 'download-and-extract', 04:03:23 INFO - 'populate-webroot', 04:03:23 INFO - 'create-virtualenv', 04:03:23 INFO - 'install', 04:03:23 INFO - 'run-tests'), 04:03:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:03:23 INFO - 'download_minidump_stackwalk': True, 04:03:23 INFO - 'download_symbols': 'ondemand', 04:03:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:03:23 INFO - 'tooltool.py': '/tools/tooltool.py', 04:03:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:03:23 INFO - '/tools/misc-python/virtualenv.py')}, 04:03:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:03:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:03:23 INFO - 'installer_path': 'installer.exe', 04:03:23 INFO - 'log_level': 'info', 04:03:23 INFO - 'log_name': 'talos', 04:03:23 INFO - 'log_to_console': True, 04:03:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:03:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:03:23 INFO - 'opt_config_files': (), 04:03:23 INFO - 'pip_index': False, 04:03:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:03:23 INFO - 'cmd': ('bash', 04:03:23 INFO - '-c', 04:03:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:03:23 INFO - 'enabled': True, 04:03:23 INFO - 'halt_on_failure': False, 04:03:23 INFO - 'name': 'check_screen_resolution'},), 04:03:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:03:23 INFO - 'cmd': ('bash', 04:03:23 INFO - '-c', 04:03:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:03:23 INFO - 'enabled': True, 04:03:23 INFO - 'halt_on_failure': False, 04:03:23 INFO - 'name': 'check_screen_resolution'},), 04:03:23 INFO - 'run_cmd_checks_enabled': True, 04:03:23 INFO - 'sps_profile': False, 04:03:23 INFO - 'sps_profile_interval': 0, 04:03:23 INFO - 'suite': 'dromaeojs-e10s', 04:03:23 INFO - 'system_bits': '32', 04:03:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:03:23 INFO - 'title': 't-yosemite-r7-0370', 04:03:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:03:23 INFO - 'use_talos_json': True, 04:03:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:03:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:03:23 INFO - 'work_dir': 'build'} 04:03:23 INFO - ##### 04:03:23 INFO - ##### Running clobber step. 04:03:23 INFO - ##### 04:03:23 INFO - Running pre-action listener: _resource_record_pre_action 04:03:23 INFO - Running main action method: clobber 04:03:23 INFO - rmtree: /builds/slave/test/build 04:03:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:03:25 INFO - Running post-action listener: _resource_record_post_action 04:03:25 INFO - ##### 04:03:25 INFO - ##### Running read-buildbot-config step. 04:03:25 INFO - ##### 04:03:25 INFO - Running pre-action listener: _resource_record_pre_action 04:03:25 INFO - Running main action method: read_buildbot_config 04:03:25 INFO - Using buildbot properties: 04:03:25 INFO - { 04:03:25 INFO - "project": "", 04:03:25 INFO - "product": "firefox", 04:03:25 INFO - "script_repo_revision": "production", 04:03:25 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:03:25 INFO - "repository": "", 04:03:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:03:25 INFO - "buildid": "20160725015529", 04:03:25 INFO - "pgo_build": "False", 04:03:25 INFO - "basedir": "/builds/slave/test", 04:03:25 INFO - "buildnumber": 22, 04:03:25 INFO - "slavename": "t-yosemite-r7-0370", 04:03:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:03:25 INFO - "platform": "yosemite_r7", 04:03:25 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:03:25 INFO - "branch": "mozilla-beta", 04:03:25 INFO - "repo_path": "releases/mozilla-beta", 04:03:25 INFO - "revision": "59caf5ec41614bf5de43d45f41a1decee29a869d", 04:03:25 INFO - "stage_platform": "macosx64", 04:03:25 INFO - "builduid": "7e02ace4dd9847cab657ff55c8b108f3", 04:03:25 INFO - "slavebuilddir": "test" 04:03:25 INFO - } 04:03:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:03:25 INFO - Running post-action listener: _resource_record_post_action 04:03:25 INFO - ##### 04:03:25 INFO - ##### Running download-and-extract step. 04:03:25 INFO - ##### 04:03:25 INFO - Running pre-action listener: _resource_record_pre_action 04:03:25 INFO - Running main action method: download_and_extract 04:03:25 INFO - mkdir: /builds/slave/test/build/tests 04:03:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:25 INFO - https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:03:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:03:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:03:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:03:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 04:03:28 INFO - Downloaded 1165 bytes. 04:03:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:03:28 INFO - Using the following test package requirements: 04:03:28 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:03:28 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:03:28 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:03:28 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:03:28 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:03:28 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:03:28 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:03:28 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:03:28 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:03:28 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:03:28 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:03:28 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:03:28 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:03:28 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:03:28 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:03:28 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:03:28 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:03:28 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:28 INFO - https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:03:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:03:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:03:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:03:32 INFO - Downloaded 18314940 bytes. 04:03:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:03:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:03:35 INFO - Return code: 0 04:03:35 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:35 INFO - https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:03:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:03:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:03:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:03:37 INFO - Downloaded 18314940 bytes. 04:03:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:03:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:03:40 INFO - Return code: 0 04:03:40 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:03:40 INFO - https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 04:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 04:03:41 INFO - Downloaded 10840145 bytes. 04:03:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:03:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:03:42 INFO - Return code: 0 04:03:42 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:03:42 INFO - https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 04:03:44 INFO - Downloaded 86169210 bytes. 04:03:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:03:44 INFO - mkdir: /builds/slave/test/properties 04:03:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:03:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:03:44 INFO - Contents: 04:03:44 INFO - build_url:https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:03:45 INFO - Running post-action listener: _resource_record_post_action 04:03:45 INFO - Running post-action listener: set_extra_try_arguments 04:03:45 INFO - ##### 04:03:45 INFO - ##### Running populate-webroot step. 04:03:45 INFO - ##### 04:03:45 INFO - Running pre-action listener: _resource_record_pre_action 04:03:45 INFO - Running main action method: populate_webroot 04:03:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:03:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:03:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:03:45 INFO - '--tppagecycles', 04:03:45 INFO - '7'], 04:03:45 INFO - 'tests': ['tsvgm']}}, 04:03:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:03:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:03:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:03:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:03:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:45 INFO - 'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:45 INFO - 'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['damp', 'tps']}, 04:03:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:45 INFO - 'tests': ['damp', 'tps']}, 04:03:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['dromaeo_dom']}, 04:03:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:03:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['a11yr', 04:03:45 INFO - 'ts_paint', 04:03:45 INFO - 'tpaint', 04:03:45 INFO - 'sessionrestore', 04:03:45 INFO - 'sessionrestore_no_auto_restore', 04:03:45 INFO - 'tabpaint']}, 04:03:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:03:45 INFO - 'ts_paint', 04:03:45 INFO - 'tpaint', 04:03:45 INFO - 'sessionrestore', 04:03:45 INFO - 'sessionrestore_no_auto_restore', 04:03:45 INFO - 'tabpaint']}, 04:03:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:03:45 INFO - 'ts_paint', 04:03:45 INFO - 'tpaint', 04:03:45 INFO - 'sessionrestore', 04:03:45 INFO - 'sessionrestore_no_auto_restore', 04:03:45 INFO - 'tabpaint']}, 04:03:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:03:45 INFO - 'ts_paint', 04:03:45 INFO - 'tpaint', 04:03:45 INFO - 'sessionrestore', 04:03:45 INFO - 'sessionrestore_no_auto_restore', 04:03:45 INFO - 'tabpaint']}, 04:03:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['a11yr', 04:03:45 INFO - 'ts_paint', 04:03:45 INFO - 'tpaint', 04:03:45 INFO - 'sessionrestore', 04:03:45 INFO - 'sessionrestore_no_auto_restore', 04:03:45 INFO - 'tabpaint']}, 04:03:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['a11yr', 04:03:45 INFO - 'ts_paint', 04:03:45 INFO - 'tpaint', 04:03:45 INFO - 'sessionrestore', 04:03:45 INFO - 'sessionrestore_no_auto_restore', 04:03:45 INFO - 'tabpaint']}, 04:03:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['tsvgx', 04:03:45 INFO - 'tsvgr_opacity', 04:03:45 INFO - 'tart', 04:03:45 INFO - 'tscrollx', 04:03:45 INFO - 'cart']}, 04:03:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:03:45 INFO - 'tsvgr_opacity', 04:03:45 INFO - 'tart', 04:03:45 INFO - 'tscrollx', 04:03:45 INFO - 'cart']}, 04:03:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:45 INFO - 'talos_options': ['--disable-e10s'], 04:03:45 INFO - 'tests': ['tp5o']}, 04:03:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:45 INFO - 'tests': ['tp5o']}, 04:03:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:45 INFO - 'talos_options': ['--disable-e10s', 04:03:45 INFO - '--xperf_path', 04:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:45 INFO - 'tests': ['tp5n']}, 04:03:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:03:45 INFO - 'talos_options': ['--xperf_path', 04:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:45 INFO - 'tests': ['tp5n']}}, 04:03:45 INFO - 'talos.zip': {'path': '', 04:03:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:03:45 INFO - Running post-action listener: _resource_record_post_action 04:03:45 INFO - ##### 04:03:45 INFO - ##### Running create-virtualenv step. 04:03:45 INFO - ##### 04:03:45 INFO - Running pre-action listener: _resource_record_pre_action 04:03:45 INFO - Running main action method: create_virtualenv 04:03:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:03:45 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:03:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:03:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:03:45 INFO - Using real prefix '/tools/python27' 04:03:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:03:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:03:48 INFO - Installing pip.................done. 04:03:48 INFO - Return code: 0 04:03:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:03: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:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03: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:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:03:48 INFO - 'HOME': '/Users/cltbld', 04:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:03:48 INFO - 'LOGNAME': 'cltbld', 04:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:48 INFO - 'MOZ_NO_REMOTE': '1', 04:03:48 INFO - 'NO_EM_RESTART': '1', 04:03:48 INFO - 'PAGER': '/bin/cat', 04:03:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:48 INFO - 'PWD': '/builds/slave/test', 04:03:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:03:48 INFO - 'SHELL': '/bin/bash', 04:03:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:03:48 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:03:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:03:48 INFO - 'USER': 'cltbld', 04:03:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:03:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:48 INFO - 'XPC_FLAGS': '0x0', 04:03:48 INFO - 'XPC_SERVICE_NAME': '0', 04:03:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:49 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:03:49 INFO - Cleaning up... 04:03:49 INFO - Return code: 0 04:03:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:03: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:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03: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:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:49 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 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:03:49 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:03:49 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:03:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:03:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:03:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:03:49 INFO - 'HOME': '/Users/cltbld', 04:03:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:03:49 INFO - 'LOGNAME': 'cltbld', 04:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:49 INFO - 'MOZ_NO_REMOTE': '1', 04:03:49 INFO - 'NO_EM_RESTART': '1', 04:03:49 INFO - 'PAGER': '/bin/cat', 04:03:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:49 INFO - 'PWD': '/builds/slave/test', 04:03:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:03:49 INFO - 'SHELL': '/bin/bash', 04:03:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:03:49 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:03:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:03:49 INFO - 'USER': 'cltbld', 04:03:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:03:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:49 INFO - 'XPC_FLAGS': '0x0', 04:03:49 INFO - 'XPC_SERVICE_NAME': '0', 04:03:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:49 INFO - Downloading/unpacking psutil>=0.7.1 04:03:49 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:03:49 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:03:49 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:03:49 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:03:49 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:03:49 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:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:03:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:52 INFO - Installing collected packages: psutil 04:03:52 INFO - Running setup.py install for psutil 04:03:52 INFO - building 'psutil._psutil_osx' extension 04:03:52 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:03:52 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:03:52 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:03:52 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:03:52 INFO - building 'psutil._psutil_posix' extension 04:03:52 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:03:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:03:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:03:52 INFO - ^ 04:03:52 INFO - 1 warning generated. 04:03:52 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:03:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:53 INFO - Successfully installed psutil 04:03:53 INFO - Cleaning up... 04:03:53 INFO - Return code: 0 04:03:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:03:53 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:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:53 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:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:53 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 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:03:53 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:03:53 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:03:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:03:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:03:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:03:53 INFO - 'HOME': '/Users/cltbld', 04:03:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:03:53 INFO - 'LOGNAME': 'cltbld', 04:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:53 INFO - 'MOZ_NO_REMOTE': '1', 04:03:53 INFO - 'NO_EM_RESTART': '1', 04:03:53 INFO - 'PAGER': '/bin/cat', 04:03:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:53 INFO - 'PWD': '/builds/slave/test', 04:03:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:03:53 INFO - 'SHELL': '/bin/bash', 04:03:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:03:53 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:03:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:03:53 INFO - 'USER': 'cltbld', 04:03:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:03:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:53 INFO - 'XPC_FLAGS': '0x0', 04:03:53 INFO - 'XPC_SERVICE_NAME': '0', 04:03:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:53 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:03:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:03:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:03:56 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:03:56 INFO - Installing collected packages: mozsystemmonitor 04:03:56 INFO - Running setup.py install for mozsystemmonitor 04:03:56 INFO - Successfully installed mozsystemmonitor 04:03:56 INFO - Cleaning up... 04:03:56 INFO - Return code: 0 04:03:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:56 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 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:03:56 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:03:56 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:03:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:03:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:03:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:03:56 INFO - 'HOME': '/Users/cltbld', 04:03:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:03:56 INFO - 'LOGNAME': 'cltbld', 04:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:56 INFO - 'MOZ_NO_REMOTE': '1', 04:03:56 INFO - 'NO_EM_RESTART': '1', 04:03:56 INFO - 'PAGER': '/bin/cat', 04:03:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:56 INFO - 'PWD': '/builds/slave/test', 04:03:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:03:56 INFO - 'SHELL': '/bin/bash', 04:03:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:03:56 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:03:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:03:56 INFO - 'USER': 'cltbld', 04:03:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:03:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:56 INFO - 'XPC_FLAGS': '0x0', 04:03:56 INFO - 'XPC_SERVICE_NAME': '0', 04:03:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:03:56 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:03:56 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:03:56 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:03:56 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:03:56 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:03:56 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:03:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:03:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:03: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:03: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:03: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:03: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:03: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:03: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:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:03:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:03: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:03: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:03: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:03: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:03: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:03: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:04:00 INFO - Downloading docopt-0.6.1.tar.gz 04:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:04:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:04:00 INFO - Running setup.py install for blobuploader 04:04:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:04:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:04:00 INFO - Running setup.py install for requests 04:04:00 INFO - Running setup.py install for docopt 04:04:01 INFO - Successfully installed blobuploader requests docopt 04:04:01 INFO - Cleaning up... 04:04:01 INFO - Return code: 0 04:04:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:01 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:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:01 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:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:01 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 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:04:01 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:04:01 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:04:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:04:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:01 INFO - 'HOME': '/Users/cltbld', 04:04:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:01 INFO - 'LOGNAME': 'cltbld', 04:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:01 INFO - 'MOZ_NO_REMOTE': '1', 04:04:01 INFO - 'NO_EM_RESTART': '1', 04:04:01 INFO - 'PAGER': '/bin/cat', 04:04:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:01 INFO - 'PWD': '/builds/slave/test', 04:04:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:01 INFO - 'SHELL': '/bin/bash', 04:04:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:04:01 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:04:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:01 INFO - 'USER': 'cltbld', 04:04:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:01 INFO - 'XPC_FLAGS': '0x0', 04:04:01 INFO - 'XPC_SERVICE_NAME': '0', 04:04:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:01 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Vi_UE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:01 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-UfRtTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:01 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-2_wJHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:01 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-r4Ywua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:01 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-1PNbyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:01 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-XouAWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:01 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-wArmdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-4bOmb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-yZXNjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-iJb4Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Obw2yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-fvPQZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-mXWyYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-K24_yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-cCCak1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:02 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-nOLbqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:03 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-UhKxrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:04:03 INFO - Running setup.py install for manifestparser 04:04:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:04:03 INFO - Running setup.py install for mozcrash 04:04:03 INFO - Running setup.py install for mozdebug 04:04:03 INFO - Running setup.py install for mozdevice 04:04:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:04:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:04:03 INFO - Running setup.py install for mozfile 04:04:03 INFO - Running setup.py install for mozhttpd 04:04:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:04:03 INFO - Running setup.py install for mozinfo 04:04:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:04:04 INFO - Running setup.py install for mozInstall 04:04:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:04:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:04:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:04:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:04:04 INFO - Running setup.py install for mozleak 04:04:04 INFO - Running setup.py install for mozlog 04:04:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:04:04 INFO - Running setup.py install for moznetwork 04:04:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:04:04 INFO - Running setup.py install for mozprocess 04:04:04 INFO - Running setup.py install for mozprofile 04:04:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:04:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:04:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:04:05 INFO - Running setup.py install for mozrunner 04:04:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:04:05 INFO - Running setup.py install for mozscreenshot 04:04:05 INFO - Running setup.py install for moztest 04:04:05 INFO - Running setup.py install for mozversion 04:04:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:04:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:04:05 INFO - Cleaning up... 04:04:05 INFO - Return code: 0 04:04:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04:05 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:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:05 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:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:05 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 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:04:05 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:04:05 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:04:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:04:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:05 INFO - 'HOME': '/Users/cltbld', 04:04:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:05 INFO - 'LOGNAME': 'cltbld', 04:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:05 INFO - 'MOZ_NO_REMOTE': '1', 04:04:05 INFO - 'NO_EM_RESTART': '1', 04:04:05 INFO - 'PAGER': '/bin/cat', 04:04:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:05 INFO - 'PWD': '/builds/slave/test', 04:04:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:05 INFO - 'SHELL': '/bin/bash', 04:04:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:04:05 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:04:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:05 INFO - 'USER': 'cltbld', 04:04:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:05 INFO - 'XPC_FLAGS': '0x0', 04:04:05 INFO - 'XPC_SERVICE_NAME': '0', 04:04:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:04:05 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-wHYmRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-QFzTgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-O8G86L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-BR17F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-KYQiI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-JiuuQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-wSiVLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-o7mKtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-v8IsHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:04:06 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:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:04:06 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-SuhoH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:04:07 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-xbcrBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:04:07 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ZJZCsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:04:07 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-7uZCkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:04:07 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-f3JqOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:07 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ADyEOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:04:07 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-EByXG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:04:07 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:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:04:07 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-YEd4Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:07 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:04:10 INFO - Downloading blessings-1.6.tar.gz 04:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:04:10 INFO - Installing collected packages: blessings 04:04:10 INFO - Running setup.py install for blessings 04:04:10 INFO - Successfully installed blessings 04:04:10 INFO - Cleaning up... 04:04:10 INFO - Return code: 0 04:04:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:10 INFO - Reading from file tmpfile_stdout 04:04:10 INFO - Current package versions: 04:04:10 INFO - blessings == 1.6 04:04:10 INFO - blobuploader == 1.2.4 04:04:10 INFO - docopt == 0.6.1 04:04:10 INFO - manifestparser == 1.1 04:04:10 INFO - mozInstall == 1.12 04:04:10 INFO - mozcrash == 0.17 04:04:10 INFO - mozdebug == 0.1 04:04:10 INFO - mozdevice == 0.48 04:04:10 INFO - mozfile == 1.2 04:04:10 INFO - mozhttpd == 0.7 04:04:10 INFO - mozinfo == 0.9 04:04:10 INFO - mozleak == 0.1 04:04:10 INFO - mozlog == 3.1 04:04:10 INFO - moznetwork == 0.27 04:04:10 INFO - mozprocess == 0.22 04:04:10 INFO - mozprofile == 0.28 04:04:10 INFO - mozrunner == 6.11 04:04:10 INFO - mozscreenshot == 0.1 04:04:10 INFO - mozsystemmonitor == 0.0 04:04:10 INFO - moztest == 0.7 04:04:10 INFO - mozversion == 1.4 04:04:10 INFO - psutil == 3.1.1 04:04:10 INFO - requests == 1.2.3 04:04:10 INFO - wsgiref == 0.1.2 04:04:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:04: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:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04: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:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:10 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 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:04:10 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:04:10 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:04:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:04:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:10 INFO - 'HOME': '/Users/cltbld', 04:04:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:10 INFO - 'LOGNAME': 'cltbld', 04:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:10 INFO - 'MOZ_NO_REMOTE': '1', 04:04:10 INFO - 'NO_EM_RESTART': '1', 04:04:10 INFO - 'PAGER': '/bin/cat', 04:04:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:10 INFO - 'PWD': '/builds/slave/test', 04:04:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:10 INFO - 'SHELL': '/bin/bash', 04:04:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:04:10 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:04:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:10 INFO - 'USER': 'cltbld', 04:04:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:10 INFO - 'XPC_FLAGS': '0x0', 04:04:10 INFO - 'XPC_SERVICE_NAME': '0', 04:04:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 INFO - Cleaning up... 04:04:11 INFO - Return code: 0 04:04:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:04:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:04:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:11 INFO - 'HOME': '/Users/cltbld', 04:04:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:11 INFO - 'LOGNAME': 'cltbld', 04:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:11 INFO - 'MOZ_NO_REMOTE': '1', 04:04:11 INFO - 'NO_EM_RESTART': '1', 04:04:11 INFO - 'PAGER': '/bin/cat', 04:04:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:11 INFO - 'PWD': '/builds/slave/test', 04:04:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:11 INFO - 'SHELL': '/bin/bash', 04:04:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:04:11 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:04:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:11 INFO - 'USER': 'cltbld', 04:04:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:11 INFO - 'XPC_FLAGS': '0x0', 04:04:11 INFO - 'XPC_SERVICE_NAME': '0', 04:04:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:11 INFO - Downloading/unpacking jsonschema 04:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:11 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:04:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:04:13 INFO - Downloading/unpacking functools32 (from jsonschema) 04:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:04:14 INFO - warning: no files found matching '*.txt' 04:04:14 INFO - no previously-included directories found matching 'build' 04:04:14 INFO - no previously-included directories found matching 'dist' 04:04:14 INFO - no previously-included directories found matching '.git*' 04:04:14 INFO - Installing collected packages: jsonschema, functools32 04:04:14 INFO - Running setup.py install for functools32 04:04:14 INFO - warning: no files found matching '*.txt' 04:04:14 INFO - no previously-included directories found matching 'build' 04:04:14 INFO - no previously-included directories found matching 'dist' 04:04:14 INFO - no previously-included directories found matching '.git*' 04:04:14 INFO - Successfully installed jsonschema functools32 04:04:14 INFO - Cleaning up... 04:04:14 INFO - Return code: 0 04:04:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:04:14 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 0x10ddd5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b1adc10b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, '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.22RdLovuFq/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.kRFASrJJJN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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:04:14 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:04:14 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:04:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:04:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:14 INFO - 'HOME': '/Users/cltbld', 04:04:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:14 INFO - 'LOGNAME': 'cltbld', 04:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:14 INFO - 'MOZ_NO_REMOTE': '1', 04:04:14 INFO - 'NO_EM_RESTART': '1', 04:04:14 INFO - 'PAGER': '/bin/cat', 04:04:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:14 INFO - 'PWD': '/builds/slave/test', 04:04:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:14 INFO - 'SHELL': '/bin/bash', 04:04:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:04:14 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:04:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:14 INFO - 'USER': 'cltbld', 04:04:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:14 INFO - 'XPC_FLAGS': '0x0', 04:04:14 INFO - 'XPC_SERVICE_NAME': '0', 04:04:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:04:14 INFO - Downloading/unpacking flake8 04:04:14 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:04:14 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:04:14 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:04:14 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:04:14 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:04:14 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:04:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:04:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:04: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:04: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:04: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:04: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:04: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:04: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:04:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:04:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:04: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:04: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:04: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:04: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:04: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:04: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:04:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:04:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:04:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:18 INFO - no previously-included directories found matching 'docs/_build' 04:04:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:04:18 INFO - Running setup.py install for pep8 04:04:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:04:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:04:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:04:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:04:18 INFO - no previously-included directories found matching 'docs/_build' 04:04:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:04:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:04:18 INFO - Cleaning up... 04:04:18 INFO - Return code: 0 04:04:18 INFO - Running post-action listener: _resource_record_post_action 04:04:18 INFO - Running post-action listener: _start_resource_monitoring 04:04:18 INFO - Starting resource monitoring. 04:04:18 INFO - ##### 04:04:18 INFO - ##### Running install step. 04:04:18 INFO - ##### 04:04:18 INFO - Running pre-action listener: _resource_record_pre_action 04:04:18 INFO - Running main action method: install 04:04:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:04:19 INFO - Reading from file tmpfile_stdout 04:04:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:04:19 INFO - Reading from file tmpfile_stdout 04:04:19 INFO - Output received: 04:04:19 INFO - Usage: mozinstall [options] installer 04:04:19 INFO - Options: 04:04:19 INFO - -h, --help show this help message and exit 04:04:19 INFO - -d DEST, --destination=DEST 04:04:19 INFO - Directory to install application into. [default: 04:04:19 INFO - "/builds/slave/test"] 04:04:19 INFO - --app=APP Application being installed. [default: firefox] 04:04:19 INFO - mkdir: /builds/slave/test/build/application 04:04:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:04:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:04:41 INFO - Reading from file tmpfile_stdout 04:04:41 INFO - Output received: 04:04:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:04:41 INFO - Running post-action listener: _resource_record_post_action 04:04:41 INFO - ##### 04:04:41 INFO - ##### Running run-tests step. 04:04:41 INFO - ##### 04:04:41 INFO - Running pre-action listener: _resource_record_pre_action 04:04:41 INFO - Running main action method: run_tests 04:04:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:04:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:04:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:04:41 INFO - 2016-07-25 04:04:41.101 screenresolution[1660:8914] starting screenresolution argv=screenresolution get 04:04:41 INFO - 2016-07-25 04:04:41.104 screenresolution[1660:8914] Display 0: 1600x1200x32@60 04:04:41 INFO - 2016-07-25 04:04:41.110 screenresolution[1661:8917] starting screenresolution argv=screenresolution list 04:04:41 INFO - Available Modes on Display 0 04:04:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:04:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:04:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:04:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:04:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:04:41 INFO - Intel Iris: 04:04:41 INFO - Chipset Model: Intel Iris 04:04:41 INFO - Type: GPU 04:04:41 INFO - Bus: Built-In 04:04:41 INFO - VRAM (Dynamic, Max): 1536 MB 04:04:41 INFO - Vendor: Intel (0x8086) 04:04:41 INFO - Device ID: 0x0a2e 04:04:41 INFO - Revision ID: 0x0009 04:04:41 INFO - Displays: 04:04:41 INFO - Display: 04:04:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:04:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:04:41 INFO - Display Serial Number: 1600x1200 60 04:04:41 INFO - Main Display: Yes 04:04:41 INFO - Mirror: Off 04:04:41 INFO - Online: Yes 04:04:41 INFO - Rotation: Supported 04:04:41 INFO - Return code: 0 04:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:04:41 INFO - Python 2.7.3 04:04:41 INFO - Return code: 0 04:04:41 INFO - grabbing minidump binary from tooltool 04:04:41 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:04:41 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 0x10dc74e00>, '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 0x10dadddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc6fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:04:41 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:04:41 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:04:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:04:41 INFO - Return code: 0 04:04:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:04:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:04:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:04:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:04:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:04:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:04:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:04:42 INFO - Return code: 0 04:04:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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:04:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --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:04:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.22RdLovuFq/Render', 04:04:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:04:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:04:42 INFO - 'HOME': '/Users/cltbld', 04:04:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:04:42 INFO - 'LOGNAME': 'cltbld', 04:04:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:04:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:42 INFO - 'MOZ_NO_REMOTE': '1', 04:04:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:04:42 INFO - 'NO_EM_RESTART': '1', 04:04:42 INFO - 'PAGER': '/bin/cat', 04:04:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:42 INFO - 'PWD': '/builds/slave/test', 04:04:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:04:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:04:42 INFO - 'SHELL': '/bin/bash', 04:04:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kRFASrJJJN/Listeners', 04:04:42 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:04:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:04:42 INFO - 'USER': 'cltbld', 04:04:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:04:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:42 INFO - 'XPC_FLAGS': '0x0', 04:04:42 INFO - 'XPC_SERVICE_NAME': '0', 04:04:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:04:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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:04:42 INFO - mozversion application_buildid: 20160725015529 04:04:42 INFO - mozversion application_changeset: 59caf5ec41614bf5de43d45f41a1decee29a869d 04:04:42 INFO - mozversion application_display_name: Firefox 04:04:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:04:42 INFO - mozversion application_name: Firefox 04:04:42 INFO - mozversion application_remotingname: firefox 04:04:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:04:42 INFO - mozversion application_vendor: Mozilla 04:04:42 INFO - mozversion application_version: 48.0 04:04:42 INFO - mozversion platform_buildid: 20160725015529 04:04:42 INFO - mozversion platform_changeset: 59caf5ec41614bf5de43d45f41a1decee29a869d 04:04:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:04:42 INFO - mozversion platform_version: 48.0 04:04:42 INFO - using testdate: 1469444682 04:04:42 INFO - actual date: 1469444682 04:04:42 INFO - starting webserver on 'localhost:49275' 04:04:42 INFO - SUITE-START | Running 2 tests 04:04:42 INFO - TEST-START | dromaeo_css 04:04:42 INFO - operating with platform_type : mac_ 04:04:42 INFO - Initialising browser for dromaeo_css test... 04:04:42 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpAL09Wq/profile http://localhost:49275/getInfo.html) 04:04:45 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 04:04:45 INFO - PROCESS | 1679 | colorDepth:24 04:04:45 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 04:04:45 INFO - PROCESS | 1679 | __metrics 04:04:45 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:04:46 INFO - TEST-INFO | 1679: exit 0 04:04:46 INFO - Browser initialized. 04:04:46 INFO - Running cycle 1/1 for dromaeo_css test... 04:04:46 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpAL09Wq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:58 INFO - PROCESS | 1683 | RSS: Main: 171069440 04:04:58 INFO - PROCESS | 1683 | 04:05:48 INFO - PROCESS | 1683 | 1469444748027 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] 04:07:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 04:07:59 INFO - PROCESS | 1683 | RSS: Main: 182456320 04:07:59 INFO - PROCESS | 1683 | 04:11:01 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 04:11:02 INFO - PROCESS | 1683 | RSS: Main: 192892928 04:11:02 INFO - PROCESS | 1683 | 04:14:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 04:14:04 INFO - PROCESS | 1683 | RSS: Main: 194805760 04:14:04 INFO - PROCESS | 1683 | 04:17:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 04:17:06 INFO - PROCESS | 1683 | RSS: Main: 198901760 04:17:06 INFO - PROCESS | 1683 | 04:20:09 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 04:20:10 INFO - PROCESS | 1683 | RSS: Main: 197824512 04:20:10 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 04:23:12 INFO - PROCESS | 1683 | RSS: Main: 203427840 04:23:12 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | __start_tp_report 04:23:12 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 04:23:12 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 04:23:12 INFO - PROCESS | 1683 | |i|pagename|runs| 04:23:12 INFO - PROCESS | 1683 | |0;dojo.html;3608.6932610728086;3662.560492740871;3673.9265214695724;3710.1652128271144;3716.033831203886;5814.447627475389;5951.910721339173;5976.163337132805;5980.1029845523135;5985.491233245174;5792;5941.851453713649;5957.374475680056;5961.672108034057;5988.700564971756;5320.76056577453;5351.678899266057;5353.464653534655;5366.91949620755;5456.727163641822;5359.115745901921;5461.1262198048125;5490.725463726798;5496.5053145216925;5513.669179849202;5462.426445223254;5470.753816078266;5478.205660179272;5493.752781124839;5502.394736578973;5447.101228297366;5475.425080366584;5482.5613950883835;5539.418361072069;5571.637843540157;5327.121025030865;5466.234727138204;5486.1222204447095;5487.862803429906;5496.7526461308935;6010.459058684739;6048.364921683248;6055.2430946131735;6069.605475644069;6103.05402662588;6163;6250.1874756281395;6312.368763123651;6332.271788744308;6333.651649159295;6321.715522801485;6339.397757213057;6371.585846919936;6372.426481616631;6376.0754690570075;6131.6934153292605;6163.876722465526;6166.383361663798;6166.938330616681;6169.074638804171;6365.681715914278;6503.674816259263;6570.901436478457;6625.105610742585;6660.666966651745;6285.371462853769;6288.5598008138995;6303.558750887486;6313.842153946188;6313.905291420632;6246.6876656167005;6370.235571731422;6374.904376434264;6379.266384365765;6413.35866413355;6224.62652240867;6263.248410190807;6315.431611154926;6327.620342779448;6357.237131544151;6255.186825712628;6282.591631543935;6299.401556852092;6302.936970630327;6361.9045714314325;5042.369703787027;5042.647014708935;5055.974720126376;5069.062223488666;5165.74171291434;4556.954430455719;4574.405327307495;4582.083583283356;4622.768861556976;4635.6523260755575;6194;6220.222472190976;6233.189685340967;6257.530685198628;6278.058291256348;6279.686015699197;6362.395572420613;6416.582922110048;6425.518086143465;6461.870762584722;6112.989854784201;6170.321264660884;6263.342349053284;6267.4045965633195;6292.653904035231;5660.773569057192;5678.063119585222;5680.801171958961;5695.40198279183;5706.80026199081;6519.902201466982;6593.3736295051895;6675.03212034262;6739.764108256188;6774.491913106438;4824.517548245148;6342;6444.871102578016;6482.448991835747;6604;6613;6618.371254730793;6660.467162627075;6662.433693135944;6671.866562668816;6209.813705588839;6276.592021518587;6311.90532142009;6317.241930968313;6350.301466838551;6372;6382.138411314413;6382.808515744535;6403.807885763435;6420.711068002044;6257.217847769029;6258.499320054476;6274.6548939808745;6285.371462853861;6302.338254483397;6156.78451254204;6223.595466294676;6225.750969961151;6241.500679945684;6286.779962701284;5769.211544421243;6186.721597528212;6196.566240363131;6220;6229.595076320024;5859.707014649336;6157.784477543264;6208.317085120543;6250.281217659845;6275.411435083603;5096.23556466533;6225.875482490234;6236.407541283571;6251.6561589113035;6285.717142728497 04:23:12 INFO - PROCESS | 1683 | |1;ext.html;504.5963229416466;548.3365128194883;586.8444862111538;615.1418770814713;676.333811195972;34926.95219143423;38807.44770209195;39028.21943561134;39237.41143882841;39369.01577460569;35263.82368088162;42326;42957.57042429575;43007.3548896766;43781;9665.32342736007;9768;9785.510724463784;9791.167750741195;9800.852987205197;9626.229901607889;9689.806203875918;9693.176080033205;9755.317127801056;9796.804063918717;9788.412695238272;9793.755156121082;9796.706098817047;9823.410595364265;9838.704838854846;8647.870281945712;9448.622055117787;9804.264680149017;9881.90118098817;9925.602975880993;9713.32006759527;9815;9835.31152819303;9871.309008369417;9872.308938374317;39599.80200098981;39745;40503.79748101241;40647.39028914569;40832;3250.2037000934924;3339.2820543583002;3381.188514756441;3390.74569407293;3404.540387047766;27179.320516987234;27201.047963321187;27297.45405091907;27534.862325688442;28008.719912801018;2840.573913912909;2851.615031970699;2862.155664079102;2888.927776805576;2893.1754449981654;280148;312127.4393628017;353229;353738;359373.4062659366;37645.870623881325;38396.8080159603;61909;65855.67072164608;65937;37186.814065929495;37229;37323.44014839779;37532;37572;15831.604209894846;15834.920825395799;15996.76004859928;16054.357825686842;16065.357385704441;13329.400176992058;13386.665333366744;13422.664433389047;13436.261005644588;13487.730245395038;8351.624176912053;8500.74497765068;8522.531260780717;8613.440126391764;8692.434991725517;3155.1165673611426;3525.665061819123;3590.479380489867;3600.513930619385;3605.351036813399;1049.6407152737072;1102.4267380961855;1165.6036947437913;1185.5435657272012;1188.5305304404712;30926.690733092382;30928;31358.52962205569;31591.368172636878;31679.20801979969;1143.2740209966564;1157.6584907452323;1167.311286341063;1167.4104577188634;1234.9811405590424;15550.533483995498;15965.201739912958;16034.67930641404;16153.676926461405;16235.350585976665;654295;656751;661041;664180;665597;60969;61797.382026180065;62516.68741656354;63706.6814665933;63715.04427433592;1474.262868565717;1544.4980381375874;1544.7065057639238;1559.2827299442383;1566.9764953525707;29306.120816375544;30418.239544011576;31054.844725776227;31073.378532429677;31605.20986975252;55121.724391377786;55434.72282638561;55591.444085560244;55838.60403489783;55982;492081;493088;494863;554178.1455463646;567710;26276.60585091187;27244.863775680995;27912.86043569769;27976.160715178576;28274.85862570674;47172.82067948191;47850.76074619604;48043.75978120087;48602.756986214845;48845;39252.64401860851;39613;39685;40058;40469.39295910505;33200.501992470614;36005;38966.025849353995;39314.213715726095;40102.39846402248;37779.67600293734;38920.80539597284;39061.82814515569;39395;39605.60394396019;32793.67206327906;34224.82887585546;34444.13889652779;34461.48307775335;34603.30793384169;26030.479390412464;26074.087406941424;26249.475010500064;26367.60448593311;26515.867420662773 04:23:12 INFO - PROCESS | 1683 | |2;jquery.html;361.7196672578753;408.53835166262127;414.5709190987329;419.8320671731306;426.95303516613166;15890.84109158908;16670.583235419104;19961.30135445258;20281.188752449903;20853.68719469209;19376.61246775067;19669.704954425695;19833.900830495862;19898.502537436536;19925.701114483258;5669.291338582677;5827.067669172944;6009.57932944694;6014.909776353358;6076.210092687967;5802.303723553179;5915.822525324247;5966.492848107916;5968.104784282349;6446.258680251784;6522.347765223487;6532.542722009462;6534.477241820643;6579.243387010483;6594.175728033996;6336.5247606429475;6553.279139294697;6555.672216389162;6682.064510968468;6693.828579998481;5983.910241346383;5996.910046349309;6038.124471951543;6038.18484504595;6051.243594550681;13611.931940340333;20970.951452427318;23698.881505592533;25065.749342506522;25842.483150336888;2084.72898523191;2191.2330684260382;2259.734817874365;2701.122135306033;2800.4679110969055;9676.17752491039;9909.40543567381;9979.301448898508;10026.298159128864;10035.09684128432;1822.3894995176631;1840.3190819396775;1844.3083843558666;1861.9162137703836;1916.9712454313058;110901.44549277282;116170.41914790457;116475.41762291134;116848;118040.40979795132;9670.70987870365;11702.356370399539;11961.64115076549;11992.940035299767;12058.216215946111;13683.657908552366;14607.707845843024;15083.773743393638;15210.011349262262;15272.236388180547;8706.259967902672;8723.462641885992;8792.560371981375;8881.866771998426;8960.820783584291;9000.819983600291;9031.548422578844;9046.592903319366;9050.370933232081;9052.592633331516;4731.33761273422;4736.976315118402;4773.64197685175;4809.711417314972;4810.975945120252;1793.2916497983485;1886.9528261793564;2100.737407824022;2163.0806907064434;2163.686265491495;895.1898531828706;952.6332362040664;966.7776411425411;991.7520619845038;1044.7074819050679;19131.90434047821;20007.799922000886;20032.69950950737;20200.393988180378;20249.291274805604;986.6448078691809;1009.2027298434155;1044.738815296176;1081.9188560857967;1088.472091035847;8892.777680557909;10305.587776488857;10652.307600005975;10689.30519516229;10704.30422022566;562792;571344;573259;599539;640241;123504.38247808703;125078;125191;126601;128869;1014.2849291249652;1020.5611587017505;1042.3068659341452;1056.3767377247461;1057.5346847387125;17239.56901077433;17498.73751893748;17514.211860466563;17664.381746638806;17840;39594.80202598969;47892.521074788805;48876.5112348872;51552.74223628858;53462.73268633632;65794;68527;68776.96834547386;69490;70351.29648703447;8038.718644847402;8051.154628763896;8070.596470176585;8293.751187464386;8410.201030902055;9305.022972587782;12190.268583884641;12851.228926264454;13056.086073974731;13254.138480998705;11186.832197517206;11388.829167562328;11421.657350279505;11428.14288928317;11669.299842009506;9157.679481218125;11105.278156919774;11159.386233756897;11371.601993930504;11532.59635912739;9603.991580884185;10758.13934885223;11219.71950701239;11498.25261358009;11658.18392712502;8207.917920820715;8329.791755205926;8416.4950102994;8447.366447516339;8694.869576956224;10524.31591946521;11512.30926144434;11623.360715160747;11671.474783634927;11773.882261177621 04:23:12 INFO - PROCESS | 1683 | |3;mootools.html;1636.427250462338;1654.5615411915844;1932.7294178814968;2013.6979453082035;2062.1339037604203;8319.251267385935;8988.325875559327;9199.724008279754;9379.71860844175;9385.343025988175;8912.509811960339;9037.141471560191;9046;9165.679201227958;9174.954125229382;2541.7585329393723;2542.733013033623;2545.0583284184877;2577.355661084729;2591.76674099331;2134.4770531219874;2216.7339919209635;2456.435019945414;2556.7698907098356;2561.513312470634;2130.52063285761;2469.925902222927;2524.4951009798024;2585.2890455124802;2600.4409052053807;2545.834520756145;2563.4873025394995;2575.497777933304;2581.2901452100637;2603.7786788122844;2549.8342607730438;2579.1359894435386;2579.5614745493313;2585.2761226856323;2610.7650311472057;9263.490508022123;9284.72145835626;9330.066993300683;9330.906690933072;9332.90667093334;5534.8653526027065;5547.5007249347345;5587.776488940438;5597.6641401515635;5614.326280846284;3221.067359584231;3625.7099432045375;3708.7575662153213;3725.1990821973404;3730.123420996064;1059.369675043348;1067.524951396629;1076.4348716923678;1081.9991507855202;1085.636311835536;12010.819837702442;12220.144589878711;12448.564300249447;12482.75034499305;12484;4777.498362671939;4957.504249575086;4963.950360496348;5021.49785021495;5095.1847704367865;8892;10393.16854651626;10431.21765867563;10477.580896764197;10478.109360704426;5592.133219351007;5615.185798059259;5641.746121424464;5648.039833228361;5649.209110724501;4559.6124329431705;4971.080350135237;5050.520200580939;5061.620378471629;5069.873253168626;4179.832806687759;4189.2040512302565;4206.516250631216;4215.831366745296;4333;1410.781328894023;1434.2613554019688;1440.7910852926268;1442.3941944383384;1451.1365737386238;954.6992697300328;966.8114717630135;968.3270127261486;975.9219262458986;996.0725995199313;6065;6065.5754097212775;6152.600080994721;6207.937920620826;6209.96895015522;915.208344781759;941.7221919533754;970.262600423669;972.3290929258789;1018.2770233134557;3973.1854969731135;4014.337634290368;4053.351463765783;4056.7160298778804;4073.429719839225;10715.892841071645;10805.459727013775;10820.296680715728;11050.447477626087;11075.889241107647;10795.730106747395;10984.956429139378;10994;11038.613648522263;11098.722531936766;8526.87209691855;8529.530875801891;8600.612972416131;8619.741407757778;8754.606042728092;5353.357597088374;5760.683162426107;5810.970945145247;5887.911681324698;6011.368806275278;9542.952285238529;9642.42145471274;9675.22598192157;9806;9948.154406875497;9798.559064841957;9912.35569687968;10194.694159175237;10354.171666266831;10502.579896804042;7019.5788252705;7822.335101516207;7872.960635196788;8260.545669988209;8515.872261915953;7541.585212813128;8402.117777633504;8500.489970601784;8588.22705956467;8631.56842157902;7464.888026679496;7559.1306999695735;7601.961990190013;7750.689972401041;7788.182240864628;7449.888251676338;7529.209433009455;7540.17058123595;7573.810654733676;7621.695132194872;7290.088738907637;7332.230115837973;7334.449916256195;7341.706331746884;7365.8158546036775;4957.504249575014;4960.206366981266;4969.4782047884455;5096.464871188472;5167.741612919414;5057.367829021372;5067.442581315979;5082.2122571001555;5177.404598471224;5280.4455532170105 04:23:12 INFO - PROCESS | 1683 | |4;prototype.html;332.97835640683354;336.4616613418529;337.1772874186985;340.0326072324238;348.17135218180726;5597.804076857311;7015.017897494355;7021.1925628552735;7049.154101507826;7057.400120989722;6970.721171153148;7022.016917631536;7031.296870312966;7039;7064.222935477106;4307.827686892536;4975.378077740292;5076.162433198518;5083.415407228161;5251.6061295403;5195;5220.347456567929;5237.528622423981;5240.973795131019;5243.606729495284;4219.324908014718;4219.746815191083;5202.4277329493725;5206.7917283308625;5208.166693329068;4322.740635561845;4955.40535135786;5239.921401178985;5253.737313134328;5262.684238945656;4470.284754439274;4479.372887795711;4481.7983190756495;4482.708623939466;4485.932711009337;6533.967330163367;6743.527953043289;6766.458683305324;6791.558548694319;6791.932080679179;6050.092486127072;6105.236845394325;6106.023036314168;6114.2357205349335;6114.8777024459705;6139.723712432907;7548.77353679385;7570.205128461487;7580.848383032364;7598.126215485235;3949.644531992106;4946.060248552763;4959.181735013718;4973.079980203674;4988.127077761377;7099.574025558483;7565.676006698805;7671.501352412131;7925.564093974829;7988.880166797503;4801.423829140455;4808.831690890802;4833.975830120898;4861.124997500484;4872.561469467765;4941.357623508921;4982.77577509013;5008.874778130576;5047.899042019139;5059.873503162376;5988.401159884064;5989.460948514655;5993.160957465958;5994.910076348859;6009.669468179292;7521.623918804038;7527.247275272539;7554.962225188839;7563.697452101855;7569.810754731176;1491.1798510819006;1610.5892997285616;1681.5874665281221;1741.8693597980202;1799.7930238022534;1084.728817795551;1117.9105671546256;1164.4818055965184;1166.6383421139474;1180.3095189314347;5288.444713305124;6483;6857.417119544894;7012.158540975116;7123.786286411416;6244;7644.503107298008;7727.304542591194;7776.611169441505;7833.451658383972;7194;7257.45569082321;7277.8544429111125;7281.708731650675;7338.046054012944;3740.354244132573;3761.2101458693983;3819.255245227154;4202.201581699528;4212;7560.508566943131;8230.259276665009;8282.875756863652;8296.626651800683;8320.875186872201;7939.007624046994;8151.673933042612;8182.4681395709085;8183.508989460652;8211.507309561446;8280.213379728915;8306.377021723394;8322.750317490363;8346.081930987466;8376.958115209385;7906.051273847175;7910;7917.129115797373;7952.522848629101;7954;6312.43188113072;7441.1070671519765;7510.023696919366;7705.422093343133;7788.92211077882;8272.586370681562;8280.378971577034;8310.70912518059;8311.584420779058;8369.95815020921;5055.949440505695;5073;5123.718195499283;5130.692158470503;5148.6910785353;7806.453548251568;7864.84270314602;7880.369570434466;7897.921020789719;7911.683532658629;7355.8161045974275;7543.1325397579985;7584.810379740551;7601.315881570686;7721.343685786771;7595.924040759522;7604.8479030420185;7616.504927179715;7619.885701714589;7638.961805190938;7359.8160045999275;7375.963120184365;7445.813854653677;7449.553026818408;7457.179710231761;7572.583507907118;7577.73477928292;7590.0891892973195;7635.00744903159;7639.465237433548;7103.502754807114;7426.962865185856;7428.6285685716575;7475.401967842451;7476.738314158978 04:23:12 INFO - PROCESS | 1683 | |5;yui.html;701.0325750464358;716.7168968257538;773.3310686256386;778.8130848596338;780.9687612495497;15333.769993450092;15387.153706546136;15392.846071539308;15543.766843497342;15779.816513761456;14419.990600657959;14423.134611923291;14543.418263269483;14556.636084097903;14571.417143314282;769.4729110559285;929.1405449958795;947.3605316411429;955.7992821507491;976.0873583199696;917.6237742525566;951.6478902805937;965.971020869375;967.7387105481516;967.88869280033;973.7711637765156;973.9513024348789;1008.8436292374694;1017.7760892603652;1019.6737044145876;974.4689144416275;975.9121679048919;1000.5547531348553;1005.7385079879248;1010.3937637417564;723.6924307169485;732.7801659502128;735.3639102176633;766.3486036868617;768.9000429944127;14959.850401496064;14994.70010599782;15060.698786024219;15407.460738874197;15454.227288635524;13321.866781332159;13397.062205645609;13434.932825335909;13491.988100892375;13493.055486115976;10373.79252414955;10443.477826108665;10452.425116618582;10465.947670261676;10496.212784041227;3427.9373394247614;3587.192881601645;3591.6587924147166;3727;3765.265773174232;48125.75937120327;56025.43974560243;75676;75985;76416.61791691062;9389.62441502346;9456.669016584387;9657.420554766737;9797.608095676236;9858.359206651545;22070.88964555199;22511.42420030582;22821.657675134888;22928.656070158628;23140;7837.686492540349;7877.527348359117;7903.249191326815;7916.366690664733;7969.481983671043;3642.417213245868;4123;4185.121124563815;4210.115875666083;4336.76147811867;3693.7045036397562;3715.3869611514338;3716;3773.2453509298252;3791.2038471920655;663.5123184459419;665.7736369634348;670.1723371636026;687.5153017123016;691.9273476284917;565.5419110520492;585.1749033862319;602.0968547179231;608.6378604730266;610.5542953643865;8446.113158118433;9043.32175086871;9051.909480905239;9093.454392736458;9105.681301154427;555.8943800677858;557.5288880895637;572.1103683771692;590.9982579527746;619.1084837833505;3859.7877116758846;3963.0686788604653;3972.781497017634;3986.142979259473;3990.3216453203027;71476;72786;93915.53042234745;96210.51894740481;96667.0333296672;60994.69502652458;78022;78209.4358112846;79101.60449197717;80917;71892.28107718856;72097.6395118021;72387;72914;73117;8482;8507;8678.479291242293;8701.695440659547;8821.2060914518;48391.27413088736;48991.75504122457;49135.50864491309;49207.753961229966;51301.48698513117;61124;66773;66950;67916.32083679298;68490;10813.837792432962;10903.56385744593;11145.275557088764;11269;11413.771724565297;11736.237144585575;11770.234934729215;12005.939970300093;12066.879331206575;12230.755384892074;11289.20975531705;11486.253393529394;11723.472443740222;11818.46816893259;11848.052155827341;8651.6971905983;9248.722538323862;10555.997180267863;11312.377819220023;11341.716457088638;10305.896941030494;11412.828807567726;11524.020458260806;11550.82673759911;11551.960323570918;9739.123478886651;9769.413835169913;9864.062914023156;10100.84848727255;10134.239932005277;7974.800629984296;9739.318247722875;9911.405315681082;9971.900280997097;10044.748881278027 04:23:12 INFO - PROCESS | 1683 | __end_tp_report 04:23:12 INFO - PROCESS | 1683 | __start_cc_report 04:23:12 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,397 04:23:12 INFO - PROCESS | 1683 | __end_cc_report 04:23:12 INFO - PROCESS | 1683 | __startTimestamp1469445792590__endTimestamp 04:23:12 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | ------- Summary: start ------- 04:23:12 INFO - PROCESS | 1683 | Number of tests: 6 04:23:12 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | [#0] dojo.html Cycles:165 Average:5957.36 Median:6224.63 stddev:630.20 (10.1%) stddev-sans-first:604.60 04:23:12 INFO - PROCESS | 1683 | Values: 3608.7 3662.6 3673.9 3710.2 3716.0 5814.4 5951.9 5976.2 5980.1 5985.5 5792.0 5941.9 5957.4 5961.7 5988.7 5320.8 5351.7 5353.5 5366.9 5456.7 5359.1 5461.1 5490.7 5496.5 5513.7 5462.4 5470.8 5478.2 5493.8 5502.4 5447.1 5475.4 5482.6 5539.4 5571.6 5327.1 5466.2 5486.1 5487.9 5496.8 6010.5 6048.4 6055.2 6069.6 6103.1 6163.0 6250.2 6312.4 6332.3 6333.7 6321.7 6339.4 6371.6 6372.4 6376.1 6131.7 6163.9 6166.4 6166.9 6169.1 6365.7 6503.7 6570.9 6625.1 6660.7 6285.4 6288.6 6303.6 6313.8 6313.9 6246.7 6370.2 6374.9 6379.3 6413.4 6224.6 6263.2 6315.4 6327.6 6357.2 6255.2 6282.6 6299.4 6302.9 6361.9 5042.4 5042.6 5056.0 5069.1 5165.7 4557.0 4574.4 4582.1 4622.8 4635.7 6194.0 6220.2 6233.2 6257.5 6278.1 6279.7 6362.4 6416.6 6425.5 6461.9 6113.0 6170.3 6263.3 6267.4 6292.7 5660.8 5678.1 5680.8 5695.4 5706.8 6519.9 6593.4 6675.0 6739.8 6774.5 4824.5 6342.0 6444.9 6482.4 6604.0 6613.0 6618.4 6660.5 6662.4 6671.9 6209.8 6276.6 6311.9 6317.2 6350.3 6372.0 6382.1 6382.8 6403.8 6420.7 6257.2 6258.5 6274.7 6285.4 6302.3 6156.8 6223.6 6225.8 6241.5 6286.8 5769.2 6186.7 6196.6 6220.0 6229.6 5859.7 6157.8 6208.3 6250.3 6275.4 5096.2 6225.9 6236.4 6251.7 6285.7 04:23:12 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | [#1] ext.html Cycles:180 Average:63898.38 Median:38088.24 stddev:140004.16 (367.6%) stddev-sans-first:140316.00 04:23:12 INFO - PROCESS | 1683 | Values: 504.6 548.3 586.8 615.1 676.3 34927.0 38807.4 39028.2 39237.4 39369.0 35263.8 42326.0 42957.6 43007.4 43781.0 9665.3 9768.0 9785.5 9791.2 9800.9 9626.2 9689.8 9693.2 9755.3 9796.8 9788.4 9793.8 9796.7 9823.4 9838.7 8647.9 9448.6 9804.3 9881.9 9925.6 9713.3 9815.0 9835.3 9871.3 9872.3 39599.8 39745.0 40503.8 40647.4 40832.0 3250.2 3339.3 3381.2 3390.7 3404.5 27179.3 27201.0 27297.5 27534.9 28008.7 2840.6 2851.6 2862.2 2888.9 2893.2 280148.0 312127.4 353229.0 353738.0 359373.4 37645.9 38396.8 61909.0 65855.7 65937.0 37186.8 37229.0 37323.4 37532.0 37572.0 15831.6 15834.9 15996.8 16054.4 16065.4 13329.4 13386.7 13422.7 13436.3 13487.7 8351.6 8500.7 8522.5 8613.4 8692.4 3155.1 3525.7 3590.5 3600.5 3605.4 1049.6 1102.4 1165.6 1185.5 1188.5 30926.7 30928.0 31358.5 31591.4 31679.2 1143.3 1157.7 1167.3 1167.4 1235.0 15550.5 15965.2 16034.7 16153.7 16235.4 654295.0 656751.0 661041.0 664180.0 665597.0 60969.0 61797.4 62516.7 63706.7 63715.0 1474.3 1544.5 1544.7 1559.3 1567.0 29306.1 30418.2 31054.8 31073.4 31605.2 55121.7 55434.7 55591.4 55838.6 55982.0 492081.0 493088.0 494863.0 554178.1 567710.0 26276.6 27244.9 27912.9 27976.2 28274.9 47172.8 47850.8 48043.8 48602.8 48845.0 39252.6 39613.0 39685.0 40058.0 40469.4 33200.5 36005.0 38966.0 39314.2 40102.4 37779.7 38920.8 39061.8 39395.0 39605.6 32793.7 34224.8 34444.1 34461.5 34603.3 26030.5 26074.1 26249.5 26367.6 26515.9 04:23:12 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | [#2] jquery.html Cycles:180 Average:34135.08 Median:2225.48 stddev:98345.94 (4419.1%) stddev-sans-first:98589.13 04:23:12 INFO - PROCESS | 1683 | Values: 361.7 408.5 414.6 419.8 427.0 15890.8 16670.6 19961.3 20281.2 20853.7 19376.6 19669.7 19833.9 19898.5 19925.7 5669.3 5827.1 6009.6 6014.9 6076.2 5802.3 5915.8 5966.5 5968.1 6446.3 6522.3 6532.5 6534.5 6579.2 6594.2 6336.5 6553.3 6555.7 6682.1 6693.8 5983.9 5996.9 6038.1 6038.2 6051.2 13611.9 20971.0 23698.9 25065.7 25842.5 2084.7 2191.2 2259.7 2701.1 2800.5 9676.2 9909.4 9979.3 10026.3 10035.1 1822.4 1840.3 1844.3 1861.9 1917.0 110901.4 116170.4 116475.4 116848.0 118040.4 9670.7 11702.4 11961.6 11992.9 12058.2 13683.7 14607.7 15083.8 15210.0 15272.2 8706.3 8723.5 8792.6 8881.9 8960.8 9000.8 9031.5 9046.6 9050.4 9052.6 4731.3 4737.0 4773.6 4809.7 4811.0 1793.3 1887.0 2100.7 2163.1 2163.7 895.2 952.6 966.8 991.8 1044.7 19131.9 20007.8 20032.7 20200.4 20249.3 986.6 1009.2 1044.7 1081.9 1088.5 8892.8 10305.6 10652.3 10689.3 10704.3 562792.0 571344.0 573259.0 599539.0 640241.0 123504.4 125078.0 125191.0 126601.0 128869.0 1014.3 1020.6 1042.3 1056.4 1057.5 17239.6 17498.7 17514.2 17664.4 17840.0 39594.8 47892.5 48876.5 51552.7 53462.7 65794.0 68527.0 68777.0 69490.0 70351.3 8038.7 8051.2 8070.6 8293.8 8410.2 9305.0 12190.3 12851.2 13056.1 13254.1 11186.8 11388.8 11421.7 11428.1 11669.3 9157.7 11105.3 11159.4 11371.6 11532.6 9604.0 10758.1 11219.7 11498.3 11658.2 8207.9 8329.8 8416.5 8447.4 8694.9 10524.3 11512.3 11623.4 11671.5 11773.9 04:23:12 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | [#3] mootools.html Cycles:180 Average:5913.89 Median:5068.66 stddev:3263.50 (64.4%) stddev-sans-first:3256.82 04:23:12 INFO - PROCESS | 1683 | Values: 1636.4 1654.6 1932.7 2013.7 2062.1 8319.3 8988.3 9199.7 9379.7 9385.3 8912.5 9037.1 9046.0 9165.7 9175.0 2541.8 2542.7 2545.1 2577.4 2591.8 2134.5 2216.7 2456.4 2556.8 2561.5 2130.5 2469.9 2524.5 2585.3 2600.4 2545.8 2563.5 2575.5 2581.3 2603.8 2549.8 2579.1 2579.6 2585.3 2610.8 9263.5 9284.7 9330.1 9330.9 9332.9 5534.9 5547.5 5587.8 5597.7 5614.3 3221.1 3625.7 3708.8 3725.2 3730.1 1059.4 1067.5 1076.4 1082.0 1085.6 12010.8 12220.1 12448.6 12482.8 12484.0 4777.5 4957.5 4964.0 5021.5 5095.2 8892.0 10393.2 10431.2 10477.6 10478.1 5592.1 5615.2 5641.7 5648.0 5649.2 4559.6 4971.1 5050.5 5061.6 5069.9 4179.8 4189.2 4206.5 4215.8 4333.0 1410.8 1434.3 1440.8 1442.4 1451.1 954.7 966.8 968.3 975.9 996.1 6065.0 6065.6 6152.6 6207.9 6210.0 915.2 941.7 970.3 972.3 1018.3 3973.2 4014.3 4053.4 4056.7 4073.4 10715.9 10805.5 10820.3 11050.4 11075.9 10795.7 10985.0 10994.0 11038.6 11098.7 8526.9 8529.5 8600.6 8619.7 8754.6 5353.4 5760.7 5811.0 5887.9 6011.4 9543.0 9642.4 9675.2 9806.0 9948.2 9798.6 9912.4 10194.7 10354.2 10502.6 7019.6 7822.3 7873.0 8260.5 8515.9 7541.6 8402.1 8500.5 8588.2 8631.6 7464.9 7559.1 7602.0 7750.7 7788.2 7449.9 7529.2 7540.2 7573.8 7621.7 7290.1 7332.2 7334.4 7341.7 7365.8 4957.5 4960.2 4969.5 5096.5 5167.7 5057.4 5067.4 5082.2 5177.4 5280.4 04:23:12 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | [#4] prototype.html Cycles:180 Average:6145.99 Median:7021.60 stddev:2013.01 (28.7%) stddev-sans-first:1970.81 04:23:12 INFO - PROCESS | 1683 | Values: 333.0 336.5 337.2 340.0 348.2 5597.8 7015.0 7021.2 7049.2 7057.4 6970.7 7022.0 7031.3 7039.0 7064.2 4307.8 4975.4 5076.2 5083.4 5251.6 5195.0 5220.3 5237.5 5241.0 5243.6 4219.3 4219.7 5202.4 5206.8 5208.2 4322.7 4955.4 5239.9 5253.7 5262.7 4470.3 4479.4 4481.8 4482.7 4485.9 6534.0 6743.5 6766.5 6791.6 6791.9 6050.1 6105.2 6106.0 6114.2 6114.9 6139.7 7548.8 7570.2 7580.8 7598.1 3949.6 4946.1 4959.2 4973.1 4988.1 7099.6 7565.7 7671.5 7925.6 7988.9 4801.4 4808.8 4834.0 4861.1 4872.6 4941.4 4982.8 5008.9 5047.9 5059.9 5988.4 5989.5 5993.2 5994.9 6009.7 7521.6 7527.2 7555.0 7563.7 7569.8 1491.2 1610.6 1681.6 1741.9 1799.8 1084.7 1117.9 1164.5 1166.6 1180.3 5288.4 6483.0 6857.4 7012.2 7123.8 6244.0 7644.5 7727.3 7776.6 7833.5 7194.0 7257.5 7277.9 7281.7 7338.0 3740.4 3761.2 3819.3 4202.2 4212.0 7560.5 8230.3 8282.9 8296.6 8320.9 7939.0 8151.7 8182.5 8183.5 8211.5 8280.2 8306.4 8322.8 8346.1 8377.0 7906.1 7910.0 7917.1 7952.5 7954.0 6312.4 7441.1 7510.0 7705.4 7788.9 8272.6 8280.4 8310.7 8311.6 8370.0 5055.9 5073.0 5123.7 5130.7 5148.7 7806.5 7864.8 7880.4 7897.9 7911.7 7355.8 7543.1 7584.8 7601.3 7721.3 7595.9 7604.8 7616.5 7619.9 7639.0 7359.8 7376.0 7445.8 7449.6 7457.2 7572.6 7577.7 7590.1 7635.0 7639.5 7103.5 7427.0 7428.6 7475.4 7476.7 04:23:12 INFO - PROCESS | 1683 | 04:23:12 INFO - PROCESS | 1683 | [#5] yui.html Cycles:180 Average:17815.58 Median:28295.49 stddev:24347.05 (86.0%) stddev-sans-first:24381.44 04:23:12 INFO - PROCESS | 1683 | Values: 701.0 716.7 773.3 778.8 781.0 15333.8 15387.2 15392.8 15543.8 15779.8 14420.0 14423.1 14543.4 14556.6 14571.4 769.5 929.1 947.4 955.8 976.1 917.6 951.6 966.0 967.7 967.9 973.8 974.0 1008.8 1017.8 1019.7 974.5 975.9 1000.6 1005.7 1010.4 723.7 732.8 735.4 766.3 768.9 14959.9 14994.7 15060.7 15407.5 15454.2 13321.9 13397.1 13434.9 13492.0 13493.1 10373.8 10443.5 10452.4 10465.9 10496.2 3427.9 3587.2 3591.7 3727.0 3765.3 48125.8 56025.4 75676.0 75985.0 76416.6 9389.6 9456.7 9657.4 9797.6 9858.4 22070.9 22511.4 22821.7 22928.7 23140.0 7837.7 7877.5 7903.2 7916.4 7969.5 3642.4 4123.0 4185.1 4210.1 4336.8 3693.7 3715.4 3716.0 3773.2 3791.2 663.5 665.8 670.2 687.5 691.9 565.5 585.2 602.1 608.6 610.6 8446.1 9043.3 9051.9 9093.5 9105.7 555.9 557.5 572.1 591.0 619.1 3859.8 3963.1 3972.8 3986.1 3990.3 71476.0 72786.0 93915.5 96210.5 96667.0 60994.7 78022.0 78209.4 79101.6 80917.0 71892.3 72097.6 72387.0 72914.0 73117.0 8482.0 8507.0 8678.5 8701.7 8821.2 48391.3 48991.8 49135.5 49207.8 51301.5 61124.0 66773.0 66950.0 67916.3 68490.0 10813.8 10903.6 11145.3 11269.0 11413.8 11736.2 11770.2 12005.9 12066.9 12230.8 11289.2 11486.3 11723.5 11818.5 11848.1 8651.7 9248.7 10556.0 11312.4 11341.7 10305.9 11412.8 11524.0 11550.8 11552.0 9739.1 9769.4 9864.1 10100.8 10134.2 7974.8 9739.3 9911.4 9971.9 10044.7 04:23:12 INFO - PROCESS | 1683 | -------- Summary: end -------- 04:23:12 INFO - PROCESS | 1683 | 04:23:13 INFO - TEST-INFO | 1683: exit 0 04:23:13 INFO - TEST-OK | dromaeo_css | took 1110360ms 04:23:13 INFO - TEST-START | kraken 04:23:13 INFO - operating with platform_type : mac_ 04:23:13 INFO - Initialising browser for kraken test... 04:23:13 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmp5JSBLv/profile http://localhost:49275/getInfo.html) 04:23:15 INFO - PROCESS | 1693 | __metrics Screen width/height:1600/1200 04:23:15 INFO - PROCESS | 1693 | colorDepth:24 04:23:15 INFO - PROCESS | 1693 | Browser inner width/height: 1024/689 04:23:15 INFO - PROCESS | 1693 | __metrics 04:23:15 ERROR - PROCESS | 1693 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:23:16 INFO - TEST-INFO | 1693: exit 0 04:23:16 INFO - Browser initialized. 04:23:16 INFO - Running cycle 1/1 for kraken test... 04:23:16 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmp5JSBLv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:28 INFO - PROCESS | 1697 | RSS: Main: 171278336 04:23:28 INFO - PROCESS | 1697 | 04:23:30 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 04:23:31 INFO - PROCESS | 1697 | RSS: Main: 183812096 04:23:31 INFO - PROCESS | 1697 | 04:23:34 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 04:23:35 INFO - PROCESS | 1697 | RSS: Main: 193003520 04:23:35 INFO - PROCESS | 1697 | 04:23:38 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 04:23:39 INFO - PROCESS | 1697 | RSS: Main: 195870720 04:23:39 INFO - PROCESS | 1697 | 04:23:41 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 04:23:41 INFO - PROCESS | 1697 | RSS: Main: 196792320 04:23:41 INFO - PROCESS | 1697 | 04:23:43 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:23:44 INFO - PROCESS | 1697 | RSS: Main: 197087232 04:23:44 INFO - PROCESS | 1697 | 04:23:47 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 04:23:47 INFO - PROCESS | 1697 | RSS: Main: 198787072 04:23:47 INFO - PROCESS | 1697 | 04:23:50 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 04:23:51 INFO - PROCESS | 1697 | RSS: Main: 198590464 04:23:51 INFO - PROCESS | 1697 | 04:23:54 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 04:23:54 INFO - PROCESS | 1697 | RSS: Main: 198795264 04:23:54 INFO - PROCESS | 1697 | 04:23:56 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:23:57 INFO - PROCESS | 1697 | RSS: Main: 197816320 04:23:57 INFO - PROCESS | 1697 | 04:23:59 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:23:59 INFO - PROCESS | 1697 | RSS: Main: 197844992 04:23:59 INFO - PROCESS | 1697 | 04:24:01 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:24:02 INFO - PROCESS | 1697 | RSS: Main: 198381568 04:24:02 INFO - PROCESS | 1697 | 04:24:05 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:24:05 INFO - PROCESS | 1697 | RSS: Main: 197955584 04:24:05 INFO - PROCESS | 1697 | 04:24:08 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:24:09 INFO - PROCESS | 1697 | RSS: Main: 197824512 04:24:09 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 04:24:11 INFO - PROCESS | 1697 | RSS: Main: 199557120 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | __start_tp_report 04:24:11 INFO - PROCESS | 1697 | _x_x_mozilla_page_load 04:24:11 INFO - PROCESS | 1697 | _x_x_mozilla_page_load_details 04:24:11 INFO - PROCESS | 1697 | |i|pagename|runs| 04:24:11 INFO - PROCESS | 1697 | |0;ai-astar;117;112;135;118;119;132;116;116;118;117 04:24:11 INFO - PROCESS | 1697 | |1;audio-beat-detection;156;121;139;156;120;150;158;180;194;158 04:24:11 INFO - PROCESS | 1697 | |2;audio-dft;199;197;219;269;205;197;197;196;194;192 04:24:11 INFO - PROCESS | 1697 | |3;audio-fft;63;79;74;146;75;83;90;60;125;57 04:24:11 INFO - PROCESS | 1697 | |4;audio-oscillator;79;80;120;78;78;89;119;79;79;122 04:24:11 INFO - PROCESS | 1697 | |5;imaging-gaussian-blur;96;89;90;89;89;92;90;92;136;86 04:24:11 INFO - PROCESS | 1697 | |6;imaging-darkroom;94;95;95;94;97;150;149;94;94;95 04:24:11 INFO - PROCESS | 1697 | |7;imaging-desaturate;90;93;89;92;101;148;145;90;115;146 04:24:11 INFO - PROCESS | 1697 | |8;json-parse-financial;59;62;63;82;76;54;79;103;94;90 04:24:11 INFO - PROCESS | 1697 | |9;json-stringify-tinderbox;59;60;104;96;115;82;71;65;67;73 04:24:11 INFO - PROCESS | 1697 | |10;stanford-crypto-aes;85;101;104;70;96;69;80;108;87;100 04:24:11 INFO - PROCESS | 1697 | |11;stanford-crypto-ccm;125;129;128;128;132;127;124;116;152;159 04:24:11 INFO - PROCESS | 1697 | |12;stanford-crypto-pbkdf2;165;179;202;161;232;162;163;181;216;195 04:24:11 INFO - PROCESS | 1697 | |13;stanford-crypto-sha256-iterative;70;70;69;65;70;82;97;91;95;66 04:24:11 INFO - PROCESS | 1697 | __end_tp_report 04:24:11 INFO - PROCESS | 1697 | __start_cc_report 04:24:11 INFO - PROCESS | 1697 | _x_x_mozilla_cycle_collect,1029 04:24:11 INFO - PROCESS | 1697 | __end_cc_report 04:24:11 INFO - PROCESS | 1697 | __startTimestamp1469445851602__endTimestamp 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | ------- Summary: start ------- 04:24:11 INFO - PROCESS | 1697 | Number of tests: 14 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#0] ai-astar Cycles:10 Average:120.00 Median:118.00 stddev:7.39 (6.3%) stddev-sans-first:7.76 04:24:11 INFO - PROCESS | 1697 | Values: 117.0 112.0 135.0 118.0 119.0 132.0 116.0 116.0 118.0 117.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:157.00 stddev:23.08 (14.7%) stddev-sans-first:24.46 04:24:11 INFO - PROCESS | 1697 | Values: 156.0 121.0 139.0 156.0 120.0 150.0 158.0 180.0 194.0 158.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#2] audio-dft Cycles:10 Average:206.50 Median:198.00 stddev:23.26 (11.7%) stddev-sans-first:24.51 04:24:11 INFO - PROCESS | 1697 | Values: 199.0 197.0 219.0 269.0 205.0 197.0 197.0 196.0 194.0 192.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#3] audio-fft Cycles:10 Average:85.20 Median:74.50 stddev:28.87 (38.7%) stddev-sans-first:29.48 04:24:11 INFO - PROCESS | 1697 | Values: 63.0 79.0 74.0 146.0 75.0 83.0 90.0 60.0 125.0 57.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:79.00 stddev:19.62 (24.8%) stddev-sans-first:20.21 04:24:11 INFO - PROCESS | 1697 | Values: 79.0 80.0 120.0 78.0 78.0 89.0 119.0 79.0 79.0 122.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#5] imaging-gaussian-blur Cycles:10 Average:94.90 Median:90.00 stddev:14.68 (16.3%) stddev-sans-first:15.56 04:24:11 INFO - PROCESS | 1697 | Values: 96.0 89.0 90.0 89.0 89.0 92.0 90.0 92.0 136.0 86.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#6] imaging-darkroom Cycles:10 Average:105.70 Median:94.50 stddev:23.10 (24.4%) stddev-sans-first:24.11 04:24:11 INFO - PROCESS | 1697 | Values: 94.0 95.0 95.0 94.0 97.0 150.0 149.0 94.0 94.0 95.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#7] imaging-desaturate Cycles:10 Average:110.90 Median:89.50 stddev:25.64 (28.6%) stddev-sans-first:26.06 04:24:11 INFO - PROCESS | 1697 | Values: 90.0 93.0 89.0 92.0 101.0 148.0 145.0 90.0 115.0 146.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#8] json-parse-financial Cycles:10 Average:76.20 Median:77.50 stddev:16.44 (21.2%) stddev-sans-first:16.21 04:24:11 INFO - PROCESS | 1697 | Values: 59.0 62.0 63.0 82.0 76.0 54.0 79.0 103.0 94.0 90.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#9] json-stringify-tinderbox Cycles:10 Average:79.20 Median:69.00 stddev:19.49 (28.2%) stddev-sans-first:19.26 04:24:11 INFO - PROCESS | 1697 | Values: 59.0 60.0 104.0 96.0 115.0 82.0 71.0 65.0 67.0 73.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:75.00 stddev:13.95 (18.6%) stddev-sans-first:14.68 04:24:11 INFO - PROCESS | 1697 | Values: 85.0 101.0 104.0 70.0 96.0 69.0 80.0 108.0 87.0 100.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#11] stanford-crypto-ccm Cycles:10 Average:132.00 Median:128.50 stddev:13.18 (10.3%) stddev-sans-first:13.74 04:24:11 INFO - PROCESS | 1697 | Values: 125.0 129.0 128.0 128.0 132.0 127.0 124.0 116.0 152.0 159.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.60 Median:188.00 stddev:24.94 (13.3%) stddev-sans-first:25.31 04:24:11 INFO - PROCESS | 1697 | Values: 165.0 179.0 202.0 161.0 232.0 162.0 163.0 181.0 216.0 195.0 04:24:11 INFO - PROCESS | 1697 | 04:24:11 INFO - PROCESS | 1697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:76.00 stddev:12.55 (16.5%) stddev-sans-first:13.02 04:24:11 INFO - PROCESS | 1697 | Values: 70.0 70.0 69.0 65.0 70.0 82.0 97.0 91.0 95.0 66.0 04:24:11 INFO - PROCESS | 1697 | -------- Summary: end -------- 04:24:11 INFO - PROCESS | 1697 | 04:24:12 INFO - TEST-INFO | 1697: exit 0 04:24:12 INFO - TEST-OK | kraken | took 59245ms 04:24:12 INFO - SUITE-END | took 1169s 04:24:12 INFO - Completed test suite (00:19:30) 04:24:12 INFO - javascript benchmark 04:24:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3608.6932610728086, 3662.560492740871, 3673.9265214695724, 3710.1652128271144, 3716.033831203886, 5814.447627475389, 5951.910721339173, 5976.163337132805, 5980.1029845523135, 5985.491233245174, 5792.0, 5941.851453713649, 5957.374475680056, 5961.672108034057, 5988.700564971756, 5320.76056577453, 5351.678899266057, 5353.464653534655, 5366.91949620755, 5456.727163641822, 5359.115745901921, 5461.1262198048125, 5490.725463726798, 5496.5053145216925, 5513.669179849202, 5462.426445223254, 5470.753816078266, 5478.205660179272, 5493.752781124839, 5502.394736578973, 5447.101228297366, 5475.425080366584, 5482.5613950883835, 5539.418361072069, 5571.637843540157, 5327.121025030865, 5466.234727138204, 5486.1222204447095, 5487.862803429906, 5496.7526461308935, 6010.459058684739, 6048.364921683248, 6055.2430946131735, 6069.605475644069, 6103.05402662588, 6163.0, 6250.1874756281395, 6312.368763123651, 6332.271788744308, 6333.651649159295, 6321.715522801485, 6339.397757213057, 6371.585846919936, 6372.426481616631, 6376.0754690570075, 6131.6934153292605, 6163.876722465526, 6166.383361663798, 6166.938330616681, 6169.074638804171, 6365.681715914278, 6503.674816259263, 6570.901436478457, 6625.105610742585, 6660.666966651745, 6285.371462853769, 6288.5598008138995, 6303.558750887486, 6313.842153946188, 6313.905291420632, 6246.6876656167005, 6370.235571731422, 6374.904376434264, 6379.266384365765, 6413.35866413355, 6224.62652240867, 6263.248410190807, 6315.431611154926, 6327.620342779448, 6357.237131544151, 6255.186825712628, 6282.591631543935, 6299.401556852092, 6302.936970630327, 6361.9045714314325, 5042.369703787027, 5042.647014708935, 5055.974720126376, 5069.062223488666, 5165.74171291434, 4556.954430455719, 4574.405327307495, 4582.083583283356, 4622.768861556976, 4635.6523260755575, 6194.0, 6220.222472190976, 6233.189685340967, 6257.530685198628, 6278.058291256348, 6279.686015699197, 6362.395572420613, 6416.582922110048, 6425.518086143465, 6461.870762584722, 6112.989854784201, 6170.321264660884, 6263.342349053284, 6267.4045965633195, 6292.653904035231, 5660.773569057192, 5678.063119585222, 5680.801171958961, 5695.40198279183, 5706.80026199081, 6519.902201466982, 6593.3736295051895, 6675.03212034262, 6739.764108256188, 6774.491913106438, 4824.517548245148, 6342.0, 6444.871102578016, 6482.448991835747, 6604.0, 6613.0, 6618.371254730793, 6660.467162627075, 6662.433693135944, 6671.866562668816, 6209.813705588839, 6276.592021518587, 6311.90532142009, 6317.241930968313, 6350.301466838551, 6372.0, 6382.138411314413, 6382.808515744535, 6403.807885763435, 6420.711068002044, 6257.217847769029, 6258.499320054476, 6274.6548939808745, 6285.371462853861, 6302.338254483397, 6156.78451254204, 6223.595466294676, 6225.750969961151, 6241.500679945684, 6286.779962701284, 5769.211544421243, 6186.721597528212, 6196.566240363131, 6220.0, 6229.595076320024, 5859.707014649336, 6157.784477543264, 6208.317085120543, 6250.281217659845, 6275.411435083603, 5096.23556466533, 6225.875482490234, 6236.407541283571, 6251.6561589113035, 6285.717142728497], "value": 5920.623045439681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.5963229416466, 548.3365128194883, 586.8444862111538, 615.1418770814713, 676.333811195972, 34926.95219143423, 38807.44770209195, 39028.21943561134, 39237.41143882841, 39369.01577460569, 35263.82368088162, 42326.0, 42957.57042429575, 43007.3548896766, 43781.0, 9665.32342736007, 9768.0, 9785.510724463784, 9791.167750741195, 9800.852987205197, 9626.229901607889, 9689.806203875918, 9693.176080033205, 9755.317127801056, 9796.804063918717, 9788.412695238272, 9793.755156121082, 9796.706098817047, 9823.410595364265, 9838.704838854846, 8647.870281945712, 9448.622055117787, 9804.264680149017, 9881.90118098817, 9925.602975880993, 9713.32006759527, 9815.0, 9835.31152819303, 9871.309008369417, 9872.308938374317, 39599.80200098981, 39745.0, 40503.79748101241, 40647.39028914569, 40832.0, 3250.2037000934924, 3339.2820543583002, 3381.188514756441, 3390.74569407293, 3404.540387047766, 27179.320516987234, 27201.047963321187, 27297.45405091907, 27534.862325688442, 28008.719912801018, 2840.573913912909, 2851.615031970699, 2862.155664079102, 2888.927776805576, 2893.1754449981654, 280148.0, 312127.4393628017, 353229.0, 353738.0, 359373.4062659366, 37645.870623881325, 38396.8080159603, 61909.0, 65855.67072164608, 65937.0, 37186.814065929495, 37229.0, 37323.44014839779, 37532.0, 37572.0, 15831.604209894846, 15834.920825395799, 15996.76004859928, 16054.357825686842, 16065.357385704441, 13329.400176992058, 13386.665333366744, 13422.664433389047, 13436.261005644588, 13487.730245395038, 8351.624176912053, 8500.74497765068, 8522.531260780717, 8613.440126391764, 8692.434991725517, 3155.1165673611426, 3525.665061819123, 3590.479380489867, 3600.513930619385, 3605.351036813399, 1049.6407152737072, 1102.4267380961855, 1165.6036947437913, 1185.5435657272012, 1188.5305304404712, 30926.690733092382, 30928.0, 31358.52962205569, 31591.368172636878, 31679.20801979969, 1143.2740209966564, 1157.6584907452323, 1167.311286341063, 1167.4104577188634, 1234.9811405590424, 15550.533483995498, 15965.201739912958, 16034.67930641404, 16153.676926461405, 16235.350585976665, 654295.0, 656751.0, 661041.0, 664180.0, 665597.0, 60969.0, 61797.382026180065, 62516.68741656354, 63706.6814665933, 63715.04427433592, 1474.262868565717, 1544.4980381375874, 1544.7065057639238, 1559.2827299442383, 1566.9764953525707, 29306.120816375544, 30418.239544011576, 31054.844725776227, 31073.378532429677, 31605.20986975252, 55121.724391377786, 55434.72282638561, 55591.444085560244, 55838.60403489783, 55982.0, 492081.0, 493088.0, 494863.0, 554178.1455463646, 567710.0, 26276.60585091187, 27244.863775680995, 27912.86043569769, 27976.160715178576, 28274.85862570674, 47172.82067948191, 47850.76074619604, 48043.75978120087, 48602.756986214845, 48845.0, 39252.64401860851, 39613.0, 39685.0, 40058.0, 40469.39295910505, 33200.501992470614, 36005.0, 38966.025849353995, 39314.213715726095, 40102.39846402248, 37779.67600293734, 38920.80539597284, 39061.82814515569, 39395.0, 39605.60394396019, 32793.67206327906, 34224.82887585546, 34444.13889652779, 34461.48307775335, 34603.30793384169, 26030.479390412464, 26074.087406941424, 26249.475010500064, 26367.60448593311, 26515.867420662773], "value": 18936.78717090879, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.7196672578753, 408.53835166262127, 414.5709190987329, 419.8320671731306, 426.95303516613166, 15890.84109158908, 16670.583235419104, 19961.30135445258, 20281.188752449903, 20853.68719469209, 19376.61246775067, 19669.704954425695, 19833.900830495862, 19898.502537436536, 19925.701114483258, 5669.291338582677, 5827.067669172944, 6009.57932944694, 6014.909776353358, 6076.210092687967, 5802.303723553179, 5915.822525324247, 5966.492848107916, 5968.104784282349, 6446.258680251784, 6522.347765223487, 6532.542722009462, 6534.477241820643, 6579.243387010483, 6594.175728033996, 6336.5247606429475, 6553.279139294697, 6555.672216389162, 6682.064510968468, 6693.828579998481, 5983.910241346383, 5996.910046349309, 6038.124471951543, 6038.18484504595, 6051.243594550681, 13611.931940340333, 20970.951452427318, 23698.881505592533, 25065.749342506522, 25842.483150336888, 2084.72898523191, 2191.2330684260382, 2259.734817874365, 2701.122135306033, 2800.4679110969055, 9676.17752491039, 9909.40543567381, 9979.301448898508, 10026.298159128864, 10035.09684128432, 1822.3894995176631, 1840.3190819396775, 1844.3083843558666, 1861.9162137703836, 1916.9712454313058, 110901.44549277282, 116170.41914790457, 116475.41762291134, 116848.0, 118040.40979795132, 9670.70987870365, 11702.356370399539, 11961.64115076549, 11992.940035299767, 12058.216215946111, 13683.657908552366, 14607.707845843024, 15083.773743393638, 15210.011349262262, 15272.236388180547, 8706.259967902672, 8723.462641885992, 8792.560371981375, 8881.866771998426, 8960.820783584291, 9000.819983600291, 9031.548422578844, 9046.592903319366, 9050.370933232081, 9052.592633331516, 4731.33761273422, 4736.976315118402, 4773.64197685175, 4809.711417314972, 4810.975945120252, 1793.2916497983485, 1886.9528261793564, 2100.737407824022, 2163.0806907064434, 2163.686265491495, 895.1898531828706, 952.6332362040664, 966.7776411425411, 991.7520619845038, 1044.7074819050679, 19131.90434047821, 20007.799922000886, 20032.69950950737, 20200.393988180378, 20249.291274805604, 986.6448078691809, 1009.2027298434155, 1044.738815296176, 1081.9188560857967, 1088.472091035847, 8892.777680557909, 10305.587776488857, 10652.307600005975, 10689.30519516229, 10704.30422022566, 562792.0, 571344.0, 573259.0, 599539.0, 640241.0, 123504.38247808703, 125078.0, 125191.0, 126601.0, 128869.0, 1014.2849291249652, 1020.5611587017505, 1042.3068659341452, 1056.3767377247461, 1057.5346847387125, 17239.56901077433, 17498.73751893748, 17514.211860466563, 17664.381746638806, 17840.0, 39594.80202598969, 47892.521074788805, 48876.5112348872, 51552.74223628858, 53462.73268633632, 65794.0, 68527.0, 68776.96834547386, 69490.0, 70351.29648703447, 8038.718644847402, 8051.154628763896, 8070.596470176585, 8293.751187464386, 8410.201030902055, 9305.022972587782, 12190.268583884641, 12851.228926264454, 13056.086073974731, 13254.138480998705, 11186.832197517206, 11388.829167562328, 11421.657350279505, 11428.14288928317, 11669.299842009506, 9157.679481218125, 11105.278156919774, 11159.386233756897, 11371.601993930504, 11532.59635912739, 9603.991580884185, 10758.13934885223, 11219.71950701239, 11498.25261358009, 11658.18392712502, 8207.917920820715, 8329.791755205926, 8416.4950102994, 8447.366447516339, 8694.869576956224, 10524.31591946521, 11512.30926144434, 11623.360715160747, 11671.474783634927, 11773.882261177621], "value": 9615.456302781491, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1636.427250462338, 1654.5615411915844, 1932.7294178814968, 2013.6979453082035, 2062.1339037604203, 8319.251267385935, 8988.325875559327, 9199.724008279754, 9379.71860844175, 9385.343025988175, 8912.509811960339, 9037.141471560191, 9046.0, 9165.679201227958, 9174.954125229382, 2541.7585329393723, 2542.733013033623, 2545.0583284184877, 2577.355661084729, 2591.76674099331, 2134.4770531219874, 2216.7339919209635, 2456.435019945414, 2556.7698907098356, 2561.513312470634, 2130.52063285761, 2469.925902222927, 2524.4951009798024, 2585.2890455124802, 2600.4409052053807, 2545.834520756145, 2563.4873025394995, 2575.497777933304, 2581.2901452100637, 2603.7786788122844, 2549.8342607730438, 2579.1359894435386, 2579.5614745493313, 2585.2761226856323, 2610.7650311472057, 9263.490508022123, 9284.72145835626, 9330.066993300683, 9330.906690933072, 9332.90667093334, 5534.8653526027065, 5547.5007249347345, 5587.776488940438, 5597.6641401515635, 5614.326280846284, 3221.067359584231, 3625.7099432045375, 3708.7575662153213, 3725.1990821973404, 3730.123420996064, 1059.369675043348, 1067.524951396629, 1076.4348716923678, 1081.9991507855202, 1085.636311835536, 12010.819837702442, 12220.144589878711, 12448.564300249447, 12482.75034499305, 12484.0, 4777.498362671939, 4957.504249575086, 4963.950360496348, 5021.49785021495, 5095.1847704367865, 8892.0, 10393.16854651626, 10431.21765867563, 10477.580896764197, 10478.109360704426, 5592.133219351007, 5615.185798059259, 5641.746121424464, 5648.039833228361, 5649.209110724501, 4559.6124329431705, 4971.080350135237, 5050.520200580939, 5061.620378471629, 5069.873253168626, 4179.832806687759, 4189.2040512302565, 4206.516250631216, 4215.831366745296, 4333.0, 1410.781328894023, 1434.2613554019688, 1440.7910852926268, 1442.3941944383384, 1451.1365737386238, 954.6992697300328, 966.8114717630135, 968.3270127261486, 975.9219262458986, 996.0725995199313, 6065.0, 6065.5754097212775, 6152.600080994721, 6207.937920620826, 6209.96895015522, 915.208344781759, 941.7221919533754, 970.262600423669, 972.3290929258789, 1018.2770233134557, 3973.1854969731135, 4014.337634290368, 4053.351463765783, 4056.7160298778804, 4073.429719839225, 10715.892841071645, 10805.459727013775, 10820.296680715728, 11050.447477626087, 11075.889241107647, 10795.730106747395, 10984.956429139378, 10994.0, 11038.613648522263, 11098.722531936766, 8526.87209691855, 8529.530875801891, 8600.612972416131, 8619.741407757778, 8754.606042728092, 5353.357597088374, 5760.683162426107, 5810.970945145247, 5887.911681324698, 6011.368806275278, 9542.952285238529, 9642.42145471274, 9675.22598192157, 9806.0, 9948.154406875497, 9798.559064841957, 9912.35569687968, 10194.694159175237, 10354.171666266831, 10502.579896804042, 7019.5788252705, 7822.335101516207, 7872.960635196788, 8260.545669988209, 8515.872261915953, 7541.585212813128, 8402.117777633504, 8500.489970601784, 8588.22705956467, 8631.56842157902, 7464.888026679496, 7559.1306999695735, 7601.961990190013, 7750.689972401041, 7788.182240864628, 7449.888251676338, 7529.209433009455, 7540.17058123595, 7573.810654733676, 7621.695132194872, 7290.088738907637, 7332.230115837973, 7334.449916256195, 7341.706331746884, 7365.8158546036775, 4957.504249575014, 4960.206366981266, 4969.4782047884455, 5096.464871188472, 5167.741612919414, 5057.367829021372, 5067.442581315979, 5082.2122571001555, 5177.404598471224, 5280.4455532170105], "value": 4791.311938272351, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.97835640683354, 336.4616613418529, 337.1772874186985, 340.0326072324238, 348.17135218180726, 5597.804076857311, 7015.017897494355, 7021.1925628552735, 7049.154101507826, 7057.400120989722, 6970.721171153148, 7022.016917631536, 7031.296870312966, 7039.0, 7064.222935477106, 4307.827686892536, 4975.378077740292, 5076.162433198518, 5083.415407228161, 5251.6061295403, 5195.0, 5220.347456567929, 5237.528622423981, 5240.973795131019, 5243.606729495284, 4219.324908014718, 4219.746815191083, 5202.4277329493725, 5206.7917283308625, 5208.166693329068, 4322.740635561845, 4955.40535135786, 5239.921401178985, 5253.737313134328, 5262.684238945656, 4470.284754439274, 4479.372887795711, 4481.7983190756495, 4482.708623939466, 4485.932711009337, 6533.967330163367, 6743.527953043289, 6766.458683305324, 6791.558548694319, 6791.932080679179, 6050.092486127072, 6105.236845394325, 6106.023036314168, 6114.2357205349335, 6114.8777024459705, 6139.723712432907, 7548.77353679385, 7570.205128461487, 7580.848383032364, 7598.126215485235, 3949.644531992106, 4946.060248552763, 4959.181735013718, 4973.079980203674, 4988.127077761377, 7099.574025558483, 7565.676006698805, 7671.501352412131, 7925.564093974829, 7988.880166797503, 4801.423829140455, 4808.831690890802, 4833.975830120898, 4861.124997500484, 4872.561469467765, 4941.357623508921, 4982.77577509013, 5008.874778130576, 5047.899042019139, 5059.873503162376, 5988.401159884064, 5989.460948514655, 5993.160957465958, 5994.910076348859, 6009.669468179292, 7521.623918804038, 7527.247275272539, 7554.962225188839, 7563.697452101855, 7569.810754731176, 1491.1798510819006, 1610.5892997285616, 1681.5874665281221, 1741.8693597980202, 1799.7930238022534, 1084.728817795551, 1117.9105671546256, 1164.4818055965184, 1166.6383421139474, 1180.3095189314347, 5288.444713305124, 6483.0, 6857.417119544894, 7012.158540975116, 7123.786286411416, 6244.0, 7644.503107298008, 7727.304542591194, 7776.611169441505, 7833.451658383972, 7194.0, 7257.45569082321, 7277.8544429111125, 7281.708731650675, 7338.046054012944, 3740.354244132573, 3761.2101458693983, 3819.255245227154, 4202.201581699528, 4212.0, 7560.508566943131, 8230.259276665009, 8282.875756863652, 8296.626651800683, 8320.875186872201, 7939.007624046994, 8151.673933042612, 8182.4681395709085, 8183.508989460652, 8211.507309561446, 8280.213379728915, 8306.377021723394, 8322.750317490363, 8346.081930987466, 8376.958115209385, 7906.051273847175, 7910.0, 7917.129115797373, 7952.522848629101, 7954.0, 6312.43188113072, 7441.1070671519765, 7510.023696919366, 7705.422093343133, 7788.92211077882, 8272.586370681562, 8280.378971577034, 8310.70912518059, 8311.584420779058, 8369.95815020921, 5055.949440505695, 5073.0, 5123.718195499283, 5130.692158470503, 5148.6910785353, 7806.453548251568, 7864.84270314602, 7880.369570434466, 7897.921020789719, 7911.683532658629, 7355.8161045974275, 7543.1325397579985, 7584.810379740551, 7601.315881570686, 7721.343685786771, 7595.924040759522, 7604.8479030420185, 7616.504927179715, 7619.885701714589, 7638.961805190938, 7359.8160045999275, 7375.963120184365, 7445.813854653677, 7449.553026818408, 7457.179710231761, 7572.583507907118, 7577.73477928292, 7590.0891892973195, 7635.00744903159, 7639.465237433548, 7103.502754807114, 7426.962865185856, 7428.6285685716575, 7475.401967842451, 7476.738314158978], "value": 5469.098862173826, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.0325750464358, 716.7168968257538, 773.3310686256386, 778.8130848596338, 780.9687612495497, 15333.769993450092, 15387.153706546136, 15392.846071539308, 15543.766843497342, 15779.816513761456, 14419.990600657959, 14423.134611923291, 14543.418263269483, 14556.636084097903, 14571.417143314282, 769.4729110559285, 929.1405449958795, 947.3605316411429, 955.7992821507491, 976.0873583199696, 917.6237742525566, 951.6478902805937, 965.971020869375, 967.7387105481516, 967.88869280033, 973.7711637765156, 973.9513024348789, 1008.8436292374694, 1017.7760892603652, 1019.6737044145876, 974.4689144416275, 975.9121679048919, 1000.5547531348553, 1005.7385079879248, 1010.3937637417564, 723.6924307169485, 732.7801659502128, 735.3639102176633, 766.3486036868617, 768.9000429944127, 14959.850401496064, 14994.70010599782, 15060.698786024219, 15407.460738874197, 15454.227288635524, 13321.866781332159, 13397.062205645609, 13434.932825335909, 13491.988100892375, 13493.055486115976, 10373.79252414955, 10443.477826108665, 10452.425116618582, 10465.947670261676, 10496.212784041227, 3427.9373394247614, 3587.192881601645, 3591.6587924147166, 3727.0, 3765.265773174232, 48125.75937120327, 56025.43974560243, 75676.0, 75985.0, 76416.61791691062, 9389.62441502346, 9456.669016584387, 9657.420554766737, 9797.608095676236, 9858.359206651545, 22070.88964555199, 22511.42420030582, 22821.657675134888, 22928.656070158628, 23140.0, 7837.686492540349, 7877.527348359117, 7903.249191326815, 7916.366690664733, 7969.481983671043, 3642.417213245868, 4123.0, 4185.121124563815, 4210.115875666083, 4336.76147811867, 3693.7045036397562, 3715.3869611514338, 3716.0, 3773.2453509298252, 3791.2038471920655, 663.5123184459419, 665.7736369634348, 670.1723371636026, 687.5153017123016, 691.9273476284917, 565.5419110520492, 585.1749033862319, 602.0968547179231, 608.6378604730266, 610.5542953643865, 8446.113158118433, 9043.32175086871, 9051.909480905239, 9093.454392736458, 9105.681301154427, 555.8943800677858, 557.5288880895637, 572.1103683771692, 590.9982579527746, 619.1084837833505, 3859.7877116758846, 3963.0686788604653, 3972.781497017634, 3986.142979259473, 3990.3216453203027, 71476.0, 72786.0, 93915.53042234745, 96210.51894740481, 96667.0333296672, 60994.69502652458, 78022.0, 78209.4358112846, 79101.60449197717, 80917.0, 71892.28107718856, 72097.6395118021, 72387.0, 72914.0, 73117.0, 8482.0, 8507.0, 8678.479291242293, 8701.695440659547, 8821.2060914518, 48391.27413088736, 48991.75504122457, 49135.50864491309, 49207.753961229966, 51301.48698513117, 61124.0, 66773.0, 66950.0, 67916.32083679298, 68490.0, 10813.837792432962, 10903.56385744593, 11145.275557088764, 11269.0, 11413.771724565297, 11736.237144585575, 11770.234934729215, 12005.939970300093, 12066.879331206575, 12230.755384892074, 11289.20975531705, 11486.253393529394, 11723.472443740222, 11818.46816893259, 11848.052155827341, 8651.6971905983, 9248.722538323862, 10555.997180267863, 11312.377819220023, 11341.716457088638, 10305.896941030494, 11412.828807567726, 11524.020458260806, 11550.82673759911, 11551.960323570918, 9739.123478886651, 9769.413835169913, 9864.062914023156, 10100.84848727255, 10134.239932005277, 7974.800629984296, 9739.318247722875, 9911.405315681082, 9971.900280997097, 10044.748881278027], "value": 7007.094858663579, "unit": "score"}], "name": "dromaeo_css", "value": 7634.208123041609, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 112.0, 135.0, 118.0, 119.0, 132.0, 116.0, 116.0, 118.0, 117.0], "value": 120.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 139.0, 156.0, 120.0, 150.0, 158.0, 180.0, 194.0, 158.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 197.0, 219.0, 269.0, 205.0, 197.0, 197.0, 196.0, 194.0, 192.0], "value": 206.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 79.0, 74.0, 146.0, 75.0, 83.0, 90.0, 60.0, 125.0, 57.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 120.0, 78.0, 78.0, 89.0, 119.0, 79.0, 79.0, 122.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 89.0, 90.0, 89.0, 89.0, 92.0, 90.0, 92.0, 136.0, 86.0], "value": 94.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 97.0, 150.0, 149.0, 94.0, 94.0, 95.0], "value": 105.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 89.0, 92.0, 101.0, 148.0, 145.0, 90.0, 115.0, 146.0], "value": 110.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 63.0, 82.0, 76.0, 54.0, 79.0, 103.0, 94.0, 90.0], "value": 76.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 104.0, 96.0, 115.0, 82.0, 71.0, 65.0, 67.0, 73.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 101.0, 104.0, 70.0, 96.0, 69.0, 80.0, 108.0, 87.0, 100.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 128.0, 128.0, 132.0, 127.0, 124.0, 116.0, 152.0, 159.0], "value": 132.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 179.0, 202.0, 161.0, 232.0, 162.0, 163.0, 181.0, 216.0, 195.0], "value": 185.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 65.0, 70.0, 82.0, 97.0, 91.0, 95.0, 66.0], "value": 77.5, "unit": "score"}], "name": "kraken", "value": 1609.1999999999998, "alertThreshold": 2.0}]} 04:24:12 INFO - Return code: 0 04:24:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:24:12 ERROR - # TBPL SUCCESS # 04:24:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:24:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:24:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:24:12 INFO - 2016-07-25 04:24:12.945 screenresolution[1702:11915] starting screenresolution argv=screenresolution get 04:24:12 INFO - 2016-07-25 04:24:12.948 screenresolution[1702:11915] Display 0: 1600x1200x32@60 04:24:12 INFO - 2016-07-25 04:24:12.954 screenresolution[1703:11918] starting screenresolution argv=screenresolution list 04:24:12 INFO - Available Modes on Display 0 04:24:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:24:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:24:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:24:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:24:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:24:13 INFO - Intel Iris: 04:24:13 INFO - Chipset Model: Intel Iris 04:24:13 INFO - Type: GPU 04:24:13 INFO - Bus: Built-In 04:24:13 INFO - VRAM (Dynamic, Max): 1536 MB 04:24:13 INFO - Vendor: Intel (0x8086) 04:24:13 INFO - Device ID: 0x0a2e 04:24:13 INFO - Revision ID: 0x0009 04:24:13 INFO - Displays: 04:24:13 INFO - Display: 04:24:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:24:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:24:13 INFO - Display Serial Number: 1600x1200 60 04:24:13 INFO - Main Display: Yes 04:24:13 INFO - Mirror: Off 04:24:13 INFO - Online: Yes 04:24:13 INFO - Rotation: Supported 04:24:13 INFO - Return code: 0 04:24:13 INFO - Running post-action listener: _resource_record_post_action 04:24:13 INFO - Running post-run listener: _resource_record_post_run 04:24:14 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 31882752; Write bytes: 500935168; Read time: 202; Write time: 1601 04:24:14 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 194847232; Write bytes: 195434496; Read time: 17534; Write time: 452 04:24:14 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 30100992; Write bytes: 300950016; Read time: 186; Write time: 1131 04:24:14 INFO - Running post-run listener: _upload_blobber_files 04:24:14 INFO - Blob upload gear active. 04:24:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:24:14 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 04:24:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:24:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:24:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:24:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:24:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:24:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:15 INFO - (blobuploader) - INFO - Done attempting. 04:24:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:24:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:24:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:24:16 INFO - (blobuploader) - INFO - Done attempting. 04:24:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:24:16 INFO - Return code: 0 04:24:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:24:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:24:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96e57fd0421012ba1baac181eccc233edcc04738b593c44b8bcaba40e4f31bfc3b703c27554a5ee681eedce9e3a8969fba44a5c1ed5e8396d6f8108575162e41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/484d4a2816670ac7b2387f05b5ec32a250b28a397f2feef1f69a13851b62f0f529560d6b76a3e56053352ba4df9920d108212fb1decbbf501054789cd0aaad25"} 04:24:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:24:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:24:16 INFO - Contents: 04:24:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96e57fd0421012ba1baac181eccc233edcc04738b593c44b8bcaba40e4f31bfc3b703c27554a5ee681eedce9e3a8969fba44a5c1ed5e8396d6f8108575162e41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/484d4a2816670ac7b2387f05b5ec32a250b28a397f2feef1f69a13851b62f0f529560d6b76a3e56053352ba4df9920d108212fb1decbbf501054789cd0aaad25"} 04:24:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:24:16 INFO - Copying logs to upload dir... 04:24:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:24:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.144303 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-25 04:24:16.892633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 04:24:16.896314) ========= 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.22RdLovuFq/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.kRFASrJJJN/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96e57fd0421012ba1baac181eccc233edcc04738b593c44b8bcaba40e4f31bfc3b703c27554a5ee681eedce9e3a8969fba44a5c1ed5e8396d6f8108575162e41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/484d4a2816670ac7b2387f05b5ec32a250b28a397f2feef1f69a13851b62f0f529560d6b76a3e56053352ba4df9920d108212fb1decbbf501054789cd0aaad25"} build_url:https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/QWR1MmyyTj-3ghxIpsU-EQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96e57fd0421012ba1baac181eccc233edcc04738b593c44b8bcaba40e4f31bfc3b703c27554a5ee681eedce9e3a8969fba44a5c1ed5e8396d6f8108575162e41", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/484d4a2816670ac7b2387f05b5ec32a250b28a397f2feef1f69a13851b62f0f529560d6b76a3e56053352ba4df9920d108212fb1decbbf501054789cd0aaad25"}' ========= master_lag: 0.22 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-25 04:24:17.124283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:24:17.124663) ========= 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.22RdLovuFq/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.kRFASrJJJN/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.005047 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-25 04:24:17.151734) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 04:24:17.152068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-25 04:24:17.152396) ========= ========= Total master_lag: 0.35 =========