builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0178 starttime: 1478263176.99 results: success (0) buildid: 20161104031921 builduid: 10e0142511e243baa1f549e9a2e78873 revision: e00ed3bd29f9cc2ba1dff27acce50d65b57e8c0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:36.988416) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:36.988819) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:36.989102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:37.013907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:37.014196) ========= 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.tF0PVublDP/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.frVx6cfApF/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-04 05:39:37-- 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% 161M=0s 2016-11-04 05:39:37 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155097 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:37.197394) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:37.197725) ========= 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.tF0PVublDP/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.frVx6cfApF/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.025548 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:37.245868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-11-04 05:39:37.246206) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e00ed3bd29f9cc2ba1dff27acce50d65b57e8c0f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e00ed3bd29f9cc2ba1dff27acce50d65b57e8c0f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tF0PVublDP/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.frVx6cfApF/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-04 05:39:37,327 truncating revision to first 12 chars 2016-11-04 05:39:37,328 Setting DEBUG logging. 2016-11-04 05:39:37,328 attempt 1/10 2016-11-04 05:39:37,328 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e00ed3bd29f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-04 05:39:38,899 unpacking tar archive at: mozilla-central-e00ed3bd29f9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.819773 ========= master_lag: 2.70 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-11-04 05:39:41.765344) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:41.765699) ========= script_repo_revision: e00ed3bd29f9cc2ba1dff27acce50d65b57e8c0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:41.766140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:41.770441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 05:39:41.891456) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-11-04 05:39:41.891823) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tF0PVublDP/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.frVx6cfApF/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:39:42 INFO - MultiFileLogger online at 20161104 05:39:42 in /builds/slave/test 05:39:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:39:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:39:42 INFO - {'append_to_log': False, 05:39:42 INFO - 'base_work_dir': '/builds/slave/test', 05:39:42 INFO - 'blob_upload_branch': 'Firefox', 05:39:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:39:42 INFO - 'branch': 'Firefox', 05:39:42 INFO - 'buildbot_json_path': 'buildprops.json', 05:39:42 INFO - 'config_files': ('talos/mac_config.py',), 05:39:42 INFO - 'default_actions': ('clobber', 05:39:42 INFO - 'read-buildbot-config', 05:39:42 INFO - 'download-and-extract', 05:39:42 INFO - 'populate-webroot', 05:39:42 INFO - 'create-virtualenv', 05:39:42 INFO - 'install', 05:39:42 INFO - 'run-tests'), 05:39:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:39:42 INFO - 'download_minidump_stackwalk': True, 05:39:42 INFO - 'download_symbols': 'ondemand', 05:39:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:39:42 INFO - 'tooltool.py': '/tools/tooltool.py', 05:39:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:39:42 INFO - '/tools/misc-python/virtualenv.py')}, 05:39:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:39:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:39:42 INFO - 'installer_path': 'installer.exe', 05:39:42 INFO - 'log_level': 'info', 05:39:42 INFO - 'log_name': 'talos', 05:39:42 INFO - 'log_to_console': True, 05:39:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:39:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:39:42 INFO - 'opt_config_files': (), 05:39:42 INFO - 'pip_index': False, 05:39:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:39:42 INFO - 'cmd': ('bash', 05:39:42 INFO - '-c', 05:39:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:39:42 INFO - 'enabled': True, 05:39:42 INFO - 'halt_on_failure': False, 05:39:42 INFO - 'name': 'check_screen_resolution'},), 05:39:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:39:42 INFO - 'cmd': ('bash', 05:39:42 INFO - '-c', 05:39:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:39:42 INFO - 'enabled': True, 05:39:42 INFO - 'halt_on_failure': False, 05:39:42 INFO - 'name': 'check_screen_resolution'},), 05:39:42 INFO - 'run_cmd_checks_enabled': True, 05:39:42 INFO - 'sps_profile': False, 05:39:42 INFO - 'sps_profile_interval': 0, 05:39:42 INFO - 'suite': 'dromaeojs', 05:39:42 INFO - 'system_bits': '32', 05:39:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:39:42 INFO - 'title': 't-yosemite-r7-0178', 05:39:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:39:42 INFO - 'use_talos_json': True, 05:39:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:39:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:39:42 INFO - 'work_dir': 'build'} 05:39:42 INFO - [mozharness: 2016-11-04 12:39:42.104326Z] Running clobber step. 05:39:42 INFO - Running pre-action listener: _resource_record_pre_action 05:39:42 INFO - Running main action method: clobber 05:39:42 INFO - rmtree: /builds/slave/test/build 05:39:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:39:44 INFO - Running post-action listener: _resource_record_post_action 05:39:44 INFO - [mozharness: 2016-11-04 12:39:44.243887Z] Finished clobber step (success) 05:39:44 INFO - [mozharness: 2016-11-04 12:39:44.244134Z] Running read-buildbot-config step. 05:39:44 INFO - Running pre-action listener: _resource_record_pre_action 05:39:44 INFO - Running main action method: read_buildbot_config 05:39:44 INFO - Using buildbot properties: 05:39:44 INFO - { 05:39:44 INFO - "project": "", 05:39:44 INFO - "product": "firefox", 05:39:44 INFO - "script_repo_revision": "production", 05:39:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:39:44 INFO - "repository": "", 05:39:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:39:44 INFO - "buildid": "20161104031921", 05:39:44 INFO - "stage_platform": "macosx64", 05:39:44 INFO - "basedir": "/builds/slave/test", 05:39:44 INFO - "nightly_build": "True", 05:39:44 INFO - "buildnumber": 21, 05:39:44 INFO - "slavename": "t-yosemite-r7-0178", 05:39:44 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:39:44 INFO - "platform": "yosemite_r7", 05:39:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:39:44 INFO - "branch": "mozilla-central", 05:39:44 INFO - "repo_path": "mozilla-central", 05:39:44 INFO - "revision": "e00ed3bd29f9cc2ba1dff27acce50d65b57e8c0f", 05:39:44 INFO - "pgo_build": "False", 05:39:44 INFO - "builduid": "10e0142511e243baa1f549e9a2e78873", 05:39:44 INFO - "slavebuilddir": "test" 05:39:44 INFO - } 05:39:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:39:44 INFO - Running post-action listener: _resource_record_post_action 05:39:44 INFO - [mozharness: 2016-11-04 12:39:44.250120Z] Finished read-buildbot-config step (success) 05:39:44 INFO - [mozharness: 2016-11-04 12:39:44.250298Z] Running download-and-extract step. 05:39:44 INFO - Running pre-action listener: _resource_record_pre_action 05:39:44 INFO - Running main action method: download_and_extract 05:39:44 INFO - mkdir: /builds/slave/test/build/tests 05:39: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')]} 05:39:44 INFO - trying https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:39:44 INFO - Downloading https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:39:45 INFO - Downloaded 1199 bytes. 05:39:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:39:45 INFO - Using the following test package requirements: 05:39:45 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:39:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:39:45 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:39:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:39:45 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:39:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:39:45 INFO - u'jsshell-mac.zip'], 05:39:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:39:45 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:39:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:39:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:39:45 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:39:45 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:39:45 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:39:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:39:45 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:39:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:39:45 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:39:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:39:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:39:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:39:45 INFO - Fetch https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:39:46 INFO - Http code: 200 05:39:46 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 05:39:46 INFO - x-amz-cf-id: nmSeiwWFNKQ-5l7AuUTMI0ICe4HJxIuo79hhoWPz_mpVqEy53DyKyA== 05:39:46 INFO - x-amz-version-id: udkt78_qbSYkniyyldvtRcjDaXR7v.yl 05:39:46 INFO - Expected file size: 16398020 05:39:46 INFO - Obtained file size: 16398020 05:39:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:39:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:39:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:39:53 INFO - Fetch https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:39:53 INFO - Http code: 200 05:39:53 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 05:39:53 INFO - x-amz-cf-id: tIfevcdqolsvUAG4PFZvlu-gFEzGDXPSho_9pFiDS5lz3BrVNTJ17w== 05:39:53 INFO - x-amz-version-id: udkt78_qbSYkniyyldvtRcjDaXR7v.yl 05:39:54 INFO - Expected file size: 16398020 05:39:54 INFO - Obtained file size: 16398020 05:40:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:40:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:40:00 INFO - Fetch https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:40:01 INFO - Http code: 200 05:40:01 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 05:40:01 INFO - x-amz-cf-id: fEnI5ksVv3WMlKTLjoQ0otjx4-wqYKlzxLlkx78W7B3N31rhuZh-Rw== 05:40:01 INFO - x-amz-version-id: HrlBGahQZoTlGb6OVzjl0LFMPrH9jkRx 05:40:01 INFO - Expected file size: 14409038 05:40:01 INFO - Obtained file size: 14409038 05:40:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:01 INFO - trying https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:01 INFO - Downloading https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:40:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:40:04 INFO - Downloaded 111961432 bytes. 05:40:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:04 INFO - mkdir: /builds/slave/test/properties 05:40:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:40:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:40:04 INFO - Contents: 05:40:04 INFO - build_url:https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:40:05 INFO - Running post-action listener: _resource_record_post_action 05:40:05 INFO - Running post-action listener: set_extra_try_arguments 05:40:05 INFO - [mozharness: 2016-11-04 12:40:05.243933Z] Finished download-and-extract step (success) 05:40:05 INFO - [mozharness: 2016-11-04 12:40:05.244064Z] Running populate-webroot step. 05:40:05 INFO - Running pre-action listener: _resource_record_pre_action 05:40:05 INFO - Running main action method: populate_webroot 05:40:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:05 INFO - '--tppagecycles', 05:40:05 INFO - '7'], 05:40:05 INFO - 'tests': ['tsvgm']}}, 05:40:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:40:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:40:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:40:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:05 INFO - 'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:05 INFO - 'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['damp', 'tps']}, 05:40:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:05 INFO - 'tests': ['damp', 'tps']}, 05:40:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['dromaeo_dom']}, 05:40:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['basic_compositor_video']}, 05:40:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:40:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['a11yr', 05:40:05 INFO - 'ts_paint', 05:40:05 INFO - 'tpaint', 05:40:05 INFO - 'sessionrestore', 05:40:05 INFO - 'sessionrestore_no_auto_restore', 05:40:05 INFO - 'tabpaint']}, 05:40:05 INFO - 'other-e10s': {'tests': ['a11yr', 05:40:05 INFO - 'ts_paint', 05:40:05 INFO - 'tpaint', 05:40:05 INFO - 'sessionrestore', 05:40:05 INFO - 'sessionrestore_no_auto_restore', 05:40:05 INFO - 'tabpaint']}, 05:40:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:40:05 INFO - 'ts_paint', 05:40:05 INFO - 'tpaint', 05:40:05 INFO - 'sessionrestore', 05:40:05 INFO - 'sessionrestore_no_auto_restore', 05:40:05 INFO - 'tabpaint']}, 05:40:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:40:05 INFO - 'ts_paint', 05:40:05 INFO - 'tpaint', 05:40:05 INFO - 'sessionrestore', 05:40:05 INFO - 'sessionrestore_no_auto_restore', 05:40:05 INFO - 'tabpaint']}, 05:40:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['a11yr', 05:40:05 INFO - 'ts_paint', 05:40:05 INFO - 'tpaint', 05:40:05 INFO - 'sessionrestore', 05:40:05 INFO - 'sessionrestore_no_auto_restore', 05:40:05 INFO - 'tabpaint']}, 05:40:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['a11yr', 05:40:05 INFO - 'ts_paint', 05:40:05 INFO - 'tpaint', 05:40:05 INFO - 'sessionrestore', 05:40:05 INFO - 'sessionrestore_no_auto_restore', 05:40:05 INFO - 'tabpaint']}, 05:40:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['tsvgx', 05:40:05 INFO - 'tsvgr_opacity', 05:40:05 INFO - 'tart', 05:40:05 INFO - 'tscrollx', 05:40:05 INFO - 'cart']}, 05:40:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:40:05 INFO - 'tsvgr_opacity', 05:40:05 INFO - 'tart', 05:40:05 INFO - 'tscrollx', 05:40:05 INFO - 'cart']}, 05:40:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:05 INFO - 'talos_options': ['--disable-e10s'], 05:40:05 INFO - 'tests': ['tp5o']}, 05:40:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:05 INFO - 'tests': ['tp5o']}, 05:40:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:05 INFO - 'talos_options': ['--disable-e10s', 05:40:05 INFO - '--xperf_path', 05:40:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:05 INFO - 'tests': ['tp5n']}, 05:40:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:05 INFO - 'talos_options': ['--xperf_path', 05:40:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:05 INFO - 'tests': ['tp5n']}}, 05:40:05 INFO - 'talos.zip': {'path': '', 05:40:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:05 INFO - Running post-action listener: _resource_record_post_action 05:40:05 INFO - [mozharness: 2016-11-04 12:40:05.262577Z] Finished populate-webroot step (success) 05:40:05 INFO - [mozharness: 2016-11-04 12:40:05.262686Z] Running create-virtualenv step. 05:40:05 INFO - Running pre-action listener: _resource_record_pre_action 05:40:05 INFO - Running main action method: create_virtualenv 05:40:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:40:05 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 05:40:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:40:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:05 INFO - Using real prefix '/tools/python27' 05:40:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:40:06 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:09 INFO - Installing pip.................done. 05:40:09 INFO - Return code: 0 05:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:40:09 INFO - Reading from file tmpfile_stdout 05:40:09 INFO - Output received: 05:40:09 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) 05:40:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:09 INFO - 'HOME': '/Users/cltbld', 05:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:09 INFO - 'LOGNAME': 'cltbld', 05:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:09 INFO - 'MOZ_NO_REMOTE': '1', 05:40:09 INFO - 'NO_EM_RESTART': '1', 05:40:09 INFO - 'PAGER': '/bin/cat', 05:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:09 INFO - 'PWD': '/builds/slave/test', 05:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:09 INFO - 'SHELL': '/bin/bash', 05:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:09 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:09 INFO - 'USER': 'cltbld', 05:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:09 INFO - 'XPC_FLAGS': '0x0', 05:40:09 INFO - 'XPC_SERVICE_NAME': '0', 05:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:09 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 05:40:09 INFO - Cleaning up... 05:40:09 INFO - Return code: 0 05:40:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:09 INFO - 'HOME': '/Users/cltbld', 05:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:09 INFO - 'LOGNAME': 'cltbld', 05:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:09 INFO - 'MOZ_NO_REMOTE': '1', 05:40:09 INFO - 'NO_EM_RESTART': '1', 05:40:09 INFO - 'PAGER': '/bin/cat', 05:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:09 INFO - 'PWD': '/builds/slave/test', 05:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:09 INFO - 'SHELL': '/bin/bash', 05:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:09 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:09 INFO - 'USER': 'cltbld', 05:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:09 INFO - 'XPC_FLAGS': '0x0', 05:40:09 INFO - 'XPC_SERVICE_NAME': '0', 05:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:09 INFO - Downloading/unpacking psutil>=3.1.1 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:13 INFO - Installing collected packages: psutil 05:40:13 INFO - Running setup.py install for psutil 05:40:13 INFO - building 'psutil._psutil_osx' extension 05:40:13 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 05:40:13 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 05:40:13 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 05:40:14 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 05:40:14 INFO - building 'psutil._psutil_posix' extension 05:40:14 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 05:40:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:40:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:40:14 INFO - ^ 05:40:14 INFO - 1 warning generated. 05:40:14 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 05:40:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:14 INFO - Successfully installed psutil 05:40:14 INFO - Cleaning up... 05:40:14 INFO - Return code: 0 05:40:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:14 INFO - 'HOME': '/Users/cltbld', 05:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:14 INFO - 'LOGNAME': 'cltbld', 05:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:14 INFO - 'MOZ_NO_REMOTE': '1', 05:40:14 INFO - 'NO_EM_RESTART': '1', 05:40:14 INFO - 'PAGER': '/bin/cat', 05:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:14 INFO - 'PWD': '/builds/slave/test', 05:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:14 INFO - 'SHELL': '/bin/bash', 05:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:14 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:14 INFO - 'USER': 'cltbld', 05:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:14 INFO - 'XPC_FLAGS': '0x0', 05:40:14 INFO - 'XPC_SERVICE_NAME': '0', 05:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:40:18 INFO - Installing collected packages: mozsystemmonitor 05:40:18 INFO - Running setup.py install for mozsystemmonitor 05:40:18 INFO - Successfully installed mozsystemmonitor 05:40:18 INFO - Cleaning up... 05:40:18 INFO - Return code: 0 05:40:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:40:18 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')]} 05:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:18 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')]} 05:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:18 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 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40:18 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 05:40:18 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 05:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:18 INFO - 'HOME': '/Users/cltbld', 05:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:18 INFO - 'LOGNAME': 'cltbld', 05:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:18 INFO - 'MOZ_NO_REMOTE': '1', 05:40:18 INFO - 'NO_EM_RESTART': '1', 05:40:18 INFO - 'PAGER': '/bin/cat', 05:40:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:18 INFO - 'PWD': '/builds/slave/test', 05:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:18 INFO - 'SHELL': '/bin/bash', 05:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:18 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:18 INFO - 'USER': 'cltbld', 05:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:18 INFO - 'XPC_FLAGS': '0x0', 05:40:18 INFO - 'XPC_SERVICE_NAME': '0', 05:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40: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 05:40:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:40:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:21 INFO - warning: no files found matching '*.txt' 05:40:21 INFO - no previously-included directories found matching 'build' 05:40:21 INFO - no previously-included directories found matching 'dist' 05:40:21 INFO - no previously-included directories found matching '.git*' 05:40:21 INFO - Installing collected packages: jsonschema, functools32 05:40:21 INFO - Running setup.py install for functools32 05:40:21 INFO - warning: no files found matching '*.txt' 05:40:21 INFO - no previously-included directories found matching 'build' 05:40:21 INFO - no previously-included directories found matching 'dist' 05:40:21 INFO - no previously-included directories found matching '.git*' 05:40:21 INFO - Successfully installed jsonschema functools32 05:40:21 INFO - Cleaning up... 05:40:22 INFO - Return code: 0 05:40:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', '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 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:40: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 functools32==3.2.3-2 05:40:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:22 INFO - 'HOME': '/Users/cltbld', 05:40:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:22 INFO - 'LOGNAME': 'cltbld', 05:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:22 INFO - 'MOZ_NO_REMOTE': '1', 05:40:22 INFO - 'NO_EM_RESTART': '1', 05:40:22 INFO - 'PAGER': '/bin/cat', 05:40:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:22 INFO - 'PWD': '/builds/slave/test', 05:40:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:22 INFO - 'SHELL': '/bin/bash', 05:40:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:22 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:22 INFO - 'USER': 'cltbld', 05:40:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:22 INFO - 'XPC_FLAGS': '0x0', 05:40:22 INFO - 'XPC_SERVICE_NAME': '0', 05:40:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:40:22 INFO - Cleaning up... 05:40:22 INFO - Return code: 0 05:40:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:40: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')]} 05:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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')]} 05:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40: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', '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 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:40: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 blobuploader==1.2.4 05:40:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:22 INFO - 'HOME': '/Users/cltbld', 05:40:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:22 INFO - 'LOGNAME': 'cltbld', 05:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:22 INFO - 'MOZ_NO_REMOTE': '1', 05:40:22 INFO - 'NO_EM_RESTART': '1', 05:40:22 INFO - 'PAGER': '/bin/cat', 05:40:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:22 INFO - 'PWD': '/builds/slave/test', 05:40:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:22 INFO - 'SHELL': '/bin/bash', 05:40:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:22 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:22 INFO - 'USER': 'cltbld', 05:40:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:22 INFO - 'XPC_FLAGS': '0x0', 05:40:22 INFO - 'XPC_SERVICE_NAME': '0', 05:40:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:40:22 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 05:40:22 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 05:40:22 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 05:40:22 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 05:40:22 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 05:40:22 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 05:40:24 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:40:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:26 INFO - Downloading docopt-0.6.1.tar.gz 05:40:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:26 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:26 INFO - Running setup.py install for blobuploader 05:40:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:40:26 INFO - Running setup.py install for requests 05:40:26 INFO - Running setup.py install for docopt 05:40:27 INFO - Successfully installed blobuploader requests docopt 05:40:27 INFO - Cleaning up... 05:40:27 INFO - Return code: 0 05:40:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:27 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')]} 05:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:27 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')]} 05:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:27 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 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40:27 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 05:40:27 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 05:40:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:27 INFO - 'HOME': '/Users/cltbld', 05:40:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:27 INFO - 'LOGNAME': 'cltbld', 05:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:27 INFO - 'MOZ_NO_REMOTE': '1', 05:40:27 INFO - 'NO_EM_RESTART': '1', 05:40:27 INFO - 'PAGER': '/bin/cat', 05:40:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:27 INFO - 'PWD': '/builds/slave/test', 05:40:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:27 INFO - 'SHELL': '/bin/bash', 05:40:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:27 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:27 INFO - 'USER': 'cltbld', 05:40:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:27 INFO - 'XPC_FLAGS': '0x0', 05:40:27 INFO - 'XPC_SERVICE_NAME': '0', 05:40:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wYIC6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-6kA8Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-s1gi3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-lpNxlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:27 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-PYy0nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-DLMp4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-uWaPqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-08Y0YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-1oEYuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wn5kFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pF1Y6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-cyVC7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-DGj3Hi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-NKp35N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:28 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-mnwkjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:29 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-deh2Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:29 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-aaPQ7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:29 INFO - Running setup.py install for manifestparser 05:40:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Running setup.py install for mozcrash 05:40:29 INFO - Running setup.py install for mozdebug 05:40:29 INFO - Running setup.py install for mozdevice 05:40:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:40:29 INFO - Running setup.py install for mozfile 05:40:29 INFO - Running setup.py install for mozhttpd 05:40:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Running setup.py install for mozinfo 05:40:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Running setup.py install for mozInstall 05:40:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Running setup.py install for mozleak 05:40:30 INFO - Running setup.py install for mozlog 05:40:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Running setup.py install for moznetwork 05:40:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:40:30 INFO - Running setup.py install for mozprocess 05:40:31 INFO - Running setup.py install for mozprofile 05:40:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:40:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:40:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:40:31 INFO - Running setup.py install for mozrunner 05:40:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:40:31 INFO - Running setup.py install for mozscreenshot 05:40:31 INFO - Running setup.py install for moztest 05:40:31 INFO - Running setup.py install for mozversion 05:40:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:40:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:31 INFO - Cleaning up... 05:40:31 INFO - Return code: 0 05:40:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:31 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')]} 05:40:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:31 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')]} 05:40:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:31 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 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40:31 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 05:40:31 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 05:40:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:31 INFO - 'HOME': '/Users/cltbld', 05:40:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:31 INFO - 'LOGNAME': 'cltbld', 05:40:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:31 INFO - 'MOZ_NO_REMOTE': '1', 05:40:31 INFO - 'NO_EM_RESTART': '1', 05:40:31 INFO - 'PAGER': '/bin/cat', 05:40:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:31 INFO - 'PWD': '/builds/slave/test', 05:40:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:31 INFO - 'SHELL': '/bin/bash', 05:40:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:31 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:31 INFO - 'USER': 'cltbld', 05:40:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:31 INFO - 'XPC_FLAGS': '0x0', 05:40:31 INFO - 'XPC_SERVICE_NAME': '0', 05:40:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jrDGRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pRqlzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:40:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-lcCemv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Lo_eFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-oOTdEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hzIgwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-9Hr3AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-xObV4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:40:32 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)) 05:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:40:32 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-B2CMTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:40:33 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)) 05:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:40:33 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-A3kdIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:40:33 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)) 05:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:40:33 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pmmFNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:40:33 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)) 05:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:40:33 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-l0Wejt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:40:33 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)) 05:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:40:33 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-WMLcCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:40:33 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)) 05:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:40:33 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-KBpeL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:33 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-FZ9Qr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:40:33 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)) 05:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:40:33 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-lul5AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:40:33 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-CeA1A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:40:33 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)) 05:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:40:33 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)) 05:40:33 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)) 05:40:33 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)) 05:40:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:33 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 05:40:33 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 05:40:33 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 05:40:33 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 05:40:33 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 05:40:33 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 05:40:37 INFO - Downloading blessings-1.6.tar.gz 05:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:37 INFO - Installing collected packages: blessings 05:40:37 INFO - Running setup.py install for blessings 05:40:38 INFO - Successfully installed blessings 05:40:38 INFO - Cleaning up... 05:40:38 INFO - Return code: 0 05:40:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:38 INFO - Reading from file tmpfile_stdout 05:40:38 INFO - Current package versions: 05:40:38 INFO - blessings == 1.6 05:40:38 INFO - blobuploader == 1.2.4 05:40:38 INFO - docopt == 0.6.1 05:40:38 INFO - functools32 == 3.2.3-2 05:40:38 INFO - jsonschema == 2.5.1 05:40:38 INFO - manifestparser == 1.1 05:40:38 INFO - mozInstall == 1.12 05:40:38 INFO - mozcrash == 0.17 05:40:38 INFO - mozdebug == 0.1 05:40:38 INFO - mozdevice == 0.48 05:40:38 INFO - mozfile == 1.2 05:40:38 INFO - mozhttpd == 0.7 05:40:38 INFO - mozinfo == 0.9 05:40:38 INFO - mozleak == 0.1 05:40:38 INFO - mozlog == 3.4 05:40:38 INFO - moznetwork == 0.27 05:40:38 INFO - mozprocess == 0.23 05:40:38 INFO - mozprofile == 0.28 05:40:38 INFO - mozrunner == 6.12 05:40:38 INFO - mozscreenshot == 0.1 05:40:38 INFO - mozsystemmonitor == 0.3 05:40:38 INFO - moztest == 0.7 05:40:38 INFO - mozversion == 1.4 05:40:38 INFO - psutil == 3.1.1 05:40:38 INFO - requests == 1.2.3 05:40:38 INFO - wsgiref == 0.1.2 05:40:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:38 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 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40:38 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 05:40:38 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 05:40:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:38 INFO - 'HOME': '/Users/cltbld', 05:40:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:38 INFO - 'LOGNAME': 'cltbld', 05:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:38 INFO - 'MOZ_NO_REMOTE': '1', 05:40:38 INFO - 'NO_EM_RESTART': '1', 05:40:38 INFO - 'PAGER': '/bin/cat', 05:40:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:38 INFO - 'PWD': '/builds/slave/test', 05:40:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:38 INFO - 'SHELL': '/bin/bash', 05:40:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:38 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:38 INFO - 'USER': 'cltbld', 05:40:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:38 INFO - 'XPC_FLAGS': '0x0', 05:40:38 INFO - 'XPC_SERVICE_NAME': '0', 05:40:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 INFO - Cleaning up... 05:40:39 INFO - Return code: 0 05:40:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:40:39 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')]} 05:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 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')]} 05:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 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 0x106530490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064a6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec71598220>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, '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.tF0PVublDP/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.frVx6cfApF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 05:40:39 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 05:40:39 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 05:40:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:40:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:40:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:40:39 INFO - 'HOME': '/Users/cltbld', 05:40:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:40:39 INFO - 'LOGNAME': 'cltbld', 05:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:39 INFO - 'MOZ_NO_REMOTE': '1', 05:40:39 INFO - 'NO_EM_RESTART': '1', 05:40:39 INFO - 'PAGER': '/bin/cat', 05:40:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:40:39 INFO - 'PWD': '/builds/slave/test', 05:40:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:40:39 INFO - 'SHELL': '/bin/bash', 05:40:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:40:39 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:40:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:40:39 INFO - 'USER': 'cltbld', 05:40:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:40:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:39 INFO - 'XPC_FLAGS': '0x0', 05:40:39 INFO - 'XPC_SERVICE_NAME': '0', 05:40:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:40:39 INFO - Cleaning up... 05:40:39 INFO - Return code: 0 05:40:39 INFO - Running post-action listener: _resource_record_post_action 05:40:39 INFO - Running post-action listener: _start_resource_monitoring 05:40:39 INFO - Starting resource monitoring. 05:40:39 INFO - [mozharness: 2016-11-04 12:40:39.489313Z] Finished create-virtualenv step (success) 05:40:39 INFO - [mozharness: 2016-11-04 12:40:39.490240Z] Running install step. 05:40:39 INFO - Running pre-action listener: _resource_record_pre_action 05:40:39 INFO - Running main action method: install 05:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:40:39 INFO - Reading from file tmpfile_stdout 05:40:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:40:39 INFO - Reading from file tmpfile_stdout 05:40:39 INFO - Output received: 05:40:39 INFO - Usage: mozinstall [options] installer 05:40:39 INFO - Options: 05:40:39 INFO - -h, --help show this help message and exit 05:40:39 INFO - -d DEST, --destination=DEST 05:40:39 INFO - Directory to install application into. [default: 05:40:39 INFO - "/builds/slave/test"] 05:40:39 INFO - --app=APP Application being installed. [default: firefox] 05:40:39 INFO - mkdir: /builds/slave/test/build/application 05:40:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:41:14 INFO - Reading from file tmpfile_stdout 05:41:14 INFO - Output received: 05:41:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:41:14 INFO - Running post-action listener: _resource_record_post_action 05:41:14 INFO - [mozharness: 2016-11-04 12:41:14.880374Z] Finished install step (success) 05:41:14 INFO - [mozharness: 2016-11-04 12:41:14.880520Z] Running run-tests step. 05:41:14 INFO - Running pre-action listener: _resource_record_pre_action 05:41:14 INFO - Running main action method: run_tests 05:41:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:41:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:41:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:41:14 INFO - 2016-11-04 05:41:14.894 screenresolution[1636:7400] starting screenresolution argv=screenresolution get 05:41:14 INFO - 2016-11-04 05:41:14.896 screenresolution[1636:7400] Display 0: 1600x1200x32@60 05:41:14 INFO - 2016-11-04 05:41:14.902 screenresolution[1637:7402] starting screenresolution argv=screenresolution list 05:41:14 INFO - Available Modes on Display 0 05:41:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:41:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:41:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:41:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:41:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:41:15 INFO - Intel Iris: 05:41:15 INFO - Chipset Model: Intel Iris 05:41:15 INFO - Type: GPU 05:41:15 INFO - Bus: Built-In 05:41:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:41:15 INFO - Vendor: Intel (0x8086) 05:41:15 INFO - Device ID: 0x0a2e 05:41:15 INFO - Revision ID: 0x0009 05:41:15 INFO - Displays: 05:41:15 INFO - Display: 05:41:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:41:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:41:15 INFO - Display Serial Number: 1600x1200 60 05:41:15 INFO - Main Display: Yes 05:41:15 INFO - Mirror: Off 05:41:15 INFO - Online: Yes 05:41:15 INFO - Rotation: Supported 05:41:15 INFO - Return code: 0 05:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:41:15 INFO - Python 2.7.3 05:41:15 INFO - Return code: 0 05:41:15 INFO - grabbing minidump binary from tooltool 05:41: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')]} 05:41:15 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 0x106344d30>, '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 0x10616adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10633cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:41:15 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 05:41:15 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 05:41:15 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 05:41:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:15 INFO - Return code: 0 05:41:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:41:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:41:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:41:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:41:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 05:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --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 05:41:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tF0PVublDP/Render', 05:41:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:41:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:41:15 INFO - 'HOME': '/Users/cltbld', 05:41:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:41:15 INFO - 'LOGNAME': 'cltbld', 05:41:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:41:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:15 INFO - 'MOZ_NO_REMOTE': '1', 05:41:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:41:15 INFO - 'NO_EM_RESTART': '1', 05:41:15 INFO - 'PAGER': '/bin/cat', 05:41:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:41:15 INFO - 'PWD': '/builds/slave/test', 05:41:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:41:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:41:15 INFO - 'SHELL': '/bin/bash', 05:41:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.frVx6cfApF/Listeners', 05:41:15 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 05:41:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:41:15 INFO - 'USER': 'cltbld', 05:41:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:41:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:15 INFO - 'XPC_FLAGS': '0x0', 05:41:15 INFO - 'XPC_SERVICE_NAME': '0', 05:41:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:41:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 05:41:15 INFO - mozversion application_buildid: 20161104031921 05:41:15 INFO - mozversion application_changeset: e00ed3bd29f9cc2ba1dff27acce50d65b57e8c0f 05:41:15 INFO - mozversion application_display_name: Nightly 05:41:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:15 INFO - mozversion application_name: Firefox 05:41:15 INFO - mozversion application_remotingname: firefox 05:41:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:41:15 INFO - mozversion application_vendor: Mozilla 05:41:15 INFO - mozversion application_version: 52.0a1 05:41:15 INFO - mozversion platform_buildid: 20161104031921 05:41:15 INFO - mozversion platform_changeset: e00ed3bd29f9cc2ba1dff27acce50d65b57e8c0f 05:41:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:41:15 INFO - mozversion platform_version: 52.0a1 05:41:15 INFO - using testdate: 1478263275 05:41:15 INFO - actual date: 1478263275 05:41:15 INFO - starting webserver on 'localhost:49274' 05:41:15 INFO - SUITE-START | Running 2 tests 05:41:15 INFO - TEST-START | dromaeo_css 05:41:15 INFO - operating with platform_type : mac_ 05:41:15 INFO - Initialising browser for dromaeo_css test... 05:41:15 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp9PR0kd/profile http://localhost:49274/getInfo.html) 05:41:18 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 05:41:18 INFO - PROCESS | 1647 | colorDepth:24 05:41:18 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 05:41:18 INFO - PROCESS | 1647 | __metrics 05:41:18 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:41:18 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:19 INFO - TEST-INFO | 1647: exit 0 05:41:19 INFO - Browser initialized. 05:41:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:19 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp9PR0kd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:31 INFO - PROCESS | 1649 | RSS: Main: 232337408 05:41:31 INFO - PROCESS | 1649 | 05:42:23 INFO - PROCESS | 1649 | 1478263343213 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:44:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:44:37 INFO - PROCESS | 1649 | RSS: Main: 400326656 05:44:37 INFO - PROCESS | 1649 | 05:47:40 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:47:40 INFO - PROCESS | 1649 | RSS: Main: 374693888 05:47:40 INFO - PROCESS | 1649 | 05:50:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:50:43 INFO - PROCESS | 1649 | RSS: Main: 338046976 05:50:43 INFO - PROCESS | 1649 | 05:53:46 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:53:46 INFO - PROCESS | 1649 | RSS: Main: 336830464 05:53:46 INFO - PROCESS | 1649 | 05:56:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:56:50 INFO - PROCESS | 1649 | RSS: Main: 327929856 05:56:50 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:59:54 INFO - PROCESS | 1649 | RSS: Main: 549564416 05:59:54 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | __start_tp_report 05:59:54 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 05:59:54 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 05:59:54 INFO - PROCESS | 1649 | |i|pagename|runs| 05:59:54 INFO - PROCESS | 1649 | |0;dojo.html;2800.9859950700256;2815.774738020958;3367.9831600841994;3393.8133402662843;3423.7261019118473;5642.1254705520605;5689.061304884699;5707.885842283152;5800.53595712343;5801.622894511854;5722.113072473773;5733.397993210715;5828.9417105828925;5884.823455296348;5904.498117659993;5130.07658621448;5133.435322114565;5180.611454140936;5211.921821172686;5255.553277971377;5330.866728331784;5334.733263336837;5346.759395827177;5362.1420572708375;5371.785128594852;5302.814401495968;5322.840314790563;5347.7058761768085;5354.973225133869;5395.244665746799;5143.254228136937;5165.276861239429;5199.66202196856;5205.141151709963;5217.869553261199;5220.321358223407;5222.686638801684;5240.423553409122;5260.526552610283;5303.992241474108;5734.684592347419;5756.222909907151;5764.51001664859;5765.596408251424;5787.421257874221;6102.389761023862;6119.045604113885;6130.275842464065;6135.07973803933;6175.289841668221;6112.473085128069;6135.049067394516;6152.169457123276;6177.351378105279;6210.099535567318;5929.0513517836935;5932.3474417814;5946.524278057832;5951.910721339226;5994.640321580676;6222.875542489215;6287.874242515216;6296.055591661196;6299.401556852184;6303.464205542488;5208.84373468789;6031.09533569968;6094.939050609437;6157.0456579230295;6168.691565421711;6117.857853872241;6149.446549810538;6213.844653883689;6309.274433440213;6330.39861213184;6195.96902015487;6250.031245157008;6270.122182894398;6281.152044473937;6282.4974002079725;6125.081237814364;6266.592671476431;6269.279032911274;6280.811575652647;6290.433860952537;4868.002059577849;4884.95115048852;4901.534354236342;4901.950980490221;4955.207166853286;4432.312991486325;4464.241079016575;4480.103979204172;4503.009337945647;4532.841350552781;5801.245838041028;5810.070388737781;5815.389384114692;5832.24180856486;5878.088896221093;6118.314626315956;6168.25980882297;6251.624902505864;6271;6343.904841427382;5729.9713501432225;5733.512651424592;5780;5781.1328300754385;5868.853278667982;5408.215808707715;5429.375621803464;5432.782688692487;5438.782448702008;5438.91841622376;6253.155823963707;6296.842578935563;6299.874002519924;6307.842303942438;6310.0534919761485;6128.3503509891225;6152.50779937595;6197.907031394442;6199.597026193283;6216.191895053614;6159.9528080227365;6194.349593292639;6284.151639528788;6306.810795676137;6315;6207.255129384503;6227.595206311576;6250.49996000328;6260.843478913063;6267;5931.406859314034;6061.424164704346;6100.974805932192;6144.56988010835;6170.9074363885475;6097.695115244309;6109.283207920342;6122.550631083031;6177.104319873683;6189.84525386869;6027.78902738402;6111.171737814916;6153.876922461615;6165.414285642857;6166.537509686881;5518.117101263779;5799.913001305068;5819.0689489681445;6043.54673399488;6049.455549000611;6027.36712645166;6085.878282434415;6100.267967843887;6129.785457508966;6145.217886812953;5083.703655567807;5789.305283365855;5967.850803729942;6015.428534289235;6029.035354343284 05:59:54 INFO - PROCESS | 1649 | |1;ext.html;462.52591094128513;465.5135383524217;483.164126061913;510.36204744069914;529.998303206939;30011.249718757015;31227;31273.84363078184;31299.843500782492;31348.216294592647;31523.527147092755;31941.284990775755;32052.679473205262;32282.67717322832;40625.59374406255;9225.16973472389;9421.576029078708;9428.198603118708;9429.81140377192;9448.244140468745;9141.497217653026;9242.353035287533;9265.490398028105;9266.258699304073;9277.95361023194;9247.398919070272;9296.023917488668;9297.116773906468;9297.907020929806;9359.391639543443;9201.125893040151;9265.953670231673;9277.072292770668;9293.860592091123;9298.767530811716;7083.964580177066;9275.814483710355;9315.254779617615;9322.580483878173;9323.627054917795;38962.80518597389;39307.60692393068;39315.41026884599;39315.60684393177;39330.41004384936;3232.8060316380856;3317.5023746437987;3595.5505561804775;3946.3291240489184;4085.85699500519;29289.12132636003;29700.960466383574;30981.535276970862;31160.688393116234;31273.84363078193;2655.7742591879714;3117.392108538836;3274.1650879025933;3334.649861764504;3338.9499157512655;472635;475506;477066;477430;479432.9999999965;58430.415695843345;58794.41205587975;58846.70576647175;58884.41115588875;58981.41018589845;62177;62592.06111908325;62615.6869215651;62670;62681.373186268465;15689.293981770848;15916.522504324888;15939.521814345588;15947.521574352788;15948;12226.816597751042;12279.263244205376;12297.954673852644;12304.261744295192;12312.445939932724;16763.664726705643;17460.214290356966;17518.649627007388;17602.559936001704;17621.383251586132;5105.8723531912;5898.233229680114;6059.7273122709585;6086.513078953673;6125.96937015321;830.3647709502236;882.3294296334832;949.9145076943108;977;1012.2661070723814;28220.43559128847;29207.707922920497;29442.969496067963;29746.8888524867;29962.700372996427;947.9952600237093;1034.9482525873827;1037.9273450858368;1061.6125114333367;1085.6417382263835;14765.483208087666;15722.29249683767;15865.04809711421;16097.678046439005;16389.0166590005;644569;649738;650326;651113;651982.7400862966;57655.423445765846;57798.7110064447;57887.13169302464;57961.710191449616;58040.70979645075;1189.8453201083803;1226.4971361742;1234.160770675949;1329.4482789642384;1348.9123206991515;24832.627510587718;30400.543991840583;31074.0677779667;31736.658354114712;32011.35977280488;53998.46001540092;54473;54660.72669636626;54761.45238547563;54961;576291;581041;581339;581340;581941;25656.358591035372;25991.960321586925;26037.609435858856;26756.331091722863;27313.453730925667;46326.76836615795;46812.53187468082;46893.2966005517;47322.52677473319;47783.805404863764;38129.809350953066;38678.03304917287;38932.6106738929;39262.60737392589;40069;38162.80918595389;38253.80873095617;38928;39803.80098099491;40092.59907400889;36879.092796677505;37758;38111.23777524378;38213.808930955165;39360.80319598383;30165.547516787705;33703.4944475838;33833;33945.98162055142;34263.48604770881;22758.65862012038;23809.880950595136;24404;25335.113271035425;26011.959521618923 05:59:54 INFO - PROCESS | 1649 | |2;jquery.html;315.74582461118797;351.03290434851976;365.0945654776155;372.5510759534761;403.6185804414829;14867.107973521597;14964.925175374121;16341.83658163418;20789.688154677693;21183.57632847342;19759.308424205155;20178.19287228509;20800.375988720323;20872.95635218237;21075.15699372027;5739.885202295962;6040.758369665208;6055.878882422349;6073.240844894388;6082.239720034996;5006.874828129289;6540.869182616369;6639.535232533724;6709.8322541936595;6715.731370745164;5675.574331925122;5952.226210592617;6561.901571476432;6567.802965911006;6649.26858045617;6018.939810601903;6067.7572897084065;6069.57512974092;6072.817815465499;6082.482988945945;5039.168537191359;5300.337457817773;5356.330458692663;5384.730763461811;5825.359210486843;12710.555130570478;12801.55194568195;12909.677258068623;12954.676133096653;12981.350932453339;2168.414528077426;2231.9107235710553;2234.218023691711;2243.842930994831;2737.712540183272;9762.170215531689;9778.706638800848;10299.485025748683;10808.189385796019;15677;1795.6139430022477;1830.588117673526;1830.7253911913187;1846.870719049667;1869.2242719271621;108149.45925270324;110471;111417.44291278573;112138.61851413044;112830;8535.829283414421;11270.745850829866;11363.602273920373;11377.772444551229;11500.48247828833;14270.643233919027;14290.42805291417;14300.499482518062;14308.427662893368;14312.49906253297;8094.595270236465;8212.384071194685;8266.338692904554;8273.669053237923;8369.623366948503;8158.102608713037;8189.26296633294;8345.707900223462;8345.833083338299;8375;4319.265724826787;4423.248047831812;4436.933445998313;4509.368688383629;4520.751358675238;1702.8212037736107;1817.5910420155624;1848.4639454558028;1894.9242030318908;1905.2569497895831;886.5833058462513;897.3539051882634;898.4250079948838;901.4456109492746;962.6341990043738;19846.206151754057;21302.893485532473;21502.98958145861;21752.89123554372;22445.78205725715;856.9914300857037;901.5627420700955;932.4824722279064;956.6272399107303;1025.8461230815437;10614.363138211733;10952.616658416917;11373;11394.544218231344;11533.365664888512;577515;585730;591054;599990;601528;76021;135634.39973369153;139569;140956.8040893649;145053.8241926372;995.4823491784232;1006.4464544500496;1031.8142734307746;1032.0969151992008;1032.8708911386077;18868;19100.33148839784;19179.232830686615;19182.616347673247;19208.231670733574;41893;53098.20352694635;56443.43556564382;57773.13340299983;57997.71001144967;57934.4206557929;79541;82035.7694634569;84989;85182.1481785199;7596.544207347577;7878.803029924297;8073.959630201812;8096;8267.917320826955;9139.817203656023;12007.339596321937;12805.359732013549;13158.078934474495;13382.531611393555;9399.906000939904;10141.188704903738;11006.284591501526;11138.498767555317;11573.710657233636;10912.61805836792;11063.557457701601;11114;11321.660350189508;11567.01680357179;11332.376719280519;11337.149713771336;11697.2981621103;11766.352850593299;11812.409379530816;7888;8114.026316842017;8158.3473322132895;8285.053012542168;8444.577771111542;10348.793024139324;11236.438178090899;11457.312561246352;11538.76922461563;11630.6510804676 05:59:54 INFO - PROCESS | 1649 | |3;mootools.html;1304.5694920676178;1337.7792664210406;1467.046419827112;1614;1832.4594244697805;7423.851522969544;7817.648205830744;7818.810732994756;7821.061472623293;7824.100228473727;7613.0483689538805;7928.841423171533;8177.345812335014;8185.959070204641;8279.668813247463;2281.167373908524;2312.4218945263683;2312.560613483441;2312.9653055204185;2317.756635553268;2277.533105713325;2315.444293369596;2334.579775640384;2343.988280058606;2344.6365813298967;2271.5911135995516;2274.8293877959136;2293.2088429491882;2297.3337732057685;2310.6996090508296;2246.3036458697857;2258.796708296253;2284.6915666385075;2286.27982185611;2286.817054635625;2301.4361481437154;2315.166540045582;2318.177047148272;2319.1419174905222;2322.059565875823;8225.136360682101;8364.456310339809;8365.912431383942;8387.077421483631;8387.412881098326;4292.763897985609;4975.278584605248;5221.373435187764;5228.163493841005;5230.503102205284;3490.89527314181;3587.551556055493;3590.4434812604086;3604.2070744436182;3604.2250916053176;1047.2983101322056;1069.9572017119306;1095.315427857589;1097.8408130821067;1098.8132017557034;10757.83863242052;10780.946095269552;10782.838257426145;10786.946065269702;10801.78396432067;4180.143070670505;4352.825886964486;4368.584984426474;4436.423264975532;4448.488423831301;8446.746597602081;8597.52713600758;8607.569621518898;8618.439801412887;8623.827523449496;5068.847934561969;5074.644774865797;5075.061113693979;5076.74616269185;5081.822136225214;3948.2893079245437;4162.937555936664;4775.4269487661;4776.737279449594;4793.281007848781;3541.3709693540745;3599.226166374242;3629.891103266906;3680.245549662313;3681.116532032293;964.2286171063122;1044.5717255925185;1127.639155470258;1131.6548452722;1131.9830202546968;777.941654375924;830.339879795564;845.2012847858838;850.6809946270149;872.0276891266193;5460.808871689472;5614.242077319591;5715.771369145271;5867.3839246879315;5868.794592189253;761.3118751765711;775.5501808950795;798.9880151797728;893.9284857211408;896.6458248991743;3668.3947148720695;3800.1829606634706;3814.256220037066;3905.8437662493184;3909.159530700913;9511.334206605472;9886.30795844284;10079.798404031879;10204;10217.386956782617;9846.803063938682;10186.847197292047;10192.643257485952;10192.789271379492;10209.642662506776;7708.653110609924;7826.373890088779;7887.566183859828;7897.486663366863;7924.088729796147;5572.888542229051;5623.718814059199;5698.31620205578;5708.65748055118;5795.1017592273265;7946.284834364935;9172.12864777845;9260.675876344296;9300.255979521757;9432.575534100844;8941.731748047569;9334;9338.95330523343;9358.485283309483;9366.344355895022;6498.870022599427;6707.932920670731;6708.765193218214;7072.3634872861685;7251.347378735939;7319.780406587811;7392.852142957003;7393.630318484162;7410.96294518524;7639;6659.7003134860015;7027.332403421667;7062.223155452793;7100.396466300423;7173.0316407284345;6919.7232110715;6991.7902462926195;7007.474439416962;7054.4003759681;7067.752628657972;6333.909809762675;6555.983822507519;6592.538522303585;6600.80197594073;6669.09967154428;4157.563455837094;4828.855134345975;4832.251001094836;4918.311436398979;4958.057968985881;4793.544613261734;4800.399950006249;4858.902821943612;4927.384076990376;4999.375078115236 05:59:54 INFO - PROCESS | 1649 | |4;prototype.html;256.6458287563163;294.58463566371415;295.7220212999779;306.953956906464;310.9968900310996;5300.337457817773;5344.839654810357;5380.408155102936;5389.892202155955;5416.377116631588;4377.846775362863;5023.497650234975;5093.344662984527;5164.483551644834;5288.382250785857;3210.855511501982;3549.0417587251427;4020.3768415895584;4031.9395209071886;4066.573009833969;3321.667833216671;4017.698672599552;4026.315526360526;4055.5336136344404;4056.817443215062;3556.911077223077;3583.802890841003;3987.6012398760035;3995;4010.438538604598;3527.594326652429;4001.299772539823;4003.719739618228;4018.45750823638;4026.4966879140106;3019.4866872631706;3463.359278533454;3474.808885511296;3478.217401084761;3493.8427770750122;4243.302678928422;5060.760113772149;5181.228042997016;5192.662476938987;5196.895257420751;4388.868333949987;4539.955810163648;4590;4594.66754641157;4612.840204459956;5570.749316280777;5575.69333686647;5580.776768929238;5594.412586678381;5613.859653508654;3356.4294070007913;3569.036360182762;3569.644534137928;3684.7420680552373;3811.2949104415493;5511.807086751985;5758.654480731169;5772.595918285721;5812.9709351452975;5833.416658334133;3430.7598468106994;3672.265546890633;3843.6348546888003;3853.9229215415535;3855.496356420942;3884.9992253989217;3885.611438856148;3891.8637847675195;3899.863504777376;3903.863364782219;3537.893863184109;4499.061239164272;4541.070045230764;4544.841065528269;4548.5906268436;5284.3009893075005;5586.13414920688;5592.217089607459;5593.972030139823;5618.6628802272;1233.3771445420005;1327.8141060251573;1329.3818374455732;1332.3404914567352;1338.4941940317144;739.7521830186947;836.3774277900853;855.3456605696647;860.548212188606;899.9145081217274;4607.608353289941;4989.725565093955;5240.292560504359;5269.367675878919;5272.499112584298;5277.788888444496;5435.83692489226;5671.788002678959;5672.716364181774;5677.460641239076;4086.9169670037463;4902.28916807061;5103.515166059218;5139.177731562932;5242.6971008264545;2707.5803250496206;2897.9565306520417;2947.7347038766616;2953.2764472704325;2983.254186453387;5137.486251374908;5599.356074051455;5809.501914176944;5872.647641141545;5895.64626122434;4583.449986001635;4775.94929115594;5275.841724748264;5693.658380497183;5775.191473193756;5063.518965698179;5073.340465739504;5696.629719068247;5707.486326230659;5828.0966450200285;5293.07371210029;5607.719614019201;5630.60585758993;5659.840017586988;5689.630174038674;5562.610617256753;5579.581531385244;5583.720813959367;5585.994520986262;5603.943960560342;4857.595490232357;5107.361579802525;5451.863703407446;5836.9416305838095;5848.052564519017;3194.5048517479827;3658.32321020612;3747.7376583638884;3794.6964242859954;3820.1404683947003;4648.651890951586;5313.734313284243;5536.557075434036;5583.553315734813;5651.632643878134;4606.88482787933;5445.455454454523;5494.7802087917635;5495.285612870462;5507.752151153128;4947.653664243612;5081.263216833465;5220.504052115043;5354.78580856777;5496.6701997880255;4780;4935.654504184673;5128.897422051464;5339.385970613429;5390.407055224001;5029.346184995927;5424.698072462502;5464.754086066057;5554;5601.375601075805;5427.402985671652;5483.479069488392;5488.341399032141;5490.533304668988;5495.5436809246385 05:59:54 INFO - PROCESS | 1649 | |5;yui.html;600.9241185046081;690.6132565763173;710.9751158709446;742.3281929853481;784.3529088501987;14369.13785172889;14892.851071489282;14926.850731492681;14965.027273227233;15007.024543404672;13298.534551290706;13415.12801667891;13416.865831341684;13417.597472075853;13436.3953622087;636.4526507203801;658.700291367429;781.86708259596;792.3700657976893;806.4193780478047;786.4259090863673;803.4295650088444;805.0299389235956;809.1261437647356;810.9959450202741;843.359047124187;844.8986121665378;851.6252848746562;854.5428195915187;870.7344260000697;674.9325067493261;697.7557854750847;821.1911267401605;865.6148014133713;866.0127454701645;587.9235699359099;628.0140179917531;628.421851896252;629.1035274733532;629.8299459146051;14373.64065898361;14422.423103075864;14437.639059023608;14443.49447769323;14445.422183112769;13145.342732863413;13275.800862987064;13312.733745325038;13329.600111996655;13403.798943015863;11883.346415947119;12027.699307517381;12101.334426606532;12242.510299588006;12573.245605263714;4322.913541729179;4383.715058521186;4431.6233120184825;4435.0908063847155;4533.77331133442;88897.11102888953;91742.62386064214;91763.70590735218;91870.54064729634;91898.62152067725;9081.954590227007;9282.860757088649;9369.063093690576;9582.760430989141;9694.321397502248;18191.45425637233;18477.81522184761;18771.249150033847;18809.435716928514;18811.435656930313;6939.271376505495;6941.479389045841;6949.548279361927;7067.010618513412;7155.821104472429;3996.3805610130476;4041.0301527633155;4042.110735638155;4058.9596298069205;4165.708400411942;2940.7794415418502;3187.2669286064333;3195.817547507437;3326.3513614845356;3327.168207948013;614.7510258345377;615.8706671598925;624.3444383397415;627.5168120547245;633.762339122829;487.6586389527345;538.2222688215569;539.8596364945142;548.44333002003;581.8458108601224;7779;7789.922100778919;8084.636191371403;8628.22345988864;8762.780930476789;546.8550834028986;553.5848113914564;556.6048105844815;603.0620051066543;628.3465196195997;3499.545059142295;3639.363111455538;4008.098177909947;4199.790010499462;4305.526392096866;72793.27206727865;101533.96932061318;105733;111561.32658010136;112690;98297.01702983021;98610;98796;99565;100059;77444.22555774482;77567;79718.20281797108;83156.58421707853;89345;8042.276195142465;8983.865242021506;9024.548772561477;9029.187373136449;9107.772305692411;49113;51224.74387628038;51937.22094168515;52036.05657462535;52498;39096;48757;53585.73207133939;71640;73757;10483.68548943533;11408.144389170679;11718.472668729757;11858.881411185777;12417.503299867903;14194.432222710975;14230.501932432315;14269.64325891861;15045.247737613294;15154.848451515343;13093.083484156017;13418;13558.593242202749;13563.321833908069;13779.517716879862;12973.481060757464;13289.534866279633;13464.93267533656;13606.183628982293;13756.518521851687;10693.465326733476;12848.036397270054;12948.417321220757;13264.270465124126;13576.93211533936;10884.61903833362;11119.72200694989;11296.943515282372;11337.206395552232;11714.76570468603;9369.953150234205;9429.764255893657;10099;11414.372209528556;11423.257488263236 05:59:54 INFO - PROCESS | 1649 | __end_tp_report 05:59:54 INFO - PROCESS | 1649 | __start_cc_report 05:59:54 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1945 05:59:54 INFO - PROCESS | 1649 | __end_cc_report 05:59:54 INFO - PROCESS | 1649 | __startTimestamp1478264394419__endTimestamp 05:59:54 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | ------- Summary: start ------- 05:59:54 INFO - PROCESS | 1649 | Number of tests: 6 05:59:54 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5746.78 Median:5994.64 stddev:651.85 (10.9%) stddev-sans-first:611.52 05:59:54 INFO - PROCESS | 1649 | Values: 2801.0 2815.8 3368.0 3393.8 3423.7 5642.1 5689.1 5707.9 5800.5 5801.6 5722.1 5733.4 5828.9 5884.8 5904.5 5130.1 5133.4 5180.6 5211.9 5255.6 5330.9 5334.7 5346.8 5362.1 5371.8 5302.8 5322.8 5347.7 5355.0 5395.2 5143.3 5165.3 5199.7 5205.1 5217.9 5220.3 5222.7 5240.4 5260.5 5304.0 5734.7 5756.2 5764.5 5765.6 5787.4 6102.4 6119.0 6130.3 6135.1 6175.3 6112.5 6135.0 6152.2 6177.4 6210.1 5929.1 5932.3 5946.5 5951.9 5994.6 6222.9 6287.9 6296.1 6299.4 6303.5 5208.8 6031.1 6094.9 6157.0 6168.7 6117.9 6149.4 6213.8 6309.3 6330.4 6196.0 6250.0 6270.1 6281.2 6282.5 6125.1 6266.6 6269.3 6280.8 6290.4 4868.0 4885.0 4901.5 4902.0 4955.2 4432.3 4464.2 4480.1 4503.0 4532.8 5801.2 5810.1 5815.4 5832.2 5878.1 6118.3 6168.3 6251.6 6271.0 6343.9 5730.0 5733.5 5780.0 5781.1 5868.9 5408.2 5429.4 5432.8 5438.8 5438.9 6253.2 6296.8 6299.9 6307.8 6310.1 6128.4 6152.5 6197.9 6199.6 6216.2 6160.0 6194.3 6284.2 6306.8 6315.0 6207.3 6227.6 6250.5 6260.8 6267.0 5931.4 6061.4 6101.0 6144.6 6170.9 6097.7 6109.3 6122.6 6177.1 6189.8 6027.8 6111.2 6153.9 6165.4 6166.5 5518.1 5799.9 5819.1 6043.5 6049.5 6027.4 6085.9 6100.3 6129.8 6145.2 5083.7 5789.3 5967.9 6015.4 6029.0 05:59:54 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:69577.72 Median:39315.51 stddev:153366.56 (390.1%) stddev-sans-first:153709.01 05:59:54 INFO - PROCESS | 1649 | Values: 462.5 465.5 483.2 510.4 530.0 30011.2 31227.0 31273.8 31299.8 31348.2 31523.5 31941.3 32052.7 32282.7 40625.6 9225.2 9421.6 9428.2 9429.8 9448.2 9141.5 9242.4 9265.5 9266.3 9278.0 9247.4 9296.0 9297.1 9297.9 9359.4 9201.1 9266.0 9277.1 9293.9 9298.8 7084.0 9275.8 9315.3 9322.6 9323.6 38962.8 39307.6 39315.4 39315.6 39330.4 3232.8 3317.5 3595.6 3946.3 4085.9 29289.1 29701.0 30981.5 31160.7 31273.8 2655.8 3117.4 3274.2 3334.6 3338.9 472635.0 475506.0 477066.0 477430.0 479433.0 58430.4 58794.4 58846.7 58884.4 58981.4 62177.0 62592.1 62615.7 62670.0 62681.4 15689.3 15916.5 15939.5 15947.5 15948.0 12226.8 12279.3 12298.0 12304.3 12312.4 16763.7 17460.2 17518.6 17602.6 17621.4 5105.9 5898.2 6059.7 6086.5 6126.0 830.4 882.3 949.9 977.0 1012.3 28220.4 29207.7 29443.0 29746.9 29962.7 948.0 1034.9 1037.9 1061.6 1085.6 14765.5 15722.3 15865.0 16097.7 16389.0 644569.0 649738.0 650326.0 651113.0 651982.7 57655.4 57798.7 57887.1 57961.7 58040.7 1189.8 1226.5 1234.2 1329.4 1348.9 24832.6 30400.5 31074.1 31736.7 32011.4 53998.5 54473.0 54660.7 54761.5 54961.0 576291.0 581041.0 581339.0 581340.0 581941.0 25656.4 25992.0 26037.6 26756.3 27313.5 46326.8 46812.5 46893.3 47322.5 47783.8 38129.8 38678.0 38932.6 39262.6 40069.0 38162.8 38253.8 38928.0 39803.8 40092.6 36879.1 37758.0 38111.2 38213.8 39360.8 30165.5 33703.5 33833.0 33946.0 34263.5 22758.7 23809.9 24404.0 25335.1 26012.0 05:59:54 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:34256.10 Median:2239.03 stddev:98743.23 (4410.1%) stddev-sans-first:98987.35 05:59:54 INFO - PROCESS | 1649 | Values: 315.7 351.0 365.1 372.6 403.6 14867.1 14964.9 16341.8 20789.7 21183.6 19759.3 20178.2 20800.4 20873.0 21075.2 5739.9 6040.8 6055.9 6073.2 6082.2 5006.9 6540.9 6639.5 6709.8 6715.7 5675.6 5952.2 6561.9 6567.8 6649.3 6018.9 6067.8 6069.6 6072.8 6082.5 5039.2 5300.3 5356.3 5384.7 5825.4 12710.6 12801.6 12909.7 12954.7 12981.4 2168.4 2231.9 2234.2 2243.8 2737.7 9762.2 9778.7 10299.5 10808.2 15677.0 1795.6 1830.6 1830.7 1846.9 1869.2 108149.5 110471.0 111417.4 112138.6 112830.0 8535.8 11270.7 11363.6 11377.8 11500.5 14270.6 14290.4 14300.5 14308.4 14312.5 8094.6 8212.4 8266.3 8273.7 8369.6 8158.1 8189.3 8345.7 8345.8 8375.0 4319.3 4423.2 4436.9 4509.4 4520.8 1702.8 1817.6 1848.5 1894.9 1905.3 886.6 897.4 898.4 901.4 962.6 19846.2 21302.9 21503.0 21752.9 22445.8 857.0 901.6 932.5 956.6 1025.8 10614.4 10952.6 11373.0 11394.5 11533.4 577515.0 585730.0 591054.0 599990.0 601528.0 76021.0 135634.4 139569.0 140956.8 145053.8 995.5 1006.4 1031.8 1032.1 1032.9 18868.0 19100.3 19179.2 19182.6 19208.2 41893.0 53098.2 56443.4 57773.1 57997.7 57934.4 79541.0 82035.8 84989.0 85182.1 7596.5 7878.8 8074.0 8096.0 8267.9 9139.8 12007.3 12805.4 13158.1 13382.5 9399.9 10141.2 11006.3 11138.5 11573.7 10912.6 11063.6 11114.0 11321.7 11567.0 11332.4 11337.1 11697.3 11766.4 11812.4 7888.0 8114.0 8158.3 8285.1 8444.6 10348.8 11236.4 11457.3 11538.8 11630.7 05:59:54 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5343.01 Median:5075.90 stddev:2921.23 (57.6%) stddev-sans-first:2913.65 05:59:54 INFO - PROCESS | 1649 | Values: 1304.6 1337.8 1467.0 1614.0 1832.5 7423.9 7817.6 7818.8 7821.1 7824.1 7613.0 7928.8 8177.3 8186.0 8279.7 2281.2 2312.4 2312.6 2313.0 2317.8 2277.5 2315.4 2334.6 2344.0 2344.6 2271.6 2274.8 2293.2 2297.3 2310.7 2246.3 2258.8 2284.7 2286.3 2286.8 2301.4 2315.2 2318.2 2319.1 2322.1 8225.1 8364.5 8365.9 8387.1 8387.4 4292.8 4975.3 5221.4 5228.2 5230.5 3490.9 3587.6 3590.4 3604.2 3604.2 1047.3 1070.0 1095.3 1097.8 1098.8 10757.8 10780.9 10782.8 10786.9 10801.8 4180.1 4352.8 4368.6 4436.4 4448.5 8446.7 8597.5 8607.6 8618.4 8623.8 5068.8 5074.6 5075.1 5076.7 5081.8 3948.3 4162.9 4775.4 4776.7 4793.3 3541.4 3599.2 3629.9 3680.2 3681.1 964.2 1044.6 1127.6 1131.7 1132.0 777.9 830.3 845.2 850.7 872.0 5460.8 5614.2 5715.8 5867.4 5868.8 761.3 775.6 799.0 893.9 896.6 3668.4 3800.2 3814.3 3905.8 3909.2 9511.3 9886.3 10079.8 10204.0 10217.4 9846.8 10186.8 10192.6 10192.8 10209.6 7708.7 7826.4 7887.6 7897.5 7924.1 5572.9 5623.7 5698.3 5708.7 5795.1 7946.3 9172.1 9260.7 9300.3 9432.6 8941.7 9334.0 9339.0 9358.5 9366.3 6498.9 6707.9 6708.8 7072.4 7251.3 7319.8 7392.9 7393.6 7411.0 7639.0 6659.7 7027.3 7062.2 7100.4 7173.0 6919.7 6991.8 7007.5 7054.4 7067.8 6333.9 6556.0 6592.5 6600.8 6669.1 4157.6 4828.9 4832.3 4918.3 4958.1 4793.5 4800.4 4858.9 4927.4 4999.4 05:59:54 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4456.01 Median:5098.43 stddev:1378.14 (27.0%) stddev-sans-first:1345.48 05:59:54 INFO - PROCESS | 1649 | Values: 256.6 294.6 295.7 307.0 311.0 5300.3 5344.8 5380.4 5389.9 5416.4 4377.8 5023.5 5093.3 5164.5 5288.4 3210.9 3549.0 4020.4 4031.9 4066.6 3321.7 4017.7 4026.3 4055.5 4056.8 3556.9 3583.8 3987.6 3995.0 4010.4 3527.6 4001.3 4003.7 4018.5 4026.5 3019.5 3463.4 3474.8 3478.2 3493.8 4243.3 5060.8 5181.2 5192.7 5196.9 4388.9 4540.0 4590.0 4594.7 4612.8 5570.7 5575.7 5580.8 5594.4 5613.9 3356.4 3569.0 3569.6 3684.7 3811.3 5511.8 5758.7 5772.6 5813.0 5833.4 3430.8 3672.3 3843.6 3853.9 3855.5 3885.0 3885.6 3891.9 3899.9 3903.9 3537.9 4499.1 4541.1 4544.8 4548.6 5284.3 5586.1 5592.2 5594.0 5618.7 1233.4 1327.8 1329.4 1332.3 1338.5 739.8 836.4 855.3 860.5 899.9 4607.6 4989.7 5240.3 5269.4 5272.5 5277.8 5435.8 5671.8 5672.7 5677.5 4086.9 4902.3 5103.5 5139.2 5242.7 2707.6 2898.0 2947.7 2953.3 2983.3 5137.5 5599.4 5809.5 5872.6 5895.6 4583.4 4775.9 5275.8 5693.7 5775.2 5063.5 5073.3 5696.6 5707.5 5828.1 5293.1 5607.7 5630.6 5659.8 5689.6 5562.6 5579.6 5583.7 5586.0 5603.9 4857.6 5107.4 5451.9 5836.9 5848.1 3194.5 3658.3 3747.7 3794.7 3820.1 4648.7 5313.7 5536.6 5583.6 5651.6 4606.9 5445.5 5494.8 5495.3 5507.8 4947.7 5081.3 5220.5 5354.8 5496.7 4780.0 4935.7 5128.9 5339.4 5390.4 5029.3 5424.7 5464.8 5554.0 5601.4 5427.4 5483.5 5488.3 5490.5 5495.5 05:59:54 INFO - PROCESS | 1649 | 05:59:54 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:19742.05 Median:48935.00 stddev:28944.12 (59.1%) stddev-sans-first:28989.64 05:59:54 INFO - PROCESS | 1649 | Values: 600.9 690.6 711.0 742.3 784.4 14369.1 14892.9 14926.9 14965.0 15007.0 13298.5 13415.1 13416.9 13417.6 13436.4 636.5 658.7 781.9 792.4 806.4 786.4 803.4 805.0 809.1 811.0 843.4 844.9 851.6 854.5 870.7 674.9 697.8 821.2 865.6 866.0 587.9 628.0 628.4 629.1 629.8 14373.6 14422.4 14437.6 14443.5 14445.4 13145.3 13275.8 13312.7 13329.6 13403.8 11883.3 12027.7 12101.3 12242.5 12573.2 4322.9 4383.7 4431.6 4435.1 4533.8 88897.1 91742.6 91763.7 91870.5 91898.6 9082.0 9282.9 9369.1 9582.8 9694.3 18191.5 18477.8 18771.2 18809.4 18811.4 6939.3 6941.5 6949.5 7067.0 7155.8 3996.4 4041.0 4042.1 4059.0 4165.7 2940.8 3187.3 3195.8 3326.4 3327.2 614.8 615.9 624.3 627.5 633.8 487.7 538.2 539.9 548.4 581.8 7779.0 7789.9 8084.6 8628.2 8762.8 546.9 553.6 556.6 603.1 628.3 3499.5 3639.4 4008.1 4199.8 4305.5 72793.3 101534.0 105733.0 111561.3 112690.0 98297.0 98610.0 98796.0 99565.0 100059.0 77444.2 77567.0 79718.2 83156.6 89345.0 8042.3 8983.9 9024.5 9029.2 9107.8 49113.0 51224.7 51937.2 52036.1 52498.0 39096.0 48757.0 53585.7 71640.0 73757.0 10483.7 11408.1 11718.5 11858.9 12417.5 14194.4 14230.5 14269.6 15045.2 15154.8 13093.1 13418.0 13558.6 13563.3 13779.5 12973.5 13289.5 13464.9 13606.2 13756.5 10693.5 12848.0 12948.4 13264.3 13576.9 10884.6 11119.7 11296.9 11337.2 11714.8 9370.0 9429.8 10099.0 11414.4 11423.3 05:59:54 INFO - PROCESS | 1649 | -------- Summary: end -------- 05:59:54 INFO - PROCESS | 1649 | 05:59:55 INFO - TEST-INFO | 1649: exit 0 05:59:55 INFO - TEST-OK | dromaeo_css | took 1119613ms 05:59:55 INFO - TEST-START | kraken 05:59:55 INFO - operating with platform_type : mac_ 05:59:55 INFO - Initialising browser for kraken test... 05:59:55 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpiTld31/profile http://localhost:49274/getInfo.html) 05:59:57 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 05:59:57 INFO - PROCESS | 1659 | colorDepth:24 05:59:57 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 05:59:57 INFO - PROCESS | 1659 | __metrics 05:59:57 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:59:57 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:58 INFO - TEST-INFO | 1659: exit 0 05:59:58 INFO - Browser initialized. 05:59:58 INFO - Running cycle 1/1 for kraken test... 05:59:58 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpiTld31/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:10 INFO - PROCESS | 1660 | RSS: Main: 232443904 06:00:10 INFO - PROCESS | 1660 | 06:00:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 06:00:13 INFO - PROCESS | 1660 | RSS: Main: 290988032 06:00:13 INFO - PROCESS | 1660 | 06:00:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 06:00:17 INFO - PROCESS | 1660 | RSS: Main: 292196352 06:00:17 INFO - PROCESS | 1660 | 06:00:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 06:00:21 INFO - PROCESS | 1660 | RSS: Main: 383152128 06:00:21 INFO - PROCESS | 1660 | 06:00:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 06:00:23 INFO - PROCESS | 1660 | RSS: Main: 284962816 06:00:23 INFO - PROCESS | 1660 | 06:00:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:26 INFO - PROCESS | 1660 | RSS: Main: 290762752 06:00:26 INFO - PROCESS | 1660 | 06:00:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:29 INFO - PROCESS | 1660 | RSS: Main: 327540736 06:00:29 INFO - PROCESS | 1660 | 06:00:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:33 INFO - PROCESS | 1660 | RSS: Main: 328294400 06:00:33 INFO - PROCESS | 1660 | 06:00:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 06:00:36 INFO - PROCESS | 1660 | RSS: Main: 326914048 06:00:36 INFO - PROCESS | 1660 | 06:00:38 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:38 INFO - PROCESS | 1660 | RSS: Main: 303583232 06:00:39 INFO - PROCESS | 1660 | 06:00:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:41 INFO - PROCESS | 1660 | RSS: Main: 305647616 06:00:41 INFO - PROCESS | 1660 | 06:00:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:44 INFO - PROCESS | 1660 | RSS: Main: 312180736 06:00:44 INFO - PROCESS | 1660 | 06:00:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:48 INFO - PROCESS | 1660 | RSS: Main: 317235200 06:00:48 INFO - PROCESS | 1660 | 06:00:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:51 INFO - PROCESS | 1660 | RSS: Main: 317366272 06:00:51 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 06:00:53 INFO - PROCESS | 1660 | RSS: Main: 360181760 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | __start_tp_report 06:00:53 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 06:00:53 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 06:00:53 INFO - PROCESS | 1660 | |i|pagename|runs| 06:00:53 INFO - PROCESS | 1660 | |0;ai-astar;104;114;114;113;114;115;114;113;114;114 06:00:53 INFO - PROCESS | 1660 | |1;audio-beat-detection;149;116;113;149;113;112;107;126;168;138 06:00:53 INFO - PROCESS | 1660 | |2;audio-dft;186;184;183;183;184;191;200;184;182;185 06:00:53 INFO - PROCESS | 1660 | |3;audio-fft;80;58;61;86;73;58;58;59;83;58 06:00:53 INFO - PROCESS | 1660 | |4;audio-oscillator;84;70;90;68;68;68;90;66;68;92 06:00:53 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;92;89;92;89;92;88;92;89;90;88 06:00:53 INFO - PROCESS | 1660 | |6;imaging-darkroom;99;100;100;100;100;108;98;101;100;101 06:00:53 INFO - PROCESS | 1660 | |7;imaging-desaturate;83;83;79;79;81;82;83;86;81;82 06:00:53 INFO - PROCESS | 1660 | |8;json-parse-financial;57;54;55;54;53;52;73;83;83;85 06:00:53 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;65;74;70;77;73;71;69;71;71;70 06:00:53 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;87;90;90;89;87;90;87;84;88;85 06:00:53 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;141;165;132;153;154;153;149;146;190;145 06:00:53 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;174;175;175;175;173;174;173;174;179;238 06:00:53 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;67;67;67;68;67;68;71;85;89;86 06:00:53 INFO - PROCESS | 1660 | __end_tp_report 06:00:53 INFO - PROCESS | 1660 | __start_cc_report 06:00:53 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2038 06:00:53 INFO - PROCESS | 1660 | __end_cc_report 06:00:53 INFO - PROCESS | 1660 | __startTimestamp1478264453809__endTimestamp 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | ------- Summary: start ------- 06:00:53 INFO - PROCESS | 1660 | Number of tests: 14 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.18 (2.8%) stddev-sans-first:0.60 06:00:53 INFO - PROCESS | 1660 | Values: 104.0 114.0 114.0 113.0 114.0 115.0 114.0 113.0 114.0 114.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:132.00 stddev:20.72 (15.7%) stddev-sans-first:20.69 06:00:53 INFO - PROCESS | 1660 | Values: 149.0 116.0 113.0 149.0 113.0 112.0 107.0 126.0 168.0 138.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:186.20 Median:184.50 stddev:5.45 (3.0%) stddev-sans-first:5.78 06:00:53 INFO - PROCESS | 1660 | Values: 186.0 184.0 183.0 183.0 184.0 191.0 200.0 184.0 182.0 185.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:67.40 Median:67.00 stddev:11.76 (17.6%) stddev-sans-first:11.55 06:00:53 INFO - PROCESS | 1660 | Values: 80.0 58.0 61.0 86.0 73.0 58.0 58.0 59.0 83.0 58.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:77.00 stddev:11.07 (14.4%) stddev-sans-first:11.39 06:00:53 INFO - PROCESS | 1660 | Values: 84.0 70.0 90.0 68.0 68.0 68.0 90.0 66.0 68.0 92.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:90.10 Median:91.00 stddev:1.73 (1.9%) stddev-sans-first:1.69 06:00:53 INFO - PROCESS | 1660 | Values: 92.0 89.0 92.0 89.0 92.0 88.0 92.0 89.0 90.0 88.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:100.70 Median:101.00 stddev:2.71 (2.7%) stddev-sans-first:2.80 06:00:53 INFO - PROCESS | 1660 | Values: 99.0 100.0 100.0 100.0 100.0 108.0 98.0 101.0 100.0 101.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:81.90 Median:82.50 stddev:2.08 (2.5%) stddev-sans-first:2.17 06:00:53 INFO - PROCESS | 1660 | Values: 83.0 83.0 79.0 79.0 81.0 82.0 83.0 86.0 81.0 82.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:14.26 (21.9%) stddev-sans-first:14.84 06:00:53 INFO - PROCESS | 1660 | Values: 57.0 54.0 55.0 54.0 53.0 52.0 73.0 83.0 83.0 85.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:3.18 (4.5%) stddev-sans-first:2.49 06:00:53 INFO - PROCESS | 1660 | Values: 65.0 74.0 70.0 77.0 73.0 71.0 69.0 71.0 71.0 70.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.50 stddev:2.11 (2.4%) stddev-sans-first:2.22 06:00:53 INFO - PROCESS | 1660 | Values: 87.0 90.0 90.0 89.0 87.0 90.0 87.0 84.0 88.0 85.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:153.00 stddev:15.73 (10.3%) stddev-sans-first:16.10 06:00:53 INFO - PROCESS | 1660 | Values: 141.0 165.0 132.0 153.0 154.0 153.0 149.0 146.0 190.0 145.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:175.00 stddev:20.10 (11.5%) stddev-sans-first:21.16 06:00:53 INFO - PROCESS | 1660 | Values: 174.0 175.0 175.0 175.0 173.0 174.0 173.0 174.0 179.0 238.0 06:00:53 INFO - PROCESS | 1660 | 06:00:53 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:69.50 stddev:9.22 (13.3%) stddev-sans-first:9.47 06:00:53 INFO - PROCESS | 1660 | Values: 67.0 67.0 67.0 68.0 67.0 68.0 71.0 85.0 89.0 86.0 06:00:53 INFO - PROCESS | 1660 | -------- Summary: end -------- 06:00:53 INFO - PROCESS | 1660 | 06:00:54 INFO - TEST-INFO | 1660: exit 0 06:00:54 INFO - TEST-OK | kraken | took 59783ms 06:00:54 INFO - SUITE-END | took 1179s 06:00:54 INFO - Completed test suite (00:19:39) 06:00:54 INFO - javascript benchmark 06:00:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2800.9859950700256, 2815.774738020958, 3367.9831600841994, 3393.8133402662843, 3423.7261019118473, 5642.1254705520605, 5689.061304884699, 5707.885842283152, 5800.53595712343, 5801.622894511854, 5722.113072473773, 5733.397993210715, 5828.9417105828925, 5884.823455296348, 5904.498117659993, 5130.07658621448, 5133.435322114565, 5180.611454140936, 5211.921821172686, 5255.553277971377, 5330.866728331784, 5334.733263336837, 5346.759395827177, 5362.1420572708375, 5371.785128594852, 5302.814401495968, 5322.840314790563, 5347.7058761768085, 5354.973225133869, 5395.244665746799, 5143.254228136937, 5165.276861239429, 5199.66202196856, 5205.141151709963, 5217.869553261199, 5220.321358223407, 5222.686638801684, 5240.423553409122, 5260.526552610283, 5303.992241474108, 5734.684592347419, 5756.222909907151, 5764.51001664859, 5765.596408251424, 5787.421257874221, 6102.389761023862, 6119.045604113885, 6130.275842464065, 6135.07973803933, 6175.289841668221, 6112.473085128069, 6135.049067394516, 6152.169457123276, 6177.351378105279, 6210.099535567318, 5929.0513517836935, 5932.3474417814, 5946.524278057832, 5951.910721339226, 5994.640321580676, 6222.875542489215, 6287.874242515216, 6296.055591661196, 6299.401556852184, 6303.464205542488, 5208.84373468789, 6031.09533569968, 6094.939050609437, 6157.0456579230295, 6168.691565421711, 6117.857853872241, 6149.446549810538, 6213.844653883689, 6309.274433440213, 6330.39861213184, 6195.96902015487, 6250.031245157008, 6270.122182894398, 6281.152044473937, 6282.4974002079725, 6125.081237814364, 6266.592671476431, 6269.279032911274, 6280.811575652647, 6290.433860952537, 4868.002059577849, 4884.95115048852, 4901.534354236342, 4901.950980490221, 4955.207166853286, 4432.312991486325, 4464.241079016575, 4480.103979204172, 4503.009337945647, 4532.841350552781, 5801.245838041028, 5810.070388737781, 5815.389384114692, 5832.24180856486, 5878.088896221093, 6118.314626315956, 6168.25980882297, 6251.624902505864, 6271.0, 6343.904841427382, 5729.9713501432225, 5733.512651424592, 5780.0, 5781.1328300754385, 5868.853278667982, 5408.215808707715, 5429.375621803464, 5432.782688692487, 5438.782448702008, 5438.91841622376, 6253.155823963707, 6296.842578935563, 6299.874002519924, 6307.842303942438, 6310.0534919761485, 6128.3503509891225, 6152.50779937595, 6197.907031394442, 6199.597026193283, 6216.191895053614, 6159.9528080227365, 6194.349593292639, 6284.151639528788, 6306.810795676137, 6315.0, 6207.255129384503, 6227.595206311576, 6250.49996000328, 6260.843478913063, 6267.0, 5931.406859314034, 6061.424164704346, 6100.974805932192, 6144.56988010835, 6170.9074363885475, 6097.695115244309, 6109.283207920342, 6122.550631083031, 6177.104319873683, 6189.84525386869, 6027.78902738402, 6111.171737814916, 6153.876922461615, 6165.414285642857, 6166.537509686881, 5518.117101263779, 5799.913001305068, 5819.0689489681445, 6043.54673399488, 6049.455549000611, 6027.36712645166, 6085.878282434415, 6100.267967843887, 6129.785457508966, 6145.217886812953, 5083.703655567807, 5789.305283365855, 5967.850803729942, 6015.428534289235, 6029.035354343284], "value": 5702.5342619801395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.52591094128513, 465.5135383524217, 483.164126061913, 510.36204744069914, 529.998303206939, 30011.249718757015, 31227.0, 31273.84363078184, 31299.843500782492, 31348.216294592647, 31523.527147092755, 31941.284990775755, 32052.679473205262, 32282.67717322832, 40625.59374406255, 9225.16973472389, 9421.576029078708, 9428.198603118708, 9429.81140377192, 9448.244140468745, 9141.497217653026, 9242.353035287533, 9265.490398028105, 9266.258699304073, 9277.95361023194, 9247.398919070272, 9296.023917488668, 9297.116773906468, 9297.907020929806, 9359.391639543443, 9201.125893040151, 9265.953670231673, 9277.072292770668, 9293.860592091123, 9298.767530811716, 7083.964580177066, 9275.814483710355, 9315.254779617615, 9322.580483878173, 9323.627054917795, 38962.80518597389, 39307.60692393068, 39315.41026884599, 39315.60684393177, 39330.41004384936, 3232.8060316380856, 3317.5023746437987, 3595.5505561804775, 3946.3291240489184, 4085.85699500519, 29289.12132636003, 29700.960466383574, 30981.535276970862, 31160.688393116234, 31273.84363078193, 2655.7742591879714, 3117.392108538836, 3274.1650879025933, 3334.649861764504, 3338.9499157512655, 472635.0, 475506.0, 477066.0, 477430.0, 479432.9999999965, 58430.415695843345, 58794.41205587975, 58846.70576647175, 58884.41115588875, 58981.41018589845, 62177.0, 62592.06111908325, 62615.6869215651, 62670.0, 62681.373186268465, 15689.293981770848, 15916.522504324888, 15939.521814345588, 15947.521574352788, 15948.0, 12226.816597751042, 12279.263244205376, 12297.954673852644, 12304.261744295192, 12312.445939932724, 16763.664726705643, 17460.214290356966, 17518.649627007388, 17602.559936001704, 17621.383251586132, 5105.8723531912, 5898.233229680114, 6059.7273122709585, 6086.513078953673, 6125.96937015321, 830.3647709502236, 882.3294296334832, 949.9145076943108, 977.0, 1012.2661070723814, 28220.43559128847, 29207.707922920497, 29442.969496067963, 29746.8888524867, 29962.700372996427, 947.9952600237093, 1034.9482525873827, 1037.9273450858368, 1061.6125114333367, 1085.6417382263835, 14765.483208087666, 15722.29249683767, 15865.04809711421, 16097.678046439005, 16389.0166590005, 644569.0, 649738.0, 650326.0, 651113.0, 651982.7400862966, 57655.423445765846, 57798.7110064447, 57887.13169302464, 57961.710191449616, 58040.70979645075, 1189.8453201083803, 1226.4971361742, 1234.160770675949, 1329.4482789642384, 1348.9123206991515, 24832.627510587718, 30400.543991840583, 31074.0677779667, 31736.658354114712, 32011.35977280488, 53998.46001540092, 54473.0, 54660.72669636626, 54761.45238547563, 54961.0, 576291.0, 581041.0, 581339.0, 581340.0, 581941.0, 25656.358591035372, 25991.960321586925, 26037.609435858856, 26756.331091722863, 27313.453730925667, 46326.76836615795, 46812.53187468082, 46893.2966005517, 47322.52677473319, 47783.805404863764, 38129.809350953066, 38678.03304917287, 38932.6106738929, 39262.60737392589, 40069.0, 38162.80918595389, 38253.80873095617, 38928.0, 39803.80098099491, 40092.59907400889, 36879.092796677505, 37758.0, 38111.23777524378, 38213.808930955165, 39360.80319598383, 30165.547516787705, 33703.4944475838, 33833.0, 33945.98162055142, 34263.48604770881, 22758.65862012038, 23809.880950595136, 24404.0, 25335.113271035425, 26011.959521618923], "value": 19300.203316664378, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.74582461118797, 351.03290434851976, 365.0945654776155, 372.5510759534761, 403.6185804414829, 14867.107973521597, 14964.925175374121, 16341.83658163418, 20789.688154677693, 21183.57632847342, 19759.308424205155, 20178.19287228509, 20800.375988720323, 20872.95635218237, 21075.15699372027, 5739.885202295962, 6040.758369665208, 6055.878882422349, 6073.240844894388, 6082.239720034996, 5006.874828129289, 6540.869182616369, 6639.535232533724, 6709.8322541936595, 6715.731370745164, 5675.574331925122, 5952.226210592617, 6561.901571476432, 6567.802965911006, 6649.26858045617, 6018.939810601903, 6067.7572897084065, 6069.57512974092, 6072.817815465499, 6082.482988945945, 5039.168537191359, 5300.337457817773, 5356.330458692663, 5384.730763461811, 5825.359210486843, 12710.555130570478, 12801.55194568195, 12909.677258068623, 12954.676133096653, 12981.350932453339, 2168.414528077426, 2231.9107235710553, 2234.218023691711, 2243.842930994831, 2737.712540183272, 9762.170215531689, 9778.706638800848, 10299.485025748683, 10808.189385796019, 15677.0, 1795.6139430022477, 1830.588117673526, 1830.7253911913187, 1846.870719049667, 1869.2242719271621, 108149.45925270324, 110471.0, 111417.44291278573, 112138.61851413044, 112830.0, 8535.829283414421, 11270.745850829866, 11363.602273920373, 11377.772444551229, 11500.48247828833, 14270.643233919027, 14290.42805291417, 14300.499482518062, 14308.427662893368, 14312.49906253297, 8094.595270236465, 8212.384071194685, 8266.338692904554, 8273.669053237923, 8369.623366948503, 8158.102608713037, 8189.26296633294, 8345.707900223462, 8345.833083338299, 8375.0, 4319.265724826787, 4423.248047831812, 4436.933445998313, 4509.368688383629, 4520.751358675238, 1702.8212037736107, 1817.5910420155624, 1848.4639454558028, 1894.9242030318908, 1905.2569497895831, 886.5833058462513, 897.3539051882634, 898.4250079948838, 901.4456109492746, 962.6341990043738, 19846.206151754057, 21302.893485532473, 21502.98958145861, 21752.89123554372, 22445.78205725715, 856.9914300857037, 901.5627420700955, 932.4824722279064, 956.6272399107303, 1025.8461230815437, 10614.363138211733, 10952.616658416917, 11373.0, 11394.544218231344, 11533.365664888512, 577515.0, 585730.0, 591054.0, 599990.0, 601528.0, 76021.0, 135634.39973369153, 139569.0, 140956.8040893649, 145053.8241926372, 995.4823491784232, 1006.4464544500496, 1031.8142734307746, 1032.0969151992008, 1032.8708911386077, 18868.0, 19100.33148839784, 19179.232830686615, 19182.616347673247, 19208.231670733574, 41893.0, 53098.20352694635, 56443.43556564382, 57773.13340299983, 57997.71001144967, 57934.4206557929, 79541.0, 82035.7694634569, 84989.0, 85182.1481785199, 7596.544207347577, 7878.803029924297, 8073.959630201812, 8096.0, 8267.917320826955, 9139.817203656023, 12007.339596321937, 12805.359732013549, 13158.078934474495, 13382.531611393555, 9399.906000939904, 10141.188704903738, 11006.284591501526, 11138.498767555317, 11573.710657233636, 10912.61805836792, 11063.557457701601, 11114.0, 11321.660350189508, 11567.01680357179, 11332.376719280519, 11337.149713771336, 11697.2981621103, 11766.352850593299, 11812.409379530816, 7888.0, 8114.026316842017, 8158.3473322132895, 8285.053012542168, 8444.577771111542, 10348.793024139324, 11236.438178090899, 11457.312561246352, 11538.76922461563, 11630.6510804676], "value": 9358.515700984732, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.5694920676178, 1337.7792664210406, 1467.046419827112, 1614.0, 1832.4594244697805, 7423.851522969544, 7817.648205830744, 7818.810732994756, 7821.061472623293, 7824.100228473727, 7613.0483689538805, 7928.841423171533, 8177.345812335014, 8185.959070204641, 8279.668813247463, 2281.167373908524, 2312.4218945263683, 2312.560613483441, 2312.9653055204185, 2317.756635553268, 2277.533105713325, 2315.444293369596, 2334.579775640384, 2343.988280058606, 2344.6365813298967, 2271.5911135995516, 2274.8293877959136, 2293.2088429491882, 2297.3337732057685, 2310.6996090508296, 2246.3036458697857, 2258.796708296253, 2284.6915666385075, 2286.27982185611, 2286.817054635625, 2301.4361481437154, 2315.166540045582, 2318.177047148272, 2319.1419174905222, 2322.059565875823, 8225.136360682101, 8364.456310339809, 8365.912431383942, 8387.077421483631, 8387.412881098326, 4292.763897985609, 4975.278584605248, 5221.373435187764, 5228.163493841005, 5230.503102205284, 3490.89527314181, 3587.551556055493, 3590.4434812604086, 3604.2070744436182, 3604.2250916053176, 1047.2983101322056, 1069.9572017119306, 1095.315427857589, 1097.8408130821067, 1098.8132017557034, 10757.83863242052, 10780.946095269552, 10782.838257426145, 10786.946065269702, 10801.78396432067, 4180.143070670505, 4352.825886964486, 4368.584984426474, 4436.423264975532, 4448.488423831301, 8446.746597602081, 8597.52713600758, 8607.569621518898, 8618.439801412887, 8623.827523449496, 5068.847934561969, 5074.644774865797, 5075.061113693979, 5076.74616269185, 5081.822136225214, 3948.2893079245437, 4162.937555936664, 4775.4269487661, 4776.737279449594, 4793.281007848781, 3541.3709693540745, 3599.226166374242, 3629.891103266906, 3680.245549662313, 3681.116532032293, 964.2286171063122, 1044.5717255925185, 1127.639155470258, 1131.6548452722, 1131.9830202546968, 777.941654375924, 830.339879795564, 845.2012847858838, 850.6809946270149, 872.0276891266193, 5460.808871689472, 5614.242077319591, 5715.771369145271, 5867.3839246879315, 5868.794592189253, 761.3118751765711, 775.5501808950795, 798.9880151797728, 893.9284857211408, 896.6458248991743, 3668.3947148720695, 3800.1829606634706, 3814.256220037066, 3905.8437662493184, 3909.159530700913, 9511.334206605472, 9886.30795844284, 10079.798404031879, 10204.0, 10217.386956782617, 9846.803063938682, 10186.847197292047, 10192.643257485952, 10192.789271379492, 10209.642662506776, 7708.653110609924, 7826.373890088779, 7887.566183859828, 7897.486663366863, 7924.088729796147, 5572.888542229051, 5623.718814059199, 5698.31620205578, 5708.65748055118, 5795.1017592273265, 7946.284834364935, 9172.12864777845, 9260.675876344296, 9300.255979521757, 9432.575534100844, 8941.731748047569, 9334.0, 9338.95330523343, 9358.485283309483, 9366.344355895022, 6498.870022599427, 6707.932920670731, 6708.765193218214, 7072.3634872861685, 7251.347378735939, 7319.780406587811, 7392.852142957003, 7393.630318484162, 7410.96294518524, 7639.0, 6659.7003134860015, 7027.332403421667, 7062.223155452793, 7100.396466300423, 7173.0316407284345, 6919.7232110715, 6991.7902462926195, 7007.474439416962, 7054.4003759681, 7067.752628657972, 6333.909809762675, 6555.983822507519, 6592.538522303585, 6600.80197594073, 6669.09967154428, 4157.563455837094, 4828.855134345975, 4832.251001094836, 4918.311436398979, 4958.057968985881, 4793.544613261734, 4800.399950006249, 4858.902821943612, 4927.384076990376, 4999.375078115236], "value": 4320.175713128473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [256.6458287563163, 294.58463566371415, 295.7220212999779, 306.953956906464, 310.9968900310996, 5300.337457817773, 5344.839654810357, 5380.408155102936, 5389.892202155955, 5416.377116631588, 4377.846775362863, 5023.497650234975, 5093.344662984527, 5164.483551644834, 5288.382250785857, 3210.855511501982, 3549.0417587251427, 4020.3768415895584, 4031.9395209071886, 4066.573009833969, 3321.667833216671, 4017.698672599552, 4026.315526360526, 4055.5336136344404, 4056.817443215062, 3556.911077223077, 3583.802890841003, 3987.6012398760035, 3995.0, 4010.438538604598, 3527.594326652429, 4001.299772539823, 4003.719739618228, 4018.45750823638, 4026.4966879140106, 3019.4866872631706, 3463.359278533454, 3474.808885511296, 3478.217401084761, 3493.8427770750122, 4243.302678928422, 5060.760113772149, 5181.228042997016, 5192.662476938987, 5196.895257420751, 4388.868333949987, 4539.955810163648, 4590.0, 4594.66754641157, 4612.840204459956, 5570.749316280777, 5575.69333686647, 5580.776768929238, 5594.412586678381, 5613.859653508654, 3356.4294070007913, 3569.036360182762, 3569.644534137928, 3684.7420680552373, 3811.2949104415493, 5511.807086751985, 5758.654480731169, 5772.595918285721, 5812.9709351452975, 5833.416658334133, 3430.7598468106994, 3672.265546890633, 3843.6348546888003, 3853.9229215415535, 3855.496356420942, 3884.9992253989217, 3885.611438856148, 3891.8637847675195, 3899.863504777376, 3903.863364782219, 3537.893863184109, 4499.061239164272, 4541.070045230764, 4544.841065528269, 4548.5906268436, 5284.3009893075005, 5586.13414920688, 5592.217089607459, 5593.972030139823, 5618.6628802272, 1233.3771445420005, 1327.8141060251573, 1329.3818374455732, 1332.3404914567352, 1338.4941940317144, 739.7521830186947, 836.3774277900853, 855.3456605696647, 860.548212188606, 899.9145081217274, 4607.608353289941, 4989.725565093955, 5240.292560504359, 5269.367675878919, 5272.499112584298, 5277.788888444496, 5435.83692489226, 5671.788002678959, 5672.716364181774, 5677.460641239076, 4086.9169670037463, 4902.28916807061, 5103.515166059218, 5139.177731562932, 5242.6971008264545, 2707.5803250496206, 2897.9565306520417, 2947.7347038766616, 2953.2764472704325, 2983.254186453387, 5137.486251374908, 5599.356074051455, 5809.501914176944, 5872.647641141545, 5895.64626122434, 4583.449986001635, 4775.94929115594, 5275.841724748264, 5693.658380497183, 5775.191473193756, 5063.518965698179, 5073.340465739504, 5696.629719068247, 5707.486326230659, 5828.0966450200285, 5293.07371210029, 5607.719614019201, 5630.60585758993, 5659.840017586988, 5689.630174038674, 5562.610617256753, 5579.581531385244, 5583.720813959367, 5585.994520986262, 5603.943960560342, 4857.595490232357, 5107.361579802525, 5451.863703407446, 5836.9416305838095, 5848.052564519017, 3194.5048517479827, 3658.32321020612, 3747.7376583638884, 3794.6964242859954, 3820.1404683947003, 4648.651890951586, 5313.734313284243, 5536.557075434036, 5583.553315734813, 5651.632643878134, 4606.88482787933, 5445.455454454523, 5494.7802087917635, 5495.285612870462, 5507.752151153128, 4947.653664243612, 5081.263216833465, 5220.504052115043, 5354.78580856777, 5496.6701997880255, 4780.0, 4935.654504184673, 5128.897422051464, 5339.385970613429, 5390.407055224001, 5029.346184995927, 5424.698072462502, 5464.754086066057, 5554.0, 5601.375601075805, 5427.402985671652, 5483.479069488392, 5488.341399032141, 5490.533304668988, 5495.5436809246385], "value": 4011.7664717405933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9241185046081, 690.6132565763173, 710.9751158709446, 742.3281929853481, 784.3529088501987, 14369.13785172889, 14892.851071489282, 14926.850731492681, 14965.027273227233, 15007.024543404672, 13298.534551290706, 13415.12801667891, 13416.865831341684, 13417.597472075853, 13436.3953622087, 636.4526507203801, 658.700291367429, 781.86708259596, 792.3700657976893, 806.4193780478047, 786.4259090863673, 803.4295650088444, 805.0299389235956, 809.1261437647356, 810.9959450202741, 843.359047124187, 844.8986121665378, 851.6252848746562, 854.5428195915187, 870.7344260000697, 674.9325067493261, 697.7557854750847, 821.1911267401605, 865.6148014133713, 866.0127454701645, 587.9235699359099, 628.0140179917531, 628.421851896252, 629.1035274733532, 629.8299459146051, 14373.64065898361, 14422.423103075864, 14437.639059023608, 14443.49447769323, 14445.422183112769, 13145.342732863413, 13275.800862987064, 13312.733745325038, 13329.600111996655, 13403.798943015863, 11883.346415947119, 12027.699307517381, 12101.334426606532, 12242.510299588006, 12573.245605263714, 4322.913541729179, 4383.715058521186, 4431.6233120184825, 4435.0908063847155, 4533.77331133442, 88897.11102888953, 91742.62386064214, 91763.70590735218, 91870.54064729634, 91898.62152067725, 9081.954590227007, 9282.860757088649, 9369.063093690576, 9582.760430989141, 9694.321397502248, 18191.45425637233, 18477.81522184761, 18771.249150033847, 18809.435716928514, 18811.435656930313, 6939.271376505495, 6941.479389045841, 6949.548279361927, 7067.010618513412, 7155.821104472429, 3996.3805610130476, 4041.0301527633155, 4042.110735638155, 4058.9596298069205, 4165.708400411942, 2940.7794415418502, 3187.2669286064333, 3195.817547507437, 3326.3513614845356, 3327.168207948013, 614.7510258345377, 615.8706671598925, 624.3444383397415, 627.5168120547245, 633.762339122829, 487.6586389527345, 538.2222688215569, 539.8596364945142, 548.44333002003, 581.8458108601224, 7779.0, 7789.922100778919, 8084.636191371403, 8628.22345988864, 8762.780930476789, 546.8550834028986, 553.5848113914564, 556.6048105844815, 603.0620051066543, 628.3465196195997, 3499.545059142295, 3639.363111455538, 4008.098177909947, 4199.790010499462, 4305.526392096866, 72793.27206727865, 101533.96932061318, 105733.0, 111561.32658010136, 112690.0, 98297.01702983021, 98610.0, 98796.0, 99565.0, 100059.0, 77444.22555774482, 77567.0, 79718.20281797108, 83156.58421707853, 89345.0, 8042.276195142465, 8983.865242021506, 9024.548772561477, 9029.187373136449, 9107.772305692411, 49113.0, 51224.74387628038, 51937.22094168515, 52036.05657462535, 52498.0, 39096.0, 48757.0, 53585.73207133939, 71640.0, 73757.0, 10483.68548943533, 11408.144389170679, 11718.472668729757, 11858.881411185777, 12417.503299867903, 14194.432222710975, 14230.501932432315, 14269.64325891861, 15045.247737613294, 15154.848451515343, 13093.083484156017, 13418.0, 13558.593242202749, 13563.321833908069, 13779.517716879862, 12973.481060757464, 13289.534866279633, 13464.93267533656, 13606.183628982293, 13756.518521851687, 10693.465326733476, 12848.036397270054, 12948.417321220757, 13264.270465124126, 13576.93211533936, 10884.61903833362, 11119.72200694989, 11296.943515282372, 11337.206395552232, 11714.76570468603, 9369.953150234205, 9429.764255893657, 10099.0, 11414.372209528556, 11423.257488263236], "value": 7031.698307043981, "unit": "score"}], "name": "dromaeo_css", "value": 7076.1478650960835, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 113.0, 149.0, 113.0, 112.0, 107.0, 126.0, 168.0, 138.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 183.0, 183.0, 184.0, 191.0, 200.0, 184.0, 182.0, 185.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 61.0, 86.0, 73.0, 58.0, 58.0, 59.0, 83.0, 58.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 90.0, 68.0, 68.0, 68.0, 90.0, 66.0, 68.0, 92.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 89.0, 92.0, 88.0, 92.0, 89.0, 90.0, 88.0], "value": 90.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 100.0, 100.0, 100.0, 108.0, 98.0, 101.0, 100.0, 101.0], "value": 100.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 79.0, 79.0, 81.0, 82.0, 83.0, 86.0, 81.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 54.0, 53.0, 52.0, 73.0, 83.0, 83.0, 85.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 70.0, 77.0, 73.0, 71.0, 69.0, 71.0, 71.0, 70.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 90.0, 89.0, 87.0, 90.0, 87.0, 84.0, 88.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 165.0, 132.0, 153.0, 154.0, 153.0, 149.0, 146.0, 190.0, 145.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 175.0, 175.0, 173.0, 174.0, 173.0, 174.0, 179.0, 238.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 71.0, 85.0, 89.0, 86.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1475.7, "alertThreshold": 2.0}]} 06:00:55 INFO - Return code: 0 06:00:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:00:55 INFO - # TBPL SUCCESS # 06:00:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:00:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:00:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:00:55 INFO - 2016-11-04 06:00:55.083 screenresolution[1664:9809] starting screenresolution argv=screenresolution get 06:00:55 INFO - 2016-11-04 06:00:55.087 screenresolution[1664:9809] Display 0: 1600x1200x32@60 06:00:55 INFO - 2016-11-04 06:00:55.093 screenresolution[1665:9812] starting screenresolution argv=screenresolution list 06:00:55 INFO - Available Modes on Display 0 06:00:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:00:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:00:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:00:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:00:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:00:55 INFO - Intel Iris: 06:00:55 INFO - Chipset Model: Intel Iris 06:00:55 INFO - Type: GPU 06:00:55 INFO - Bus: Built-In 06:00:55 INFO - VRAM (Dynamic, Max): 1536 MB 06:00:55 INFO - Vendor: Intel (0x8086) 06:00:55 INFO - Device ID: 0x0a2e 06:00:55 INFO - Revision ID: 0x0009 06:00:55 INFO - Displays: 06:00:55 INFO - Display: 06:00:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:00:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:00:55 INFO - Display Serial Number: 1600x1200 60 06:00:55 INFO - Main Display: Yes 06:00:55 INFO - Mirror: Off 06:00:55 INFO - Online: Yes 06:00:55 INFO - Rotation: Supported 06:00:55 INFO - Return code: 0 06:00:55 INFO - Running post-action listener: _resource_record_post_action 06:00:55 INFO - [mozharness: 2016-11-04 13:00:55.344455Z] Finished run-tests step (success) 06:00:55 INFO - Running post-run listener: _resource_record_post_run 06:00:55 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 49891328; Write bytes: 716981248; Read time: 538; Write time: 2219 06:00:55 INFO - TinderboxPrint: CPU usage
53.5% 06:00:55 INFO - TinderboxPrint: I/O read bytes / time
49,891,328 / 538 06:00:55 INFO - TinderboxPrint: I/O write bytes / time
716,981,248 / 2,219 06:00:55 INFO - TinderboxPrint: CPU idle
2,258.9 (46.5%) 06:00:55 INFO - TinderboxPrint: CPU system
976.0 (20.1%) 06:00:55 INFO - TinderboxPrint: CPU user
1,626.8 (33.5%) 06:00:55 INFO - TinderboxPrint: Swap in / out
448,679,936 / 0 06:00:55 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 401361408; Write bytes: 395950080; Read time: 30823; Write time: 921 06:00:55 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 47769600; Write bytes: 306514944; Read time: 514; Write time: 1261 06:00:55 INFO - Running post-run listener: _upload_blobber_files 06:00:55 INFO - Blob upload gear active. 06:00:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:00:55 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 06:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:00:56 INFO - (blobuploader) - INFO - Open directory for files ... 06:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:56 INFO - (blobuploader) - INFO - Done attempting. 06:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:00:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:00:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:00:57 INFO - (blobuploader) - INFO - Done attempting. 06:00:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:00:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:00:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:01:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:00 INFO - (blobuploader) - INFO - Done attempting. 06:01:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:00 INFO - Return code: 0 06:01:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:01:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9723bab19a29d202d2a91b95e28051ed3f40367c62ceb590e604a79472eb1e8991481fbfca2c173aaca5fe71bd3ada5356d6fd6ff4166e77222f823a2931377b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9239e54189c9cf7b5acb22f7728ca55ade4e800031dc82e4422661752f84975ea4dea681e6e634d30fc358b762473c1b3f56befa780e1c748ed394daaa07423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9a3ea2cd0947d2f02f7f6a41dfe4d6b1f7c44d15649ba83be63e6646418e230f6084c8c00bf3191270eec62433ab7b4484f6919690ecd2d2eec982ec5cb1e9"} 06:01:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:01:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:01:00 INFO - Contents: 06:01:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9723bab19a29d202d2a91b95e28051ed3f40367c62ceb590e604a79472eb1e8991481fbfca2c173aaca5fe71bd3ada5356d6fd6ff4166e77222f823a2931377b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9239e54189c9cf7b5acb22f7728ca55ade4e800031dc82e4422661752f84975ea4dea681e6e634d30fc358b762473c1b3f56befa780e1c748ed394daaa07423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9a3ea2cd0947d2f02f7f6a41dfe4d6b1f7c44d15649ba83be63e6646418e230f6084c8c00bf3191270eec62433ab7b4484f6919690ecd2d2eec982ec5cb1e9"} 06:01:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:01:00 INFO - Copying logs to upload dir... 06:01:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:01:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.177957 ========= master_lag: 6.81 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-11-04 06:01:06.878288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 12 secs) (at 2016-11-04 06:01:06.885900) ========= 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.tF0PVublDP/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.frVx6cfApF/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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/Firefox/sha512/9723bab19a29d202d2a91b95e28051ed3f40367c62ceb590e604a79472eb1e8991481fbfca2c173aaca5fe71bd3ada5356d6fd6ff4166e77222f823a2931377b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9239e54189c9cf7b5acb22f7728ca55ade4e800031dc82e4422661752f84975ea4dea681e6e634d30fc358b762473c1b3f56befa780e1c748ed394daaa07423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9a3ea2cd0947d2f02f7f6a41dfe4d6b1f7c44d15649ba83be63e6646418e230f6084c8c00bf3191270eec62433ab7b4484f6919690ecd2d2eec982ec5cb1e9"} build_url:https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011766 build_url: 'https://queue.taskcluster.net/v1/task/aPNalCWbRiO4DZ11p8zeNg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9723bab19a29d202d2a91b95e28051ed3f40367c62ceb590e604a79472eb1e8991481fbfca2c173aaca5fe71bd3ada5356d6fd6ff4166e77222f823a2931377b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9239e54189c9cf7b5acb22f7728ca55ade4e800031dc82e4422661752f84975ea4dea681e6e634d30fc358b762473c1b3f56befa780e1c748ed394daaa07423", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d9a3ea2cd0947d2f02f7f6a41dfe4d6b1f7c44d15649ba83be63e6646418e230f6084c8c00bf3191270eec62433ab7b4484f6919690ecd2d2eec982ec5cb1e9"}' ========= master_lag: 12.85 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 12 secs) (at 2016-11-04 06:01:19.748438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 34 secs) (at 2016-11-04 06:01:19.748791) ========= 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.tF0PVublDP/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.frVx6cfApF/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005243 ========= master_lag: 34.96 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 34 secs) (at 2016-11-04 06:01:54.717767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 06:01:54.718130) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 06:01:55.506346) ========= ========= Total master_lag: 57.37 =========