builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0377 starttime: 1479754515.21 results: success (0) buildid: 20161121081008 builduid: 914a8b378e93418aa6d42c2f96d4648e revision: 063eae32d7016f0513bbe6de5c77e956dc712949 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:15.209872) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:15.210411) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:15.210854) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:15.238474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:15.238914) ========= 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.i6DOKZPQNR/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.McaGPsTOdG/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-21 10:55:15-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2016-11-21 10:55:15 (17.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089170 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:15.352146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:15.352464) ========= 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.i6DOKZPQNR/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.McaGPsTOdG/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025108 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:15.400945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 10:55:15.401298) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 063eae32d7016f0513bbe6de5c77e956dc712949 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 063eae32d7016f0513bbe6de5c77e956dc712949 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.i6DOKZPQNR/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.McaGPsTOdG/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-21 10:55:15,498 truncating revision to first 12 chars 2016-11-21 10:55:15,498 Setting DEBUG logging. 2016-11-21 10:55:15,498 attempt 1/10 2016-11-21 10:55:15,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/063eae32d701?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 10:55:17,174 unpacking tar archive at: mozilla-aurora-063eae32d701/testing/mozharness/ program finished with exit code 0 elapsedTime=1.953711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 10:55:17.378369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:17.378694) ========= script_repo_revision: 063eae32d7016f0513bbe6de5c77e956dc712949 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:17.379082) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:17.379353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 10:55:17.400786) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-21 10:55:17.401079) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.i6DOKZPQNR/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.McaGPsTOdG/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:55:17 INFO - MultiFileLogger online at 20161121 10:55:17 in /builds/slave/test 10:55:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 10:55:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:55:17 INFO - {'append_to_log': False, 10:55:17 INFO - 'base_work_dir': '/builds/slave/test', 10:55:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:55:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:55:17 INFO - 'branch': 'Mozilla-Aurora', 10:55:17 INFO - 'buildbot_json_path': 'buildprops.json', 10:55:17 INFO - 'config_files': ('talos/mac_config.py',), 10:55:17 INFO - 'default_actions': ('clobber', 10:55:17 INFO - 'read-buildbot-config', 10:55:17 INFO - 'download-and-extract', 10:55:17 INFO - 'populate-webroot', 10:55:17 INFO - 'create-virtualenv', 10:55:17 INFO - 'install', 10:55:17 INFO - 'run-tests'), 10:55:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:55:17 INFO - 'download_minidump_stackwalk': True, 10:55:17 INFO - 'download_symbols': 'ondemand', 10:55:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:55:17 INFO - 'tooltool.py': '/tools/tooltool.py', 10:55:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:55:17 INFO - '/tools/misc-python/virtualenv.py')}, 10:55:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:55:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:55:17 INFO - 'installer_path': 'installer.exe', 10:55:17 INFO - 'log_level': 'info', 10:55:17 INFO - 'log_name': 'talos', 10:55:17 INFO - 'log_to_console': True, 10:55:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:55:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:55:17 INFO - 'opt_config_files': (), 10:55:17 INFO - 'pip_index': False, 10:55:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:17 INFO - 'cmd': ('bash', 10:55:17 INFO - '-c', 10:55:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:17 INFO - 'enabled': True, 10:55:17 INFO - 'halt_on_failure': False, 10:55:17 INFO - 'name': 'check_screen_resolution'},), 10:55:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:17 INFO - 'cmd': ('bash', 10:55:17 INFO - '-c', 10:55:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:17 INFO - 'enabled': True, 10:55:17 INFO - 'halt_on_failure': False, 10:55:17 INFO - 'name': 'check_screen_resolution'},), 10:55:17 INFO - 'run_cmd_checks_enabled': True, 10:55:17 INFO - 'sps_profile': False, 10:55:17 INFO - 'sps_profile_interval': 0, 10:55:17 INFO - 'suite': 'dromaeojs-e10s', 10:55:17 INFO - 'system_bits': '32', 10:55:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:55:17 INFO - 'title': 't-yosemite-r7-0377', 10:55:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:55:17 INFO - 'use_talos_json': True, 10:55:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:55:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:55:17 INFO - 'work_dir': 'build'} 10:55:17 INFO - [mozharness: 2016-11-21 18:55:17.604740Z] Running clobber step. 10:55:17 INFO - Running pre-action listener: _resource_record_pre_action 10:55:17 INFO - Running main action method: clobber 10:55:17 INFO - rmtree: /builds/slave/test/build 10:55:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:55:19 INFO - Running post-action listener: _resource_record_post_action 10:55:19 INFO - [mozharness: 2016-11-21 18:55:19.919405Z] Finished clobber step (success) 10:55:19 INFO - [mozharness: 2016-11-21 18:55:19.919507Z] Running read-buildbot-config step. 10:55:19 INFO - Running pre-action listener: _resource_record_pre_action 10:55:19 INFO - Running main action method: read_buildbot_config 10:55:19 INFO - Using buildbot properties: 10:55:19 INFO - { 10:55:19 INFO - "project": "", 10:55:19 INFO - "product": "firefox", 10:55:19 INFO - "script_repo_revision": "production", 10:55:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 10:55:19 INFO - "repository": "", 10:55:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 10:55:19 INFO - "buildid": "20161121081008", 10:55:19 INFO - "pgo_build": "False", 10:55:19 INFO - "basedir": "/builds/slave/test", 10:55:19 INFO - "buildnumber": 33, 10:55:19 INFO - "slavename": "t-yosemite-r7-0377", 10:55:19 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:55:19 INFO - "platform": "yosemite_r7", 10:55:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 10:55:19 INFO - "branch": "mozilla-aurora", 10:55:19 INFO - "repo_path": "releases/mozilla-aurora", 10:55:19 INFO - "revision": "063eae32d7016f0513bbe6de5c77e956dc712949", 10:55:19 INFO - "stage_platform": "macosx64", 10:55:19 INFO - "builduid": "914a8b378e93418aa6d42c2f96d4648e", 10:55:19 INFO - "slavebuilddir": "test" 10:55:19 INFO - } 10:55:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 10:55:19 INFO - Running post-action listener: _resource_record_post_action 10:55:19 INFO - [mozharness: 2016-11-21 18:55:19.922742Z] Finished read-buildbot-config step (success) 10:55:19 INFO - [mozharness: 2016-11-21 18:55:19.922851Z] Running download-and-extract step. 10:55:19 INFO - Running pre-action listener: _resource_record_pre_action 10:55:19 INFO - Running main action method: download_and_extract 10:55:19 INFO - mkdir: /builds/slave/test/build/tests 10:55:19 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:19 INFO - trying https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 10:55:19 INFO - Downloading https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:55:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 10:55:20 INFO - Downloaded 1199 bytes. 10:55:20 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 10:55:20 INFO - Using the following test package requirements: 10:55:20 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:55:20 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:55:20 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 10:55:20 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:55:20 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 10:55:20 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:55:20 INFO - u'jsshell-mac.zip'], 10:55:20 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:55:20 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 10:55:20 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 10:55:20 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:55:20 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 10:55:20 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:55:20 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 10:55:20 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:55:20 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 10:55:20 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 10:55:20 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 10:55:20 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 10:55:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:55:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:55:20 INFO - Fetch https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:55:21 INFO - Http code: 200 10:55:21 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 10:55:21 INFO - x-amz-cf-id: FllSSMEo9U7O5w6rf0plSsGcRPfO5wAtKBzbLYetCpPqHCwYr-H5bA== 10:55:21 INFO - x-amz-version-id: cdHdA._yJSagU6xzkb4paWixPWO8l1hd 10:55:21 INFO - Expected file size: 16277201 10:55:21 INFO - Obtained file size: 16277201 10:55:28 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 10:55:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 10:55:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 10:55:28 INFO - Fetch https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 10:55:29 INFO - Http code: 200 10:55:29 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 10:55:29 INFO - x-amz-cf-id: RIWjVigg1UakGDzC3bHhpJveUhhB0Cv72g6wB40VJ3Qx9V8kLuiWMg== 10:55:29 INFO - x-amz-version-id: cdHdA._yJSagU6xzkb4paWixPWO8l1hd 10:55:29 INFO - Expected file size: 16277201 10:55:29 INFO - Obtained file size: 16277201 10:55:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 10:55:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 10:55:35 INFO - Fetch https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 10:55:36 INFO - Http code: 200 10:55:36 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 10:55:36 INFO - x-amz-cf-id: vj8kP-tBAjJ-17yt-JwfZcBS7C6GJZU0I4g6dEiNOak8dn3_4j81PA== 10:55:36 INFO - x-amz-version-id: 4pCkT..HUZf8hz2rVNCocduDJd5ljv3R 10:55:36 INFO - Expected file size: 14409038 10:55:36 INFO - Obtained file size: 14409038 10:55:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:37 INFO - trying https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:55:37 INFO - Downloading https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 10:55:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 10:55:40 INFO - Downloaded 114501637 bytes. 10:55:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:55:40 INFO - mkdir: /builds/slave/test/properties 10:55:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:55:40 INFO - Writing to file /builds/slave/test/properties/build_url 10:55:40 INFO - Contents: 10:55:40 INFO - build_url:https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 10:55:40 INFO - Running post-action listener: _resource_record_post_action 10:55:40 INFO - Running post-action listener: set_extra_try_arguments 10:55:40 INFO - [mozharness: 2016-11-21 18:55:40.987454Z] Finished download-and-extract step (success) 10:55:40 INFO - [mozharness: 2016-11-21 18:55:40.987600Z] Running populate-webroot step. 10:55:40 INFO - Running pre-action listener: _resource_record_pre_action 10:55:40 INFO - Running main action method: populate_webroot 10:55:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:55:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:55:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:55:40 INFO - '--tppagecycles', 10:55:40 INFO - '7'], 10:55:40 INFO - 'tests': ['tsvgm']}}, 10:55:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:55:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:55:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:55:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:55:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:55:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:55:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:40 INFO - 'talos_options': ['--disable-e10s'], 10:55:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:55:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:55:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:40 INFO - 'talos_options': ['--disable-e10s'], 10:55:40 INFO - 'tests': ['damp', 'tps']}, 10:55:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:40 INFO - 'tests': ['damp', 'tps']}, 10:55:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:55:40 INFO - 'tests': ['dromaeo_dom']}, 10:55:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:55:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:55:40 INFO - 'tests': ['basic_compositor_video']}, 10:55:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:55:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:55:40 INFO - 'tests': ['a11yr', 10:55:40 INFO - 'ts_paint', 10:55:40 INFO - 'tpaint', 10:55:40 INFO - 'sessionrestore', 10:55:40 INFO - 'sessionrestore_no_auto_restore', 10:55:40 INFO - 'tabpaint']}, 10:55:40 INFO - 'other-e10s': {'tests': ['a11yr', 10:55:41 INFO - 'ts_paint', 10:55:41 INFO - 'tpaint', 10:55:41 INFO - 'sessionrestore', 10:55:41 INFO - 'sessionrestore_no_auto_restore', 10:55:41 INFO - 'tabpaint']}, 10:55:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:55:41 INFO - 'ts_paint', 10:55:41 INFO - 'tpaint', 10:55:41 INFO - 'sessionrestore', 10:55:41 INFO - 'sessionrestore_no_auto_restore', 10:55:41 INFO - 'tabpaint']}, 10:55:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:55:41 INFO - 'ts_paint', 10:55:41 INFO - 'tpaint', 10:55:41 INFO - 'sessionrestore', 10:55:41 INFO - 'sessionrestore_no_auto_restore', 10:55:41 INFO - 'tabpaint']}, 10:55:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:55:41 INFO - 'tests': ['a11yr', 10:55:41 INFO - 'ts_paint', 10:55:41 INFO - 'tpaint', 10:55:41 INFO - 'sessionrestore', 10:55:41 INFO - 'sessionrestore_no_auto_restore', 10:55:41 INFO - 'tabpaint']}, 10:55:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:55:41 INFO - 'tests': ['a11yr', 10:55:41 INFO - 'ts_paint', 10:55:41 INFO - 'tpaint', 10:55:41 INFO - 'sessionrestore', 10:55:41 INFO - 'sessionrestore_no_auto_restore', 10:55:41 INFO - 'tabpaint']}, 10:55:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:55:41 INFO - 'tests': ['tsvgx', 10:55:41 INFO - 'tsvgr_opacity', 10:55:41 INFO - 'tart', 10:55:41 INFO - 'tscrollx', 10:55:41 INFO - 'cart']}, 10:55:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:55:41 INFO - 'tsvgr_opacity', 10:55:41 INFO - 'tart', 10:55:41 INFO - 'tscrollx', 10:55:41 INFO - 'cart']}, 10:55:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:41 INFO - 'talos_options': ['--disable-e10s'], 10:55:41 INFO - 'tests': ['tp5o']}, 10:55:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:41 INFO - 'tests': ['tp5o']}, 10:55:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:41 INFO - 'talos_options': ['--disable-e10s', 10:55:41 INFO - '--xperf_path', 10:55:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:55:41 INFO - 'tests': ['tp5n']}, 10:55:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:55:41 INFO - 'talos_options': ['--xperf_path', 10:55:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:55:41 INFO - 'tests': ['tp5n']}}, 10:55:41 INFO - 'talos.zip': {'path': '', 10:55:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:55:41 INFO - Running post-action listener: _resource_record_post_action 10:55:41 INFO - [mozharness: 2016-11-21 18:55:41.006167Z] Finished populate-webroot step (success) 10:55:41 INFO - [mozharness: 2016-11-21 18:55:41.006310Z] Running create-virtualenv step. 10:55:41 INFO - Running pre-action listener: _resource_record_pre_action 10:55:41 INFO - Running main action method: create_virtualenv 10:55:41 INFO - Creating virtualenv /builds/slave/test/build/venv 10:55:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:55:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:55:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:55:41 INFO - Using real prefix '/tools/python27' 10:55:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:55:41 INFO - Installing distribute.............................................................................................................................................................................................done. 10:55:44 INFO - Installing pip.................done. 10:55:44 INFO - Return code: 0 10:55:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:55:44 INFO - Reading from file tmpfile_stdout 10:55:44 INFO - Output received: 10:55:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:55:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:44 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 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:55:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:55:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:55:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:44 INFO - 'HOME': '/Users/cltbld', 10:55:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:44 INFO - 'LOGNAME': 'cltbld', 10:55:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:44 INFO - 'MOZ_NO_REMOTE': '1', 10:55:44 INFO - 'NO_EM_RESTART': '1', 10:55:44 INFO - 'PAGER': '/bin/cat', 10:55:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:44 INFO - 'PWD': '/builds/slave/test', 10:55:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:44 INFO - 'SHELL': '/bin/bash', 10:55:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:55:44 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:55:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:44 INFO - 'USER': 'cltbld', 10:55:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:44 INFO - 'XPC_FLAGS': '0x0', 10:55:44 INFO - 'XPC_SERVICE_NAME': '0', 10:55:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:55:45 INFO - Cleaning up... 10:55:45 INFO - Return code: 0 10:55:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:45 INFO - 'HOME': '/Users/cltbld', 10:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:45 INFO - 'LOGNAME': 'cltbld', 10:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:45 INFO - 'MOZ_NO_REMOTE': '1', 10:55:45 INFO - 'NO_EM_RESTART': '1', 10:55:45 INFO - 'PAGER': '/bin/cat', 10:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:45 INFO - 'PWD': '/builds/slave/test', 10:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:45 INFO - 'SHELL': '/bin/bash', 10:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:55:45 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:45 INFO - 'USER': 'cltbld', 10:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:45 INFO - 'XPC_FLAGS': '0x0', 10:55:45 INFO - 'XPC_SERVICE_NAME': '0', 10:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:45 INFO - Downloading/unpacking psutil>=3.1.1 10:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:55:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:48 INFO - Installing collected packages: psutil 10:55:48 INFO - Running setup.py install for psutil 10:55:48 INFO - building 'psutil._psutil_osx' extension 10:55:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:55:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:55:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:55:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:55:49 INFO - building 'psutil._psutil_posix' extension 10:55:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:55:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:55:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:55:49 INFO - ^ 10:55:49 INFO - 1 warning generated. 10:55:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:55:49 INFO - Successfully installed psutil 10:55:49 INFO - Cleaning up... 10:55:50 INFO - Return code: 0 10:55:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:55:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:50 INFO - 'HOME': '/Users/cltbld', 10:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:50 INFO - 'LOGNAME': 'cltbld', 10:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:50 INFO - 'MOZ_NO_REMOTE': '1', 10:55:50 INFO - 'NO_EM_RESTART': '1', 10:55:50 INFO - 'PAGER': '/bin/cat', 10:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:50 INFO - 'PWD': '/builds/slave/test', 10:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:50 INFO - 'SHELL': '/bin/bash', 10:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:55:50 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:50 INFO - 'USER': 'cltbld', 10:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:50 INFO - 'XPC_FLAGS': '0x0', 10:55:50 INFO - 'XPC_SERVICE_NAME': '0', 10:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:55:52 INFO - Installing collected packages: mozsystemmonitor 10:55:52 INFO - Running setup.py install for mozsystemmonitor 10:55:53 INFO - Successfully installed mozsystemmonitor 10:55:53 INFO - Cleaning up... 10:55:53 INFO - Return code: 0 10:55:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:55: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 jsonschema==2.5.1 10:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:53 INFO - 'HOME': '/Users/cltbld', 10:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:53 INFO - 'LOGNAME': 'cltbld', 10:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:53 INFO - 'MOZ_NO_REMOTE': '1', 10:55:53 INFO - 'NO_EM_RESTART': '1', 10:55:53 INFO - 'PAGER': '/bin/cat', 10:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:53 INFO - 'PWD': '/builds/slave/test', 10:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:53 INFO - 'SHELL': '/bin/bash', 10:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:55:53 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:53 INFO - 'USER': 'cltbld', 10:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:53 INFO - 'XPC_FLAGS': '0x0', 10:55:53 INFO - 'XPC_SERVICE_NAME': '0', 10:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:53 INFO - Downloading/unpacking jsonschema==2.5.1 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:55:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:56 INFO - Downloading functools32-3.2.3-2.tar.gz 10:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:55:56 INFO - warning: no files found matching '*.txt' 10:55:56 INFO - no previously-included directories found matching 'build' 10:55:56 INFO - no previously-included directories found matching 'dist' 10:55:56 INFO - no previously-included directories found matching '.git*' 10:55:56 INFO - Installing collected packages: jsonschema, functools32 10:55:56 INFO - Running setup.py install for functools32 10:55:56 INFO - warning: no files found matching '*.txt' 10:55:56 INFO - no previously-included directories found matching 'build' 10:55:56 INFO - no previously-included directories found matching 'dist' 10:55:56 INFO - no previously-included directories found matching '.git*' 10:55:56 INFO - Successfully installed jsonschema functools32 10:55:56 INFO - Cleaning up... 10:55:56 INFO - Return code: 0 10:55:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:55: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 functools32==3.2.3-2 10:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:56 INFO - 'HOME': '/Users/cltbld', 10:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:56 INFO - 'LOGNAME': 'cltbld', 10:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:56 INFO - 'MOZ_NO_REMOTE': '1', 10:55:56 INFO - 'NO_EM_RESTART': '1', 10:55:56 INFO - 'PAGER': '/bin/cat', 10:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:56 INFO - 'PWD': '/builds/slave/test', 10:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:56 INFO - 'SHELL': '/bin/bash', 10:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:55:56 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:56 INFO - 'USER': 'cltbld', 10:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:56 INFO - 'XPC_FLAGS': '0x0', 10:55:56 INFO - 'XPC_SERVICE_NAME': '0', 10:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:55:56 INFO - Cleaning up... 10:55:56 INFO - Return code: 0 10:55:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:55: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 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:55: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 10:55: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 10:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:56 INFO - 'HOME': '/Users/cltbld', 10:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:56 INFO - 'LOGNAME': 'cltbld', 10:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:56 INFO - 'MOZ_NO_REMOTE': '1', 10:55:56 INFO - 'NO_EM_RESTART': '1', 10:55:56 INFO - 'PAGER': '/bin/cat', 10:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:56 INFO - 'PWD': '/builds/slave/test', 10:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:56 INFO - 'SHELL': '/bin/bash', 10:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:55:56 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:56 INFO - 'USER': 'cltbld', 10:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:56 INFO - 'XPC_FLAGS': '0x0', 10:55:56 INFO - 'XPC_SERVICE_NAME': '0', 10:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:55:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:55:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:55:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:55:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:55: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 10:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:56:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:00 INFO - Downloading docopt-0.6.1.tar.gz 10:56:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:56:01 INFO - Installing collected packages: blobuploader, requests, docopt 10:56:01 INFO - Running setup.py install for blobuploader 10:56:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:56:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:56:01 INFO - Running setup.py install for requests 10:56:01 INFO - Running setup.py install for docopt 10:56:01 INFO - Successfully installed blobuploader requests docopt 10:56:01 INFO - Cleaning up... 10:56:01 INFO - Return code: 0 10:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56: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 10:56: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 10:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:01 INFO - 'HOME': '/Users/cltbld', 10:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:01 INFO - 'LOGNAME': 'cltbld', 10:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:01 INFO - 'MOZ_NO_REMOTE': '1', 10:56:01 INFO - 'NO_EM_RESTART': '1', 10:56:01 INFO - 'PAGER': '/bin/cat', 10:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:01 INFO - 'PWD': '/builds/slave/test', 10:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:01 INFO - 'SHELL': '/bin/bash', 10:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:56:01 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:01 INFO - 'USER': 'cltbld', 10:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:01 INFO - 'XPC_FLAGS': '0x0', 10:56:01 INFO - 'XPC_SERVICE_NAME': '0', 10:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:02 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-rhlIaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:02 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5UEPMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:02 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-62MEgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:02 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-vMms7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:02 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-tkgXMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:02 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-b8iIN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:02 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-RHUKcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:02 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-xJNK65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-mBHJko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-yGY4af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-61hQ24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-rTidy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-lRhufz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-3jgcVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-0aiyVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-qhxdgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:03 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-rTHmHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:56:04 INFO - Running setup.py install for manifestparser 10:56:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:56:04 INFO - Running setup.py install for mozcrash 10:56:04 INFO - Running setup.py install for mozdebug 10:56:04 INFO - Running setup.py install for mozdevice 10:56:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:56:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:56:04 INFO - Running setup.py install for mozfile 10:56:04 INFO - Running setup.py install for mozhttpd 10:56:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:56:04 INFO - Running setup.py install for mozinfo 10:56:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Running setup.py install for mozInstall 10:56:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Running setup.py install for mozleak 10:56:05 INFO - Running setup.py install for mozlog 10:56:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Running setup.py install for moznetwork 10:56:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Running setup.py install for mozprocess 10:56:05 INFO - Running setup.py install for mozprofile 10:56:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:56:05 INFO - Running setup.py install for mozrunner 10:56:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:56:06 INFO - Running setup.py install for mozscreenshot 10:56:06 INFO - Running setup.py install for moztest 10:56:06 INFO - Running setup.py install for mozversion 10:56:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:56:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:56:06 INFO - Cleaning up... 10:56:06 INFO - Return code: 0 10:56:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:06 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 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:06 INFO - 'HOME': '/Users/cltbld', 10:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:06 INFO - 'LOGNAME': 'cltbld', 10:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:06 INFO - 'MOZ_NO_REMOTE': '1', 10:56:06 INFO - 'NO_EM_RESTART': '1', 10:56:06 INFO - 'PAGER': '/bin/cat', 10:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:06 INFO - 'PWD': '/builds/slave/test', 10:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:06 INFO - 'SHELL': '/bin/bash', 10:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:56:06 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:06 INFO - 'USER': 'cltbld', 10:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:06 INFO - 'XPC_FLAGS': '0x0', 10:56:06 INFO - 'XPC_SERVICE_NAME': '0', 10:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:56:06 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-RCPpAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:56: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)) 10:56:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:56:06 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-hsaK26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-KDzCC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-1Rdasj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-22MjLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-AzGb6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Yq39b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-H21qrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-ngABhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-VG5Hio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:56:07 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-yI5zlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:56:08 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-bgXgpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:56:08 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-KLVDqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:56:08 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-PjFNaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:08 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-rNw4iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:56:08 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-m4ggBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:56:08 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-L4dxHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:56:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:56:11 INFO - Downloading blessings-1.6.tar.gz 10:56:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:56:11 INFO - Installing collected packages: blessings 10:56:11 INFO - Running setup.py install for blessings 10:56:11 INFO - Successfully installed blessings 10:56:11 INFO - Cleaning up... 10:56:11 INFO - Return code: 0 10:56:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:56:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:11 INFO - Reading from file tmpfile_stdout 10:56:11 INFO - Current package versions: 10:56:11 INFO - blessings == 1.6 10:56:11 INFO - blobuploader == 1.2.4 10:56:11 INFO - docopt == 0.6.1 10:56:11 INFO - functools32 == 3.2.3-2 10:56:11 INFO - jsonschema == 2.5.1 10:56:11 INFO - manifestparser == 1.1 10:56:11 INFO - mozInstall == 1.12 10:56:11 INFO - mozcrash == 1.0 10:56:11 INFO - mozdebug == 0.1 10:56:11 INFO - mozdevice == 0.48 10:56:11 INFO - mozfile == 1.2 10:56:11 INFO - mozhttpd == 0.7 10:56:11 INFO - mozinfo == 0.9 10:56:11 INFO - mozleak == 0.1 10:56:11 INFO - mozlog == 3.4 10:56:11 INFO - moznetwork == 0.27 10:56:11 INFO - mozprocess == 0.23 10:56:11 INFO - mozprofile == 0.28 10:56:11 INFO - mozrunner == 6.13 10:56:11 INFO - mozscreenshot == 0.1 10:56:11 INFO - mozsystemmonitor == 0.3 10:56:11 INFO - moztest == 0.7 10:56:11 INFO - mozversion == 1.4 10:56:11 INFO - psutil == 3.1.1 10:56:11 INFO - requests == 1.2.3 10:56:11 INFO - wsgiref == 0.1.2 10:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:56: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:12 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 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:56:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:56:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:56:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:12 INFO - 'HOME': '/Users/cltbld', 10:56:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:12 INFO - 'LOGNAME': 'cltbld', 10:56:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:12 INFO - 'MOZ_NO_REMOTE': '1', 10:56:12 INFO - 'NO_EM_RESTART': '1', 10:56:12 INFO - 'PAGER': '/bin/cat', 10:56:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:12 INFO - 'PWD': '/builds/slave/test', 10:56:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:12 INFO - 'SHELL': '/bin/bash', 10:56:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:56:12 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:56:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:12 INFO - 'USER': 'cltbld', 10:56:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:12 INFO - 'XPC_FLAGS': '0x0', 10:56:12 INFO - 'XPC_SERVICE_NAME': '0', 10:56:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:56:12 INFO - Cleaning up... 10:56:12 INFO - Return code: 0 10:56:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da4a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec11c702d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, '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.i6DOKZPQNR/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.McaGPsTOdG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:13 INFO - 'HOME': '/Users/cltbld', 10:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:13 INFO - 'LOGNAME': 'cltbld', 10:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:13 INFO - 'MOZ_NO_REMOTE': '1', 10:56:13 INFO - 'NO_EM_RESTART': '1', 10:56:13 INFO - 'PAGER': '/bin/cat', 10:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:13 INFO - 'PWD': '/builds/slave/test', 10:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:13 INFO - 'SHELL': '/bin/bash', 10:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:56:13 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:13 INFO - 'USER': 'cltbld', 10:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:13 INFO - 'XPC_FLAGS': '0x0', 10:56:13 INFO - 'XPC_SERVICE_NAME': '0', 10:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:56:13 INFO - Cleaning up... 10:56:13 INFO - Return code: 0 10:56:13 INFO - Running post-action listener: _resource_record_post_action 10:56:13 INFO - Running post-action listener: _start_resource_monitoring 10:56:13 INFO - Starting resource monitoring. 10:56:13 INFO - [mozharness: 2016-11-21 18:56:13.657404Z] Finished create-virtualenv step (success) 10:56:13 INFO - [mozharness: 2016-11-21 18:56:13.658416Z] Running install step. 10:56:13 INFO - Running pre-action listener: _resource_record_pre_action 10:56:13 INFO - Running main action method: install 10:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:56:13 INFO - Reading from file tmpfile_stdout 10:56:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:56:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:56:14 INFO - Reading from file tmpfile_stdout 10:56:14 INFO - Output received: 10:56:14 INFO - Usage: mozinstall [options] installer 10:56:14 INFO - Options: 10:56:14 INFO - -h, --help show this help message and exit 10:56:14 INFO - -d DEST, --destination=DEST 10:56:14 INFO - Directory to install application into. [default: 10:56:14 INFO - "/builds/slave/test"] 10:56:14 INFO - --app=APP Application being installed. [default: firefox] 10:56:14 INFO - mkdir: /builds/slave/test/build/application 10:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 10:56:45 INFO - Reading from file tmpfile_stdout 10:56:45 INFO - Output received: 10:56:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 10:56:45 INFO - Running post-action listener: _resource_record_post_action 10:56:45 INFO - [mozharness: 2016-11-21 18:56:45.928621Z] Finished install step (success) 10:56:45 INFO - [mozharness: 2016-11-21 18:56:45.928717Z] Running run-tests step. 10:56:45 INFO - Running pre-action listener: _resource_record_pre_action 10:56:45 INFO - Running main action method: run_tests 10:56:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:56:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:56:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:56:45 INFO - 2016-11-21 10:56:45.941 screenresolution[1623:7598] starting screenresolution argv=screenresolution get 10:56:45 INFO - 2016-11-21 10:56:45.943 screenresolution[1623:7598] Display 0: 1600x1200x32@60 10:56:45 INFO - 2016-11-21 10:56:45.949 screenresolution[1624:7601] starting screenresolution argv=screenresolution list 10:56:45 INFO - Available Modes on Display 0 10:56:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:56:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:56:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:56:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:56:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:56:46 INFO - Intel Iris: 10:56:46 INFO - Chipset Model: Intel Iris 10:56:46 INFO - Type: GPU 10:56:46 INFO - Bus: Built-In 10:56:46 INFO - VRAM (Dynamic, Max): 1536 MB 10:56:46 INFO - Vendor: Intel (0x8086) 10:56:46 INFO - Device ID: 0x0a2e 10:56:46 INFO - Revision ID: 0x0009 10:56:46 INFO - Displays: 10:56:46 INFO - Display: 10:56:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:56:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:56:46 INFO - Display Serial Number: 1600x1200 60 10:56:46 INFO - Main Display: Yes 10:56:46 INFO - Mirror: Off 10:56:46 INFO - Online: Yes 10:56:46 INFO - Rotation: Supported 10:56:46 INFO - Return code: 0 10:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:56:46 INFO - Python 2.7.3 10:56:46 INFO - Return code: 0 10:56:46 INFO - grabbing minidump binary from tooltool 10:56:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:56:46 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d85ed30>, '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 0x10d6c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d856b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:56:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:56:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:56:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:56:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:56:46 INFO - Return code: 0 10:56:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:56:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:56:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:56:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:56:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0377 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:56:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i6DOKZPQNR/Render', 10:56:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:46 INFO - 'HOME': '/Users/cltbld', 10:56:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:46 INFO - 'LOGNAME': 'cltbld', 10:56:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:56:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:46 INFO - 'MOZ_NO_REMOTE': '1', 10:56:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:56:46 INFO - 'NO_EM_RESTART': '1', 10:56:46 INFO - 'PAGER': '/bin/cat', 10:56:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:46 INFO - 'PWD': '/builds/slave/test', 10:56:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:56:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:46 INFO - 'SHELL': '/bin/bash', 10:56:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.McaGPsTOdG/Listeners', 10:56:46 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 10:56:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:46 INFO - 'USER': 'cltbld', 10:56:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:46 INFO - 'XPC_FLAGS': '0x0', 10:56:46 INFO - 'XPC_SERVICE_NAME': '0', 10:56:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:56:46 INFO - mozversion application_buildid: 20161121081008 10:56:46 INFO - mozversion application_changeset: 063eae32d7016f0513bbe6de5c77e956dc712949 10:56:46 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:56:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:56:46 INFO - mozversion application_name: Firefox 10:56:46 INFO - mozversion application_remotingname: firefox-dev 10:56:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:56:46 INFO - mozversion application_vendor: Mozilla 10:56:46 INFO - mozversion application_version: 52.0a2 10:56:46 INFO - mozversion platform_buildid: 20161121081008 10:56:46 INFO - mozversion platform_changeset: 063eae32d7016f0513bbe6de5c77e956dc712949 10:56:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:56:46 INFO - mozversion platform_version: 52.0a2 10:56:46 INFO - using testdate: 1479754606 10:56:46 INFO - actual date: 1479754606 10:56:46 INFO - starting webserver on 'localhost:49241' 10:56:46 INFO - SUITE-START | Running 2 tests 10:56:46 INFO - TEST-START | dromaeo_css 10:56:46 INFO - operating with platform_type : mac_ 10:56:46 INFO - Initialising browser for dromaeo_css test... 10:56:46 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpAwaz6Y/profile http://localhost:49241/getInfo.html) 10:56:48 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 10:56:49 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 10:56:49 INFO - PROCESS | 1634 | colorDepth:24 10:56:49 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 10:56:49 INFO - PROCESS | 1634 | __metrics 10:56:49 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 10:56:50 INFO - TEST-INFO | 1634: exit 0 10:56:50 INFO - Browser initialized. 10:56:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:56:50 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpAwaz6Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:02 INFO - PROCESS | 1637 | RSS: Main: 224137216 10:57:02 INFO - PROCESS | 1637 | 10:57:52 INFO - PROCESS | 1637 | 1479754672057 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] 11:00:05 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 11:00:07 INFO - PROCESS | 1637 | RSS: Main: 233775104 11:00:07 INFO - PROCESS | 1637 | 11:03:09 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 11:03:09 INFO - PROCESS | 1637 | RSS: Main: 245145600 11:03:09 INFO - PROCESS | 1637 | 11:06:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 11:06:12 INFO - PROCESS | 1637 | RSS: Main: 248008704 11:06:12 INFO - PROCESS | 1637 | 11:09:14 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 11:09:14 INFO - PROCESS | 1637 | RSS: Main: 247197696 11:09:14 INFO - PROCESS | 1637 | 11:12:17 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 11:12:18 INFO - PROCESS | 1637 | RSS: Main: 250617856 11:12:18 INFO - PROCESS | 1637 | 11:15:20 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 11:15:21 INFO - PROCESS | 1637 | RSS: Main: 252768256 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - PROCESS | 1637 | __start_tp_report 11:15:21 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 11:15:21 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 11:15:21 INFO - PROCESS | 1637 | |i|pagename|runs| 11:15:21 INFO - PROCESS | 1637 | |0;dojo.html;2866.5413533834603;2896.8551572421375;2898.289918969853;3439.8108104054277;3489.3021395720853;4759.952400475994;5849.473547380735;5856.8242952711435;5899.734511946956;5930.762769489215;5490.396056433789;5831.446012628804;5916.792912248072;5923.822285331447;6009.038553831388;5273.340832395941;5293.15309550472;5299.178627312773;5329.200619907026;5353.464653534655;5366.221897824813;5374.247605335257;5416.91874621881;5417.891642167155;5434.266374039514;4592.816287348519;4797.472278049412;4992.925106123411;5336.786528538853;5383.919241211385;5249.370075590934;5303.204519322113;5359.383670877821;5374.113271310229;5394.109971854639;4018.397240413932;4185.204811085914;4715.552022557851;5294.338207724035;5399.514043736082;5287.286216360781;5603.635763675389;5902.970485147547;6019.578629495893;6041.456268935773;6113.932424433829;6149.86227547905;6163.414475624809;6215;6278.78024269153;5186.455422180692;5446.801703625196;6034.849128771772;6169.568130230886;6191.9071213931375;5866.70666466675;5889.204957330791;5891.646501209942;5912.14273930282;5921.608422020821;6335.081413195061;6358.459530939922;6359.427651511386;6383.138276332728;6480.51396145291;6180.783672571439;6193.84515387119;6195.19462469876;6204.503639708812;6207.844803879939;4928.67963582366;5588.714595643025;6271.560990730696;6348.396902294275;6352.555321127476;5441.129419292974;6113.841195312599;6140.565599444524;6163.753449861955;6198.411150940653;5200.401953775364;5651.660900345993;6180.505559555225;6195.4424101831055;6235.844103897439;5008.348914641073;5014.648974571818;5022.648414610942;5033.5469807716745;5062;4426.136903303889;4436.068425630589;4458.71018383804;4475.485319188335;4489.483709373464;6035.909461358083;6038.698065096815;6047.637141771508;6068.089786531968;6094.360092190256;6130.275842464154;6174.9073763893575;6180.3201647818705;6282.070442883421;6322.241331040213;5997.2803263607775;6021.066734656048;6047.576669633171;6136.2636483622255;6143.109249158847;5426.810061647823;5484.8354549363585;5514.724263786875;5518.365387980353;5534.225208470817;6373.2989371168205;6461.095446637474;6464.062710906798;6478.546501744832;6569.704363303758;5632.831015069554;6314.052892066043;6329.2404911409085;6331.430171284606;6348.492120630431;6564.4748420125325;6589.6705164740615;6592.571482853599;6604.933950660432;6622.403983641495;5187.714675692873;6121.908171377522;6137.22377000893;6161.84595385119;6176.413240742122;6198.845028874314;6227.408396202353;6230;6237.220347456568;6346.650934198663;6101.694915254308;6161.815145545641;6162.014077747539;6172.753089876534;6188.071789231652;6042.214512113397;6107.46191531438;6165.445109940127;6182.289036760651;6211.565190436626;5870.55970802183;6025.367336429612;6091.847703807441;6102.603330783485;6156.076588511759;6147.938520614736;6153.507719382349;6186.164867742978;6186.412290832363;6186.81439556814;5132.486751324837;5318.441563635917;6080.087986802015;6101.694915254131;6146.385361463997 11:15:21 INFO - PROCESS | 1637 | |1;ext.html;443.9589163411798;478.3804972560536;496.24075164997555;520.8020952038225;524.7612336386944;32947.34105317892;37964.430533541985;39512.407313890246;39574;39655.206895862066;40773.59226407735;41078.178436431255;41189;41246.58753412465;41273;9367.81264374712;9492.52537373132;9520.714378568618;9534.141927226548;9552.280589493888;9418.529073546295;9449.622015119387;9466.763330916714;9480.857787133198;9490.905090949105;9376.671816486425;9472.857907131398;9497.287703422237;9520.381175223589;9525.142737153656;9408.388454750419;9447.858282125773;9471.47906865122;9479.952600237024;9513;9412.294077944112;9537.47543885086;9549.522523873778;9561.760955976086;9571;38862.02844928871;39289.803550982346;39290.214195715926;39372.40941385881;39411.4088288673;3159.004913452255;3269.2807582331848;3295.6045274566964;3325.3016866458074;3667.2848794485085;28980.13059608194;29326.706732932824;30001.549976750368;30010.24974375636;30268.84865575658;3162.4623813951453;3202.2794871154038;3242.3353212591364;3260.380527699753;3307.7849939753837;339837.30081349437;358056;359238.2038089793;359243.4075659236;359583;56211;56522.717386412805;56543.15185272224;56577.15134272989;56714;58806.41193588095;58912.70543647254;59387;59468.40531594715;59924;15278.923605381902;15466.917315787787;15482.30329635169;15492.14793186363;15517.146556939477;9091.772705682411;10277;11547.884521154681;11884.762304753856;11961.40192990347;13821.654458638413;14085.577432677037;14164.150150990974;15258.694826103416;15261.694766104616;6766.594004359754;6798.620482830969;6926;6929.653517324114;6934.306569343025;742.6509540515949;876.3952872517942;877.9692710755221;918.0177210384824;928.0858354520792;23277;28416.431671366456;28819.71180288212;29874;29998.85000574983;957.1624828275259;998.3361064891766;1001.2840818814583;1042.3172821801732;1049.9055085042382;12070.336131512675;13474.461021559027;14370.640733981525;15391.46129885471;16337.91831040861;533442;539484;540800;541629;543466;54107.64730881759;54396.728016359666;54531.454685452634;54656.72671636617;54899.176512352344;1342.812006319116;1358.042579981111;1375.8417781955004;1382.640513466506;1384.7092110656674;27922.58116128219;28507.714922850508;28723.138305850858;29038.7096129036;29277.975270865416;46626.76686616545;52134.47865521448;52918.47081529135;53016;53758.46241537535;560480;562603;568672;569608;573411;25118;25296.747032529438;25613;25678.972841086146;25730.970761169345;45226.32160517661;45228;45245.32132018088;45794.85512862205;46291.76854115708;31174.844125779226;33833.83083084569;35756.56973721022;37152.62847371492;37551.624483754815;31607.525887112173;37598.8120059398;38380.84857454281;38389.424158638205;38670.2265954685;36042;36470.452943205346;36836.07909802169;37268.813655931546;37513.81243093767;32145.35709285848;32966;33154.834225828716;33302.50046249357;33972.66027339695;24949.625755613317;25333.61999569971;25360.74639253584;25734.742652573233;25782.742172578033 11:15:21 INFO - PROCESS | 1637 | |2;jquery.html;369.698695563116;374.61601858095463;380.4996429694952;391.13949311514676;401.25567073079435;18091.81908180918;19909.800901990977;20197.88911609861;20413;20649.690254646193;19278.710819337684;19588.510287242825;19838.107285172166;20090.29683961058;20162.59674806503;5510.0632892408385;5737.426257374271;5806.129080637896;6036.426539478764;6044.848878778022;5828.03837366834;5957.523398128139;6027.035674292114;6035.637861728288;6039.939600604003;5026.346574945252;5843;5902.498287645555;5929.962256605098;5930.614510056833;5693.629914055615;5857.85355366115;5906.320773111082;5911;5923.970380148093;4994.900101997976;5113.284140220372;5131.794728210867;5134.255532947702;5147.665401748912;24113;24127.155549555857;24239;24275.15036973715;24450.510989780105;2232.843700940935;2251.7297924249033;2281.977180228193;2413.5896897527464;2422.7819496245247;12830.935845320808;14837.332320045516;14966.850331496655;15065.548033559011;15148.939574229807;1387.1191793211383;1656.7514872769061;1889.2159753702197;1910.245453046053;1914.339552854263;87099;112690;112885;113529;113905.43047284793;8891.599878005505;10704.518296676668;10979.1765617579;11499.597514087134;11720;11436.199466037298;13826.930865345608;13832.100913440594;13833.893288537094;13840.93079534616;8188.959055204686;8404.579771011426;8432.957835210786;8482.151784821592;8506.829863402698;8297.502149871027;8375.623096960651;8394.874076888851;8523.275521580612;8572.185642363966;6646.966765166143;6738.056672065817;6792.558483698544;6811.829704257334;6846.657667116624;1612.5323656139822;1863.1615772902248;1907.303834100571;1914.3204162522381;1915.090332092273;858.4548811504615;912.7900582865979;941.4727752458508;987.3236832769576;1013.8834034086175;21029.789702102782;21689;21718.674219886714;21762.238321658668;21922.232721854976;917.1195652173855;927.8700981862545;939.8825146856643;948.4451595816524;950.8336041192764;11332.320060796379;11618.012468940065;11793.172058330973;11802.94098529519;11804.40977951099;227843.86078069505;229011;229323;229440;229488;106768;111294.44352778184;112903;114947.42526287315;115043.42478287555;817.440053563311;982.8918818929913;1003.3829195045141;1003.6136087606178;1006.6476733143488;18847.434576962714;19170.233190672217;19550.511237219183;19629.901850490656;19673.606527869648;50207.48952600857;50659.49340506548;51041;51858;53136.468635313155;65211;65704.0144397844;67609.66195168992;69348.65325673339;73225;7865.724699635485;8002.319802816825;8081.595920203848;8241.464304820167;8280.254777070093;12511.436985335864;12843.614691559269;13137.540186093442;13373.331333433094;13483.528076517276;10870.130389568658;10914.236003479999;11332.716682082684;11348.489317980546;11410.885891140982;10190.847137293094;11046.944765276123;11242.94378528102;11544.960953513888;11727.706807329885;9700.223982081558;11427.771444571228;11623.825642615537;11831.822522661994;11940.044796416092;8050.355971522381;8102.83794324122;8119.865151704333;8285.627146778288;8336.791580210544;11173.273737207055;11249.606263780728;11699.23954942926;11756.11829112837;11786.823197652213 11:15:21 INFO - PROCESS | 1637 | |3;mootools.html;1443.790650355698;1495.9551213463596;1661.3935913391608;1771.8671099667529;1791.4894255137287;7089;7614.923850761491;7826.804329891741;8650.178233067849;8656.653733850646;6785.5589386689835;7490.775276741707;8034.03591569011;8154.347652187826;8648.221660050594;2349.2952114365708;2362.3857796972825;2363.515479326734;2364.6807680963107;2366.85798852069;1976.6046790641858;2370.312609343297;2420.6611074449593;2420.7337192908853;2424.5150969806023;2237.2617036377956;2339.368370539953;2355.858648481088;2378.6907701998716;2381.761823817622;2144.3888491779844;2351;2357.3281614739803;2365.266767302142;2378.1914149189274;1924.9326273580357;2009.387136923238;2321.5240875620457;2368.3842201027683;2387.9522409551887;8542.74371768848;8635.568221588957;8684.478931264144;8696.347773916981;8711.172438618321;4716.52834716529;5223.791048358099;5228.424873263938;5241.161414173752;5247.816326428595;3343.866245350183;3439.105832483572;3582.1223800168864;3674.2467794102145;3682.3187710273687;1054.3673795722582;1071.4374953149659;1113.8273567597034;1115.341948250536;1127.9041281491084;11478.483468243865;11506.539738410453;11598.536058557647;11599.246049006872;11609.30344179352;4521.231390663595;4698.342232087511;4781.976090119597;4784.425868895685;4823.734694591761;9478.905210947802;9615.711528654152;9628.133467987775;9635.56639951204;9636.614535418645;5244.816431424882;5261.947380526222;5282.286891269706;5284.101702710548;5305.469453054664;4147.958520414818;4243.490781106287;4299.419578356944;4807;4852.902941941142;3833.5783063862955;3872.53529576447;3950.822213000422;3961.0493481564217;4010.859619913289;1278.7506436244844;1298.8311519502404;1299.7855353866696;1305.2755720574983;1309.888659463937;795.5783434779576;898.8427025270682;902.634433054614;926.2080920812742;926.6849271247808;5790.073588225863;5805.419458054245;5823.534117270693;5879.441453061952;6053.757849685963;457.76425141052385;458.5574920202021;462.73624034300127;996.4868092932146;1027.3219675014454;3848.5189351331082;3891.3384724596885;3937.5274967004143;3978.5424676162033;4026.416169655442;10210.336328138646;10258.43578603184;10540.104091152338;10595.364278143335;10618.566493523276;10257.07686308221;10504.73738156537;10548.525316360781;10581.259311848251;10606.15150787935;8056.798580035546;8078.959605201936;8100.189981001853;8122.390820688472;8191.71329003494;5183.5593974512585;5554.777808887761;5641.351244606759;5797.333306669787;5819.70901454934;8861.689840855539;9466.95266523663;9566;9567.760805979906;9700.5149742514;9633.566489507848;9743.561539730586;9880.209583233467;9924.156446701822;9924.206063515046;6340.714667839866;6503.414692677682;6745.865082698417;6880.69036893331;7040.788776336718;8003.19968003195;8045.637946292314;8236.682130859033;8241.381896357678;8246.711365102192;7131.964340178266;7247.601381924045;7305.379042781423;7344.522606030591;7423.8144046399275;7112.57324560528;7220.061392019214;7231.457640677076;7249.891251631335;7286.453515986428;5278.920816187837;6653.5009874260595;6722.428593569406;6891.173059232924;6955.374016338554;4077.2049450356894;4226.852060177879;4467.2182368084805;4500.80728606926;4534.319852022091;4849.58778503817;4906.484819094087;5018.322526459027;5065.468125846881;5178.197379406198 11:15:21 INFO - PROCESS | 1637 | |4;prototype.html;261.6284875476822;287.4524031719575;297.50910996855185;299.1951650061335;312.7654259305521;5115.7697903594335;5116.692998420097;5300.787968481256;5393.325834270716;5546.500814926656;4941.431735350436;5258.526732594075;5406.513413792768;5493.725313734307;5508.586855985797;3852.460655508231;4186.895327616819;4191.497020357561;4191.832326706944;4208.936865947013;3495.7378196635227;3834.4631751554666;4112.753234805907;4223.450951376317;4237;3469.768232277543;4060.634542891139;4063.1061166543313;4107.938380924288;4129.781714394246;3301.5212794144954;4104.399284279104;4108.28105081611;4122.9381559276635;4169.353750168699;2969.539721343195;3574.4459608760426;3584.4981702561663;3584.8566057357675;3586.946195807065;4627.467841198271;4946;5284.5772338212855;5321.627486075976;5406.810761623325;3929.8821035368983;4208.452901122834;4371.907023244189;4738.19450693383;4754.9286760698615;4814.6870453420415;4902.65681402302;4928.704277743347;5552.86117847053;5684.715764211773;3094.5300982033577;3734.3859298490893;3865.1303456722294;3865.9613403866165;3879.4568760373572;5441.367589723067;5804.187413762077;6067.75610999744;6105.32841387447;6132.386761323832;3978.960210397917;3979.422983667352;3979.721419500607;4006.9198616028098;4058.736182148151;3332.5001249812235;3869.0520822398694;3957.821898014596;3976.383660532622;4039.959600403958;3970.8630182156353;4404.700613319079;4610.723356598614;4633.976830115827;4707.246840505502;5113.846584602468;5575.69333686643;5751.820876720262;5877.5591830612875;5918.201042859159;1239.6405042537563;1248.7003119251315;1265.829113069742;1297.8053292006086;1336.7326534692907;716.1978583985968;777.8249893773856;840.3151680879919;850.3707256630049;887.7824932891483;4834.371531700856;4950.846381823918;5233.241180028875;5268.420473747885;5268.578513718893;5552.861178470571;5682.715864206773;5717.028105222123;5760.971195143998;5793.333766616893;4259.74441533509;4613.947727238668;4995.826815335341;5207.833733013574;5266.315379000705;2864.8424336661683;2981.552767084911;2982.4482470742983;3011.578379026938;3013.303093731098;5208.453112423217;5266.631335806457;5800.100984347433;5915.201447804578;5950.8809823803285;4649.930251046237;4803.783829727601;5253.658512196772;5415.918761218585;5630.915536266959;5439.646422982493;5497.45025497455;5673.602847800615;5956.851078723066;5967.761289548456;4693.6949098308505;5544.667319960815;5575.581831362583;5620.662760234399;5739.770409183753;4844.346013288302;5355.036093503051;5637.490007993507;5647.604667673223;5671.17767923657;5640.041192997282;5920.3783602722815;5936.436038576328;5984.790532331347;5997.670128142994;3142.6385965614245;3332.7333813294395;3588.4079126944807;3693.0028892199493;3752.399616061417;4811.511654050785;4920.630952678492;5353.036453438419;5528.7235638218735;5702.942970570241;4713.81144754206;4809.326694262736;4995.701977090579;5102.902875881703;5822.186467863557;5324.7220667038855;5768.865519757716;5781.4218578141845;5821.214136091573;5897.351291358033;4858.4898585648;5049.57078648319;5271.525562699376;5639.6444115751065;5658.773649053992;4618.353430519797;5079.415867175322;5546;5559.579410075145;5746.741396637245;4693.460252071056;5655.236543066798;5658.632188907708;5664.886702266014;5705.001624715741 11:15:21 INFO - PROCESS | 1637 | |5;yui.html;632.6804963493436;644.8806970710419;660.9074729537863;747.7868807389895;765.3418060467997;13235.801462978052;13831.861681383183;13857.23785191814;13886.722265554683;13890.999999999987;12938.223706577612;13103.148295360796;13116.409761560728;13116.54092106774;13127.015473839476;639.2233436374804;657.2113463843383;786.5477350523444;799.460364254129;814.9918500815005;795.2087672765606;804.1917872538091;804.8752443371287;807.2976510435929;809.1706001348635;857.6312185760121;866.3459088388258;867.5618812499679;867.6919693508809;868.4224990381389;852.4544291653347;856.6830272799073;861.4701958295634;862.5557837713583;862.9568521573896;640.3404493371835;640.7533099756581;641.3458272562008;641.425923798198;641.6054126712086;13533;13619.18284902909;13643.931780341134;13689;13802.309884505734;13402.46390144393;13624.727505449935;13625.386857591433;13805.378757955916;13914.234717090556;11061.778764424747;11115.333080015143;11312.660620181408;11382;11480;3636.327279453283;3662.230931504387;3681.079730067483;3683.465897444882;3735.1782607826235;72972;85450.5727471365;86853;88588;89976;9144.588493517807;9550.61797528105;10265.538050787583;10513;10674.73313167177;17187.65624687499;17245.56886077858;18448.446546603624;20505.692414613794;21115.472113197295;7396.593187374746;7604.581748003913;7625.351845093229;7723.961380193063;7809.140994490602;4144.606262405066;4189.916201675949;4293.162833247549;4321.286987647066;4347.369631403429;3383.3909896218424;3445.8277086145595;3488.0407887831047;3489.267253876714;3509.456034314634;650.5121159130651;653.1248127509066;656.389557711333;658.4205898809113;671.4896678524259;626.28603392133;631.0786252071935;649.555054787472;662.211967758366;680.2245440198178;8562.48625082497;8760.693375731818;8935.329850261256;9159.267258619295;9177.541122943827;581.6626356713181;614.3242433323309;627.5669787846463;651.2998526583847;671.1308855032744;3979.5423526294267;4272.6154646082;4469.128519938646;4482.254207417815;4543.273076307775;108851.91148088576;109158.45420772846;114485.4275728616;115980.42009789897;116463;98279.50860245652;102021;103664.48167759264;103709;104459;86718;90150.54924725466;91222.54388728147;92310.53844730867;92441.53779231195;8395.340585974842;8694;8696.565171741515;8738.563071846509;8876.112388761072;54537.45462545324;55524.72237638786;56603;56668.14997775119;57415.71292143512;63334.566580338935;76792;77831.83252251334;78560;80655.59672201837;11124.777504449703;11376.601818936297;11461.48423320936;11488.885111148782;11515.136364772843;12266.141370104364;12335.753284934071;12337.321447320484;13701.383437745126;13971.790423143864;12546.498140074294;12675.17611355259;13172.60482185536;13754.105983111065;13939.51211707626;12420.813687794871;13120.540781073;13185;13900.51348202808;13920.51278205258;12300.023877745998;12842.614721558368;13123;13142.671433214246;13555.525556605471;10395.94802025985;11332.206745527734;11347.33453873494;11384.829227561428;11450.82823757661;8774.166454186841;10166.440845753554;10835.349879007284;11408.94295528517;11583.305001699924 11:15:21 INFO - PROCESS | 1637 | __end_tp_report 11:15:21 INFO - PROCESS | 1637 | __start_cc_report 11:15:21 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,370 11:15:21 INFO - PROCESS | 1637 | __end_cc_report 11:15:21 INFO - PROCESS | 1637 | __startTimestamp1479755721219__endTimestamp 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - PROCESS | 1637 | ------- Summary: start ------- 11:15:21 INFO - PROCESS | 1637 | Number of tests: 6 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5742.55 Median:6041.46 stddev:718.14 (11.9%) stddev-sans-first:683.99 11:15:21 INFO - PROCESS | 1637 | Values: 2866.5 2896.9 2898.3 3439.8 3489.3 4760.0 5849.5 5856.8 5899.7 5930.8 5490.4 5831.4 5916.8 5923.8 6009.0 5273.3 5293.2 5299.2 5329.2 5353.5 5366.2 5374.2 5416.9 5417.9 5434.3 4592.8 4797.5 4992.9 5336.8 5383.9 5249.4 5303.2 5359.4 5374.1 5394.1 4018.4 4185.2 4715.6 5294.3 5399.5 5287.3 5603.6 5903.0 6019.6 6041.5 6113.9 6149.9 6163.4 6215.0 6278.8 5186.5 5446.8 6034.8 6169.6 6191.9 5866.7 5889.2 5891.6 5912.1 5921.6 6335.1 6358.5 6359.4 6383.1 6480.5 6180.8 6193.8 6195.2 6204.5 6207.8 4928.7 5588.7 6271.6 6348.4 6352.6 5441.1 6113.8 6140.6 6163.8 6198.4 5200.4 5651.7 6180.5 6195.4 6235.8 5008.3 5014.6 5022.6 5033.5 5062.0 4426.1 4436.1 4458.7 4475.5 4489.5 6035.9 6038.7 6047.6 6068.1 6094.4 6130.3 6174.9 6180.3 6282.1 6322.2 5997.3 6021.1 6047.6 6136.3 6143.1 5426.8 5484.8 5514.7 5518.4 5534.2 6373.3 6461.1 6464.1 6478.5 6569.7 5632.8 6314.1 6329.2 6331.4 6348.5 6564.5 6589.7 6592.6 6604.9 6622.4 5187.7 6121.9 6137.2 6161.8 6176.4 6198.8 6227.4 6230.0 6237.2 6346.7 6101.7 6161.8 6162.0 6172.8 6188.1 6042.2 6107.5 6165.4 6182.3 6211.6 5870.6 6025.4 6091.8 6102.6 6156.1 6147.9 6153.5 6186.2 6186.4 6186.8 5132.5 5318.4 6080.1 6101.7 6146.4 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:62416.81 Median:39290.01 stddev:132452.12 (337.1%) stddev-sans-first:132741.95 11:15:21 INFO - PROCESS | 1637 | Values: 444.0 478.4 496.2 520.8 524.8 32947.3 37964.4 39512.4 39574.0 39655.2 40773.6 41078.2 41189.0 41246.6 41273.0 9367.8 9492.5 9520.7 9534.1 9552.3 9418.5 9449.6 9466.8 9480.9 9490.9 9376.7 9472.9 9497.3 9520.4 9525.1 9408.4 9447.9 9471.5 9480.0 9513.0 9412.3 9537.5 9549.5 9561.8 9571.0 38862.0 39289.8 39290.2 39372.4 39411.4 3159.0 3269.3 3295.6 3325.3 3667.3 28980.1 29326.7 30001.5 30010.2 30268.8 3162.5 3202.3 3242.3 3260.4 3307.8 339837.3 358056.0 359238.2 359243.4 359583.0 56211.0 56522.7 56543.2 56577.2 56714.0 58806.4 58912.7 59387.0 59468.4 59924.0 15278.9 15466.9 15482.3 15492.1 15517.1 9091.8 10277.0 11547.9 11884.8 11961.4 13821.7 14085.6 14164.2 15258.7 15261.7 6766.6 6798.6 6926.0 6929.7 6934.3 742.7 876.4 878.0 918.0 928.1 23277.0 28416.4 28819.7 29874.0 29998.9 957.2 998.3 1001.3 1042.3 1049.9 12070.3 13474.5 14370.6 15391.5 16337.9 533442.0 539484.0 540800.0 541629.0 543466.0 54107.6 54396.7 54531.5 54656.7 54899.2 1342.8 1358.0 1375.8 1382.6 1384.7 27922.6 28507.7 28723.1 29038.7 29278.0 46626.8 52134.5 52918.5 53016.0 53758.5 560480.0 562603.0 568672.0 569608.0 573411.0 25118.0 25296.7 25613.0 25679.0 25731.0 45226.3 45228.0 45245.3 45794.9 46291.8 31174.8 33833.8 35756.6 37152.6 37551.6 31607.5 37598.8 38380.8 38389.4 38670.2 36042.0 36470.5 36836.1 37268.8 37513.8 32145.4 32966.0 33154.8 33302.5 33972.7 24949.6 25333.6 25360.7 25734.7 25782.7 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:23883.77 Median:229167.00 stddev:43465.78 (19.0%) stddev-sans-first:43551.86 11:15:21 INFO - PROCESS | 1637 | Values: 369.7 374.6 380.5 391.1 401.3 18091.8 19909.8 20197.9 20413.0 20649.7 19278.7 19588.5 19838.1 20090.3 20162.6 5510.1 5737.4 5806.1 6036.4 6044.8 5828.0 5957.5 6027.0 6035.6 6039.9 5026.3 5843.0 5902.5 5930.0 5930.6 5693.6 5857.9 5906.3 5911.0 5924.0 4994.9 5113.3 5131.8 5134.3 5147.7 24113.0 24127.2 24239.0 24275.2 24450.5 2232.8 2251.7 2282.0 2413.6 2422.8 12830.9 14837.3 14966.9 15065.5 15148.9 1387.1 1656.8 1889.2 1910.2 1914.3 87099.0 112690.0 112885.0 113529.0 113905.4 8891.6 10704.5 10979.2 11499.6 11720.0 11436.2 13826.9 13832.1 13833.9 13840.9 8189.0 8404.6 8433.0 8482.2 8506.8 8297.5 8375.6 8394.9 8523.3 8572.2 6647.0 6738.1 6792.6 6811.8 6846.7 1612.5 1863.2 1907.3 1914.3 1915.1 858.5 912.8 941.5 987.3 1013.9 21029.8 21689.0 21718.7 21762.2 21922.2 917.1 927.9 939.9 948.4 950.8 11332.3 11618.0 11793.2 11802.9 11804.4 227843.9 229011.0 229323.0 229440.0 229488.0 106768.0 111294.4 112903.0 114947.4 115043.4 817.4 982.9 1003.4 1003.6 1006.6 18847.4 19170.2 19550.5 19629.9 19673.6 50207.5 50659.5 51041.0 51858.0 53136.5 65211.0 65704.0 67609.7 69348.7 73225.0 7865.7 8002.3 8081.6 8241.5 8280.3 12511.4 12843.6 13137.5 13373.3 13483.5 10870.1 10914.2 11332.7 11348.5 11410.9 10190.8 11046.9 11242.9 11545.0 11727.7 9700.2 11427.8 11623.8 11831.8 11940.0 8050.4 8102.8 8119.9 8285.6 8336.8 11173.3 11249.6 11699.2 11756.1 11786.8 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5521.13 Median:4879.69 stddev:3093.21 (63.4%) stddev-sans-first:3086.71 11:15:21 INFO - PROCESS | 1637 | Values: 1443.8 1496.0 1661.4 1771.9 1791.5 7089.0 7614.9 7826.8 8650.2 8656.7 6785.6 7490.8 8034.0 8154.3 8648.2 2349.3 2362.4 2363.5 2364.7 2366.9 1976.6 2370.3 2420.7 2420.7 2424.5 2237.3 2339.4 2355.9 2378.7 2381.8 2144.4 2351.0 2357.3 2365.3 2378.2 1924.9 2009.4 2321.5 2368.4 2388.0 8542.7 8635.6 8684.5 8696.3 8711.2 4716.5 5223.8 5228.4 5241.2 5247.8 3343.9 3439.1 3582.1 3674.2 3682.3 1054.4 1071.4 1113.8 1115.3 1127.9 11478.5 11506.5 11598.5 11599.2 11609.3 4521.2 4698.3 4782.0 4784.4 4823.7 9478.9 9615.7 9628.1 9635.6 9636.6 5244.8 5261.9 5282.3 5284.1 5305.5 4148.0 4243.5 4299.4 4807.0 4852.9 3833.6 3872.5 3950.8 3961.0 4010.9 1278.8 1298.8 1299.8 1305.3 1309.9 795.6 898.8 902.6 926.2 926.7 5790.1 5805.4 5823.5 5879.4 6053.8 457.8 458.6 462.7 996.5 1027.3 3848.5 3891.3 3937.5 3978.5 4026.4 10210.3 10258.4 10540.1 10595.4 10618.6 10257.1 10504.7 10548.5 10581.3 10606.2 8056.8 8079.0 8100.2 8122.4 8191.7 5183.6 5554.8 5641.4 5797.3 5819.7 8861.7 9467.0 9566.0 9567.8 9700.5 9633.6 9743.6 9880.2 9924.2 9924.2 6340.7 6503.4 6745.9 6880.7 7040.8 8003.2 8045.6 8236.7 8241.4 8246.7 7132.0 7247.6 7305.4 7344.5 7423.8 7112.6 7220.1 7231.5 7249.9 7286.5 5278.9 6653.5 6722.4 6891.2 6955.4 4077.2 4226.9 4467.2 4500.8 4534.3 4849.6 4906.5 5018.3 5065.5 5178.2 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4508.06 Median:4973.27 stddev:1398.03 (28.1%) stddev-sans-first:1365.13 11:15:21 INFO - PROCESS | 1637 | Values: 261.6 287.5 297.5 299.2 312.8 5115.8 5116.7 5300.8 5393.3 5546.5 4941.4 5258.5 5406.5 5493.7 5508.6 3852.5 4186.9 4191.5 4191.8 4208.9 3495.7 3834.5 4112.8 4223.5 4237.0 3469.8 4060.6 4063.1 4107.9 4129.8 3301.5 4104.4 4108.3 4122.9 4169.4 2969.5 3574.4 3584.5 3584.9 3586.9 4627.5 4946.0 5284.6 5321.6 5406.8 3929.9 4208.5 4371.9 4738.2 4754.9 4814.7 4902.7 4928.7 5552.9 5684.7 3094.5 3734.4 3865.1 3866.0 3879.5 5441.4 5804.2 6067.8 6105.3 6132.4 3979.0 3979.4 3979.7 4006.9 4058.7 3332.5 3869.1 3957.8 3976.4 4040.0 3970.9 4404.7 4610.7 4634.0 4707.2 5113.8 5575.7 5751.8 5877.6 5918.2 1239.6 1248.7 1265.8 1297.8 1336.7 716.2 777.8 840.3 850.4 887.8 4834.4 4950.8 5233.2 5268.4 5268.6 5552.9 5682.7 5717.0 5761.0 5793.3 4259.7 4613.9 4995.8 5207.8 5266.3 2864.8 2981.6 2982.4 3011.6 3013.3 5208.5 5266.6 5800.1 5915.2 5950.9 4649.9 4803.8 5253.7 5415.9 5630.9 5439.6 5497.5 5673.6 5956.9 5967.8 4693.7 5544.7 5575.6 5620.7 5739.8 4844.3 5355.0 5637.5 5647.6 5671.2 5640.0 5920.4 5936.4 5984.8 5997.7 3142.6 3332.7 3588.4 3693.0 3752.4 4811.5 4920.6 5353.0 5528.7 5702.9 4713.8 4809.3 4995.7 5102.9 5822.2 5324.7 5768.9 5781.4 5821.2 5897.4 4858.5 5049.6 5271.5 5639.6 5658.8 4618.4 5079.4 5546.0 5559.6 5746.7 4693.5 5655.2 5658.6 5664.9 5705.0 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20827.22 Median:4307.22 stddev:31101.02 (722.1%) stddev-sans-first:31151.30 11:15:21 INFO - PROCESS | 1637 | Values: 632.7 644.9 660.9 747.8 765.3 13235.8 13831.9 13857.2 13886.7 13891.0 12938.2 13103.1 13116.4 13116.5 13127.0 639.2 657.2 786.5 799.5 815.0 795.2 804.2 804.9 807.3 809.2 857.6 866.3 867.6 867.7 868.4 852.5 856.7 861.5 862.6 863.0 640.3 640.8 641.3 641.4 641.6 13533.0 13619.2 13643.9 13689.0 13802.3 13402.5 13624.7 13625.4 13805.4 13914.2 11061.8 11115.3 11312.7 11382.0 11480.0 3636.3 3662.2 3681.1 3683.5 3735.2 72972.0 85450.6 86853.0 88588.0 89976.0 9144.6 9550.6 10265.5 10513.0 10674.7 17187.7 17245.6 18448.4 20505.7 21115.5 7396.6 7604.6 7625.4 7724.0 7809.1 4144.6 4189.9 4293.2 4321.3 4347.4 3383.4 3445.8 3488.0 3489.3 3509.5 650.5 653.1 656.4 658.4 671.5 626.3 631.1 649.6 662.2 680.2 8562.5 8760.7 8935.3 9159.3 9177.5 581.7 614.3 627.6 651.3 671.1 3979.5 4272.6 4469.1 4482.3 4543.3 108851.9 109158.5 114485.4 115980.4 116463.0 98279.5 102021.0 103664.5 103709.0 104459.0 86718.0 90150.5 91222.5 92310.5 92441.5 8395.3 8694.0 8696.6 8738.6 8876.1 54537.5 55524.7 56603.0 56668.1 57415.7 63334.6 76792.0 77831.8 78560.0 80655.6 11124.8 11376.6 11461.5 11488.9 11515.1 12266.1 12335.8 12337.3 13701.4 13971.8 12546.5 12675.2 13172.6 13754.1 13939.5 12420.8 13120.5 13185.0 13900.5 13920.5 12300.0 12842.6 13123.0 13142.7 13555.5 10395.9 11332.2 11347.3 11384.8 11450.8 8774.2 10166.4 10835.3 11408.9 11583.3 11:15:21 INFO - PROCESS | 1637 | -------- Summary: end -------- 11:15:21 INFO - PROCESS | 1637 | 11:15:21 INFO - TEST-INFO | 1637: exit 0 11:15:21 INFO - TEST-OK | dromaeo_css | took 1115366ms 11:15:21 INFO - TEST-START | kraken 11:15:21 INFO - operating with platform_type : mac_ 11:15:21 INFO - Initialising browser for kraken test... 11:15:21 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmptz57r0/profile http://localhost:49241/getInfo.html) 11:15:23 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 11:15:24 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 11:15:24 INFO - PROCESS | 1649 | colorDepth:24 11:15:24 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 11:15:24 INFO - PROCESS | 1649 | __metrics 11:15:24 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 11:15:25 INFO - TEST-INFO | 1649: exit 0 11:15:25 INFO - Browser initialized. 11:15:25 INFO - Running cycle 1/1 for kraken test... 11:15:25 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmptz57r0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:15:37 INFO - PROCESS | 1651 | RSS: Main: 224022528 11:15:37 INFO - PROCESS | 1651 | 11:15:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 11:15:40 INFO - PROCESS | 1651 | RSS: Main: 236711936 11:15:40 INFO - PROCESS | 1651 | 11:15:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 11:15:44 INFO - PROCESS | 1651 | RSS: Main: 244211712 11:15:44 INFO - PROCESS | 1651 | 11:15:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 11:15:48 INFO - PROCESS | 1651 | RSS: Main: 248029184 11:15:48 INFO - PROCESS | 1651 | 11:15:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 11:15:50 INFO - PROCESS | 1651 | RSS: Main: 249434112 11:15:50 INFO - PROCESS | 1651 | 11:15:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:15:53 INFO - PROCESS | 1651 | RSS: Main: 249438208 11:15:53 INFO - PROCESS | 1651 | 11:15:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 11:15:57 INFO - PROCESS | 1651 | RSS: Main: 253558784 11:15:57 INFO - PROCESS | 1651 | 11:16:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:01 INFO - PROCESS | 1651 | RSS: Main: 252977152 11:16:01 INFO - PROCESS | 1651 | 11:16:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 11:16:04 INFO - PROCESS | 1651 | RSS: Main: 252956672 11:16:04 INFO - PROCESS | 1651 | 11:16:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:16:06 INFO - PROCESS | 1651 | RSS: Main: 252203008 11:16:06 INFO - PROCESS | 1651 | 11:16:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:16:09 INFO - PROCESS | 1651 | RSS: Main: 252182528 11:16:09 INFO - PROCESS | 1651 | 11:16:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:16:12 INFO - PROCESS | 1651 | RSS: Main: 252227584 11:16:12 INFO - PROCESS | 1651 | 11:16:15 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:16:16 INFO - PROCESS | 1651 | RSS: Main: 252518400 11:16:16 INFO - PROCESS | 1651 | 11:16:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:16:19 INFO - PROCESS | 1651 | RSS: Main: 252329984 11:16:19 INFO - PROCESS | 1651 | 11:16:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 11:16:22 INFO - PROCESS | 1651 | RSS: Main: 254119936 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | __start_tp_report 11:16:22 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 11:16:22 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 11:16:22 INFO - PROCESS | 1651 | |i|pagename|runs| 11:16:22 INFO - PROCESS | 1651 | |0;ai-astar;107;118;116;118;121;119;120;120;118;118 11:16:22 INFO - PROCESS | 1651 | |1;audio-beat-detection;141;149;149;183;123;115;116;115;156;153 11:16:22 INFO - PROCESS | 1651 | |2;audio-dft;199;196;196;192;192;194;196;195;230;279 11:16:22 INFO - PROCESS | 1651 | |3;audio-fft;83;66;85;110;64;60;60;50;100;85 11:16:22 INFO - PROCESS | 1651 | |4;audio-oscillator;80;72;101;102;99;59;102;64;74;117 11:16:22 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;92;125;89;86;84;122;115;131;115;85 11:16:22 INFO - PROCESS | 1651 | |6;imaging-darkroom;98;100;101;108;100;109;99;174;172;169 11:16:22 INFO - PROCESS | 1651 | |7;imaging-desaturate;92;76;142;142;89;88;90;98;90;87 11:16:22 INFO - PROCESS | 1651 | |8;json-parse-financial;58;57;55;58;61;75;88;92;91;75 11:16:22 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;77;102;111;119;88;75;68;68;69;72 11:16:22 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;87;85;85;90;107;106;80;85;85;87 11:16:22 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;166;152;163;141;162;172;150;176;218;198 11:16:22 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;168;171;193;224;190;166;170;169;171;169 11:16:22 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;68;82;76;85;88;63;69;88;87;91 11:16:22 INFO - PROCESS | 1651 | __end_tp_report 11:16:22 INFO - PROCESS | 1651 | __start_cc_report 11:16:22 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,988 11:16:22 INFO - PROCESS | 1651 | __end_cc_report 11:16:22 INFO - PROCESS | 1651 | __startTimestamp1479755782091__endTimestamp 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | ------- Summary: start ------- 11:16:22 INFO - PROCESS | 1651 | Number of tests: 14 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:117.50 Median:118.50 stddev:3.95 (3.3%) stddev-sans-first:1.50 11:16:22 INFO - PROCESS | 1651 | Values: 107.0 118.0 116.0 118.0 121.0 119.0 120.0 120.0 118.0 118.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:149.00 stddev:22.49 (15.1%) stddev-sans-first:23.85 11:16:22 INFO - PROCESS | 1651 | Values: 141.0 149.0 149.0 183.0 123.0 115.0 116.0 115.0 156.0 153.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:206.90 Median:196.00 stddev:27.69 (14.1%) stddev-sans-first:29.23 11:16:22 INFO - PROCESS | 1651 | Values: 199.0 196.0 196.0 192.0 192.0 194.0 196.0 195.0 230.0 279.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:76.30 Median:65.00 stddev:19.36 (29.8%) stddev-sans-first:20.38 11:16:22 INFO - PROCESS | 1651 | Values: 83.0 66.0 85.0 110.0 64.0 60.0 60.0 50.0 100.0 85.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:68.00 stddev:19.57 (28.8%) stddev-sans-first:20.59 11:16:22 INFO - PROCESS | 1651 | Values: 80.0 72.0 101.0 102.0 99.0 59.0 102.0 64.0 74.0 117.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:104.40 Median:84.50 stddev:18.82 (22.3%) stddev-sans-first:19.42 11:16:22 INFO - PROCESS | 1651 | Values: 92.0 125.0 89.0 86.0 84.0 122.0 115.0 131.0 115.0 85.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:123.00 Median:170.50 stddev:33.80 (19.8%) stddev-sans-first:34.62 11:16:22 INFO - PROCESS | 1651 | Values: 98.0 100.0 101.0 108.0 100.0 109.0 99.0 174.0 172.0 169.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:99.40 Median:89.50 stddev:23.10 (25.8%) stddev-sans-first:24.35 11:16:22 INFO - PROCESS | 1651 | Values: 92.0 76.0 142.0 142.0 89.0 88.0 90.0 98.0 90.0 87.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:71.00 Median:75.00 stddev:15.10 (20.1%) stddev-sans-first:15.27 11:16:22 INFO - PROCESS | 1651 | Values: 58.0 57.0 55.0 58.0 61.0 75.0 88.0 92.0 91.0 75.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:84.90 Median:70.50 stddev:19.14 (27.1%) stddev-sans-first:20.09 11:16:22 INFO - PROCESS | 1651 | Values: 77.0 102.0 111.0 119.0 88.0 75.0 68.0 68.0 69.0 72.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:85.00 stddev:9.20 (10.8%) stddev-sans-first:9.71 11:16:22 INFO - PROCESS | 1651 | Values: 87.0 85.0 85.0 90.0 107.0 106.0 80.0 85.0 85.0 87.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:169.80 Median:169.00 stddev:23.15 (13.7%) stddev-sans-first:24.51 11:16:22 INFO - PROCESS | 1651 | Values: 166.0 152.0 163.0 141.0 162.0 172.0 150.0 176.0 218.0 198.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:171.00 stddev:18.38 (10.7%) stddev-sans-first:19.05 11:16:22 INFO - PROCESS | 1651 | Values: 168.0 171.0 193.0 224.0 190.0 166.0 170.0 169.0 171.0 169.0 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.70 Median:86.00 stddev:9.98 (11.6%) stddev-sans-first:9.64 11:16:22 INFO - PROCESS | 1651 | Values: 68.0 82.0 76.0 85.0 88.0 63.0 69.0 88.0 87.0 91.0 11:16:22 INFO - PROCESS | 1651 | -------- Summary: end -------- 11:16:22 INFO - PROCESS | 1651 | 11:16:22 INFO - TEST-INFO | 1651: exit 0 11:16:22 INFO - TEST-OK | kraken | took 61067ms 11:16:22 INFO - SUITE-END | took 1176s 11:16:23 INFO - Completed test suite (00:19:36) 11:16:23 INFO - javascript benchmark 11:16:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7121.281313947816, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2866.5413533834603, 2896.8551572421375, 2898.289918969853, 3439.8108104054277, 3489.3021395720853, 4759.952400475994, 5849.473547380735, 5856.8242952711435, 5899.734511946956, 5930.762769489215, 5490.396056433789, 5831.446012628804, 5916.792912248072, 5923.822285331447, 6009.038553831388, 5273.340832395941, 5293.15309550472, 5299.178627312773, 5329.200619907026, 5353.464653534655, 5366.221897824813, 5374.247605335257, 5416.91874621881, 5417.891642167155, 5434.266374039514, 4592.816287348519, 4797.472278049412, 4992.925106123411, 5336.786528538853, 5383.919241211385, 5249.370075590934, 5303.204519322113, 5359.383670877821, 5374.113271310229, 5394.109971854639, 4018.397240413932, 4185.204811085914, 4715.552022557851, 5294.338207724035, 5399.514043736082, 5287.286216360781, 5603.635763675389, 5902.970485147547, 6019.578629495893, 6041.456268935773, 6113.932424433829, 6149.86227547905, 6163.414475624809, 6215.0, 6278.78024269153, 5186.455422180692, 5446.801703625196, 6034.849128771772, 6169.568130230886, 6191.9071213931375, 5866.70666466675, 5889.204957330791, 5891.646501209942, 5912.14273930282, 5921.608422020821, 6335.081413195061, 6358.459530939922, 6359.427651511386, 6383.138276332728, 6480.51396145291, 6180.783672571439, 6193.84515387119, 6195.19462469876, 6204.503639708812, 6207.844803879939, 4928.67963582366, 5588.714595643025, 6271.560990730696, 6348.396902294275, 6352.555321127476, 5441.129419292974, 6113.841195312599, 6140.565599444524, 6163.753449861955, 6198.411150940653, 5200.401953775364, 5651.660900345993, 6180.505559555225, 6195.4424101831055, 6235.844103897439, 5008.348914641073, 5014.648974571818, 5022.648414610942, 5033.5469807716745, 5062.0, 4426.136903303889, 4436.068425630589, 4458.71018383804, 4475.485319188335, 4489.483709373464, 6035.909461358083, 6038.698065096815, 6047.637141771508, 6068.089786531968, 6094.360092190256, 6130.275842464154, 6174.9073763893575, 6180.3201647818705, 6282.070442883421, 6322.241331040213, 5997.2803263607775, 6021.066734656048, 6047.576669633171, 6136.2636483622255, 6143.109249158847, 5426.810061647823, 5484.8354549363585, 5514.724263786875, 5518.365387980353, 5534.225208470817, 6373.2989371168205, 6461.095446637474, 6464.062710906798, 6478.546501744832, 6569.704363303758, 5632.831015069554, 6314.052892066043, 6329.2404911409085, 6331.430171284606, 6348.492120630431, 6564.4748420125325, 6589.6705164740615, 6592.571482853599, 6604.933950660432, 6622.403983641495, 5187.714675692873, 6121.908171377522, 6137.22377000893, 6161.84595385119, 6176.413240742122, 6198.845028874314, 6227.408396202353, 6230.0, 6237.220347456568, 6346.650934198663, 6101.694915254308, 6161.815145545641, 6162.014077747539, 6172.753089876534, 6188.071789231652, 6042.214512113397, 6107.46191531438, 6165.445109940127, 6182.289036760651, 6211.565190436626, 5870.55970802183, 6025.367336429612, 6091.847703807441, 6102.603330783485, 6156.076588511759, 6147.938520614736, 6153.507719382349, 6186.164867742978, 6186.412290832363, 6186.81439556814, 5132.486751324837, 5318.441563635917, 6080.087986802015, 6101.694915254131, 6146.385361463997], "value": 5693.976468181495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.9589163411798, 478.3804972560536, 496.24075164997555, 520.8020952038225, 524.7612336386944, 32947.34105317892, 37964.430533541985, 39512.407313890246, 39574.0, 39655.206895862066, 40773.59226407735, 41078.178436431255, 41189.0, 41246.58753412465, 41273.0, 9367.81264374712, 9492.52537373132, 9520.714378568618, 9534.141927226548, 9552.280589493888, 9418.529073546295, 9449.622015119387, 9466.763330916714, 9480.857787133198, 9490.905090949105, 9376.671816486425, 9472.857907131398, 9497.287703422237, 9520.381175223589, 9525.142737153656, 9408.388454750419, 9447.858282125773, 9471.47906865122, 9479.952600237024, 9513.0, 9412.294077944112, 9537.47543885086, 9549.522523873778, 9561.760955976086, 9571.0, 38862.02844928871, 39289.803550982346, 39290.214195715926, 39372.40941385881, 39411.4088288673, 3159.004913452255, 3269.2807582331848, 3295.6045274566964, 3325.3016866458074, 3667.2848794485085, 28980.13059608194, 29326.706732932824, 30001.549976750368, 30010.24974375636, 30268.84865575658, 3162.4623813951453, 3202.2794871154038, 3242.3353212591364, 3260.380527699753, 3307.7849939753837, 339837.30081349437, 358056.0, 359238.2038089793, 359243.4075659236, 359583.0, 56211.0, 56522.717386412805, 56543.15185272224, 56577.15134272989, 56714.0, 58806.41193588095, 58912.70543647254, 59387.0, 59468.40531594715, 59924.0, 15278.923605381902, 15466.917315787787, 15482.30329635169, 15492.14793186363, 15517.146556939477, 9091.772705682411, 10277.0, 11547.884521154681, 11884.762304753856, 11961.40192990347, 13821.654458638413, 14085.577432677037, 14164.150150990974, 15258.694826103416, 15261.694766104616, 6766.594004359754, 6798.620482830969, 6926.0, 6929.653517324114, 6934.306569343025, 742.6509540515949, 876.3952872517942, 877.9692710755221, 918.0177210384824, 928.0858354520792, 23277.0, 28416.431671366456, 28819.71180288212, 29874.0, 29998.85000574983, 957.1624828275259, 998.3361064891766, 1001.2840818814583, 1042.3172821801732, 1049.9055085042382, 12070.336131512675, 13474.461021559027, 14370.640733981525, 15391.46129885471, 16337.91831040861, 533442.0, 539484.0, 540800.0, 541629.0, 543466.0, 54107.64730881759, 54396.728016359666, 54531.454685452634, 54656.72671636617, 54899.176512352344, 1342.812006319116, 1358.042579981111, 1375.8417781955004, 1382.640513466506, 1384.7092110656674, 27922.58116128219, 28507.714922850508, 28723.138305850858, 29038.7096129036, 29277.975270865416, 46626.76686616545, 52134.47865521448, 52918.47081529135, 53016.0, 53758.46241537535, 560480.0, 562603.0, 568672.0, 569608.0, 573411.0, 25118.0, 25296.747032529438, 25613.0, 25678.972841086146, 25730.970761169345, 45226.32160517661, 45228.0, 45245.32132018088, 45794.85512862205, 46291.76854115708, 31174.844125779226, 33833.83083084569, 35756.56973721022, 37152.62847371492, 37551.624483754815, 31607.525887112173, 37598.8120059398, 38380.84857454281, 38389.424158638205, 38670.2265954685, 36042.0, 36470.452943205346, 36836.07909802169, 37268.813655931546, 37513.81243093767, 32145.35709285848, 32966.0, 33154.834225828716, 33302.50046249357, 33972.66027339695, 24949.625755613317, 25333.61999569971, 25360.74639253584, 25734.742652573233, 25782.742172578033], "value": 18864.527487479405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.698695563116, 374.61601858095463, 380.4996429694952, 391.13949311514676, 401.25567073079435, 18091.81908180918, 19909.800901990977, 20197.88911609861, 20413.0, 20649.690254646193, 19278.710819337684, 19588.510287242825, 19838.107285172166, 20090.29683961058, 20162.59674806503, 5510.0632892408385, 5737.426257374271, 5806.129080637896, 6036.426539478764, 6044.848878778022, 5828.03837366834, 5957.523398128139, 6027.035674292114, 6035.637861728288, 6039.939600604003, 5026.346574945252, 5843.0, 5902.498287645555, 5929.962256605098, 5930.614510056833, 5693.629914055615, 5857.85355366115, 5906.320773111082, 5911.0, 5923.970380148093, 4994.900101997976, 5113.284140220372, 5131.794728210867, 5134.255532947702, 5147.665401748912, 24113.0, 24127.155549555857, 24239.0, 24275.15036973715, 24450.510989780105, 2232.843700940935, 2251.7297924249033, 2281.977180228193, 2413.5896897527464, 2422.7819496245247, 12830.935845320808, 14837.332320045516, 14966.850331496655, 15065.548033559011, 15148.939574229807, 1387.1191793211383, 1656.7514872769061, 1889.2159753702197, 1910.245453046053, 1914.339552854263, 87099.0, 112690.0, 112885.0, 113529.0, 113905.43047284793, 8891.599878005505, 10704.518296676668, 10979.1765617579, 11499.597514087134, 11720.0, 11436.199466037298, 13826.930865345608, 13832.100913440594, 13833.893288537094, 13840.93079534616, 8188.959055204686, 8404.579771011426, 8432.957835210786, 8482.151784821592, 8506.829863402698, 8297.502149871027, 8375.623096960651, 8394.874076888851, 8523.275521580612, 8572.185642363966, 6646.966765166143, 6738.056672065817, 6792.558483698544, 6811.829704257334, 6846.657667116624, 1612.5323656139822, 1863.1615772902248, 1907.303834100571, 1914.3204162522381, 1915.090332092273, 858.4548811504615, 912.7900582865979, 941.4727752458508, 987.3236832769576, 1013.8834034086175, 21029.789702102782, 21689.0, 21718.674219886714, 21762.238321658668, 21922.232721854976, 917.1195652173855, 927.8700981862545, 939.8825146856643, 948.4451595816524, 950.8336041192764, 11332.320060796379, 11618.012468940065, 11793.172058330973, 11802.94098529519, 11804.40977951099, 227843.86078069505, 229011.0, 229323.0, 229440.0, 229488.0, 106768.0, 111294.44352778184, 112903.0, 114947.42526287315, 115043.42478287555, 817.440053563311, 982.8918818929913, 1003.3829195045141, 1003.6136087606178, 1006.6476733143488, 18847.434576962714, 19170.233190672217, 19550.511237219183, 19629.901850490656, 19673.606527869648, 50207.48952600857, 50659.49340506548, 51041.0, 51858.0, 53136.468635313155, 65211.0, 65704.0144397844, 67609.66195168992, 69348.65325673339, 73225.0, 7865.724699635485, 8002.319802816825, 8081.595920203848, 8241.464304820167, 8280.254777070093, 12511.436985335864, 12843.614691559269, 13137.540186093442, 13373.331333433094, 13483.528076517276, 10870.130389568658, 10914.236003479999, 11332.716682082684, 11348.489317980546, 11410.885891140982, 10190.847137293094, 11046.944765276123, 11242.94378528102, 11544.960953513888, 11727.706807329885, 9700.223982081558, 11427.771444571228, 11623.825642615537, 11831.822522661994, 11940.044796416092, 8050.355971522381, 8102.83794324122, 8119.865151704333, 8285.627146778288, 8336.791580210544, 11173.273737207055, 11249.606263780728, 11699.23954942926, 11756.11829112837, 11786.823197652213], "value": 9363.430922639858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.790650355698, 1495.9551213463596, 1661.3935913391608, 1771.8671099667529, 1791.4894255137287, 7089.0, 7614.923850761491, 7826.804329891741, 8650.178233067849, 8656.653733850646, 6785.5589386689835, 7490.775276741707, 8034.03591569011, 8154.347652187826, 8648.221660050594, 2349.2952114365708, 2362.3857796972825, 2363.515479326734, 2364.6807680963107, 2366.85798852069, 1976.6046790641858, 2370.312609343297, 2420.6611074449593, 2420.7337192908853, 2424.5150969806023, 2237.2617036377956, 2339.368370539953, 2355.858648481088, 2378.6907701998716, 2381.761823817622, 2144.3888491779844, 2351.0, 2357.3281614739803, 2365.266767302142, 2378.1914149189274, 1924.9326273580357, 2009.387136923238, 2321.5240875620457, 2368.3842201027683, 2387.9522409551887, 8542.74371768848, 8635.568221588957, 8684.478931264144, 8696.347773916981, 8711.172438618321, 4716.52834716529, 5223.791048358099, 5228.424873263938, 5241.161414173752, 5247.816326428595, 3343.866245350183, 3439.105832483572, 3582.1223800168864, 3674.2467794102145, 3682.3187710273687, 1054.3673795722582, 1071.4374953149659, 1113.8273567597034, 1115.341948250536, 1127.9041281491084, 11478.483468243865, 11506.539738410453, 11598.536058557647, 11599.246049006872, 11609.30344179352, 4521.231390663595, 4698.342232087511, 4781.976090119597, 4784.425868895685, 4823.734694591761, 9478.905210947802, 9615.711528654152, 9628.133467987775, 9635.56639951204, 9636.614535418645, 5244.816431424882, 5261.947380526222, 5282.286891269706, 5284.101702710548, 5305.469453054664, 4147.958520414818, 4243.490781106287, 4299.419578356944, 4807.0, 4852.902941941142, 3833.5783063862955, 3872.53529576447, 3950.822213000422, 3961.0493481564217, 4010.859619913289, 1278.7506436244844, 1298.8311519502404, 1299.7855353866696, 1305.2755720574983, 1309.888659463937, 795.5783434779576, 898.8427025270682, 902.634433054614, 926.2080920812742, 926.6849271247808, 5790.073588225863, 5805.419458054245, 5823.534117270693, 5879.441453061952, 6053.757849685963, 457.76425141052385, 458.5574920202021, 462.73624034300127, 996.4868092932146, 1027.3219675014454, 3848.5189351331082, 3891.3384724596885, 3937.5274967004143, 3978.5424676162033, 4026.416169655442, 10210.336328138646, 10258.43578603184, 10540.104091152338, 10595.364278143335, 10618.566493523276, 10257.07686308221, 10504.73738156537, 10548.525316360781, 10581.259311848251, 10606.15150787935, 8056.798580035546, 8078.959605201936, 8100.189981001853, 8122.390820688472, 8191.71329003494, 5183.5593974512585, 5554.777808887761, 5641.351244606759, 5797.333306669787, 5819.70901454934, 8861.689840855539, 9466.95266523663, 9566.0, 9567.760805979906, 9700.5149742514, 9633.566489507848, 9743.561539730586, 9880.209583233467, 9924.156446701822, 9924.206063515046, 6340.714667839866, 6503.414692677682, 6745.865082698417, 6880.69036893331, 7040.788776336718, 8003.19968003195, 8045.637946292314, 8236.682130859033, 8241.381896357678, 8246.711365102192, 7131.964340178266, 7247.601381924045, 7305.379042781423, 7344.522606030591, 7423.8144046399275, 7112.57324560528, 7220.061392019214, 7231.457640677076, 7249.891251631335, 7286.453515986428, 5278.920816187837, 6653.5009874260595, 6722.428593569406, 6891.173059232924, 6955.374016338554, 4077.2049450356894, 4226.852060177879, 4467.2182368084805, 4500.80728606926, 4534.319852022091, 4849.58778503817, 4906.484819094087, 5018.322526459027, 5065.468125846881, 5178.197379406198], "value": 4433.360724854727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.6284875476822, 287.4524031719575, 297.50910996855185, 299.1951650061335, 312.7654259305521, 5115.7697903594335, 5116.692998420097, 5300.787968481256, 5393.325834270716, 5546.500814926656, 4941.431735350436, 5258.526732594075, 5406.513413792768, 5493.725313734307, 5508.586855985797, 3852.460655508231, 4186.895327616819, 4191.497020357561, 4191.832326706944, 4208.936865947013, 3495.7378196635227, 3834.4631751554666, 4112.753234805907, 4223.450951376317, 4237.0, 3469.768232277543, 4060.634542891139, 4063.1061166543313, 4107.938380924288, 4129.781714394246, 3301.5212794144954, 4104.399284279104, 4108.28105081611, 4122.9381559276635, 4169.353750168699, 2969.539721343195, 3574.4459608760426, 3584.4981702561663, 3584.8566057357675, 3586.946195807065, 4627.467841198271, 4946.0, 5284.5772338212855, 5321.627486075976, 5406.810761623325, 3929.8821035368983, 4208.452901122834, 4371.907023244189, 4738.19450693383, 4754.9286760698615, 4814.6870453420415, 4902.65681402302, 4928.704277743347, 5552.86117847053, 5684.715764211773, 3094.5300982033577, 3734.3859298490893, 3865.1303456722294, 3865.9613403866165, 3879.4568760373572, 5441.367589723067, 5804.187413762077, 6067.75610999744, 6105.32841387447, 6132.386761323832, 3978.960210397917, 3979.422983667352, 3979.721419500607, 4006.9198616028098, 4058.736182148151, 3332.5001249812235, 3869.0520822398694, 3957.821898014596, 3976.383660532622, 4039.959600403958, 3970.8630182156353, 4404.700613319079, 4610.723356598614, 4633.976830115827, 4707.246840505502, 5113.846584602468, 5575.69333686643, 5751.820876720262, 5877.5591830612875, 5918.201042859159, 1239.6405042537563, 1248.7003119251315, 1265.829113069742, 1297.8053292006086, 1336.7326534692907, 716.1978583985968, 777.8249893773856, 840.3151680879919, 850.3707256630049, 887.7824932891483, 4834.371531700856, 4950.846381823918, 5233.241180028875, 5268.420473747885, 5268.578513718893, 5552.861178470571, 5682.715864206773, 5717.028105222123, 5760.971195143998, 5793.333766616893, 4259.74441533509, 4613.947727238668, 4995.826815335341, 5207.833733013574, 5266.315379000705, 2864.8424336661683, 2981.552767084911, 2982.4482470742983, 3011.578379026938, 3013.303093731098, 5208.453112423217, 5266.631335806457, 5800.100984347433, 5915.201447804578, 5950.8809823803285, 4649.930251046237, 4803.783829727601, 5253.658512196772, 5415.918761218585, 5630.915536266959, 5439.646422982493, 5497.45025497455, 5673.602847800615, 5956.851078723066, 5967.761289548456, 4693.6949098308505, 5544.667319960815, 5575.581831362583, 5620.662760234399, 5739.770409183753, 4844.346013288302, 5355.036093503051, 5637.490007993507, 5647.604667673223, 5671.17767923657, 5640.041192997282, 5920.3783602722815, 5936.436038576328, 5984.790532331347, 5997.670128142994, 3142.6385965614245, 3332.7333813294395, 3588.4079126944807, 3693.0028892199493, 3752.399616061417, 4811.511654050785, 4920.630952678492, 5353.036453438419, 5528.7235638218735, 5702.942970570241, 4713.81144754206, 4809.326694262736, 4995.701977090579, 5102.902875881703, 5822.186467863557, 5324.7220667038855, 5768.865519757716, 5781.4218578141845, 5821.214136091573, 5897.351291358033, 4858.4898585648, 5049.57078648319, 5271.525562699376, 5639.6444115751065, 5658.773649053992, 4618.353430519797, 5079.415867175322, 5546.0, 5559.579410075145, 5746.741396637245, 4693.460252071056, 5655.236543066798, 5658.632188907708, 5664.886702266014, 5705.001624715741], "value": 4052.5344313792443, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.6804963493436, 644.8806970710419, 660.9074729537863, 747.7868807389895, 765.3418060467997, 13235.801462978052, 13831.861681383183, 13857.23785191814, 13886.722265554683, 13890.999999999987, 12938.223706577612, 13103.148295360796, 13116.409761560728, 13116.54092106774, 13127.015473839476, 639.2233436374804, 657.2113463843383, 786.5477350523444, 799.460364254129, 814.9918500815005, 795.2087672765606, 804.1917872538091, 804.8752443371287, 807.2976510435929, 809.1706001348635, 857.6312185760121, 866.3459088388258, 867.5618812499679, 867.6919693508809, 868.4224990381389, 852.4544291653347, 856.6830272799073, 861.4701958295634, 862.5557837713583, 862.9568521573896, 640.3404493371835, 640.7533099756581, 641.3458272562008, 641.425923798198, 641.6054126712086, 13533.0, 13619.18284902909, 13643.931780341134, 13689.0, 13802.309884505734, 13402.46390144393, 13624.727505449935, 13625.386857591433, 13805.378757955916, 13914.234717090556, 11061.778764424747, 11115.333080015143, 11312.660620181408, 11382.0, 11480.0, 3636.327279453283, 3662.230931504387, 3681.079730067483, 3683.465897444882, 3735.1782607826235, 72972.0, 85450.5727471365, 86853.0, 88588.0, 89976.0, 9144.588493517807, 9550.61797528105, 10265.538050787583, 10513.0, 10674.73313167177, 17187.65624687499, 17245.56886077858, 18448.446546603624, 20505.692414613794, 21115.472113197295, 7396.593187374746, 7604.581748003913, 7625.351845093229, 7723.961380193063, 7809.140994490602, 4144.606262405066, 4189.916201675949, 4293.162833247549, 4321.286987647066, 4347.369631403429, 3383.3909896218424, 3445.8277086145595, 3488.0407887831047, 3489.267253876714, 3509.456034314634, 650.5121159130651, 653.1248127509066, 656.389557711333, 658.4205898809113, 671.4896678524259, 626.28603392133, 631.0786252071935, 649.555054787472, 662.211967758366, 680.2245440198178, 8562.48625082497, 8760.693375731818, 8935.329850261256, 9159.267258619295, 9177.541122943827, 581.6626356713181, 614.3242433323309, 627.5669787846463, 651.2998526583847, 671.1308855032744, 3979.5423526294267, 4272.6154646082, 4469.128519938646, 4482.254207417815, 4543.273076307775, 108851.91148088576, 109158.45420772846, 114485.4275728616, 115980.42009789897, 116463.0, 98279.50860245652, 102021.0, 103664.48167759264, 103709.0, 104459.0, 86718.0, 90150.54924725466, 91222.54388728147, 92310.53844730867, 92441.53779231195, 8395.340585974842, 8694.0, 8696.565171741515, 8738.563071846509, 8876.112388761072, 54537.45462545324, 55524.72237638786, 56603.0, 56668.14997775119, 57415.71292143512, 63334.566580338935, 76792.0, 77831.83252251334, 78560.0, 80655.59672201837, 11124.777504449703, 11376.601818936297, 11461.48423320936, 11488.885111148782, 11515.136364772843, 12266.141370104364, 12335.753284934071, 12337.321447320484, 13701.383437745126, 13971.790423143864, 12546.498140074294, 12675.17611355259, 13172.60482185536, 13754.105983111065, 13939.51211707626, 12420.813687794871, 13120.540781073, 13185.0, 13900.51348202808, 13920.51278205258, 12300.023877745998, 12842.614721558368, 13123.0, 13142.671433214246, 13555.525556605471, 10395.94802025985, 11332.206745527734, 11347.33453873494, 11384.829227561428, 11450.82823757661, 8774.166454186841, 10166.440845753554, 10835.349879007284, 11408.94295528517, 11583.305001699924], "value": 7216.845431451981, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1628.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 116.0, 118.0, 121.0, 119.0, 120.0, 120.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 149.0, 149.0, 183.0, 123.0, 115.0, 116.0, 115.0, 156.0, 153.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 196.0, 196.0, 192.0, 192.0, 194.0, 196.0, 195.0, 230.0, 279.0], "value": 206.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 66.0, 85.0, 110.0, 64.0, 60.0, 60.0, 50.0, 100.0, 85.0], "value": 76.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 72.0, 101.0, 102.0, 99.0, 59.0, 102.0, 64.0, 74.0, 117.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 125.0, 89.0, 86.0, 84.0, 122.0, 115.0, 131.0, 115.0, 85.0], "value": 104.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 100.0, 101.0, 108.0, 100.0, 109.0, 99.0, 174.0, 172.0, 169.0], "value": 123.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 76.0, 142.0, 142.0, 89.0, 88.0, 90.0, 98.0, 90.0, 87.0], "value": 99.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 55.0, 58.0, 61.0, 75.0, 88.0, 92.0, 91.0, 75.0], "value": 71.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 102.0, 111.0, 119.0, 88.0, 75.0, 68.0, 68.0, 69.0, 72.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 90.0, 107.0, 106.0, 80.0, 85.0, 85.0, 87.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 152.0, 163.0, 141.0, 162.0, 172.0, 150.0, 176.0, 218.0, 198.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 171.0, 193.0, 224.0, 190.0, 166.0, 170.0, 169.0, 171.0, 169.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 82.0, 76.0, 85.0, 88.0, 63.0, 69.0, 88.0, 87.0, 91.0], "value": 79.7, "unit": "score"}]}]} 11:16:23 INFO - Return code: 0 11:16:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:16:23 ERROR - # TBPL SUCCESS # 11:16:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:16:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:16:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:16:23 INFO - 2016-11-21 11:16:23.367 screenresolution[1656:11003] starting screenresolution argv=screenresolution get 11:16:23 INFO - 2016-11-21 11:16:23.369 screenresolution[1656:11003] Display 0: 1600x1200x32@60 11:16:23 INFO - 2016-11-21 11:16:23.375 screenresolution[1657:11006] starting screenresolution argv=screenresolution list 11:16:23 INFO - Available Modes on Display 0 11:16:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:16:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:16:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:16:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:16:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:16:23 INFO - Intel Iris: 11:16:23 INFO - Chipset Model: Intel Iris 11:16:23 INFO - Type: GPU 11:16:23 INFO - Bus: Built-In 11:16:23 INFO - VRAM (Dynamic, Max): 1536 MB 11:16:23 INFO - Vendor: Intel (0x8086) 11:16:23 INFO - Device ID: 0x0a2e 11:16:23 INFO - Revision ID: 0x0009 11:16:23 INFO - Displays: 11:16:23 INFO - Display: 11:16:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:16:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:16:23 INFO - Display Serial Number: 1600x1200 60 11:16:23 INFO - Main Display: Yes 11:16:23 INFO - Mirror: Off 11:16:23 INFO - Online: Yes 11:16:23 INFO - Rotation: Supported 11:16:23 INFO - Return code: 0 11:16:23 INFO - Running post-action listener: _resource_record_post_action 11:16:23 INFO - [mozharness: 2016-11-21 19:16:23.618670Z] Finished run-tests step (success) 11:16:23 INFO - Running post-run listener: _resource_record_post_run 11:16:23 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37929984; Write bytes: 655696384; Read time: 246; Write time: 1912 11:16:23 INFO - TinderboxPrint: CPU usage
54.3% 11:16:23 INFO - TinderboxPrint: I/O read bytes / time
37,929,984 / 246 11:16:23 INFO - TinderboxPrint: I/O write bytes / time
655,696,384 / 1,912 11:16:23 INFO - TinderboxPrint: CPU idle
2,211.3 (45.7%) 11:16:23 INFO - TinderboxPrint: CPU system
976.6 (20.2%) 11:16:23 INFO - TinderboxPrint: CPU user
1,649.8 (34.1%) 11:16:23 INFO - TinderboxPrint: Swap in / out
390,443,008 / 0 11:16:23 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 352735744; Write bytes: 346425344; Read time: 27816; Write time: 727 11:16:23 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35562496; Write bytes: 299026944; Read time: 223; Write time: 1149 11:16:24 INFO - Running post-run listener: _upload_blobber_files 11:16:24 INFO - Blob upload gear active. 11:16:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:16:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:16:24 INFO - (blobuploader) - INFO - Open directory for files ... 11:16:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:16:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:16:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:25 INFO - (blobuploader) - INFO - Done attempting. 11:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:26 INFO - (blobuploader) - INFO - Done attempting. 11:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:16:29 INFO - (blobuploader) - INFO - Done attempting. 11:16:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:16:29 INFO - Return code: 0 11:16:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:16:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:16:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33508a382a13a9228d5fe9f2cb257607e1276443d25fad706dd40681b39330cbd7dc0066bd03b361e8e600d2853ae311ec8df317ed7ff2ca96a3338abdbcb12f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78216f96810aea4666b491408a54c495cfc870653ec5f6868eb88b0ea6e5b2dc4f37d7178d542dc22961331c33e98ba5ac85d363556106ff138c5a957617b142", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69f318f14883909f109f7b6ee7821f392a08ab7c6473c0857c5e2593849b118d08e605ec7ccc1a8f501418d79a49322a209e353fe730ac5e038ec6c58e8edf6"} 11:16:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:16:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:16:29 INFO - Contents: 11:16:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33508a382a13a9228d5fe9f2cb257607e1276443d25fad706dd40681b39330cbd7dc0066bd03b361e8e600d2853ae311ec8df317ed7ff2ca96a3338abdbcb12f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78216f96810aea4666b491408a54c495cfc870653ec5f6868eb88b0ea6e5b2dc4f37d7178d542dc22961331c33e98ba5ac85d363556106ff138c5a957617b142", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69f318f14883909f109f7b6ee7821f392a08ab7c6473c0857c5e2593849b118d08e605ec7ccc1a8f501418d79a49322a209e353fe730ac5e038ec6c58e8edf6"} 11:16:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:16:29 INFO - Copying logs to upload dir... 11:16:29 INFO - mkdir: /builds/slave/test/build/upload/logs 11:16:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.651414 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-11-21 11:16:29.092609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 11:16:29.096353) ========= 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.i6DOKZPQNR/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.McaGPsTOdG/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33508a382a13a9228d5fe9f2cb257607e1276443d25fad706dd40681b39330cbd7dc0066bd03b361e8e600d2853ae311ec8df317ed7ff2ca96a3338abdbcb12f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78216f96810aea4666b491408a54c495cfc870653ec5f6868eb88b0ea6e5b2dc4f37d7178d542dc22961331c33e98ba5ac85d363556106ff138c5a957617b142", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69f318f14883909f109f7b6ee7821f392a08ab7c6473c0857c5e2593849b118d08e605ec7ccc1a8f501418d79a49322a209e353fe730ac5e038ec6c58e8edf6"} build_url:https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/REZsIkoEQv-D43iqZj1_gg/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33508a382a13a9228d5fe9f2cb257607e1276443d25fad706dd40681b39330cbd7dc0066bd03b361e8e600d2853ae311ec8df317ed7ff2ca96a3338abdbcb12f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/78216f96810aea4666b491408a54c495cfc870653ec5f6868eb88b0ea6e5b2dc4f37d7178d542dc22961331c33e98ba5ac85d363556106ff138c5a957617b142", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a69f318f14883909f109f7b6ee7821f392a08ab7c6473c0857c5e2593849b118d08e605ec7ccc1a8f501418d79a49322a209e353fe730ac5e038ec6c58e8edf6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 11:16:29.130672) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 11:16:29.130998) ========= 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.i6DOKZPQNR/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.McaGPsTOdG/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005496 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 11:16:29.179385) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 11:16:29.179682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 11:16:29.179981) ========= ========= Total master_lag: 0.18 =========