builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0248 starttime: 1486489034.5 results: success (0) buildid: 20170207070657 builduid: f01dde18ba9d4b87ae9ebed4ee04f64f revision: 0af2fd3e36ba3227f78c8e0a42ccb0551c753d03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 09:37:14.502580) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-07 09:37:14.502939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-02-07 09:37:14.503212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-02-07 09:37:17.636749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:37:17.637101) ========= 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.Qq88Imx7H3/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.gFMRLmJptz/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 --2017-02-07 09:37:17-- 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% 157M=0s 2017-02-07 09:37:17 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147423 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:37:18.074221) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-02-07 09:37:18.074574) ========= 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.Qq88Imx7H3/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.gFMRLmJptz/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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.035719 ========= master_lag: 2.92 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2017-02-07 09:37:21.033125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 09:37:21.033508) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0af2fd3e36ba3227f78c8e0a42ccb0551c753d03 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0af2fd3e36ba3227f78c8e0a42ccb0551c753d03 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qq88Imx7H3/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.gFMRLmJptz/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 2017-02-07 09:37:21,154 truncating revision to first 12 chars 2017-02-07 09:37:21,154 Setting DEBUG logging. 2017-02-07 09:37:21,154 attempt 1/10 2017-02-07 09:37:21,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0af2fd3e36ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-07 09:37:22,195 unpacking tar archive at: mozilla-beta-0af2fd3e36ba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.318647 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-07 09:37:22.388739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 09:37:22.389082) ========= script_repo_revision: 0af2fd3e36ba3227f78c8e0a42ccb0551c753d03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-07 09:37:22.389510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 09:37:22.389798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-07 09:37:22.409258) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-07 09:37:22.409660) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qq88Imx7H3/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.gFMRLmJptz/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:37:22 INFO - MultiFileLogger online at 20170207 09:37:22 in /builds/slave/test 09:37:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:37:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:37:22 INFO - {'append_to_log': False, 09:37:22 INFO - 'base_work_dir': '/builds/slave/test', 09:37:22 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:37:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:37:22 INFO - 'branch': 'Mozilla-Beta', 09:37:22 INFO - 'buildbot_json_path': 'buildprops.json', 09:37:22 INFO - 'config_files': ('talos/mac_config.py',), 09:37:22 INFO - 'default_actions': ('clobber', 09:37:22 INFO - 'read-buildbot-config', 09:37:22 INFO - 'download-and-extract', 09:37:22 INFO - 'populate-webroot', 09:37:22 INFO - 'create-virtualenv', 09:37:22 INFO - 'install', 09:37:22 INFO - 'run-tests'), 09:37:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:37:22 INFO - 'download_minidump_stackwalk': True, 09:37:22 INFO - 'download_symbols': 'ondemand', 09:37:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:37:22 INFO - 'tooltool.py': '/tools/tooltool.py', 09:37:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:37:22 INFO - '/tools/misc-python/virtualenv.py')}, 09:37:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:37:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:37:22 INFO - 'installer_path': 'installer.exe', 09:37:22 INFO - 'log_level': 'info', 09:37:22 INFO - 'log_name': 'talos', 09:37:22 INFO - 'log_to_console': True, 09:37:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:37:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:37:22 INFO - 'opt_config_files': (), 09:37:22 INFO - 'pip_index': False, 09:37:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:37:22 INFO - 'cmd': ('bash', 09:37:22 INFO - '-c', 09:37:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:37:22 INFO - 'enabled': True, 09:37:22 INFO - 'halt_on_failure': False, 09:37:22 INFO - 'name': 'check_screen_resolution'},), 09:37:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:37:22 INFO - 'cmd': ('bash', 09:37:22 INFO - '-c', 09:37:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:37:22 INFO - 'enabled': True, 09:37:22 INFO - 'halt_on_failure': False, 09:37:22 INFO - 'name': 'check_screen_resolution'},), 09:37:22 INFO - 'run_cmd_checks_enabled': True, 09:37:22 INFO - 'sps_profile': False, 09:37:22 INFO - 'sps_profile_interval': 0, 09:37:22 INFO - 'suite': 'dromaeojs', 09:37:22 INFO - 'system_bits': '32', 09:37:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:37:22 INFO - 'title': 't-yosemite-r7-0248', 09:37:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:37:22 INFO - 'use_talos_json': True, 09:37:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:37:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:37:22 INFO - 'work_dir': 'build'} 09:37:22 INFO - [mozharness: 2017-02-07 17:37:22.620190Z] Running clobber step. 09:37:22 INFO - Running pre-action listener: _resource_record_pre_action 09:37:22 INFO - Running main action method: clobber 09:37:22 INFO - rmtree: /builds/slave/test/build 09:37:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:37:24 INFO - Running post-action listener: _resource_record_post_action 09:37:24 INFO - [mozharness: 2017-02-07 17:37:24.928199Z] Finished clobber step (success) 09:37:24 INFO - [mozharness: 2017-02-07 17:37:24.928356Z] Running read-buildbot-config step. 09:37:24 INFO - Running pre-action listener: _resource_record_pre_action 09:37:24 INFO - Running main action method: read_buildbot_config 09:37:24 INFO - Using buildbot properties: 09:37:24 INFO - { 09:37:24 INFO - "project": "", 09:37:24 INFO - "product": "firefox", 09:37:24 INFO - "script_repo_revision": "production", 09:37:24 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:37:24 INFO - "repository": "", 09:37:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:37:24 INFO - "buildid": "20170207070657", 09:37:24 INFO - "pgo_build": "False", 09:37:24 INFO - "basedir": "/builds/slave/test", 09:37:24 INFO - "buildnumber": 2, 09:37:24 INFO - "slavename": "t-yosemite-r7-0248", 09:37:24 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:37:24 INFO - "platform": "yosemite_r7", 09:37:24 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:37:24 INFO - "branch": "mozilla-beta", 09:37:24 INFO - "repo_path": "releases/mozilla-beta", 09:37:24 INFO - "revision": "0af2fd3e36ba3227f78c8e0a42ccb0551c753d03", 09:37:24 INFO - "stage_platform": "macosx64", 09:37:24 INFO - "builduid": "f01dde18ba9d4b87ae9ebed4ee04f64f", 09:37:24 INFO - "slavebuilddir": "test" 09:37:24 INFO - } 09:37:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 09:37:24 INFO - Running post-action listener: _resource_record_post_action 09:37:24 INFO - [mozharness: 2017-02-07 17:37:24.931560Z] Finished read-buildbot-config step (success) 09:37:24 INFO - [mozharness: 2017-02-07 17:37:24.931687Z] Running download-and-extract step. 09:37:24 INFO - Running pre-action listener: _resource_record_pre_action 09:37:24 INFO - Running main action method: download_and_extract 09:37:24 INFO - mkdir: /builds/slave/test/build/tests 09:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:24 INFO - trying https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 09:37:24 INFO - Downloading https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:37:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 09:37:26 INFO - Downloaded 1165 bytes. 09:37:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 09:37:26 INFO - Using the following test package requirements: 09:37:26 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:37:26 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:37:26 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 09:37:26 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:37:26 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 09:37:26 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:37:26 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:37:26 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 09:37:26 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 09:37:26 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:37:26 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 09:37:26 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:37:26 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 09:37:26 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:37:26 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 09:37:26 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 09:37:26 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 09:37:26 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 09:37:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:37:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:37:26 INFO - Fetch https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:37:27 INFO - Http code: 200 09:37:27 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 09:37:27 INFO - x-amz-cf-id: KpqyhbT22uHkrJCkIG78o2cjey5Y4mQbqNCrQld6-H6IM1inIfHeTw== 09:37:27 INFO - x-amz-version-id: Y_tL5z8n0z_wW3Ex2X8e35K3S2z4w4Y5 09:37:27 INFO - Expected file size: 16091805 09:37:27 INFO - Obtained file size: 16091805 09:37:34 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:37:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 09:37:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 09:37:34 INFO - Fetch https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 09:37:35 INFO - Http code: 200 09:37:35 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 09:37:35 INFO - x-amz-cf-id: w_vH7bD0uy3eTQE-3aey6MFtzTWsq4SHXjVDlilQvXBxdN1WuWAQZQ== 09:37:35 INFO - x-amz-version-id: Y_tL5z8n0z_wW3Ex2X8e35K3S2z4w4Y5 09:37:35 INFO - Expected file size: 16091805 09:37:35 INFO - Obtained file size: 16091805 09:37:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 09:37:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 09:37:41 INFO - Fetch https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 09:37:43 INFO - Http code: 200 09:37:43 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:37:43 INFO - x-amz-cf-id: UjLXCE2iMhfB-LzUCIcTB4vDtFP0iNNJI_-DtIPW9N3khRNhvE3uZw== 09:37:43 INFO - x-amz-version-id: I88BOxmVUhPv_oKLnEHT3sCkUR8K.tdI 09:37:43 INFO - Expected file size: 14403005 09:37:43 INFO - Obtained file size: 14403005 09:37:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:43 INFO - trying https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:37:43 INFO - Downloading https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 09:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 09:37:46 INFO - Downloaded 82138580 bytes. 09:37:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:37:46 INFO - mkdir: /builds/slave/test/properties 09:37:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:46 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:46 INFO - Contents: 09:37:46 INFO - build_url:https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 09:37:47 INFO - Running post-action listener: _resource_record_post_action 09:37:47 INFO - Running post-action listener: set_extra_try_arguments 09:37:47 INFO - [mozharness: 2017-02-07 17:37:47.649558Z] Finished download-and-extract step (success) 09:37:47 INFO - [mozharness: 2017-02-07 17:37:47.649706Z] Running populate-webroot step. 09:37:47 INFO - Running pre-action listener: _resource_record_pre_action 09:37:47 INFO - Running main action method: populate_webroot 09:37:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:47 INFO - '--tppagecycles', 09:37:47 INFO - '7'], 09:37:47 INFO - 'tests': ['tsvgm']}}, 09:37:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:37:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:37:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:37:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:47 INFO - 'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:47 INFO - 'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['damp', 'tps']}, 09:37:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:47 INFO - 'tests': ['damp', 'tps']}, 09:37:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['dromaeo_dom']}, 09:37:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['basic_compositor_video']}, 09:37:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:37:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['a11yr', 09:37:47 INFO - 'ts_paint', 09:37:47 INFO - 'tpaint', 09:37:47 INFO - 'sessionrestore', 09:37:47 INFO - 'sessionrestore_no_auto_restore', 09:37:47 INFO - 'tabpaint']}, 09:37:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['tsvgx', 09:37:47 INFO - 'tsvgr_opacity', 09:37:47 INFO - 'tart', 09:37:47 INFO - 'tscrollx', 09:37:47 INFO - 'cart']}, 09:37:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:37:47 INFO - 'tsvgr_opacity', 09:37:47 INFO - 'tart', 09:37:47 INFO - 'tscrollx', 09:37:47 INFO - 'cart']}, 09:37:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:47 INFO - 'talos_options': ['--disable-e10s'], 09:37:47 INFO - 'tests': ['tp5o']}, 09:37:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:47 INFO - 'tests': ['tp5o']}, 09:37:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:47 INFO - 'talos_options': ['--disable-e10s', 09:37:47 INFO - '--xperf_path', 09:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:47 INFO - 'tests': ['tp5n']}, 09:37:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:47 INFO - 'talos_options': ['--xperf_path', 09:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:47 INFO - 'tests': ['tp5n']}}, 09:37:47 INFO - 'talos.zip': {'path': '', 09:37:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:47 INFO - Running post-action listener: _resource_record_post_action 09:37:47 INFO - [mozharness: 2017-02-07 17:37:47.668535Z] Finished populate-webroot step (success) 09:37:47 INFO - [mozharness: 2017-02-07 17:37:47.668666Z] Running create-virtualenv step. 09:37:47 INFO - Running pre-action listener: _resource_record_pre_action 09:37:47 INFO - Running main action method: create_virtualenv 09:37:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:47 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 09:37:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:47 INFO - Using real prefix '/tools/python27' 09:37:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:51 INFO - Installing pip.................done. 09:37:51 INFO - Return code: 0 09:37:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:37:51 INFO - Reading from file tmpfile_stdout 09:37:51 INFO - Output received: 09:37:51 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) 09:37:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:37:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:37:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:51 INFO - 'HOME': '/Users/cltbld', 09:37:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:51 INFO - 'LOGNAME': 'cltbld', 09:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:51 INFO - 'MOZ_NO_REMOTE': '1', 09:37:51 INFO - 'NO_EM_RESTART': '1', 09:37:51 INFO - 'PAGER': '/bin/cat', 09:37:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:51 INFO - 'PWD': '/builds/slave/test', 09:37:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:51 INFO - 'SHELL': '/bin/bash', 09:37:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:37:51 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:37:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:51 INFO - 'USER': 'cltbld', 09:37:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:51 INFO - 'XPC_FLAGS': '0x0', 09:37:51 INFO - 'XPC_SERVICE_NAME': '0', 09:37:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:51 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 09:37:51 INFO - Cleaning up... 09:37:51 INFO - Return code: 0 09:37:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:37:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:37:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:51 INFO - 'HOME': '/Users/cltbld', 09:37:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:51 INFO - 'LOGNAME': 'cltbld', 09:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:51 INFO - 'MOZ_NO_REMOTE': '1', 09:37:51 INFO - 'NO_EM_RESTART': '1', 09:37:51 INFO - 'PAGER': '/bin/cat', 09:37:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:51 INFO - 'PWD': '/builds/slave/test', 09:37:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:51 INFO - 'SHELL': '/bin/bash', 09:37:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:37:51 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:37:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:51 INFO - 'USER': 'cltbld', 09:37:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:51 INFO - 'XPC_FLAGS': '0x0', 09:37:51 INFO - 'XPC_SERVICE_NAME': '0', 09:37:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:52 INFO - Downloading/unpacking psutil>=3.1.1 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:52 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 09:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:55 INFO - Installing collected packages: psutil 09:37:55 INFO - Running setup.py install for psutil 09:37:55 INFO - building 'psutil._psutil_osx' extension 09:37:55 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 09:37:56 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 09:37:56 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 09:37:56 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 09:37:56 INFO - building 'psutil._psutil_posix' extension 09:37:56 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 09:37:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:37:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:37:56 INFO - ^ 09:37:56 INFO - 1 warning generated. 09:37:56 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 09:37:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:56 INFO - Successfully installed psutil 09:37:56 INFO - Cleaning up... 09:37:56 INFO - Return code: 0 09:37:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:37: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 mozsystemmonitor==0.3 09:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:56 INFO - 'HOME': '/Users/cltbld', 09:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:56 INFO - 'LOGNAME': 'cltbld', 09:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:56 INFO - 'MOZ_NO_REMOTE': '1', 09:37:56 INFO - 'NO_EM_RESTART': '1', 09:37:56 INFO - 'PAGER': '/bin/cat', 09:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:56 INFO - 'PWD': '/builds/slave/test', 09:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:56 INFO - 'SHELL': '/bin/bash', 09:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:37:56 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:56 INFO - 'USER': 'cltbld', 09:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:56 INFO - 'XPC_FLAGS': '0x0', 09:37:56 INFO - 'XPC_SERVICE_NAME': '0', 09:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37: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 09:37:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:37:59 INFO - Installing collected packages: mozsystemmonitor 09:37:59 INFO - Running setup.py install for mozsystemmonitor 09:37:59 INFO - Successfully installed mozsystemmonitor 09:37:59 INFO - Cleaning up... 09:37:59 INFO - Return code: 0 09:37:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:59 INFO - 'HOME': '/Users/cltbld', 09:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:59 INFO - 'LOGNAME': 'cltbld', 09:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:59 INFO - 'MOZ_NO_REMOTE': '1', 09:37:59 INFO - 'NO_EM_RESTART': '1', 09:37:59 INFO - 'PAGER': '/bin/cat', 09:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:59 INFO - 'PWD': '/builds/slave/test', 09:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:59 INFO - 'SHELL': '/bin/bash', 09:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:37:59 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:59 INFO - 'USER': 'cltbld', 09:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:59 INFO - 'XPC_FLAGS': '0x0', 09:37:59 INFO - 'XPC_SERVICE_NAME': '0', 09:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:38:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:02 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 09:38:03 INFO - Downloading functools32-3.2.3-2.tar.gz 09:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:38:03 INFO - warning: no files found matching '*.txt' 09:38:03 INFO - no previously-included directories found matching 'build' 09:38:03 INFO - no previously-included directories found matching 'dist' 09:38:03 INFO - no previously-included directories found matching '.git*' 09:38:03 INFO - Installing collected packages: jsonschema, functools32 09:38:03 INFO - Running setup.py install for functools32 09:38:03 INFO - warning: no files found matching '*.txt' 09:38:03 INFO - no previously-included directories found matching 'build' 09:38:03 INFO - no previously-included directories found matching 'dist' 09:38:03 INFO - no previously-included directories found matching '.git*' 09:38:03 INFO - Successfully installed jsonschema functools32 09:38:03 INFO - Cleaning up... 09:38:03 INFO - Return code: 0 09:38:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:03 INFO - 'HOME': '/Users/cltbld', 09:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:03 INFO - 'LOGNAME': 'cltbld', 09:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:03 INFO - 'MOZ_NO_REMOTE': '1', 09:38:03 INFO - 'NO_EM_RESTART': '1', 09:38:03 INFO - 'PAGER': '/bin/cat', 09:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:03 INFO - 'PWD': '/builds/slave/test', 09:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:03 INFO - 'SHELL': '/bin/bash', 09:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:38:03 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:03 INFO - 'USER': 'cltbld', 09:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:03 INFO - 'XPC_FLAGS': '0x0', 09:38:03 INFO - 'XPC_SERVICE_NAME': '0', 09:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:38:03 INFO - Cleaning up... 09:38:04 INFO - Return code: 0 09:38:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:04 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 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:38:04 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 09:38:04 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 09:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:04 INFO - 'HOME': '/Users/cltbld', 09:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:04 INFO - 'LOGNAME': 'cltbld', 09:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:04 INFO - 'MOZ_NO_REMOTE': '1', 09:38:04 INFO - 'NO_EM_RESTART': '1', 09:38:04 INFO - 'PAGER': '/bin/cat', 09:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:04 INFO - 'PWD': '/builds/slave/test', 09:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:04 INFO - 'SHELL': '/bin/bash', 09:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:38:04 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:04 INFO - 'USER': 'cltbld', 09:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:04 INFO - 'XPC_FLAGS': '0x0', 09:38:04 INFO - 'XPC_SERVICE_NAME': '0', 09:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:04 INFO - Downloading/unpacking blobuploader==1.2.4 09:38:04 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 09:38:04 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 09:38:04 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 09:38:04 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 09:38:04 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 09:38:04 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 09:38:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:38:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38: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 09:38:09 INFO - Downloading docopt-0.6.1.tar.gz 09:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:38:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:38:09 INFO - Running setup.py install for blobuploader 09:38:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:38:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:38:09 INFO - Running setup.py install for requests 09:38:09 INFO - Running setup.py install for docopt 09:38:10 INFO - Successfully installed blobuploader requests docopt 09:38:10 INFO - Cleaning up... 09:38:10 INFO - Return code: 0 09:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:10 INFO - 'HOME': '/Users/cltbld', 09:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:10 INFO - 'LOGNAME': 'cltbld', 09:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:10 INFO - 'MOZ_NO_REMOTE': '1', 09:38:10 INFO - 'NO_EM_RESTART': '1', 09:38:10 INFO - 'PAGER': '/bin/cat', 09:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:10 INFO - 'PWD': '/builds/slave/test', 09:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:10 INFO - 'SHELL': '/bin/bash', 09:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:38:10 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:10 INFO - 'USER': 'cltbld', 09:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:10 INFO - 'XPC_FLAGS': '0x0', 09:38:10 INFO - 'XPC_SERVICE_NAME': '0', 09:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:11 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-ITwWW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:11 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-MThMrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:11 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-VQT7IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:11 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-8t38vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:11 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-FSX8Ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:11 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-TqdIls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:11 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-u_webW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:11 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-BHpHru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-dphd3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-FX9jFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-bjvM64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-dZsKcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-17hW2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-6s0326-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-CcxrUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-ky_04x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:12 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-UjcR2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:38:13 INFO - Running setup.py install for manifestparser 09:38:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Running setup.py install for mozcrash 09:38:13 INFO - Running setup.py install for mozdebug 09:38:13 INFO - Running setup.py install for mozdevice 09:38:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Running setup.py install for mozfile 09:38:13 INFO - Running setup.py install for mozhttpd 09:38:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:38:13 INFO - Running setup.py install for mozinfo 09:38:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for mozInstall 09:38:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for mozleak 09:38:14 INFO - Running setup.py install for mozlog 09:38:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for moznetwork 09:38:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for mozprocess 09:38:14 INFO - Running setup.py install for mozprofile 09:38:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:38:14 INFO - Running setup.py install for mozrunner 09:38:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:38:15 INFO - Running setup.py install for mozscreenshot 09:38:15 INFO - Running setup.py install for moztest 09:38:15 INFO - Running setup.py install for mozversion 09:38:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:38:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:38:15 INFO - Cleaning up... 09:38:15 INFO - Return code: 0 09:38:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:38:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:38:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:38:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:15 INFO - 'HOME': '/Users/cltbld', 09:38:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:15 INFO - 'LOGNAME': 'cltbld', 09:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:15 INFO - 'MOZ_NO_REMOTE': '1', 09:38:15 INFO - 'NO_EM_RESTART': '1', 09:38:15 INFO - 'PAGER': '/bin/cat', 09:38:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:15 INFO - 'PWD': '/builds/slave/test', 09:38:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:15 INFO - 'SHELL': '/bin/bash', 09:38:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:38:15 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:38:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:15 INFO - 'USER': 'cltbld', 09:38:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:15 INFO - 'XPC_FLAGS': '0x0', 09:38:15 INFO - 'XPC_SERVICE_NAME': '0', 09:38:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:16 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-3btt13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:16 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)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:16 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-9B_uPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:16 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)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:16 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-y1cjXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:16 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-7LjGOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:16 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-tbm_f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:16 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-FhUcTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:16 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-xnLivC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:38:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:16 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-hPkFUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-kGXQRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-Pb5BoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-hRWO2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-FMVqRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-g6EoAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-pyLfXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:17 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-2L9KmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-7mZ2lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:38:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:17 INFO - Running setup.py (path:/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/pip-hREvby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:18 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)) 09:38:18 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)) 09:38:18 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)) 09:38:18 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)) 09:38:18 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)) 09:38:18 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)) 09:38:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:21 INFO - Downloading blessings-1.6.tar.gz 09:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:38:21 INFO - Installing collected packages: blessings 09:38:21 INFO - Running setup.py install for blessings 09:38:21 INFO - Successfully installed blessings 09:38:21 INFO - Cleaning up... 09:38:21 INFO - Return code: 0 09:38:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:38:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:21 INFO - Reading from file tmpfile_stdout 09:38:21 INFO - Current package versions: 09:38:21 INFO - blessings == 1.6 09:38:21 INFO - blobuploader == 1.2.4 09:38:21 INFO - docopt == 0.6.1 09:38:21 INFO - functools32 == 3.2.3-2 09:38:21 INFO - jsonschema == 2.5.1 09:38:21 INFO - manifestparser == 1.1 09:38:21 INFO - mozInstall == 1.12 09:38:21 INFO - mozcrash == 1.0 09:38:21 INFO - mozdebug == 0.1 09:38:21 INFO - mozdevice == 0.48 09:38:21 INFO - mozfile == 1.2 09:38:21 INFO - mozhttpd == 0.7 09:38:21 INFO - mozinfo == 0.9 09:38:21 INFO - mozleak == 0.1 09:38:21 INFO - mozlog == 3.4 09:38:21 INFO - moznetwork == 0.27 09:38:21 INFO - mozprocess == 0.23 09:38:21 INFO - mozprofile == 0.28 09:38:21 INFO - mozrunner == 6.13 09:38:21 INFO - mozscreenshot == 0.1 09:38:21 INFO - mozsystemmonitor == 0.3 09:38:21 INFO - moztest == 0.8 09:38:21 INFO - mozversion == 1.4 09:38:21 INFO - psutil == 3.1.1 09:38:21 INFO - requests == 1.2.3 09:38:21 INFO - wsgiref == 0.1.2 09:38:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:21 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 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:38:21 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 09:38:21 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 09:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:21 INFO - 'HOME': '/Users/cltbld', 09:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:21 INFO - 'LOGNAME': 'cltbld', 09:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:21 INFO - 'MOZ_NO_REMOTE': '1', 09:38:21 INFO - 'NO_EM_RESTART': '1', 09:38:21 INFO - 'PAGER': '/bin/cat', 09:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:21 INFO - 'PWD': '/builds/slave/test', 09:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:21 INFO - 'SHELL': '/bin/bash', 09:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:38:21 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:21 INFO - 'USER': 'cltbld', 09:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:21 INFO - 'XPC_FLAGS': '0x0', 09:38:21 INFO - 'XPC_SERVICE_NAME': '0', 09:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 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)) 09:38:22 INFO - Cleaning up... 09:38:22 INFO - Return code: 0 09:38:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:22 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 0x108ddc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d52570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855fbf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, '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.Qq88Imx7H3/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.gFMRLmJptz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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 09:38:22 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 09:38:22 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 09:38:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:38:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:22 INFO - 'HOME': '/Users/cltbld', 09:38:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:22 INFO - 'LOGNAME': 'cltbld', 09:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:22 INFO - 'MOZ_NO_REMOTE': '1', 09:38:22 INFO - 'NO_EM_RESTART': '1', 09:38:22 INFO - 'PAGER': '/bin/cat', 09:38:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:22 INFO - 'PWD': '/builds/slave/test', 09:38:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:22 INFO - 'SHELL': '/bin/bash', 09:38:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:38:22 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:38:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:22 INFO - 'USER': 'cltbld', 09:38:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:22 INFO - 'XPC_FLAGS': '0x0', 09:38:22 INFO - 'XPC_SERVICE_NAME': '0', 09:38:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:38:22 INFO - Cleaning up... 09:38:22 INFO - Return code: 0 09:38:22 INFO - Running post-action listener: _resource_record_post_action 09:38:22 INFO - Running post-action listener: _start_resource_monitoring 09:38:22 INFO - Starting resource monitoring. 09:38:22 INFO - [mozharness: 2017-02-07 17:38:22.320295Z] Finished create-virtualenv step (success) 09:38:22 INFO - [mozharness: 2017-02-07 17:38:22.321299Z] Running install step. 09:38:22 INFO - Running pre-action listener: _resource_record_pre_action 09:38:22 INFO - Running main action method: install 09:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:22 INFO - Reading from file tmpfile_stdout 09:38:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:38:22 INFO - Reading from file tmpfile_stdout 09:38:22 INFO - Output received: 09:38:22 INFO - Usage: mozinstall [options] installer 09:38:22 INFO - Options: 09:38:22 INFO - -h, --help show this help message and exit 09:38:22 INFO - -d DEST, --destination=DEST 09:38:22 INFO - Directory to install application into. [default: 09:38:22 INFO - "/builds/slave/test"] 09:38:22 INFO - --app=APP Application being installed. [default: firefox] 09:38:22 INFO - mkdir: /builds/slave/test/build/application 09:38:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:38:44 INFO - Reading from file tmpfile_stdout 09:38:44 INFO - Output received: 09:38:44 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:38:44 INFO - Running post-action listener: _resource_record_post_action 09:38:44 INFO - [mozharness: 2017-02-07 17:38:44.174035Z] Finished install step (success) 09:38:44 INFO - [mozharness: 2017-02-07 17:38:44.174168Z] Running run-tests step. 09:38:44 INFO - Running pre-action listener: _resource_record_pre_action 09:38:44 INFO - Running main action method: run_tests 09:38:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:38:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:38:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:38:44 INFO - 2017-02-07 09:38:44.188 screenresolution[1625:7369] starting screenresolution argv=screenresolution get 09:38:44 INFO - 2017-02-07 09:38:44.191 screenresolution[1625:7369] Display 0: 1600x1200x32@60 09:38:44 INFO - 2017-02-07 09:38:44.197 screenresolution[1626:7371] starting screenresolution argv=screenresolution list 09:38:44 INFO - Available Modes on Display 0 09:38:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:38:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:38:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:38:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:38:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:38:44 INFO - Intel Iris: 09:38:44 INFO - Chipset Model: Intel Iris 09:38:44 INFO - Type: GPU 09:38:44 INFO - Bus: Built-In 09:38:44 INFO - VRAM (Dynamic, Max): 1536 MB 09:38:44 INFO - Vendor: Intel (0x8086) 09:38:44 INFO - Device ID: 0x0a2e 09:38:44 INFO - Revision ID: 0x0009 09:38:44 INFO - Displays: 09:38:44 INFO - Display: 09:38:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:38:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:38:44 INFO - Display Serial Number: 1600x1200 60 09:38:44 INFO - Main Display: Yes 09:38:44 INFO - Mirror: Off 09:38:44 INFO - Online: Yes 09:38:44 INFO - Rotation: Supported 09:38:44 INFO - Return code: 0 09:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:38:44 INFO - Python 2.7.3 09:38:44 INFO - Return code: 0 09:38:44 INFO - grabbing minidump binary from tooltool 09:38: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')]} 09:38:44 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 0x108bf0d30>, '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 0x108a56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108be8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:38:44 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 09:38:44 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 09:38:44 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 09:38:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:38:44 INFO - Return code: 0 09:38:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:38:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:38:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:38:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:38:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0248', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0248 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:38:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qq88Imx7H3/Render', 09:38:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:38:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:38:44 INFO - 'HOME': '/Users/cltbld', 09:38:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:38:44 INFO - 'LOGNAME': 'cltbld', 09:38:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:38:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:44 INFO - 'MOZ_NO_REMOTE': '1', 09:38:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:38:44 INFO - 'NO_EM_RESTART': '1', 09:38:44 INFO - 'PAGER': '/bin/cat', 09:38:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:44 INFO - 'PWD': '/builds/slave/test', 09:38:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:38:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:38:44 INFO - 'SHELL': '/bin/bash', 09:38:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gFMRLmJptz/Listeners', 09:38:44 INFO - 'TMPDIR': '/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/', 09:38:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:38:44 INFO - 'USER': 'cltbld', 09:38:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:38:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:44 INFO - 'XPC_FLAGS': '0x0', 09:38:44 INFO - 'XPC_SERVICE_NAME': '0', 09:38:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:38:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0248', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:38:44 INFO - mozversion application_buildid: 20170207070657 09:38:44 INFO - mozversion application_changeset: 0af2fd3e36ba3227f78c8e0a42ccb0551c753d03 09:38:44 INFO - mozversion application_display_name: Firefox 09:38:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:38:44 INFO - mozversion application_name: Firefox 09:38:44 INFO - mozversion application_remotingname: firefox 09:38:44 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:38:44 INFO - mozversion application_vendor: Mozilla 09:38:44 INFO - mozversion application_version: 52.0 09:38:44 INFO - mozversion platform_buildid: 20170207070657 09:38:44 INFO - mozversion platform_changeset: 0af2fd3e36ba3227f78c8e0a42ccb0551c753d03 09:38:44 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:38:44 INFO - mozversion platform_version: 52.0 09:38:44 INFO - using testdate: 1486489124 09:38:44 INFO - actual date: 1486489124 09:38:44 INFO - starting webserver on 'localhost:49241' 09:38:44 INFO - SUITE-START | Running 2 tests 09:38:44 INFO - TEST-START | dromaeo_css 09:38:44 INFO - operating with platform_type : mac_ 09:38:44 INFO - Initialising browser for dromaeo_css test... 09:38:44 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmpHtJJ1K/profile http://localhost:49241/getInfo.html) 09:38:47 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 09:38:47 INFO - PROCESS | 1636 | colorDepth:24 09:38:47 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 09:38:47 INFO - PROCESS | 1636 | __metrics 09:38:47 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:38:47 INFO - PROCESS | 1636 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:48 INFO - TEST-INFO | 1636: exit 0 09:38:48 INFO - Browser initialized. 09:38:48 INFO - Running cycle 1/1 for dromaeo_css test... 09:38:48 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmpHtJJ1K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:00 INFO - PROCESS | 1640 | RSS: Main: 167624704 09:39:00 INFO - PROCESS | 1640 | 09:42:04 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:42:06 INFO - PROCESS | 1640 | RSS: Main: 301109248 09:42:06 INFO - PROCESS | 1640 | 09:45:08 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:45:09 INFO - PROCESS | 1640 | RSS: Main: 297627648 09:45:09 INFO - PROCESS | 1640 | 09:48:11 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:48:12 INFO - PROCESS | 1640 | RSS: Main: 274112512 09:48:12 INFO - PROCESS | 1640 | 09:51:14 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:51:15 INFO - PROCESS | 1640 | RSS: Main: 265023488 09:51:15 INFO - PROCESS | 1640 | 09:54:18 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:54:19 INFO - PROCESS | 1640 | RSS: Main: 258232320 09:54:19 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:57:22 INFO - PROCESS | 1640 | RSS: Main: 322875392 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | __start_tp_report 09:57:22 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 09:57:22 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 09:57:22 INFO - PROCESS | 1640 | |i|pagename|runs| 09:57:22 INFO - PROCESS | 1640 | |0;dojo.html;3496.807675577843;3515.753897227195;3523.982380088099;3534.911627209321;3576.4098923677593;5138.332016837815;5759.790444006759;5894.58737888348;5896.115582662603;5944.167816505687;4974.527419895113;5322.201669749539;5892.941070589292;5937.762489500415;5963.791267305645;5336.092864213093;5367.194920761878;5373.194020896858;5416.350037995446;5427.48438898304;5303.7082960437165;5316.601254905898;5348.3849357323825;5453.536449401806;5461.508464238218;5342.866428339303;5378.220158077076;5411.080116380205;5411.215373770801;5426.647267927592;5365.034293827129;5380.112281473552;5395.78416863325;5400.945990540084;5435.755391007375;5281.457946166294;5370.43610420904;5384.623076384654;5385.488378604026;5419.187121931703;5752.309722833287;5792.275965504312;5797.333306669702;5970.432808883149;5972.104184372379;6221.813345599594;6240.188775459162;6265.843353916143;6294.3705629437145;6295.811125666238;6216.160818289563;6251.812445626593;6258.655773932432;6261.499080073583;6282.905756413657;5825.854353641108;5922.082077278029;5984.880302393928;5986.6707331097205;6001.669908155006;6300.716467758962;6318.810435686844;6330.461910737639;6400.519961002943;6422.293547709748;6294.937050629526;6296.716647750863;6301.905471417932;6302.70794487129;6308.936910630927;6264.655443950535;6267.059941008794;6276.340984196685;6297.27581328144;6319;6245.781397651061;6271.4669253114;6294.181756371642;6315.336889626615;6320.5891617044745;6222.439980401786;6303.2751233607805;6306.873862522724;6313.179286692701;6336.144620476269;4980.77586508608;5022.901600370803;5086.567641750418;5094.4141423736;5137.152369859006;4516.096780643885;4552.271636538138;4571;4581.725096494221;4588.931166032512;5451.591130665137;5675.886482270332;5935.6735379553675;6033.42682445167;6040.395960403925;6012.368701286389;6273.9372606273355;6278.372162783685;6286.245650521967;6307.306196318401;5943.435373639584;5968.641881487125;5998.490128339053;6015.127806468037;6058.848528786815;5468.890622187534;5534.916976245279;5544.390117087117;5602.327720673546;5603.719814009283;6573.605583664899;6582.407583317525;6586.308437614173;6591.406773390418;6596.901046484402;6188.690565471618;6332.11350410952;6335.968320158369;6338.651374174465;6351.841203969938;5193.428722840409;6293.276273228637;6358.618482891041;6380.074889141141;6448.516361272829;6194.876102477835;6228.128062071223;6263.279722831932;6277.15258440123;6279.246490421178;6227.813165605039;6229.3770622937345;6235.189425374672;6235.282942461675;6249.7187626557825;6033.276006879027;6198.535109866688;6201.844953876189;6257.68711564429;6291.591046581958;6107.572469927062;6119.015143218386;6202.069689546423;6211.565190436626;6230;6113.849934583468;6118.527810132562;6137.997532011396;6145.002874065857;6163.106349579376;5829.2421985143355;6253.280872699698;6256.249250090018;6303.558750887394;6305.274893387319;5988.161657368059;6029.125776762257;6102.0541816018585;6157.1072194532435;6162.630242185483 09:57:22 INFO - PROCESS | 1640 | |1;ext.html;489.90446862861756;518.6032684995979;524.884620182113;526.4261954469629;539.430900400078;30586.84706576467;33353.83323083384;41227.381589276185;42216.57783422165;42218.57781422185;43648.56351436485;44142;44201;44204.77897610515;44218.33672494915;9648.662296819613;9762.9511852441;9820;9832.360896541737;9843.753906152368;9576.712698619018;9680.322377433582;9692.46691431971;9702.417854928726;9705.175060119898;9611.711648650517;9625.181859541912;9676.467794271312;9725.27060470464;9748.902510974905;9607.66373176939;9641.855372169422;9647.807043859118;9656.806863862683;9670.806583868354;9657.565409556586;9679.612815487371;9709.271804614682;9752;9764.462954537497;37775.055623609354;38225.61774382276;39610.80194599037;39885;41817;3203.583534140547;3247.723943464808;3354.4632858742484;3400.7449441292;3449.9655003449893;30179.547306790417;30360.216894127527;30404.8479757602;30927.690723092706;31928.361432771446;3267.77125601208;3287.260366417561;3290.901272961791;3299.2741596848655;3308.106811160997;513652;513792;515938;516023;516049;59439;59758;59836.40163598395;59893;59900.400995990356;35024;35827.28345433077;64223;64501;64556.35443645597;16516.42192523256;17082.743758843626;17099.059551724775;17111.486655400357;17113.401030963858;12974;13073.15024523403;13090.541831035867;13107.14803537767;13114.01644876638;19217.231310747415;19303.034848257532;19312.227510899407;19325.710114348298;19367.51581210481;6387.329330420332;6621.801345959629;7648.158702542716;7695.846083078307;7732.265434783799;901.9368644194843;969.3892847506027;977.3256453047375;1048.6801525534786;1068.9144868410508;29873.850630746707;29971.550426743615;30372.088837334915;30667.539986900214;30801;925.1812146250483;944.5702205496483;1051.8842927277992;1107.4850194659523;1142.5429828068673;12249.510019599116;13131.474741010252;15605.297761600756;15758.765472490484;15784.763228551581;696085;702132;702471;702716;703062;45440.77279613581;59070.70464647735;59548.70225648844;59689.40310596925;59816;1288.8968882489378;1371.7256548690302;1384.9861501384858;1422.7012327411153;1423.3168079321777;30000.049619665024;31479.84260078685;31504;31921.361572768878;32245.51631725573;50407.24389134239;50854.491455086456;50961.490385095676;50977;51220;555047;558897;649228;668619;759352;25713.742862571882;26533.204003879913;26577.867110665098;26588.734112658625;26691.33271668146;44364.77817610891;45303.77348113238;45703.542964569926;46748.59754207379;47036.52963470321;37070.62929370672;37140.88577342684;37624;37943.24113517659;39122.413163802;37662.435063473524;37795.62204378031;38012;38851.61148388593;38866.805665971486;37822.43266350952;37875.431868521446;38191.04522386962;38311.04222394351;38370.2325953485;31481.268530231057;31771.205719856265;32980.67019329776;33092.1726956828;33294.00117996464;25349.112781052576;25593.872030639726;25599.744002559735;25669.785031846688;25995.480090398465 09:57:22 INFO - PROCESS | 1640 | |2;jquery.html;357.0805176670074;368.76030580122915;384.1816929939231;398.20955403524016;401.25166564357465;19349.226030958762;20088.799112008914;20388.69416958743;20633.38099857007;20739.377818665445;19767;19832;20404.775713457202;20987.790122098773;21307.25424610139;4895.804167833282;5710.5717071219615;5871.55963302754;5924.851878703023;5972.611780234292;5768.769249230026;5864.794732184374;5867.823965281048;5869.706514674271;5883.441073098049;5610.747516361774;5830.737616807254;5832.329282132567;5853.356130825606;5874.618149820248;5573.247611572427;5793.913091303634;5840.766369345221;5858.062709966406;5870.530357571384;4571.451425828922;5059.7097740076415;5068.341115654978;5128.179491281415;5131.1277082895995;22602;25064.621445820474;25843.966241350325;25951.480970380486;25954.22137335883;2128.329576183513;2229.442639340165;2393.222202784085;2397.0771253067696;3052.2064263291704;9922.255830812646;10301.433421161833;10574.995375439321;10583.73540661482;10664.253502254845;1819.6087841114092;1900.7719073711105;1944.5235917200378;1971.428285797117;1981.1382048808814;109621.45189274082;128308.07537886845;128820;134978;135706;11319.830202546967;11435.656930292105;11745.647630571097;11797.76404471923;11964.222325548812;15182.620434489227;15199.392024319124;15216.391344346324;15217.467388641566;15224.020877285882;7541.660625271876;8006.239407256301;8595.914040859636;8726.214640682241;8777.648894044167;7273.63631818407;7706.537607743553;7732.497387669783;8437.77652240434;8496.745097647081;4528.0943811237885;4561.448593512144;4601.700889442175;4666;4680.555347242007;1680.983190168107;1902.3056584346891;1949.3664559018375;1960.5588742532816;1984.454275074366;874.3442418186361;899.7705585075764;964.1081999150757;969.3117886300664;1006.1749365520203;19883.60232795336;21611.891940540198;21620.486565940548;21689;21712.295617724776;931.2689538712078;940.5955439161089;954.7899462118323;958.6818125078017;968.5786682793008;10182.338148020355;11223.943880280547;11229.606963756229;11231.438428078563;11256.774864502664;511214;515609;517226;584498;586995;101738.74142558814;104537;106184;146741;156623;1015.3806178231273;1056.9735756606146;1057.7567159553346;1062.198040479433;1066.1257768629648;18379.356722514647;19279.4216173515;19754.70367944511;19835.30576429818;19934.30229941945;47199;55530.16704749513;57677.71161144167;57806.71096644658;58595.414045859;81793.59103204445;81818.77271841046;83590.16409836068;83908.58045709733;93289;7321.377682897013;7504.474686772092;7591;7935.365170786208;8438.451500652438;9322.673706420514;12701.36493175356;13317.934565234564;13702.862971370558;13794.93102534481;11406.030487408663;11539.4807233673;11576.768464630828;11684.415779210836;11791.882081179421;11295.435228238392;11448.713782155513;11662.650120496399;11848.229865058744;11922.701932451759;9784.755381115245;10750.784984300113;11491.253068550517;11536.711582210512;11855.99224065964;7806.180351063056;12124.908758211803;12131.878681213428;12355.567555135887;12770;11549.78727233662;11571;11677.76644467089;12027;12172.39138043112 09:57:22 INFO - PROCESS | 1640 | |3;mootools.html;1501.7146742118996;1528.0144306922036;1718.1323431667006;1829.1860122245605;1895.5545446820004;7575.507592006516;8249.670013199464;8714.564271786401;8731.607077681503;8738.432001919879;7600.77197684069;7840.490368126068;8278.337732981363;8501.319894408432;8507.617157227924;2369.3010561884284;2399.676043734091;2400.7359190489033;2406.2300063979533;2414.1309128713738;2381.023780250098;2418.613021916494;2423.3578101803037;2425.8059355251626;2428.1865575032384;2376.394019525019;2396.95206095878;2399.1286796298914;2404.603240465321;2409.180878501318;2156.277646988261;2265.048679554591;2352.882355882199;2376.869272190029;2380.7262164851004;2200.2409168836725;2252.5720113178445;2362.70466191726;2397.0891061396733;2398.1726304424947;8536.359773017048;8551.444156129832;8630.439021463584;8635.43869648477;8644.092370301154;5030.622703297267;5198.350206224222;5209.583233341324;5218.634695571312;5252.028374750684;3489.616142224353;3575.588807287143;3575.982120089409;3608.891733248007;3633.454981752732;967.8644989701377;1055.3931489393553;1065.536491626145;1069.6844430892904;1069.9251052426334;11218.102551795837;11312.660620181408;11328.263662861887;11342.71643208918;11347.035501982342;4599.793009314589;4670.1126785910565;4763.023580166057;4763.476017638057;4817.771468275568;9744.464054477072;9752.756181095529;9755.170810481188;9763;9786.706398808046;5326.121190003683;5335.039692855324;5336;5338.172583249602;5351.411344752074;4169.624733773914;4425.734455932655;4427.933580996288;4906.165951788204;4936.160852655057;3845.8461661533224;3912.491376121086;3948.2498325318097;3979.263836190314;3990.7206495545033;1273.121546133165;1273.6943133647858;1281.7628738683372;1287.587971849018;1293.6313150752178;760.7983884270673;817.435969181263;822.9753107406667;839.4082172068677;839.699569752996;4508.323751437245;4933.28467372229;5472.671639701631;5485.890282194334;5639.069553523623;898.9910100898908;937.3579098317674;942.2509105261333;944.1125342178331;1001.9949900250598;3606.2607165531003;3643.3441980443777;3691.7231207659534;3794.905127371838;3818.9427158592644;9885.604575816888;10271.229657775697;10324.070833624859;10328.793424131625;10359.94820025895;10213;10226.744331391626;10229.693109206735;10231.641892533726;10261.486925653688;7748.573828439377;8061.355091592659;8072.959635201903;8158.714444994515;8160.67357305713;4849.56353928134;5603.859903502445;5687.630304030225;5764.711764411679;5812.360640329476;9022.954885225532;9496.47769372691;9537.23702103844;9602.08780165883;9669.564869580745;9641.180499657326;9724.9027509724;9746.31775775689;9839.508024598885;9893.109620134222;6167.259928808572;6558.606483610999;6675.399214070757;7264.091988501437;7427.7771666850085;7088.326608972139;7922.049354077548;8197.79505512367;8213.753587392388;8223.05434874997;7112.324329188718;7152.356287934111;7207.387372073433;7217.350438460564;7461.626918654154;7011.929880701332;7091.858162836817;7116.395106416013;7134.072570565793;7256.96371518139;6644.302348253557;6663.666816659244;6723.294054124247;6724.293949135466;6735.865282694221;4688.179568575418;4702.247640377524;4738.881527961828;4795.760211989456;4800.3279540863605;4264.850730224427;4315.136972605429;4449.265871131227;4476.79854406559;4561.7262964222255 09:57:22 INFO - PROCESS | 1640 | |4;prototype.html;313.28258288519294;313.8838629707008;314.3665513989311;317.8855611979687;323.256510026938;4320.351947207921;5181.9740901295445;5323.9467605323935;5387.488188622085;5428.131498960162;4803.759812009403;5016.842757614234;5352.992627764588;5375.790447149389;5398.273871694789;3252.609686837583;3936.5276166859944;4075.4498142750645;4102.810185046333;4128.710990230685;3537.00963730156;3905.2775236581183;4123.670106391496;4132.214879172962;4147.6889233307475;4041.888480667825;4047.219223541647;4054.351303791394;4079.2657321682086;4087;3606.2967721294226;3685.1892583631557;3907.609239076098;4075.8369665213354;4128.422020917044;3024.8185108893317;3602.963970360289;3603.7567039371374;3614.5903097791884;3615.692666123383;5214.348206474191;5228.137357336035;5235.32469609725;5249.947500525022;5265.631405801595;4107.712460127792;4469.955300447019;4492.505824359318;4577.9771101144615;4655.25515917455;5188.792448302063;5549;5602.907433050556;5625.971870140623;5700.543956483471;3479.3215323012023;4014.016565941363;4026.255142798592;4041.413994970713;4046.9595304046875;5305.469453054702;5938;5994;6015.518758499309;6048.731725602855;4055.229506393776;4072.841394061152;4077.225327187825;4082.4692789937117;4088.100617864065;3864.671502922227;4152.356384760306;4152.896177595524;4176.932418452885;4178.680832138131;4246.9594949237635;4748.62011039123;4772.76136193189;4799.280107983761;4820.396985627792;5147.022065807485;5151.665141765849;5159.458256883048;5433.239346491494;5691.77232910679;1333.379978310071;1343.9785762820327;1346.1250187378282;1353.6548180213983;1405.4378248700602;789.9802504937308;891.8840550728494;918.3800934369274;932.8134373125403;942.9057094290516;4406.25093734066;4813.483752617914;5136.768845401966;5220.911635345816;5227.712475813867;5164.974175129176;5658.91511627326;5690.2887139107615;5863.501602363847;5874.618149820248;4438.533953934791;5185.22221666753;5312.92030619541;5337.864854058408;5340.7716225268405;2404.747501512351;2612.738726127372;2855.972259695598;2900.1734505665786;2919.664238612544;5310.814121505806;5763.3892885691275;5773.1051686988585;5786.913196302059;5803.894916219887;4770.829272680922;4854;5156.9742151289;5538.889222215533;5594.587301745932;4736.834210802605;4792.784324705397;4828.203346447867;5711.314642242957;5755.712214389264;4766.544255414797;5333.146836378876;5501.422350653123;5522.9447705524035;5532.78278778668;4753.453352864327;5062.291279220985;5118;5347.0375332440535;5474.397816240131;5264.710440925785;5438.619296649196;5705.828825135252;5761.436160908355;5811.518062894104;3376.57792775903;3711.257748450375;3713.2733279025383;3737.0844143185095;3744.2137151198554;5000;5068.6451948363265;5501;5506.3284816638925;5547.335799260287;4930.482299358516;5340.759665815125;5349.170878513836;5356.651817631841;5377.096367961413;4875.731834748981;5315.521603055744;5337.662337662337;5359.356877174764;5360.517553420055;4907.852764417074;5201.895962080813;5206.505381988705;5232.659877107976;5252.212168174651;4240.78796060202;4438.622717069085;4712.976435117939;4819.903601928012;5522.889542209214;5275.947240527546;5401.4868587484125;5499.615026948075;5504;5571.860703482445 09:57:22 INFO - PROCESS | 1640 | |5;yui.html;725.9165196002459;726.4914559808136;791.9071681080112;806.8749343851705;817.7219745286601;14266.714665706693;14715.190664513448;15273.618159546017;15287.31207095682;15411.229438528057;13722.72554548911;14089.647758806035;14091.859081409182;14092.859071409282;14116.505922292721;671.0538141220879;851.0425771007632;865.10893779407;865.640759084979;870.268974061788;708.2917082917083;844.6030365728128;866.0430224601819;878.5914549734372;881.066069965835;919.6827094652334;921.1341339141219;921.4931787516839;922.4972390047441;922.7831459606987;917.9816403671889;918.393860052369;918.807050519395;918.9356745027851;920.1028996728203;678.1556961582812;678.5352033856824;679.0222080204489;679.5684740189965;680.2789043613785;13730;13956.09285396446;14068.155910645393;14069;14805.481808136663;13864.742439710977;14278.928605356907;14303.28483575817;14355.717511702225;14543.490977815725;11557.19099663024;11558.94220528892;11699.7075073123;11718.589849355232;11767.470463829062;3737.8691745788765;3757;3758.642928921748;3973.36426171814;4003.019260281221;84379;88576.55711721464;88740.66888996735;89446.55276723574;89756.10243897543;10633.73415664599;10916.890831091587;10928.726781830359;10995.395253261147;11120.332780033224;20887.791122088584;20897.37307880766;20903.163873445195;20914.581708365746;20925.37223883286;7712.8457430852195;7810.726624568113;7816.53100813953;8067.83864322722;8175.591220438954;4399.5380485049245;4451.77741112943;4518.864434066983;4572.428446444194;4630.930536041962;3342.231286804;3442.586889573217;3451.2752322012657;3451.516787649731;3454.844531996066;578.9855253618609;617.2222999021266;656.7110471392572;702.9121359830021;733.3290039613801;555.3752028967411;610.2676787854592;611.535233222754;628.676231740654;647.2976820150095;8219.95890020546;8889.599968001456;9147.131022552847;9239.72280831576;9309.394889332172;525.4876495416938;611.9938800612026;655.1090516897016;677.8576498935279;702.1363722621103;4084.0798828837524;4191.497020357577;4415.911681766347;4429.512753597101;4513.300438432048;74731.62634186794;96813.5159324213;119353.40323298328;119914.40042799905;123451;100581;105490;106156.46921765342;107577.46211268894;108780;59839;71417;77059.22940770633;79965;88318;9303.67437139724;9700.466474343979;9744.317897747373;9748.294048541335;9768.79941625108;54750.703669076975;56683;57688.71155644195;57868.71065644813;59080.70459647846;71939;73660.89508657482;76358.6182069086;78577.214227857;78615;11402.602562828914;11694.88305116972;11809.114316426474;11911.940440297743;12645.683857903257;12685.23888566689;13030.869691302965;13747.175169489463;13778.724425511635;14879.553613391616;12367.381630918599;12954.352282385655;13229.735405292033;13545;13653.180809151483;12122.696932576757;13052.5431609897;13381.732365352444;13480.549492874861;13497.159176011248;12257.69355766113;12571.74856502883;13214.603561893158;13335.066545341733;13937.51218707381;10741.946290268499;10808.89191108079;10923;10985;11043.83434248503;9005.684801031932;10948.39783811866;11484.081273497934;11514.654560363202;11583.5945741902 09:57:22 INFO - PROCESS | 1640 | __end_tp_report 09:57:22 INFO - PROCESS | 1640 | __start_cc_report 09:57:22 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,1315 09:57:22 INFO - PROCESS | 1640 | __end_cc_report 09:57:22 INFO - PROCESS | 1640 | __startTimestamp1486490242377__endTimestamp 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | ------- Summary: start ------- 09:57:22 INFO - PROCESS | 1640 | Number of tests: 6 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5853.62 Median:6107.57 stddev:622.41 (10.2%) stddev-sans-first:596.23 09:57:22 INFO - PROCESS | 1640 | Values: 3496.8 3515.8 3524.0 3534.9 3576.4 5138.3 5759.8 5894.6 5896.1 5944.2 4974.5 5322.2 5892.9 5937.8 5963.8 5336.1 5367.2 5373.2 5416.4 5427.5 5303.7 5316.6 5348.4 5453.5 5461.5 5342.9 5378.2 5411.1 5411.2 5426.6 5365.0 5380.1 5395.8 5400.9 5435.8 5281.5 5370.4 5384.6 5385.5 5419.2 5752.3 5792.3 5797.3 5970.4 5972.1 6221.8 6240.2 6265.8 6294.4 6295.8 6216.2 6251.8 6258.7 6261.5 6282.9 5825.9 5922.1 5984.9 5986.7 6001.7 6300.7 6318.8 6330.5 6400.5 6422.3 6294.9 6296.7 6301.9 6302.7 6308.9 6264.7 6267.1 6276.3 6297.3 6319.0 6245.8 6271.5 6294.2 6315.3 6320.6 6222.4 6303.3 6306.9 6313.2 6336.1 4980.8 5022.9 5086.6 5094.4 5137.2 4516.1 4552.3 4571.0 4581.7 4588.9 5451.6 5675.9 5935.7 6033.4 6040.4 6012.4 6273.9 6278.4 6286.2 6307.3 5943.4 5968.6 5998.5 6015.1 6058.8 5468.9 5534.9 5544.4 5602.3 5603.7 6573.6 6582.4 6586.3 6591.4 6596.9 6188.7 6332.1 6336.0 6338.7 6351.8 5193.4 6293.3 6358.6 6380.1 6448.5 6194.9 6228.1 6263.3 6277.2 6279.2 6227.8 6229.4 6235.2 6235.3 6249.7 6033.3 6198.5 6201.8 6257.7 6291.6 6107.6 6119.0 6202.1 6211.6 6230.0 6113.8 6118.5 6138.0 6145.0 6163.1 5829.2 6253.3 6256.2 6303.6 6305.3 5988.2 6029.1 6102.1 6157.1 6162.6 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:73985.15 Median:39366.61 stddev:167455.33 (425.4%) stddev-sans-first:167834.17 09:57:22 INFO - PROCESS | 1640 | Values: 489.9 518.6 524.9 526.4 539.4 30586.8 33353.8 41227.4 42216.6 42218.6 43648.6 44142.0 44201.0 44204.8 44218.3 9648.7 9763.0 9820.0 9832.4 9843.8 9576.7 9680.3 9692.5 9702.4 9705.2 9611.7 9625.2 9676.5 9725.3 9748.9 9607.7 9641.9 9647.8 9656.8 9670.8 9657.6 9679.6 9709.3 9752.0 9764.5 37775.1 38225.6 39610.8 39885.0 41817.0 3203.6 3247.7 3354.5 3400.7 3450.0 30179.5 30360.2 30404.8 30927.7 31928.4 3267.8 3287.3 3290.9 3299.3 3308.1 513652.0 513792.0 515938.0 516023.0 516049.0 59439.0 59758.0 59836.4 59893.0 59900.4 35024.0 35827.3 64223.0 64501.0 64556.4 16516.4 17082.7 17099.1 17111.5 17113.4 12974.0 13073.2 13090.5 13107.1 13114.0 19217.2 19303.0 19312.2 19325.7 19367.5 6387.3 6621.8 7648.2 7695.8 7732.3 901.9 969.4 977.3 1048.7 1068.9 29873.9 29971.6 30372.1 30667.5 30801.0 925.2 944.6 1051.9 1107.5 1142.5 12249.5 13131.5 15605.3 15758.8 15784.8 696085.0 702132.0 702471.0 702716.0 703062.0 45440.8 59070.7 59548.7 59689.4 59816.0 1288.9 1371.7 1385.0 1422.7 1423.3 30000.0 31479.8 31504.0 31921.4 32245.5 50407.2 50854.5 50961.5 50977.0 51220.0 555047.0 558897.0 649228.0 668619.0 759352.0 25713.7 26533.2 26577.9 26588.7 26691.3 44364.8 45303.8 45703.5 46748.6 47036.5 37070.6 37140.9 37624.0 37943.2 39122.4 37662.4 37795.6 38012.0 38851.6 38866.8 37822.4 37875.4 38191.0 38311.0 38370.2 31481.3 31771.2 32980.7 33092.2 33294.0 25349.1 25593.9 25599.7 25669.8 25995.5 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:34035.00 Median:21654.74 stddev:91687.94 (423.4%) stddev-sans-first:91910.28 09:57:22 INFO - PROCESS | 1640 | Values: 357.1 368.8 384.2 398.2 401.3 19349.2 20088.8 20388.7 20633.4 20739.4 19767.0 19832.0 20404.8 20987.8 21307.3 4895.8 5710.6 5871.6 5924.9 5972.6 5768.8 5864.8 5867.8 5869.7 5883.4 5610.7 5830.7 5832.3 5853.4 5874.6 5573.2 5793.9 5840.8 5858.1 5870.5 4571.5 5059.7 5068.3 5128.2 5131.1 22602.0 25064.6 25844.0 25951.5 25954.2 2128.3 2229.4 2393.2 2397.1 3052.2 9922.3 10301.4 10575.0 10583.7 10664.3 1819.6 1900.8 1944.5 1971.4 1981.1 109621.5 128308.1 128820.0 134978.0 135706.0 11319.8 11435.7 11745.6 11797.8 11964.2 15182.6 15199.4 15216.4 15217.5 15224.0 7541.7 8006.2 8595.9 8726.2 8777.6 7273.6 7706.5 7732.5 8437.8 8496.7 4528.1 4561.4 4601.7 4666.0 4680.6 1681.0 1902.3 1949.4 1960.6 1984.5 874.3 899.8 964.1 969.3 1006.2 19883.6 21611.9 21620.5 21689.0 21712.3 931.3 940.6 954.8 958.7 968.6 10182.3 11223.9 11229.6 11231.4 11256.8 511214.0 515609.0 517226.0 584498.0 586995.0 101738.7 104537.0 106184.0 146741.0 156623.0 1015.4 1057.0 1057.8 1062.2 1066.1 18379.4 19279.4 19754.7 19835.3 19934.3 47199.0 55530.2 57677.7 57806.7 58595.4 81793.6 81818.8 83590.2 83908.6 93289.0 7321.4 7504.5 7591.0 7935.4 8438.5 9322.7 12701.4 13317.9 13702.9 13794.9 11406.0 11539.5 11576.8 11684.4 11791.9 11295.4 11448.7 11662.7 11848.2 11922.7 9784.8 10750.8 11491.3 11536.7 11856.0 7806.2 12124.9 12131.9 12355.6 12770.0 11549.8 11571.0 11677.8 12027.0 12172.4 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5509.11 Median:4934.72 stddev:3058.29 (62.0%) stddev-sans-first:3052.05 09:57:22 INFO - PROCESS | 1640 | Values: 1501.7 1528.0 1718.1 1829.2 1895.6 7575.5 8249.7 8714.6 8731.6 8738.4 7600.8 7840.5 8278.3 8501.3 8507.6 2369.3 2399.7 2400.7 2406.2 2414.1 2381.0 2418.6 2423.4 2425.8 2428.2 2376.4 2397.0 2399.1 2404.6 2409.2 2156.3 2265.0 2352.9 2376.9 2380.7 2200.2 2252.6 2362.7 2397.1 2398.2 8536.4 8551.4 8630.4 8635.4 8644.1 5030.6 5198.4 5209.6 5218.6 5252.0 3489.6 3575.6 3576.0 3608.9 3633.5 967.9 1055.4 1065.5 1069.7 1069.9 11218.1 11312.7 11328.3 11342.7 11347.0 4599.8 4670.1 4763.0 4763.5 4817.8 9744.5 9752.8 9755.2 9763.0 9786.7 5326.1 5335.0 5336.0 5338.2 5351.4 4169.6 4425.7 4427.9 4906.2 4936.2 3845.8 3912.5 3948.2 3979.3 3990.7 1273.1 1273.7 1281.8 1287.6 1293.6 760.8 817.4 823.0 839.4 839.7 4508.3 4933.3 5472.7 5485.9 5639.1 899.0 937.4 942.3 944.1 1002.0 3606.3 3643.3 3691.7 3794.9 3818.9 9885.6 10271.2 10324.1 10328.8 10359.9 10213.0 10226.7 10229.7 10231.6 10261.5 7748.6 8061.4 8073.0 8158.7 8160.7 4849.6 5603.9 5687.6 5764.7 5812.4 9023.0 9496.5 9537.2 9602.1 9669.6 9641.2 9724.9 9746.3 9839.5 9893.1 6167.3 6558.6 6675.4 7264.1 7427.8 7088.3 7922.0 8197.8 8213.8 8223.1 7112.3 7152.4 7207.4 7217.4 7461.6 7011.9 7091.9 7116.4 7134.1 7257.0 6644.3 6663.7 6723.3 6724.3 6735.9 4688.2 4702.2 4738.9 4795.8 4800.3 4264.9 4315.1 4449.3 4476.8 4561.7 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4467.39 Median:5039.57 stddev:1336.32 (26.5%) stddev-sans-first:1303.19 09:57:22 INFO - PROCESS | 1640 | Values: 313.3 313.9 314.4 317.9 323.3 4320.4 5182.0 5323.9 5387.5 5428.1 4803.8 5016.8 5353.0 5375.8 5398.3 3252.6 3936.5 4075.4 4102.8 4128.7 3537.0 3905.3 4123.7 4132.2 4147.7 4041.9 4047.2 4054.4 4079.3 4087.0 3606.3 3685.2 3907.6 4075.8 4128.4 3024.8 3603.0 3603.8 3614.6 3615.7 5214.3 5228.1 5235.3 5249.9 5265.6 4107.7 4470.0 4492.5 4578.0 4655.3 5188.8 5549.0 5602.9 5626.0 5700.5 3479.3 4014.0 4026.3 4041.4 4047.0 5305.5 5938.0 5994.0 6015.5 6048.7 4055.2 4072.8 4077.2 4082.5 4088.1 3864.7 4152.4 4152.9 4176.9 4178.7 4247.0 4748.6 4772.8 4799.3 4820.4 5147.0 5151.7 5159.5 5433.2 5691.8 1333.4 1344.0 1346.1 1353.7 1405.4 790.0 891.9 918.4 932.8 942.9 4406.3 4813.5 5136.8 5220.9 5227.7 5165.0 5658.9 5690.3 5863.5 5874.6 4438.5 5185.2 5312.9 5337.9 5340.8 2404.7 2612.7 2856.0 2900.2 2919.7 5310.8 5763.4 5773.1 5786.9 5803.9 4770.8 4854.0 5157.0 5538.9 5594.6 4736.8 4792.8 4828.2 5711.3 5755.7 4766.5 5333.1 5501.4 5522.9 5532.8 4753.5 5062.3 5118.0 5347.0 5474.4 5264.7 5438.6 5705.8 5761.4 5811.5 3376.6 3711.3 3713.3 3737.1 3744.2 5000.0 5068.6 5501.0 5506.3 5547.3 4930.5 5340.8 5349.2 5356.7 5377.1 4875.7 5315.5 5337.7 5359.4 5360.5 4907.9 5201.9 5206.5 5232.7 5252.2 4240.8 4438.6 4713.0 4819.9 5522.9 5275.9 5401.5 5499.6 5504.0 5571.9 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20726.56 Median:4422.71 stddev:30345.17 (686.1%) stddev-sans-first:30393.13 09:57:22 INFO - PROCESS | 1640 | Values: 725.9 726.5 791.9 806.9 817.7 14266.7 14715.2 15273.6 15287.3 15411.2 13722.7 14089.6 14091.9 14092.9 14116.5 671.1 851.0 865.1 865.6 870.3 708.3 844.6 866.0 878.6 881.1 919.7 921.1 921.5 922.5 922.8 918.0 918.4 918.8 918.9 920.1 678.2 678.5 679.0 679.6 680.3 13730.0 13956.1 14068.2 14069.0 14805.5 13864.7 14278.9 14303.3 14355.7 14543.5 11557.2 11558.9 11699.7 11718.6 11767.5 3737.9 3757.0 3758.6 3973.4 4003.0 84379.0 88576.6 88740.7 89446.6 89756.1 10633.7 10916.9 10928.7 10995.4 11120.3 20887.8 20897.4 20903.2 20914.6 20925.4 7712.8 7810.7 7816.5 8067.8 8175.6 4399.5 4451.8 4518.9 4572.4 4630.9 3342.2 3442.6 3451.3 3451.5 3454.8 579.0 617.2 656.7 702.9 733.3 555.4 610.3 611.5 628.7 647.3 8220.0 8889.6 9147.1 9239.7 9309.4 525.5 612.0 655.1 677.9 702.1 4084.1 4191.5 4415.9 4429.5 4513.3 74731.6 96813.5 119353.4 119914.4 123451.0 100581.0 105490.0 106156.5 107577.5 108780.0 59839.0 71417.0 77059.2 79965.0 88318.0 9303.7 9700.5 9744.3 9748.3 9768.8 54750.7 56683.0 57688.7 57868.7 59080.7 71939.0 73660.9 76358.6 78577.2 78615.0 11402.6 11694.9 11809.1 11911.9 12645.7 12685.2 13030.9 13747.2 13778.7 14879.6 12367.4 12954.4 13229.7 13545.0 13653.2 12122.7 13052.5 13381.7 13480.5 13497.2 12257.7 12571.7 13214.6 13335.1 13937.5 10741.9 10808.9 10923.0 10985.0 11043.8 9005.7 10948.4 11484.1 11514.7 11583.6 09:57:22 INFO - PROCESS | 1640 | -------- Summary: end -------- 09:57:22 INFO - PROCESS | 1640 | 09:57:22 INFO - TEST-INFO | 1640: exit 0 09:57:22 INFO - TEST-OK | dromaeo_css | took 1118216ms 09:57:22 INFO - TEST-START | kraken 09:57:22 INFO - operating with platform_type : mac_ 09:57:22 INFO - Initialising browser for kraken test... 09:57:23 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmp8E398a/profile http://localhost:49241/getInfo.html) 09:57:25 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 09:57:25 INFO - PROCESS | 1650 | colorDepth:24 09:57:25 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 09:57:25 INFO - PROCESS | 1650 | __metrics 09:57:25 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:57:25 INFO - PROCESS | 1650 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:26 INFO - TEST-INFO | 1650: exit 0 09:57:26 INFO - Browser initialized. 09:57:26 INFO - Running cycle 1/1 for kraken test... 09:57:26 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/T/tmp8E398a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:38 INFO - PROCESS | 1652 | RSS: Main: 171712512 09:57:38 INFO - PROCESS | 1652 | 09:57:41 INFO - PROCESS | 1652 | 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) 09:57:41 INFO - PROCESS | 1652 | RSS: Main: 222171136 09:57:41 INFO - PROCESS | 1652 | 09:57:44 INFO - PROCESS | 1652 | 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) 09:57:45 INFO - PROCESS | 1652 | RSS: Main: 234229760 09:57:45 INFO - PROCESS | 1652 | 09:57:48 INFO - PROCESS | 1652 | 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) 09:57:48 INFO - PROCESS | 1652 | RSS: Main: 330280960 09:57:48 INFO - PROCESS | 1652 | 09:57:50 INFO - PROCESS | 1652 | 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) 09:57:51 INFO - PROCESS | 1652 | RSS: Main: 233115648 09:57:51 INFO - PROCESS | 1652 | 09:57:53 INFO - PROCESS | 1652 | 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) 09:57:54 INFO - PROCESS | 1652 | RSS: Main: 234094592 09:57:54 INFO - PROCESS | 1652 | 09:57:56 INFO - PROCESS | 1652 | 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) 09:57:57 INFO - PROCESS | 1652 | RSS: Main: 272924672 09:57:57 INFO - PROCESS | 1652 | 09:58:00 INFO - PROCESS | 1652 | 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) 09:58:00 INFO - PROCESS | 1652 | RSS: Main: 276328448 09:58:00 INFO - PROCESS | 1652 | 09:58:03 INFO - PROCESS | 1652 | 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) 09:58:04 INFO - PROCESS | 1652 | RSS: Main: 270413824 09:58:04 INFO - PROCESS | 1652 | 09:58:05 INFO - PROCESS | 1652 | 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) 09:58:06 INFO - PROCESS | 1652 | RSS: Main: 248999936 09:58:06 INFO - PROCESS | 1652 | 09:58:08 INFO - PROCESS | 1652 | 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) 09:58:08 INFO - PROCESS | 1652 | RSS: Main: 251056128 09:58:08 INFO - PROCESS | 1652 | 09:58:10 INFO - PROCESS | 1652 | 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) 09:58:11 INFO - PROCESS | 1652 | RSS: Main: 253947904 09:58:11 INFO - PROCESS | 1652 | 09:58:14 INFO - PROCESS | 1652 | 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) 09:58:15 INFO - PROCESS | 1652 | RSS: Main: 271646720 09:58:15 INFO - PROCESS | 1652 | 09:58:17 INFO - PROCESS | 1652 | 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) 09:58:18 INFO - PROCESS | 1652 | RSS: Main: 265371648 09:58:18 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | 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) 09:58:20 INFO - PROCESS | 1652 | RSS: Main: 309358592 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | __start_tp_report 09:58:20 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 09:58:20 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 09:58:20 INFO - PROCESS | 1652 | |i|pagename|runs| 09:58:20 INFO - PROCESS | 1652 | |0;ai-astar;115;114;114;114;114;113;114;114;115;115 09:58:20 INFO - PROCESS | 1652 | |1;audio-beat-detection;147;117;121;168;106;107;108;107;137;106 09:58:20 INFO - PROCESS | 1652 | |2;audio-dft;181;182;181;186;185;183;182;186;184;185 09:58:20 INFO - PROCESS | 1652 | |3;audio-fft;80;56;57;85;58;58;57;58;80;71 09:58:20 INFO - PROCESS | 1652 | |4;audio-oscillator;88;72;92;68;68;69;87;68;69;89 09:58:20 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;90;86;91;87;89;87;90;85;124;86 09:58:20 INFO - PROCESS | 1652 | |6;imaging-darkroom;99;94;95;93;94;94;96;95;95;95 09:58:20 INFO - PROCESS | 1652 | |7;imaging-desaturate;81;83;82;83;83;82;130;84;90;124 09:58:20 INFO - PROCESS | 1652 | |8;json-parse-financial;54;54;52;52;55;56;56;56;56;55 09:58:20 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;71;69;64;76;73;68;68;68;70;68 09:58:20 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;81;80;78;80;81;81;80;79;84;78 09:58:20 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;135;137;135;143;142;138;139;136;183;135 09:58:20 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;160;165;161;157;209;179;159;160;159;163 09:58:20 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;65;66;66;65;65;65;66;66;65;64 09:58:20 INFO - PROCESS | 1652 | __end_tp_report 09:58:20 INFO - PROCESS | 1652 | __start_cc_report 09:58:20 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1870 09:58:20 INFO - PROCESS | 1652 | __end_cc_report 09:58:20 INFO - PROCESS | 1652 | __startTimestamp1486490300552__endTimestamp 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | ------- Summary: start ------- 09:58:20 INFO - PROCESS | 1652 | Number of tests: 14 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 09:58:20 INFO - PROCESS | 1652 | Values: 115.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 115.0 115.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:122.40 Median:119.00 stddev:21.47 (18.0%) stddev-sans-first:20.84 09:58:20 INFO - PROCESS | 1652 | Values: 147.0 117.0 121.0 168.0 106.0 107.0 108.0 107.0 137.0 106.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.50 stddev:1.96 (1.1%) stddev-sans-first:1.86 09:58:20 INFO - PROCESS | 1652 | Values: 181.0 182.0 181.0 186.0 185.0 183.0 182.0 186.0 184.0 185.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:66.00 Median:64.50 stddev:11.70 (18.1%) stddev-sans-first:11.26 09:58:20 INFO - PROCESS | 1652 | Values: 80.0 56.0 57.0 85.0 58.0 58.0 57.0 58.0 80.0 71.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:79.50 stddev:10.47 (13.2%) stddev-sans-first:10.32 09:58:20 INFO - PROCESS | 1652 | Values: 88.0 72.0 92.0 68.0 68.0 69.0 87.0 68.0 69.0 89.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:88.00 stddev:11.60 (13.2%) stddev-sans-first:12.29 09:58:20 INFO - PROCESS | 1652 | Values: 90.0 86.0 91.0 87.0 89.0 87.0 90.0 85.0 124.0 86.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:1.63 (1.7%) stddev-sans-first:0.88 09:58:20 INFO - PROCESS | 1652 | Values: 99.0 94.0 95.0 93.0 94.0 94.0 96.0 95.0 95.0 95.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:83.00 stddev:18.56 (22.4%) stddev-sans-first:19.24 09:58:20 INFO - PROCESS | 1652 | Values: 81.0 83.0 82.0 83.0 83.0 82.0 130.0 84.0 90.0 124.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.50 stddev:1.58 (2.8%) stddev-sans-first:1.66 09:58:20 INFO - PROCESS | 1652 | Values: 54.0 54.0 52.0 52.0 55.0 56.0 56.0 56.0 56.0 55.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:3.27 (4.7%) stddev-sans-first:3.43 09:58:20 INFO - PROCESS | 1652 | Values: 71.0 69.0 64.0 76.0 73.0 68.0 68.0 68.0 70.0 68.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:1.75 (2.2%) stddev-sans-first:1.83 09:58:20 INFO - PROCESS | 1652 | Values: 81.0 80.0 78.0 80.0 81.0 81.0 80.0 79.0 84.0 78.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:138.50 stddev:14.58 (10.5%) stddev-sans-first:15.23 09:58:20 INFO - PROCESS | 1652 | Values: 135.0 137.0 135.0 143.0 142.0 138.0 139.0 136.0 183.0 135.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:162.00 stddev:15.95 (9.8%) stddev-sans-first:16.70 09:58:20 INFO - PROCESS | 1652 | Values: 160.0 165.0 161.0 157.0 209.0 179.0 159.0 160.0 159.0 163.0 09:58:20 INFO - PROCESS | 1652 | 09:58:20 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 09:58:20 INFO - PROCESS | 1652 | Values: 65.0 66.0 66.0 65.0 65.0 65.0 66.0 66.0 65.0 64.0 09:58:20 INFO - PROCESS | 1652 | -------- Summary: end -------- 09:58:20 INFO - PROCESS | 1652 | 09:58:21 INFO - TEST-INFO | 1652: exit 0 09:58:21 INFO - TEST-OK | kraken | took 58586ms 09:58:21 INFO - SUITE-END | took 1176s 09:58:21 INFO - Completed test suite (00:19:36) 09:58:21 INFO - javascript benchmark 09:58:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3496.807675577843, 3515.753897227195, 3523.982380088099, 3534.911627209321, 3576.4098923677593, 5138.332016837815, 5759.790444006759, 5894.58737888348, 5896.115582662603, 5944.167816505687, 4974.527419895113, 5322.201669749539, 5892.941070589292, 5937.762489500415, 5963.791267305645, 5336.092864213093, 5367.194920761878, 5373.194020896858, 5416.350037995446, 5427.48438898304, 5303.7082960437165, 5316.601254905898, 5348.3849357323825, 5453.536449401806, 5461.508464238218, 5342.866428339303, 5378.220158077076, 5411.080116380205, 5411.215373770801, 5426.647267927592, 5365.034293827129, 5380.112281473552, 5395.78416863325, 5400.945990540084, 5435.755391007375, 5281.457946166294, 5370.43610420904, 5384.623076384654, 5385.488378604026, 5419.187121931703, 5752.309722833287, 5792.275965504312, 5797.333306669702, 5970.432808883149, 5972.104184372379, 6221.813345599594, 6240.188775459162, 6265.843353916143, 6294.3705629437145, 6295.811125666238, 6216.160818289563, 6251.812445626593, 6258.655773932432, 6261.499080073583, 6282.905756413657, 5825.854353641108, 5922.082077278029, 5984.880302393928, 5986.6707331097205, 6001.669908155006, 6300.716467758962, 6318.810435686844, 6330.461910737639, 6400.519961002943, 6422.293547709748, 6294.937050629526, 6296.716647750863, 6301.905471417932, 6302.70794487129, 6308.936910630927, 6264.655443950535, 6267.059941008794, 6276.340984196685, 6297.27581328144, 6319.0, 6245.781397651061, 6271.4669253114, 6294.181756371642, 6315.336889626615, 6320.5891617044745, 6222.439980401786, 6303.2751233607805, 6306.873862522724, 6313.179286692701, 6336.144620476269, 4980.77586508608, 5022.901600370803, 5086.567641750418, 5094.4141423736, 5137.152369859006, 4516.096780643885, 4552.271636538138, 4571.0, 4581.725096494221, 4588.931166032512, 5451.591130665137, 5675.886482270332, 5935.6735379553675, 6033.42682445167, 6040.395960403925, 6012.368701286389, 6273.9372606273355, 6278.372162783685, 6286.245650521967, 6307.306196318401, 5943.435373639584, 5968.641881487125, 5998.490128339053, 6015.127806468037, 6058.848528786815, 5468.890622187534, 5534.916976245279, 5544.390117087117, 5602.327720673546, 5603.719814009283, 6573.605583664899, 6582.407583317525, 6586.308437614173, 6591.406773390418, 6596.901046484402, 6188.690565471618, 6332.11350410952, 6335.968320158369, 6338.651374174465, 6351.841203969938, 5193.428722840409, 6293.276273228637, 6358.618482891041, 6380.074889141141, 6448.516361272829, 6194.876102477835, 6228.128062071223, 6263.279722831932, 6277.15258440123, 6279.246490421178, 6227.813165605039, 6229.3770622937345, 6235.189425374672, 6235.282942461675, 6249.7187626557825, 6033.276006879027, 6198.535109866688, 6201.844953876189, 6257.68711564429, 6291.591046581958, 6107.572469927062, 6119.015143218386, 6202.069689546423, 6211.565190436626, 6230.0, 6113.849934583468, 6118.527810132562, 6137.997532011396, 6145.002874065857, 6163.106349579376, 5829.2421985143355, 6253.280872699698, 6256.249250090018, 6303.558750887394, 6305.274893387319, 5988.161657368059, 6029.125776762257, 6102.0541816018585, 6157.1072194532435, 6162.630242185483], "value": 5816.453442998795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.90446862861756, 518.6032684995979, 524.884620182113, 526.4261954469629, 539.430900400078, 30586.84706576467, 33353.83323083384, 41227.381589276185, 42216.57783422165, 42218.57781422185, 43648.56351436485, 44142.0, 44201.0, 44204.77897610515, 44218.33672494915, 9648.662296819613, 9762.9511852441, 9820.0, 9832.360896541737, 9843.753906152368, 9576.712698619018, 9680.322377433582, 9692.46691431971, 9702.417854928726, 9705.175060119898, 9611.711648650517, 9625.181859541912, 9676.467794271312, 9725.27060470464, 9748.902510974905, 9607.66373176939, 9641.855372169422, 9647.807043859118, 9656.806863862683, 9670.806583868354, 9657.565409556586, 9679.612815487371, 9709.271804614682, 9752.0, 9764.462954537497, 37775.055623609354, 38225.61774382276, 39610.80194599037, 39885.0, 41817.0, 3203.583534140547, 3247.723943464808, 3354.4632858742484, 3400.7449441292, 3449.9655003449893, 30179.547306790417, 30360.216894127527, 30404.8479757602, 30927.690723092706, 31928.361432771446, 3267.77125601208, 3287.260366417561, 3290.901272961791, 3299.2741596848655, 3308.106811160997, 513652.0, 513792.0, 515938.0, 516023.0, 516049.0, 59439.0, 59758.0, 59836.40163598395, 59893.0, 59900.400995990356, 35024.0, 35827.28345433077, 64223.0, 64501.0, 64556.35443645597, 16516.42192523256, 17082.743758843626, 17099.059551724775, 17111.486655400357, 17113.401030963858, 12974.0, 13073.15024523403, 13090.541831035867, 13107.14803537767, 13114.01644876638, 19217.231310747415, 19303.034848257532, 19312.227510899407, 19325.710114348298, 19367.51581210481, 6387.329330420332, 6621.801345959629, 7648.158702542716, 7695.846083078307, 7732.265434783799, 901.9368644194843, 969.3892847506027, 977.3256453047375, 1048.6801525534786, 1068.9144868410508, 29873.850630746707, 29971.550426743615, 30372.088837334915, 30667.539986900214, 30801.0, 925.1812146250483, 944.5702205496483, 1051.8842927277992, 1107.4850194659523, 1142.5429828068673, 12249.510019599116, 13131.474741010252, 15605.297761600756, 15758.765472490484, 15784.763228551581, 696085.0, 702132.0, 702471.0, 702716.0, 703062.0, 45440.77279613581, 59070.70464647735, 59548.70225648844, 59689.40310596925, 59816.0, 1288.8968882489378, 1371.7256548690302, 1384.9861501384858, 1422.7012327411153, 1423.3168079321777, 30000.049619665024, 31479.84260078685, 31504.0, 31921.361572768878, 32245.51631725573, 50407.24389134239, 50854.491455086456, 50961.490385095676, 50977.0, 51220.0, 555047.0, 558897.0, 649228.0, 668619.0, 759352.0, 25713.742862571882, 26533.204003879913, 26577.867110665098, 26588.734112658625, 26691.33271668146, 44364.77817610891, 45303.77348113238, 45703.542964569926, 46748.59754207379, 47036.52963470321, 37070.62929370672, 37140.88577342684, 37624.0, 37943.24113517659, 39122.413163802, 37662.435063473524, 37795.62204378031, 38012.0, 38851.61148388593, 38866.805665971486, 37822.43266350952, 37875.431868521446, 38191.04522386962, 38311.04222394351, 38370.2325953485, 31481.268530231057, 31771.205719856265, 32980.67019329776, 33092.1726956828, 33294.00117996464, 25349.112781052576, 25593.872030639726, 25599.744002559735, 25669.785031846688, 25995.480090398465], "value": 20014.3126559234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.0805176670074, 368.76030580122915, 384.1816929939231, 398.20955403524016, 401.25166564357465, 19349.226030958762, 20088.799112008914, 20388.69416958743, 20633.38099857007, 20739.377818665445, 19767.0, 19832.0, 20404.775713457202, 20987.790122098773, 21307.25424610139, 4895.804167833282, 5710.5717071219615, 5871.55963302754, 5924.851878703023, 5972.611780234292, 5768.769249230026, 5864.794732184374, 5867.823965281048, 5869.706514674271, 5883.441073098049, 5610.747516361774, 5830.737616807254, 5832.329282132567, 5853.356130825606, 5874.618149820248, 5573.247611572427, 5793.913091303634, 5840.766369345221, 5858.062709966406, 5870.530357571384, 4571.451425828922, 5059.7097740076415, 5068.341115654978, 5128.179491281415, 5131.1277082895995, 22602.0, 25064.621445820474, 25843.966241350325, 25951.480970380486, 25954.22137335883, 2128.329576183513, 2229.442639340165, 2393.222202784085, 2397.0771253067696, 3052.2064263291704, 9922.255830812646, 10301.433421161833, 10574.995375439321, 10583.73540661482, 10664.253502254845, 1819.6087841114092, 1900.7719073711105, 1944.5235917200378, 1971.428285797117, 1981.1382048808814, 109621.45189274082, 128308.07537886845, 128820.0, 134978.0, 135706.0, 11319.830202546967, 11435.656930292105, 11745.647630571097, 11797.76404471923, 11964.222325548812, 15182.620434489227, 15199.392024319124, 15216.391344346324, 15217.467388641566, 15224.020877285882, 7541.660625271876, 8006.239407256301, 8595.914040859636, 8726.214640682241, 8777.648894044167, 7273.63631818407, 7706.537607743553, 7732.497387669783, 8437.77652240434, 8496.745097647081, 4528.0943811237885, 4561.448593512144, 4601.700889442175, 4666.0, 4680.555347242007, 1680.983190168107, 1902.3056584346891, 1949.3664559018375, 1960.5588742532816, 1984.454275074366, 874.3442418186361, 899.7705585075764, 964.1081999150757, 969.3117886300664, 1006.1749365520203, 19883.60232795336, 21611.891940540198, 21620.486565940548, 21689.0, 21712.295617724776, 931.2689538712078, 940.5955439161089, 954.7899462118323, 958.6818125078017, 968.5786682793008, 10182.338148020355, 11223.943880280547, 11229.606963756229, 11231.438428078563, 11256.774864502664, 511214.0, 515609.0, 517226.0, 584498.0, 586995.0, 101738.74142558814, 104537.0, 106184.0, 146741.0, 156623.0, 1015.3806178231273, 1056.9735756606146, 1057.7567159553346, 1062.198040479433, 1066.1257768629648, 18379.356722514647, 19279.4216173515, 19754.70367944511, 19835.30576429818, 19934.30229941945, 47199.0, 55530.16704749513, 57677.71161144167, 57806.71096644658, 58595.414045859, 81793.59103204445, 81818.77271841046, 83590.16409836068, 83908.58045709733, 93289.0, 7321.377682897013, 7504.474686772092, 7591.0, 7935.365170786208, 8438.451500652438, 9322.673706420514, 12701.36493175356, 13317.934565234564, 13702.862971370558, 13794.93102534481, 11406.030487408663, 11539.4807233673, 11576.768464630828, 11684.415779210836, 11791.882081179421, 11295.435228238392, 11448.713782155513, 11662.650120496399, 11848.229865058744, 11922.701932451759, 9784.755381115245, 10750.784984300113, 11491.253068550517, 11536.711582210512, 11855.99224065964, 7806.180351063056, 12124.908758211803, 12131.878681213428, 12355.567555135887, 12770.0, 11549.78727233662, 11571.0, 11677.76644467089, 12027.0, 12172.39138043112], "value": 9732.285633478128, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.7146742118996, 1528.0144306922036, 1718.1323431667006, 1829.1860122245605, 1895.5545446820004, 7575.507592006516, 8249.670013199464, 8714.564271786401, 8731.607077681503, 8738.432001919879, 7600.77197684069, 7840.490368126068, 8278.337732981363, 8501.319894408432, 8507.617157227924, 2369.3010561884284, 2399.676043734091, 2400.7359190489033, 2406.2300063979533, 2414.1309128713738, 2381.023780250098, 2418.613021916494, 2423.3578101803037, 2425.8059355251626, 2428.1865575032384, 2376.394019525019, 2396.95206095878, 2399.1286796298914, 2404.603240465321, 2409.180878501318, 2156.277646988261, 2265.048679554591, 2352.882355882199, 2376.869272190029, 2380.7262164851004, 2200.2409168836725, 2252.5720113178445, 2362.70466191726, 2397.0891061396733, 2398.1726304424947, 8536.359773017048, 8551.444156129832, 8630.439021463584, 8635.43869648477, 8644.092370301154, 5030.622703297267, 5198.350206224222, 5209.583233341324, 5218.634695571312, 5252.028374750684, 3489.616142224353, 3575.588807287143, 3575.982120089409, 3608.891733248007, 3633.454981752732, 967.8644989701377, 1055.3931489393553, 1065.536491626145, 1069.6844430892904, 1069.9251052426334, 11218.102551795837, 11312.660620181408, 11328.263662861887, 11342.71643208918, 11347.035501982342, 4599.793009314589, 4670.1126785910565, 4763.023580166057, 4763.476017638057, 4817.771468275568, 9744.464054477072, 9752.756181095529, 9755.170810481188, 9763.0, 9786.706398808046, 5326.121190003683, 5335.039692855324, 5336.0, 5338.172583249602, 5351.411344752074, 4169.624733773914, 4425.734455932655, 4427.933580996288, 4906.165951788204, 4936.160852655057, 3845.8461661533224, 3912.491376121086, 3948.2498325318097, 3979.263836190314, 3990.7206495545033, 1273.121546133165, 1273.6943133647858, 1281.7628738683372, 1287.587971849018, 1293.6313150752178, 760.7983884270673, 817.435969181263, 822.9753107406667, 839.4082172068677, 839.699569752996, 4508.323751437245, 4933.28467372229, 5472.671639701631, 5485.890282194334, 5639.069553523623, 898.9910100898908, 937.3579098317674, 942.2509105261333, 944.1125342178331, 1001.9949900250598, 3606.2607165531003, 3643.3441980443777, 3691.7231207659534, 3794.905127371838, 3818.9427158592644, 9885.604575816888, 10271.229657775697, 10324.070833624859, 10328.793424131625, 10359.94820025895, 10213.0, 10226.744331391626, 10229.693109206735, 10231.641892533726, 10261.486925653688, 7748.573828439377, 8061.355091592659, 8072.959635201903, 8158.714444994515, 8160.67357305713, 4849.56353928134, 5603.859903502445, 5687.630304030225, 5764.711764411679, 5812.360640329476, 9022.954885225532, 9496.47769372691, 9537.23702103844, 9602.08780165883, 9669.564869580745, 9641.180499657326, 9724.9027509724, 9746.31775775689, 9839.508024598885, 9893.109620134222, 6167.259928808572, 6558.606483610999, 6675.399214070757, 7264.091988501437, 7427.7771666850085, 7088.326608972139, 7922.049354077548, 8197.79505512367, 8213.753587392388, 8223.05434874997, 7112.324329188718, 7152.356287934111, 7207.387372073433, 7217.350438460564, 7461.626918654154, 7011.929880701332, 7091.858162836817, 7116.395106416013, 7134.072570565793, 7256.96371518139, 6644.302348253557, 6663.666816659244, 6723.294054124247, 6724.293949135466, 6735.865282694221, 4688.179568575418, 4702.247640377524, 4738.881527961828, 4795.760211989456, 4800.3279540863605, 4264.850730224427, 4315.136972605429, 4449.265871131227, 4476.79854406559, 4561.7262964222255], "value": 4457.242415300889, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.28258288519294, 313.8838629707008, 314.3665513989311, 317.8855611979687, 323.256510026938, 4320.351947207921, 5181.9740901295445, 5323.9467605323935, 5387.488188622085, 5428.131498960162, 4803.759812009403, 5016.842757614234, 5352.992627764588, 5375.790447149389, 5398.273871694789, 3252.609686837583, 3936.5276166859944, 4075.4498142750645, 4102.810185046333, 4128.710990230685, 3537.00963730156, 3905.2775236581183, 4123.670106391496, 4132.214879172962, 4147.6889233307475, 4041.888480667825, 4047.219223541647, 4054.351303791394, 4079.2657321682086, 4087.0, 3606.2967721294226, 3685.1892583631557, 3907.609239076098, 4075.8369665213354, 4128.422020917044, 3024.8185108893317, 3602.963970360289, 3603.7567039371374, 3614.5903097791884, 3615.692666123383, 5214.348206474191, 5228.137357336035, 5235.32469609725, 5249.947500525022, 5265.631405801595, 4107.712460127792, 4469.955300447019, 4492.505824359318, 4577.9771101144615, 4655.25515917455, 5188.792448302063, 5549.0, 5602.907433050556, 5625.971870140623, 5700.543956483471, 3479.3215323012023, 4014.016565941363, 4026.255142798592, 4041.413994970713, 4046.9595304046875, 5305.469453054702, 5938.0, 5994.0, 6015.518758499309, 6048.731725602855, 4055.229506393776, 4072.841394061152, 4077.225327187825, 4082.4692789937117, 4088.100617864065, 3864.671502922227, 4152.356384760306, 4152.896177595524, 4176.932418452885, 4178.680832138131, 4246.9594949237635, 4748.62011039123, 4772.76136193189, 4799.280107983761, 4820.396985627792, 5147.022065807485, 5151.665141765849, 5159.458256883048, 5433.239346491494, 5691.77232910679, 1333.379978310071, 1343.9785762820327, 1346.1250187378282, 1353.6548180213983, 1405.4378248700602, 789.9802504937308, 891.8840550728494, 918.3800934369274, 932.8134373125403, 942.9057094290516, 4406.25093734066, 4813.483752617914, 5136.768845401966, 5220.911635345816, 5227.712475813867, 5164.974175129176, 5658.91511627326, 5690.2887139107615, 5863.501602363847, 5874.618149820248, 4438.533953934791, 5185.22221666753, 5312.92030619541, 5337.864854058408, 5340.7716225268405, 2404.747501512351, 2612.738726127372, 2855.972259695598, 2900.1734505665786, 2919.664238612544, 5310.814121505806, 5763.3892885691275, 5773.1051686988585, 5786.913196302059, 5803.894916219887, 4770.829272680922, 4854.0, 5156.9742151289, 5538.889222215533, 5594.587301745932, 4736.834210802605, 4792.784324705397, 4828.203346447867, 5711.314642242957, 5755.712214389264, 4766.544255414797, 5333.146836378876, 5501.422350653123, 5522.9447705524035, 5532.78278778668, 4753.453352864327, 5062.291279220985, 5118.0, 5347.0375332440535, 5474.397816240131, 5264.710440925785, 5438.619296649196, 5705.828825135252, 5761.436160908355, 5811.518062894104, 3376.57792775903, 3711.257748450375, 3713.2733279025383, 3737.0844143185095, 3744.2137151198554, 5000.0, 5068.6451948363265, 5501.0, 5506.3284816638925, 5547.335799260287, 4930.482299358516, 5340.759665815125, 5349.170878513836, 5356.651817631841, 5377.096367961413, 4875.731834748981, 5315.521603055744, 5337.662337662337, 5359.356877174764, 5360.517553420055, 4907.852764417074, 5201.895962080813, 5206.505381988705, 5232.659877107976, 5252.212168174651, 4240.78796060202, 4438.622717069085, 4712.976435117939, 4819.903601928012, 5522.889542209214, 5275.947240527546, 5401.4868587484125, 5499.615026948075, 5504.0, 5571.860703482445], "value": 4046.455920561952, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.9165196002459, 726.4914559808136, 791.9071681080112, 806.8749343851705, 817.7219745286601, 14266.714665706693, 14715.190664513448, 15273.618159546017, 15287.31207095682, 15411.229438528057, 13722.72554548911, 14089.647758806035, 14091.859081409182, 14092.859071409282, 14116.505922292721, 671.0538141220879, 851.0425771007632, 865.10893779407, 865.640759084979, 870.268974061788, 708.2917082917083, 844.6030365728128, 866.0430224601819, 878.5914549734372, 881.066069965835, 919.6827094652334, 921.1341339141219, 921.4931787516839, 922.4972390047441, 922.7831459606987, 917.9816403671889, 918.393860052369, 918.807050519395, 918.9356745027851, 920.1028996728203, 678.1556961582812, 678.5352033856824, 679.0222080204489, 679.5684740189965, 680.2789043613785, 13730.0, 13956.09285396446, 14068.155910645393, 14069.0, 14805.481808136663, 13864.742439710977, 14278.928605356907, 14303.28483575817, 14355.717511702225, 14543.490977815725, 11557.19099663024, 11558.94220528892, 11699.7075073123, 11718.589849355232, 11767.470463829062, 3737.8691745788765, 3757.0, 3758.642928921748, 3973.36426171814, 4003.019260281221, 84379.0, 88576.55711721464, 88740.66888996735, 89446.55276723574, 89756.10243897543, 10633.73415664599, 10916.890831091587, 10928.726781830359, 10995.395253261147, 11120.332780033224, 20887.791122088584, 20897.37307880766, 20903.163873445195, 20914.581708365746, 20925.37223883286, 7712.8457430852195, 7810.726624568113, 7816.53100813953, 8067.83864322722, 8175.591220438954, 4399.5380485049245, 4451.77741112943, 4518.864434066983, 4572.428446444194, 4630.930536041962, 3342.231286804, 3442.586889573217, 3451.2752322012657, 3451.516787649731, 3454.844531996066, 578.9855253618609, 617.2222999021266, 656.7110471392572, 702.9121359830021, 733.3290039613801, 555.3752028967411, 610.2676787854592, 611.535233222754, 628.676231740654, 647.2976820150095, 8219.95890020546, 8889.599968001456, 9147.131022552847, 9239.72280831576, 9309.394889332172, 525.4876495416938, 611.9938800612026, 655.1090516897016, 677.8576498935279, 702.1363722621103, 4084.0798828837524, 4191.497020357577, 4415.911681766347, 4429.512753597101, 4513.300438432048, 74731.62634186794, 96813.5159324213, 119353.40323298328, 119914.40042799905, 123451.0, 100581.0, 105490.0, 106156.46921765342, 107577.46211268894, 108780.0, 59839.0, 71417.0, 77059.22940770633, 79965.0, 88318.0, 9303.67437139724, 9700.466474343979, 9744.317897747373, 9748.294048541335, 9768.79941625108, 54750.703669076975, 56683.0, 57688.71155644195, 57868.71065644813, 59080.70459647846, 71939.0, 73660.89508657482, 76358.6182069086, 78577.214227857, 78615.0, 11402.602562828914, 11694.88305116972, 11809.114316426474, 11911.940440297743, 12645.683857903257, 12685.23888566689, 13030.869691302965, 13747.175169489463, 13778.724425511635, 14879.553613391616, 12367.381630918599, 12954.352282385655, 13229.735405292033, 13545.0, 13653.180809151483, 12122.696932576757, 13052.5431609897, 13381.732365352444, 13480.549492874861, 13497.159176011248, 12257.69355766113, 12571.74856502883, 13214.603561893158, 13335.066545341733, 13937.51218707381, 10741.946290268499, 10808.89191108079, 10923.0, 10985.0, 11043.83434248503, 9005.684801031932, 10948.39783811866, 11484.081273497934, 11514.654560363202, 11583.5945741902], "value": 7425.295761642509, "unit": "score"}], "name": "dromaeo_css", "value": 7303.303361723195, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 121.0, 168.0, 106.0, 107.0, 108.0, 107.0, 137.0, 106.0], "value": 122.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 181.0, 186.0, 185.0, 183.0, 182.0, 186.0, 184.0, 185.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 56.0, 57.0, 85.0, 58.0, 58.0, 57.0, 58.0, 80.0, 71.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 92.0, 68.0, 68.0, 69.0, 87.0, 68.0, 69.0, 89.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 91.0, 87.0, 89.0, 87.0, 90.0, 85.0, 124.0, 86.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 95.0, 93.0, 94.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 83.0, 83.0, 82.0, 130.0, 84.0, 90.0, 124.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 52.0, 52.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 64.0, 76.0, 73.0, 68.0, 68.0, 68.0, 70.0, 68.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 78.0, 80.0, 81.0, 81.0, 80.0, 79.0, 84.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 135.0, 143.0, 142.0, 138.0, 139.0, 136.0, 183.0, 135.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 161.0, 157.0, 209.0, 179.0, 159.0, 160.0, 159.0, 163.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 64.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1420.9, "alertThreshold": 2.0}]} 09:58:21 INFO - Return code: 0 09:58:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:58:21 INFO - # TBPL SUCCESS # 09:58:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:21 INFO - 2017-02-07 09:58:21.904 screenresolution[1656:9821] starting screenresolution argv=screenresolution get 09:58:21 INFO - 2017-02-07 09:58:21.907 screenresolution[1656:9821] Display 0: 1600x1200x32@60 09:58:21 INFO - 2017-02-07 09:58:21.913 screenresolution[1657:9824] starting screenresolution argv=screenresolution list 09:58:21 INFO - Available Modes on Display 0 09:58:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:22 INFO - Intel Iris: 09:58:22 INFO - Chipset Model: Intel Iris 09:58:22 INFO - Type: GPU 09:58:22 INFO - Bus: Built-In 09:58:22 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:22 INFO - Vendor: Intel (0x8086) 09:58:22 INFO - Device ID: 0x0a2e 09:58:22 INFO - Revision ID: 0x0009 09:58:22 INFO - Displays: 09:58:22 INFO - Display: 09:58:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:22 INFO - Display Serial Number: 1600x1200 60 09:58:22 INFO - Main Display: Yes 09:58:22 INFO - Mirror: Off 09:58:22 INFO - Online: Yes 09:58:22 INFO - Rotation: Supported 09:58:22 INFO - Return code: 0 09:58:22 INFO - Running post-action listener: _resource_record_post_action 09:58:22 INFO - [mozharness: 2017-02-07 17:58:22.153977Z] Finished run-tests step (success) 09:58:22 INFO - Running post-run listener: _resource_record_post_run 09:58:22 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 43509248; Write bytes: 500706304; Read time: 274; Write time: 1567 09:58:22 INFO - TinderboxPrint: CPU usage
53.5% 09:58:22 INFO - TinderboxPrint: I/O read bytes / time
43,509,248 / 274 09:58:22 INFO - TinderboxPrint: I/O write bytes / time
500,706,304 / 1,567 09:58:22 INFO - TinderboxPrint: CPU idle
2,232.2 (46.5%) 09:58:22 INFO - TinderboxPrint: CPU system
959.6 (20.0%) 09:58:22 INFO - TinderboxPrint: CPU user
1,606.0 (33.5%) 09:58:22 INFO - TinderboxPrint: Swap in / out
242,819,072 / 0 09:58:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 179032576; Write bytes: 174563328; Read time: 16561; Write time: 365 09:58:22 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 42587648; Write bytes: 308411392; Read time: 262; Write time: 1147 09:58:22 INFO - Running post-run listener: _upload_blobber_files 09:58:22 INFO - Blob upload gear active. 09:58:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:58:22 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 09:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:58:23 INFO - (blobuploader) - INFO - Open directory for files ... 09:58:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:58:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:58:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:24 INFO - (blobuploader) - INFO - Done attempting. 09:58:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:58:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:26 INFO - (blobuploader) - INFO - Done attempting. 09:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:28 INFO - (blobuploader) - INFO - Done attempting. 09:58:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:58:28 INFO - Return code: 0 09:58:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:58:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:58:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec11caa81ebe66dc4349cd3f77928e3cd32025d17971acef06a4a6533ebda518436cd65e3302c9f5169e7a9384a1a908cada31281b6cc5a0897a25c88f4f113b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07de430dd578ac535fb2e9bd595c29c189017f6c1f66473578c65a6eef44a036ec30b9c96f9d405917bb955805bdaba6e0ebd81709cbf0492dfaad2041e16183", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d07429221abfc13139f42a39d0b7ad74637531007b61cc4edcfc5037545d83a8bcb74b1da6139c17ec745500c9ef73982ca0c34de278a5fd6f6c096a0662e71a"} 09:58:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:58:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:58:28 INFO - Contents: 09:58:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec11caa81ebe66dc4349cd3f77928e3cd32025d17971acef06a4a6533ebda518436cd65e3302c9f5169e7a9384a1a908cada31281b6cc5a0897a25c88f4f113b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07de430dd578ac535fb2e9bd595c29c189017f6c1f66473578c65a6eef44a036ec30b9c96f9d405917bb955805bdaba6e0ebd81709cbf0492dfaad2041e16183", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d07429221abfc13139f42a39d0b7ad74637531007b61cc4edcfc5037545d83a8bcb74b1da6139c17ec745500c9ef73982ca0c34de278a5fd6f6c096a0662e71a"} 09:58:28 INFO - Running post-run listener: copy_logs_to_upload_dir 09:58:28 INFO - Copying logs to upload dir... 09:58:28 INFO - mkdir: /builds/slave/test/build/upload/logs 09:58:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.004712 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-02-07 09:58:28.452971) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 09:58:28.456705) ========= 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.Qq88Imx7H3/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.gFMRLmJptz/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec11caa81ebe66dc4349cd3f77928e3cd32025d17971acef06a4a6533ebda518436cd65e3302c9f5169e7a9384a1a908cada31281b6cc5a0897a25c88f4f113b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07de430dd578ac535fb2e9bd595c29c189017f6c1f66473578c65a6eef44a036ec30b9c96f9d405917bb955805bdaba6e0ebd81709cbf0492dfaad2041e16183", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d07429221abfc13139f42a39d0b7ad74637531007b61cc4edcfc5037545d83a8bcb74b1da6139c17ec745500c9ef73982ca0c34de278a5fd6f6c096a0662e71a"} build_url:https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011096 build_url: 'https://queue.taskcluster.net/v1/task/GW9GYKApTg6StIQk__Hk8A/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec11caa81ebe66dc4349cd3f77928e3cd32025d17971acef06a4a6533ebda518436cd65e3302c9f5169e7a9384a1a908cada31281b6cc5a0897a25c88f4f113b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07de430dd578ac535fb2e9bd595c29c189017f6c1f66473578c65a6eef44a036ec30b9c96f9d405917bb955805bdaba6e0ebd81709cbf0492dfaad2041e16183", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d07429221abfc13139f42a39d0b7ad74637531007b61cc4edcfc5037545d83a8bcb74b1da6139c17ec745500c9ef73982ca0c34de278a5fd6f6c096a0662e71a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-07 09:58:28.490922) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:58:28.491273) ========= 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.Qq88Imx7H3/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.gFMRLmJptz/Listeners TMPDIR=/var/folders/mn/l_v3fwc55qs05rgmm7hhhx2c00000w/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.005015 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-07 09:58:28.540215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 09:58:28.540672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-07 09:58:28.541017) ========= ========= Total master_lag: 3.35 =========