builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0328 starttime: 1485561731.14 results: success (0) buildid: 20170127133620 builduid: 41444ef8a5a0436e9d8671f07b3cd6e1 revision: 07e5979a0222b793499d9f6d62680a6e5bab251c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.141761) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.142252) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.142531) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.166987) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.167364) ========= 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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-27 16:02:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.89M=0.001s 2017-01-27 16:02:11 (7.89 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.382904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.573481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.573817) ========= 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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.021433 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.623585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:11.624209) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 07e5979a0222b793499d9f6d62680a6e5bab251c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 07e5979a0222b793499d9f6d62680a6e5bab251c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IbuRwZQrEL/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.j0NFvC1UDt/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-27 16:02:11,714 truncating revision to first 12 chars 2017-01-27 16:02:11,714 Setting DEBUG logging. 2017-01-27 16:02:11,714 attempt 1/10 2017-01-27 16:02:11,714 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/07e5979a0222?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 16:02:12,362 unpacking tar archive at: mozilla-beta-07e5979a0222/testing/mozharness/ program finished with exit code 0 elapsedTime=0.905717 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:12.556317) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:12.556937) ========= script_repo_revision: 07e5979a0222b793499d9f6d62680a6e5bab251c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:12.557579) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:12.558062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 16:02:12.579228) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-27 16:02:12.579629) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IbuRwZQrEL/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.j0NFvC1UDt/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:12 INFO - MultiFileLogger online at 20170127 16:02:12 in /builds/slave/test 16:02:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:02:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:02:12 INFO - {'append_to_log': False, 16:02:12 INFO - 'base_work_dir': '/builds/slave/test', 16:02:12 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:02:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:02:12 INFO - 'branch': 'Mozilla-Beta', 16:02:12 INFO - 'buildbot_json_path': 'buildprops.json', 16:02:12 INFO - 'config_files': ('talos/mac_config.py',), 16:02:12 INFO - 'default_actions': ('clobber', 16:02:12 INFO - 'read-buildbot-config', 16:02:12 INFO - 'download-and-extract', 16:02:12 INFO - 'populate-webroot', 16:02:12 INFO - 'create-virtualenv', 16:02:12 INFO - 'install', 16:02:12 INFO - 'run-tests'), 16:02:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:02:12 INFO - 'download_minidump_stackwalk': True, 16:02:12 INFO - 'download_symbols': 'ondemand', 16:02:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:02:12 INFO - 'tooltool.py': '/tools/tooltool.py', 16:02:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:02:12 INFO - '/tools/misc-python/virtualenv.py')}, 16:02:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:02:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:02:12 INFO - 'installer_path': 'installer.exe', 16:02:12 INFO - 'log_level': 'info', 16:02:12 INFO - 'log_name': 'talos', 16:02:12 INFO - 'log_to_console': True, 16:02:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:02:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:02:12 INFO - 'opt_config_files': (), 16:02:12 INFO - 'pip_index': False, 16:02:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:02:12 INFO - 'cmd': ('bash', 16:02:12 INFO - '-c', 16:02:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:02:12 INFO - 'enabled': True, 16:02:12 INFO - 'halt_on_failure': False, 16:02:12 INFO - 'name': 'check_screen_resolution'},), 16:02:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:02:12 INFO - 'cmd': ('bash', 16:02:12 INFO - '-c', 16:02:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:02:12 INFO - 'enabled': True, 16:02:12 INFO - 'halt_on_failure': False, 16:02:12 INFO - 'name': 'check_screen_resolution'},), 16:02:12 INFO - 'run_cmd_checks_enabled': True, 16:02:12 INFO - 'sps_profile': False, 16:02:12 INFO - 'sps_profile_interval': 0, 16:02:12 INFO - 'suite': 'dromaeojs', 16:02:12 INFO - 'system_bits': '32', 16:02:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:02:12 INFO - 'title': 't-yosemite-r7-0328', 16:02:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:02:12 INFO - 'use_talos_json': True, 16:02:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:02:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:02:12 INFO - 'work_dir': 'build'} 16:02:12 INFO - [mozharness: 2017-01-28 00:02:12.784361Z] Running clobber step. 16:02:12 INFO - Running pre-action listener: _resource_record_pre_action 16:02:12 INFO - Running main action method: clobber 16:02:12 INFO - rmtree: /builds/slave/test/build 16:02:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:02:13 INFO - Running post-action listener: _resource_record_post_action 16:02:13 INFO - [mozharness: 2017-01-28 00:02:13.710587Z] Finished clobber step (success) 16:02:13 INFO - [mozharness: 2017-01-28 00:02:13.710751Z] Running read-buildbot-config step. 16:02:13 INFO - Running pre-action listener: _resource_record_pre_action 16:02:13 INFO - Running main action method: read_buildbot_config 16:02:13 INFO - Using buildbot properties: 16:02:13 INFO - { 16:02:13 INFO - "project": "", 16:02:13 INFO - "product": "firefox", 16:02:13 INFO - "script_repo_revision": "production", 16:02:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 16:02:13 INFO - "repository": "", 16:02:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 16:02:13 INFO - "buildid": "20170127133620", 16:02:13 INFO - "pgo_build": "False", 16:02:13 INFO - "basedir": "/builds/slave/test", 16:02:13 INFO - "buildnumber": 11, 16:02:13 INFO - "slavename": "t-yosemite-r7-0328", 16:02:13 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:02:13 INFO - "platform": "yosemite_r7", 16:02:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:02:13 INFO - "branch": "mozilla-beta", 16:02:13 INFO - "repo_path": "releases/mozilla-beta", 16:02:13 INFO - "revision": "07e5979a0222b793499d9f6d62680a6e5bab251c", 16:02:13 INFO - "stage_platform": "macosx64", 16:02:13 INFO - "builduid": "41444ef8a5a0436e9d8671f07b3cd6e1", 16:02:13 INFO - "slavebuilddir": "test" 16:02:13 INFO - } 16:02:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 16:02:13 INFO - Running post-action listener: _resource_record_post_action 16:02:13 INFO - [mozharness: 2017-01-28 00:02:13.714029Z] Finished read-buildbot-config step (success) 16:02:13 INFO - [mozharness: 2017-01-28 00:02:13.714160Z] Running download-and-extract step. 16:02:13 INFO - Running pre-action listener: _resource_record_pre_action 16:02:13 INFO - Running main action method: download_and_extract 16:02:13 INFO - mkdir: /builds/slave/test/build/tests 16:02:13 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')]} 16:02:13 INFO - trying https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 16:02:13 INFO - Downloading https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 16:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 16:02:14 INFO - Downloaded 1165 bytes. 16:02:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 16:02:14 INFO - Using the following test package requirements: 16:02:14 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 16:02:14 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:02:14 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 16:02:14 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:02:14 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 16:02:14 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:02:14 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:02:14 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 16:02:14 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 16:02:14 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:02:14 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 16:02:14 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:02:14 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 16:02:14 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:02:14 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 16:02:14 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:02:14 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 16:02:14 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 16:02:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 16:02:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 16:02:14 INFO - Fetch https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 16:02:15 INFO - Http code: 200 16:02:15 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 16:02:15 INFO - x-amz-cf-id: qp5b3ISzDwCOcLcj3NxgtBegSYni-w2oCj9A7DbLKSaMPoXtU1zuSg== 16:02:15 INFO - x-amz-version-id: ylm9CbZ4WtMiaFBXuIgIewAEm7X3LnNo 16:02:15 INFO - Expected file size: 16087628 16:02:15 INFO - Obtained file size: 16087628 16:02:22 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:02:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 16:02:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 16:02:22 INFO - Fetch https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 16:02:22 INFO - Http code: 200 16:02:22 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 16:02:22 INFO - x-amz-cf-id: QLx3B0hIsnySDvFW_pOd9_ouzNnURiyBn2cpawSpxwrm-QFwPY6G6g== 16:02:22 INFO - x-amz-version-id: ylm9CbZ4WtMiaFBXuIgIewAEm7X3LnNo 16:02:22 INFO - Expected file size: 16087628 16:02:22 INFO - Obtained file size: 16087628 16:02:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 16:02:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 16:02:29 INFO - Fetch https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 16:02:30 INFO - Http code: 200 16:02:30 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 16:02:30 INFO - x-amz-cf-id: si_z4Zwn4YnwhVA6SAYmc4CGIotUqz38iFPcxm1_1JB4hpPdfaGuKA== 16:02:30 INFO - x-amz-version-id: tRImXx4UjMm_JBJJU4c2kFAcXFHtttD2 16:02:30 INFO - Expected file size: 14402992 16:02:30 INFO - Obtained file size: 14402992 16:02:30 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')]} 16:02:30 INFO - trying https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:02:30 INFO - Downloading https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 16:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 16:02:33 INFO - Downloaded 82135629 bytes. 16:02:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:02:33 INFO - mkdir: /builds/slave/test/properties 16:02:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:02:33 INFO - Writing to file /builds/slave/test/properties/build_url 16:02:33 INFO - Contents: 16:02:33 INFO - build_url:https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:02:33 INFO - Running post-action listener: _resource_record_post_action 16:02:33 INFO - Running post-action listener: set_extra_try_arguments 16:02:33 INFO - [mozharness: 2017-01-28 00:02:33.732886Z] Finished download-and-extract step (success) 16:02:33 INFO - [mozharness: 2017-01-28 00:02:33.733005Z] Running populate-webroot step. 16:02:33 INFO - Running pre-action listener: _resource_record_pre_action 16:02:33 INFO - Running main action method: populate_webroot 16:02:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:02:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:02:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:02:33 INFO - '--tppagecycles', 16:02:33 INFO - '7'], 16:02:33 INFO - 'tests': ['tsvgm']}}, 16:02:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:02:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:02:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:02:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:02:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:02:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:02:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['damp', 'tps']}, 16:02:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'tests': ['damp', 'tps']}, 16:02:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['dromaeo_dom']}, 16:02:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:02:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['basic_compositor_video']}, 16:02:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:02:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other-e10s': {'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['tsvgx', 16:02:33 INFO - 'tsvgr_opacity', 16:02:33 INFO - 'tart', 16:02:33 INFO - 'tscrollx', 16:02:33 INFO - 'cart']}, 16:02:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:02:33 INFO - 'tsvgr_opacity', 16:02:33 INFO - 'tart', 16:02:33 INFO - 'tscrollx', 16:02:33 INFO - 'cart']}, 16:02:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['tp5o']}, 16:02:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'tests': ['tp5o']}, 16:02:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--disable-e10s', 16:02:33 INFO - '--xperf_path', 16:02:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:02:33 INFO - 'tests': ['tp5n']}, 16:02:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--xperf_path', 16:02:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:02:33 INFO - 'tests': ['tp5n']}}, 16:02:33 INFO - 'talos.zip': {'path': '', 16:02:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:02:33 INFO - Running post-action listener: _resource_record_post_action 16:02:33 INFO - [mozharness: 2017-01-28 00:02:33.751998Z] Finished populate-webroot step (success) 16:02:33 INFO - [mozharness: 2017-01-28 00:02:33.752134Z] Running create-virtualenv step. 16:02:33 INFO - Running pre-action listener: _resource_record_pre_action 16:02:33 INFO - Running main action method: create_virtualenv 16:02:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:02:33 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 16:02:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:02:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:02:33 INFO - Using real prefix '/tools/python27' 16:02:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:02:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:02:37 INFO - Installing pip.................done. 16:02:37 INFO - Return code: 0 16:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:02:37 INFO - Reading from file tmpfile_stdout 16:02:37 INFO - Output received: 16:02:37 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) 16:02:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:37 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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:37 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 16:02:37 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 16:02:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:02:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:37 INFO - 'HOME': '/Users/cltbld', 16:02:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:37 INFO - 'LOGNAME': 'cltbld', 16:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:37 INFO - 'MOZ_NO_REMOTE': '1', 16:02:37 INFO - 'NO_EM_RESTART': '1', 16:02:37 INFO - 'PAGER': '/bin/cat', 16:02:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:37 INFO - 'PWD': '/builds/slave/test', 16:02:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:37 INFO - 'SHELL': '/bin/bash', 16:02:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:02:37 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:02:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:37 INFO - 'USER': 'cltbld', 16:02:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:37 INFO - 'XPC_FLAGS': '0x0', 16:02:37 INFO - 'XPC_SERVICE_NAME': '0', 16:02:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:37 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 16:02:37 INFO - Cleaning up... 16:02:37 INFO - Return code: 0 16:02:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:37 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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:37 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 16:02:37 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 16:02:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:02:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:37 INFO - 'HOME': '/Users/cltbld', 16:02:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:37 INFO - 'LOGNAME': 'cltbld', 16:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:37 INFO - 'MOZ_NO_REMOTE': '1', 16:02:37 INFO - 'NO_EM_RESTART': '1', 16:02:37 INFO - 'PAGER': '/bin/cat', 16:02:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:37 INFO - 'PWD': '/builds/slave/test', 16:02:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:37 INFO - 'SHELL': '/bin/bash', 16:02:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:02:37 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:02:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:37 INFO - 'USER': 'cltbld', 16:02:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:37 INFO - 'XPC_FLAGS': '0x0', 16:02:37 INFO - 'XPC_SERVICE_NAME': '0', 16:02:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:38 INFO - Downloading/unpacking psutil>=3.1.1 16:02:38 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 16:02:38 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 16:02:38 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 16:02:38 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 16:02:38 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 16:02:38 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 16:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:02:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:41 INFO - Installing collected packages: psutil 16:02:41 INFO - Running setup.py install for psutil 16:02:41 INFO - building 'psutil._psutil_osx' extension 16:02:41 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 16:02:42 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 16:02:42 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 16:02:42 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 16:02:42 INFO - building 'psutil._psutil_posix' extension 16:02:42 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 16:02:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:02:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:02:42 INFO - ^ 16:02:42 INFO - 1 warning generated. 16:02:42 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 16:02:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:42 INFO - Successfully installed psutil 16:02:42 INFO - Cleaning up... 16:02:42 INFO - Return code: 0 16:02:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:42 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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:42 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 16:02:42 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 16:02:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:02:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:42 INFO - 'HOME': '/Users/cltbld', 16:02:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:42 INFO - 'LOGNAME': 'cltbld', 16:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:42 INFO - 'MOZ_NO_REMOTE': '1', 16:02:42 INFO - 'NO_EM_RESTART': '1', 16:02:42 INFO - 'PAGER': '/bin/cat', 16:02:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:42 INFO - 'PWD': '/builds/slave/test', 16:02:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:42 INFO - 'SHELL': '/bin/bash', 16:02:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:02:42 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:02:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:42 INFO - 'USER': 'cltbld', 16:02:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:42 INFO - 'XPC_FLAGS': '0x0', 16:02:42 INFO - 'XPC_SERVICE_NAME': '0', 16:02:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:02:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:02:45 INFO - Installing collected packages: mozsystemmonitor 16:02:45 INFO - Running setup.py install for mozsystemmonitor 16:02:45 INFO - Successfully installed mozsystemmonitor 16:02:45 INFO - Cleaning up... 16:02:46 INFO - Return code: 0 16:02:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:46 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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:46 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 16:02:46 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 16:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:46 INFO - 'HOME': '/Users/cltbld', 16:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:46 INFO - 'LOGNAME': 'cltbld', 16:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:46 INFO - 'MOZ_NO_REMOTE': '1', 16:02:46 INFO - 'NO_EM_RESTART': '1', 16:02:46 INFO - 'PAGER': '/bin/cat', 16:02:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:46 INFO - 'PWD': '/builds/slave/test', 16:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:46 INFO - 'SHELL': '/bin/bash', 16:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:02:46 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:46 INFO - 'USER': 'cltbld', 16:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:46 INFO - 'XPC_FLAGS': '0x0', 16:02:46 INFO - 'XPC_SERVICE_NAME': '0', 16:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:46 INFO - Downloading/unpacking jsonschema==2.5.1 16:02:46 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 16:02:46 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 16:02:46 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 16:02:46 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 16:02:46 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 16:02:46 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 16:02:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:02:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:02:48 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 16:02:48 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 16:02:48 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 16:02:48 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 16:02:48 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 16:02:48 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 16:02:49 INFO - Downloading functools32-3.2.3-2.tar.gz 16:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:02:49 INFO - warning: no files found matching '*.txt' 16:02:49 INFO - no previously-included directories found matching 'build' 16:02:49 INFO - no previously-included directories found matching 'dist' 16:02:49 INFO - no previously-included directories found matching '.git*' 16:02:49 INFO - Installing collected packages: jsonschema, functools32 16:02:49 INFO - Running setup.py install for functools32 16:02:49 INFO - warning: no files found matching '*.txt' 16:02:49 INFO - no previously-included directories found matching 'build' 16:02:49 INFO - no previously-included directories found matching 'dist' 16:02:49 INFO - no previously-included directories found matching '.git*' 16:02:49 INFO - Successfully installed jsonschema functools32 16:02:49 INFO - Cleaning up... 16:02:49 INFO - Return code: 0 16:02:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:02:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:02:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:49 INFO - 'HOME': '/Users/cltbld', 16:02:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:49 INFO - 'LOGNAME': 'cltbld', 16:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:49 INFO - 'MOZ_NO_REMOTE': '1', 16:02:49 INFO - 'NO_EM_RESTART': '1', 16:02:49 INFO - 'PAGER': '/bin/cat', 16:02:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:49 INFO - 'PWD': '/builds/slave/test', 16:02:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:49 INFO - 'SHELL': '/bin/bash', 16:02:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:02:49 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:02:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:49 INFO - 'USER': 'cltbld', 16:02:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:49 INFO - 'XPC_FLAGS': '0x0', 16:02:49 INFO - 'XPC_SERVICE_NAME': '0', 16:02:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:02:49 INFO - Cleaning up... 16:02:49 INFO - Return code: 0 16:02:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:02:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:02:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:49 INFO - 'HOME': '/Users/cltbld', 16:02:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:49 INFO - 'LOGNAME': 'cltbld', 16:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:49 INFO - 'MOZ_NO_REMOTE': '1', 16:02:49 INFO - 'NO_EM_RESTART': '1', 16:02:49 INFO - 'PAGER': '/bin/cat', 16:02:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:49 INFO - 'PWD': '/builds/slave/test', 16:02:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:49 INFO - 'SHELL': '/bin/bash', 16:02:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:02:49 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:02:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:49 INFO - 'USER': 'cltbld', 16:02:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:49 INFO - 'XPC_FLAGS': '0x0', 16:02:49 INFO - 'XPC_SERVICE_NAME': '0', 16:02:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:50 INFO - Downloading/unpacking blobuploader==1.2.4 16:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:52 INFO - Downloading blobuploader-1.2.4.tar.gz 16:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:02:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:02:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:54 INFO - Downloading docopt-0.6.1.tar.gz 16:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:02:54 INFO - Installing collected packages: blobuploader, requests, docopt 16:02:54 INFO - Running setup.py install for blobuploader 16:02:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:02:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:02:54 INFO - Running setup.py install for requests 16:02:54 INFO - Running setup.py install for docopt 16:02:55 INFO - Successfully installed blobuploader requests docopt 16:02:55 INFO - Cleaning up... 16:02:55 INFO - Return code: 0 16:02:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:55 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')]} 16:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:55 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')]} 16:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:55 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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:55 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 16:02:55 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 16:02:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:02:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:55 INFO - 'HOME': '/Users/cltbld', 16:02:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:55 INFO - 'LOGNAME': 'cltbld', 16:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:55 INFO - 'MOZ_NO_REMOTE': '1', 16:02:55 INFO - 'NO_EM_RESTART': '1', 16:02:55 INFO - 'PAGER': '/bin/cat', 16:02:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:55 INFO - 'PWD': '/builds/slave/test', 16:02:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:55 INFO - 'SHELL': '/bin/bash', 16:02:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:02:55 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:02:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:55 INFO - 'USER': 'cltbld', 16:02:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:55 INFO - 'XPC_FLAGS': '0x0', 16:02:55 INFO - 'XPC_SERVICE_NAME': '0', 16:02:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-V693mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-jEsyPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Y0vmrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-17vhNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-p2qv98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:55 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-29dAQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-crEUu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-sWmSQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-dz25X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-df13yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-2iW0wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-b_Lckr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-gL_XMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-y_Dlr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:56 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-JFrwDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-OQIpIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:57 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-E2F5yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:02:57 INFO - Running setup.py install for manifestparser 16:02:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:02:57 INFO - Running setup.py install for mozcrash 16:02:57 INFO - Running setup.py install for mozdebug 16:02:57 INFO - Running setup.py install for mozdevice 16:02:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:02:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:02:57 INFO - Running setup.py install for mozfile 16:02:57 INFO - Running setup.py install for mozhttpd 16:02:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:02:58 INFO - Running setup.py install for mozinfo 16:02:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:02:58 INFO - Running setup.py install for mozInstall 16:02:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:02:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:02:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:02:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:02:58 INFO - Running setup.py install for mozleak 16:02:58 INFO - Running setup.py install for mozlog 16:02:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:02:58 INFO - Running setup.py install for moznetwork 16:02:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:02:58 INFO - Running setup.py install for mozprocess 16:02:59 INFO - Running setup.py install for mozprofile 16:02:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:02:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:02:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:02:59 INFO - Running setup.py install for mozrunner 16:02:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:02:59 INFO - Running setup.py install for mozscreenshot 16:02:59 INFO - Running setup.py install for moztest 16:02:59 INFO - Running setup.py install for mozversion 16:02:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:02:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:02:59 INFO - Cleaning up... 16:02:59 INFO - Return code: 0 16:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:59 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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:02:59 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 16:02:59 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 16:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:02:59 INFO - 'HOME': '/Users/cltbld', 16:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:02:59 INFO - 'LOGNAME': 'cltbld', 16:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:59 INFO - 'MOZ_NO_REMOTE': '1', 16:02:59 INFO - 'NO_EM_RESTART': '1', 16:02:59 INFO - 'PAGER': '/bin/cat', 16:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:59 INFO - 'PWD': '/builds/slave/test', 16:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:02:59 INFO - 'SHELL': '/bin/bash', 16:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:02:59 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:02:59 INFO - 'USER': 'cltbld', 16:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:59 INFO - 'XPC_FLAGS': '0x0', 16:02:59 INFO - 'XPC_SERVICE_NAME': '0', 16:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-VZVQ9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:03:00 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)) 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-rYJPiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-4Ag1Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:03:00 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)) 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-A4PdtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:03:00 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)) 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Z3trES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:03:00 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)) 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-_57THh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:03:00 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)) 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-bUZHix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:03:00 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)) 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-kXulzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:03:00 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)) 16:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:03:00 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-0HkOQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:03:01 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)) 16:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:03:01 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-oDZ2X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:03:01 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)) 16:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:03:01 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-CTnvsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:03:01 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)) 16:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:03:01 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-PrRbCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:03:01 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)) 16:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:03:01 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-Gz6GaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:03:01 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)) 16:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:03:01 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-qcMdIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:01 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-WbYPeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:03:01 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)) 16:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:03:01 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-s5LaBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:03:01 INFO - Running setup.py (path:/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/pip-A_JCcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:03:01 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)) 16:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:03:01 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)) 16:03:01 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)) 16:03:01 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)) 16:03:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:03:01 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 16:03:01 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 16:03:01 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 16:03:01 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 16:03:01 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 16:03:01 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 16:03:04 INFO - Downloading blessings-1.6.tar.gz 16:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:03:04 INFO - Installing collected packages: blessings 16:03:04 INFO - Running setup.py install for blessings 16:03:04 INFO - Successfully installed blessings 16:03:04 INFO - Cleaning up... 16:03:04 INFO - Return code: 0 16:03:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:03:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:03:05 INFO - Reading from file tmpfile_stdout 16:03:05 INFO - Current package versions: 16:03:05 INFO - blessings == 1.6 16:03:05 INFO - blobuploader == 1.2.4 16:03:05 INFO - docopt == 0.6.1 16:03:05 INFO - functools32 == 3.2.3-2 16:03:05 INFO - jsonschema == 2.5.1 16:03:05 INFO - manifestparser == 1.1 16:03:05 INFO - mozInstall == 1.12 16:03:05 INFO - mozcrash == 1.0 16:03:05 INFO - mozdebug == 0.1 16:03:05 INFO - mozdevice == 0.48 16:03:05 INFO - mozfile == 1.2 16:03:05 INFO - mozhttpd == 0.7 16:03:05 INFO - mozinfo == 0.9 16:03:05 INFO - mozleak == 0.1 16:03:05 INFO - mozlog == 3.4 16:03:05 INFO - moznetwork == 0.27 16:03:05 INFO - mozprocess == 0.23 16:03:05 INFO - mozprofile == 0.28 16:03:05 INFO - mozrunner == 6.13 16:03:05 INFO - mozscreenshot == 0.1 16:03:05 INFO - mozsystemmonitor == 0.3 16:03:05 INFO - moztest == 0.8 16:03:05 INFO - mozversion == 1.4 16:03:05 INFO - psutil == 3.1.1 16:03:05 INFO - requests == 1.2.3 16:03:05 INFO - wsgiref == 0.1.2 16:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:05 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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:03:05 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 16:03:05 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 16:03:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:03:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:03:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:03:05 INFO - 'HOME': '/Users/cltbld', 16:03:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:03:05 INFO - 'LOGNAME': 'cltbld', 16:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:05 INFO - 'MOZ_NO_REMOTE': '1', 16:03:05 INFO - 'NO_EM_RESTART': '1', 16:03:05 INFO - 'PAGER': '/bin/cat', 16:03:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:05 INFO - 'PWD': '/builds/slave/test', 16:03:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:03:05 INFO - 'SHELL': '/bin/bash', 16:03:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:03:05 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:03:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:03:05 INFO - 'USER': 'cltbld', 16:03:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:03:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:05 INFO - 'XPC_FLAGS': '0x0', 16:03:05 INFO - 'XPC_SERVICE_NAME': '0', 16:03:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 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)) 16:03:05 INFO - Cleaning up... 16:03:05 INFO - Return code: 0 16:03:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:03:05 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 0x10d95c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d8d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7a0496f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, '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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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 16:03:05 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 16:03:05 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 16:03:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:03:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:03:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:03:05 INFO - 'HOME': '/Users/cltbld', 16:03:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:03:05 INFO - 'LOGNAME': 'cltbld', 16:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:05 INFO - 'MOZ_NO_REMOTE': '1', 16:03:05 INFO - 'NO_EM_RESTART': '1', 16:03:05 INFO - 'PAGER': '/bin/cat', 16:03:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:05 INFO - 'PWD': '/builds/slave/test', 16:03:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:03:05 INFO - 'SHELL': '/bin/bash', 16:03:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:03:05 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:03:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:03:05 INFO - 'USER': 'cltbld', 16:03:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:03:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:05 INFO - 'XPC_FLAGS': '0x0', 16:03:05 INFO - 'XPC_SERVICE_NAME': '0', 16:03:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:03:05 INFO - Cleaning up... 16:03:05 INFO - Return code: 0 16:03:05 INFO - Running post-action listener: _resource_record_post_action 16:03:05 INFO - Running post-action listener: _start_resource_monitoring 16:03:05 INFO - Starting resource monitoring. 16:03:05 INFO - [mozharness: 2017-01-28 00:03:05.752691Z] Finished create-virtualenv step (success) 16:03:05 INFO - [mozharness: 2017-01-28 00:03:05.753693Z] Running install step. 16:03:05 INFO - Running pre-action listener: _resource_record_pre_action 16:03:05 INFO - Running main action method: install 16:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:03:06 INFO - Reading from file tmpfile_stdout 16:03:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:03:06 INFO - Reading from file tmpfile_stdout 16:03:06 INFO - Output received: 16:03:06 INFO - Usage: mozinstall [options] installer 16:03:06 INFO - Options: 16:03:06 INFO - -h, --help show this help message and exit 16:03:06 INFO - -d DEST, --destination=DEST 16:03:06 INFO - Directory to install application into. [default: 16:03:06 INFO - "/builds/slave/test"] 16:03:06 INFO - --app=APP Application being installed. [default: firefox] 16:03:06 INFO - mkdir: /builds/slave/test/build/application 16:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:03:27 INFO - Reading from file tmpfile_stdout 16:03:27 INFO - Output received: 16:03:27 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:03:27 INFO - Running post-action listener: _resource_record_post_action 16:03:27 INFO - [mozharness: 2017-01-28 00:03:27.623091Z] Finished install step (success) 16:03:27 INFO - [mozharness: 2017-01-28 00:03:27.623256Z] Running run-tests step. 16:03:27 INFO - Running pre-action listener: _resource_record_pre_action 16:03:27 INFO - Running main action method: run_tests 16:03:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:03:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:03:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:03:27 INFO - 2017-01-27 16:03:27.637 screenresolution[2198:16131] starting screenresolution argv=screenresolution get 16:03:27 INFO - 2017-01-27 16:03:27.640 screenresolution[2198:16131] Display 0: 1600x1200x32@60 16:03:27 INFO - 2017-01-27 16:03:27.646 screenresolution[2199:16134] starting screenresolution argv=screenresolution list 16:03:27 INFO - Available Modes on Display 0 16:03:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:03:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:03:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:03:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:03:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:03:27 INFO - Intel Iris: 16:03:27 INFO - Chipset Model: Intel Iris 16:03:27 INFO - Type: GPU 16:03:27 INFO - Bus: Built-In 16:03:27 INFO - VRAM (Dynamic, Max): 1536 MB 16:03:27 INFO - Vendor: Intel (0x8086) 16:03:27 INFO - Device ID: 0x0a2e 16:03:27 INFO - Revision ID: 0x0009 16:03:27 INFO - Displays: 16:03:27 INFO - Display: 16:03:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:03:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:03:27 INFO - Display Serial Number: 1600x1200 60 16:03:27 INFO - Main Display: Yes 16:03:27 INFO - Mirror: Off 16:03:27 INFO - Online: Yes 16:03:27 INFO - Rotation: Supported 16:03:27 INFO - Return code: 0 16:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:03:27 INFO - Python 2.7.3 16:03:27 INFO - Return code: 0 16:03:27 INFO - grabbing minidump binary from tooltool 16:03: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')]} 16:03:27 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 0x10d770d30>, '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 0x10d5d6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d768b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:03:27 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 16:03:27 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 16:03:27 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 16:03:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:03:28 INFO - Return code: 0 16:03:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:03:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:03:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:03:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:03:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--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 16:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0328 --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 16:03:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IbuRwZQrEL/Render', 16:03:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:03:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:03:28 INFO - 'HOME': '/Users/cltbld', 16:03:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:03:28 INFO - 'LOGNAME': 'cltbld', 16:03:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:28 INFO - 'MOZ_NO_REMOTE': '1', 16:03:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:28 INFO - 'NO_EM_RESTART': '1', 16:03:28 INFO - 'PAGER': '/bin/cat', 16:03:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:28 INFO - 'PWD': '/builds/slave/test', 16:03:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:03:28 INFO - 'SHELL': '/bin/bash', 16:03:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.j0NFvC1UDt/Listeners', 16:03:28 INFO - 'TMPDIR': '/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/', 16:03:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:03:28 INFO - 'USER': 'cltbld', 16:03:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:03:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:28 INFO - 'XPC_FLAGS': '0x0', 16:03:28 INFO - 'XPC_SERVICE_NAME': '0', 16:03:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:03:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0328', '--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 16:03:28 INFO - mozversion application_buildid: 20170127133620 16:03:28 INFO - mozversion application_changeset: 07e5979a0222b793499d9f6d62680a6e5bab251c 16:03:28 INFO - mozversion application_display_name: Firefox 16:03:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:03:28 INFO - mozversion application_name: Firefox 16:03:28 INFO - mozversion application_remotingname: firefox 16:03:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:03:28 INFO - mozversion application_vendor: Mozilla 16:03:28 INFO - mozversion application_version: 52.0 16:03:28 INFO - mozversion platform_buildid: 20170127133620 16:03:28 INFO - mozversion platform_changeset: 07e5979a0222b793499d9f6d62680a6e5bab251c 16:03:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:03:28 INFO - mozversion platform_version: 52.0 16:03:28 INFO - using testdate: 1485561808 16:03:28 INFO - actual date: 1485561808 16:03:28 INFO - starting webserver on 'localhost:51755' 16:03:28 INFO - SUITE-START | Running 2 tests 16:03:28 INFO - TEST-START | dromaeo_css 16:03:28 INFO - operating with platform_type : mac_ 16:03:28 INFO - Initialising browser for dromaeo_css test... 16:03:28 INFO - TEST-INFO | started process 2209 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpwwm0u8/profile http://localhost:51755/getInfo.html) 16:03:30 INFO - PROCESS | 2209 | __metrics Screen width/height:1600/1200 16:03:30 INFO - PROCESS | 2209 | colorDepth:24 16:03:30 INFO - PROCESS | 2209 | Browser inner width/height: 1024/689 16:03:30 INFO - PROCESS | 2209 | __metrics 16:03:30 INFO - PROCESS | 2209 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:03:30 INFO - PROCESS | 2209 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:03:31 INFO - TEST-INFO | 2209: exit 0 16:03:31 INFO - Browser initialized. 16:03:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:03:31 INFO - TEST-INFO | started process 2212 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpwwm0u8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:44 INFO - PROCESS | 2212 | RSS: Main: 171720704 16:03:44 INFO - PROCESS | 2212 | 16:06:46 INFO - PROCESS | 2212 | Cycle 1(1): loaded http://localhost:51755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51755/tests/dromaeo/cssquery-ext.html) 16:06:48 INFO - PROCESS | 2212 | RSS: Main: 317292544 16:06:48 INFO - PROCESS | 2212 | 16:09:51 INFO - PROCESS | 2212 | Cycle 1(1): loaded http://localhost:51755/tests/dromaeo/cssquery-ext.html (next: http://localhost:51755/tests/dromaeo/cssquery-jquery.html) 16:09:52 INFO - PROCESS | 2212 | RSS: Main: 307712000 16:09:52 INFO - PROCESS | 2212 | 16:12:54 INFO - PROCESS | 2212 | Cycle 1(1): loaded http://localhost:51755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51755/tests/dromaeo/cssquery-mootools.html) 16:12:55 INFO - PROCESS | 2212 | RSS: Main: 271007744 16:12:55 INFO - PROCESS | 2212 | 16:15:57 INFO - PROCESS | 2212 | Cycle 1(1): loaded http://localhost:51755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51755/tests/dromaeo/cssquery-prototype.html) 16:15:58 INFO - PROCESS | 2212 | RSS: Main: 263884800 16:15:58 INFO - PROCESS | 2212 | 16:19:01 INFO - PROCESS | 2212 | Cycle 1(1): loaded http://localhost:51755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51755/tests/dromaeo/cssquery-yui.html) 16:19:02 INFO - PROCESS | 2212 | RSS: Main: 257781760 16:19:02 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | Cycle 1(1): loaded http://localhost:51755/tests/dromaeo/cssquery-yui.html (next: http://localhost:51755/tests/dromaeo/cssquery-dojo.html) 16:22:05 INFO - PROCESS | 2212 | RSS: Main: 308064256 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | __start_tp_report 16:22:05 INFO - PROCESS | 2212 | _x_x_mozilla_page_load 16:22:05 INFO - PROCESS | 2212 | _x_x_mozilla_page_load_details 16:22:05 INFO - PROCESS | 2212 | |i|pagename|runs| 16:22:05 INFO - PROCESS | 2212 | |0;dojo.html;3417.794932304062;3447.103753024213;3453.7064349530297;3474.513568100468;3515.8417871195793;5690.772369105236;5734.311882574097;5749.540036797057;5766;5795.420457954207;5758.395368486312;5818.1272809078655;5831.883362332761;5832.6792026438525;5838.795642152526;5182.144946083901;5215;5270.604704647148;5274.736263186845;5297.311349524556;5122.743862806863;5135.024345374386;5153.458886816887;5214.270002199695;5313.601479889005;5084.949150508503;5222.294990176316;5224.817131400402;5226.320578324831;5231.189165679307;4796.232602783555;5235.057689615867;5243.397009343936;5249.186376111708;5260.079486089919;5156.329677141947;5186.170212765977;5187.662801917863;5239.13554263546;5240.240165176028;5646.632968857011;5707.914381284284;5811.883762324772;5813.128030795372;5898.911516327215;6176.042713379434;6194.101855230966;6221.844453888643;6221.96889015552;6235.220597425322;6251.218597675291;6265.216847894013;6276.843078923063;6285.465735412449;6288.434040936338;5678.630888992202;5863.618864773776;5864.618799778001;5868.09044598088;5898;6191.504679625709;6228.283747369111;6232.59488133279;6234.906476402857;6255.937440625627;6178.5366097542865;6197.5351848610635;6203.31763506014;6208.4722798562625;6216.098665693539;6138.725610151984;6271.310155882849;6277.497800175975;6281.623102613858;6317.4946004319545;6133.4264757247465;6160.260768707783;6208.255009398901;6211.875762484725;6281.466075383552;6228.252609686776;6267.561270711007;6281.560290779693;6299.118123462719;6301.653409062454;4971.751412429364;5012.774425150877;5018.723970181675;5022.096022715873;5024.145895197825;4447.332900064951;4460.286354183315;4464.732116073046;4469.7988590513505;4500.459944806578;4838.588719958772;5948.851278718067;5957;5958.970205148947;5999.850003749942;6246.094316324107;6254.9687251563455;6268.1851359323;6269.655168965751;6275.748970041239;5707.942920570824;5710.771569137188;5820;5898.292204935436;5911.704414779244;5439;5447;5480.808171713971;5496.477834605706;5516.365617953907;6422.614643121427;6439.9356006440275;6446.645434501147;6451.903221451588;6453;6140.17107690456;6240.637799155055;6251.0623406487575;6283.37166283368;6305.5270854687;4948.331975183304;6256.7810126645345;6309.148264984168;6313.1477250572425;6490.350964903472;6245.094461302995;6251.9062214067735;6260.561760676709;6262.780802672067;6267.185265915584;5806.925718742046;5922.911156332744;6129.111278864629;6224.502039836892;6266.498680105672;6020.217371741645;6099.176611157614;6125.571210015256;6131.938680613137;6143.877122457437;6177.96911015442;6208.658523781235;6211.9689401552705;6213.813585592439;6215.751369945152;6073.878522429615;6075;6081.391860813883;6084.847878803065;6113.358097399887;4386.561343865588;5939.376365481735;5990.4908082813445;6049.334573197033;6171.537134714825;6059.96980513305;6078.240219972504;6082.7262773174425;6101.2068431105445;6120.296165940796 16:22:05 INFO - PROCESS | 2212 | |1;ext.html;445.68579151698077;449.4269805997354;481.3309499795285;488.0799692579487;548.3091304955759;24903;33432.82985095522;33450;33479.33041339178;33488;42005.15989680212;43164.56835431645;43269;45697;45744.85637859047;9596.472194029308;9744.707658770249;9745.074217949283;9752.853707194397;9772.169365603932;8954.14935581122;9664.903350966506;9775.951120244388;9788.265880058989;9788.461634610094;8828.382013259074;9177.265818734486;9194.724158275229;9197.724068277963;11645.592404265852;11601.013913817336;11940.820887686692;12010.579629713005;12041.879581204163;12056.63830085099;11710.648680539598;11799;11801.055915526736;11812.822807657893;11817.468213930393;41702.582974170175;41757.37363939543;41814.58185418168;41836.79081604572;41837;3346.9665303346897;3594.0835087052633;3804.353259945816;3988.6011398859882;4072.9817545613596;29695.554566681516;29971.850140749375;30955.535666965014;31920.20199495008;32290.838545807357;3251.9349613007607;3266.5426840242385;3408.3183363327435;3422.8801991930413;3461.5153878457036;508509;511756;512468.43765780935;516491;517052;65057;65422;65463.672681636286;65511.672441637485;65625.67187164034;57330.426695733346;69120;69361;69374;69402.65298673576;16356.182190890408;16512.42206522766;16535.338586456408;16549.83450165507;16553;13047.934760326327;13128.34358282082;13139.54011609589;13147.211167329991;13161.802572961413;17969.82700036895;18729.719054214198;18769.967651779283;18799.530011749543;19015.809841901682;5593;6648.800535983928;7138.500304978602;7203.567785932861;7214.639268036577;955.1737746848926;990.846418805072;1003.3929472669076;1071.603506702525;1125.932444053343;30306.786488998772;31839.68160318367;33362;33498.162545936546;33742.66257337395;1056.9524371403306;1071.3518321415588;1077.9730506737237;1087.9347239165675;1178.0869825884836;15389.538313850602;15870;15925.920370398075;16120.415644881328;16344;619270;623442;623853;627509;628079;60536.78926421535;60727;60810.69594652087;60833.08750368748;60868.086978695355;1257.9245245285313;1323.4772264955095;1324.198859689893;1432.2695425333154;1452.8547145285597;25484.490310193323;31762.682373176896;32165.678343216267;32827.67172328246;32972.1756956078;57289.713551431974;57680.42319576751;57828;57859.421405787085;57949.420505796086;621455;625689;625755.871220641;625998;626569;24470.021199152547;24600.876995614908;24819.751802481744;25427.87286063558;28048.71951280461;40700.1859962805;42142.57857421509;42525.93685157896;42887.3566896503;47982;34142.317153657285;36738;38977.6102238974;40211;40819.97950051272;39619.80190099031;39850.60149398469;40139;41554.79222603868;41599.58400415957;38585.42121868118;39338.606613933494;39820.601793982845;39952.800235998635;40002.1999560013;31240.531392028683;35208.823955880056;35246.655601991886;35491.29017419689;35686;25479;26064.869675651502;26193.153949434763;26254.737452625228;26735.866320668272 16:22:05 INFO - PROCESS | 2212 | |2;jquery.html;375.3862434918907;381.2470371017241;388.22979735945967;389.23321057516694;415.5512046989252;13728.382222799974;20437.48906277342;21047.894760526175;21389.572208555837;21406.25078122266;16134.75797863033;17815.732764008517;20119.49701257469;20711.792882071175;20850.478738031557;5722;6013.278406591194;6021.337652858182;6031.215941927543;6032.758689652431;5746.1668058131545;5847.590668653196;5991.3109992351;5997.340292567814;6050.939490605082;5924.289085309769;5925.851853703671;5944.197533333009;5948.910766338508;5954.851128721773;5694.829155125353;5905.350411454758;5941.643501389909;5985.401459854023;6003.639781613074;5201.1678131498775;5228.189630607262;5237;5237.47625237477;5237.947620523784;20826.687599686018;20936.790632093787;25155.62266566003;26201.606975895378;26619.733802662115;2258.4692597239637;2374.513224788914;2476.9009239630395;2760.9723902760916;2777.6111344411597;15908.76136857948;16032.599185020352;16066.357345706274;16243.675126497405;16736.83263167377;1661.8338166183405;1880.3230836898706;1900.9239630414904;1930.1217945834612;1967.2131147540954;117999.41000295029;118760.43718688366;122123;127353.36323318323;128624.71375286221;10689.770676372316;11028.22802403824;11099.500522476508;11361.715957100972;11362.48868800906;14155.079919805386;14254.501092461715;14258.287085645676;14267.85732142686;14269.571912842632;7701;7750.224977502317;8253.546054966915;8775.517346545874;8815.382923195315;7128.821779455555;7847.568383738949;8761.25529330014;8815.338849586307;9081.409708369067;6715.899261511081;6745.763898263537;6788.389044985975;6831.351021652935;6844.657767111625;1767.5139336682514;1799.901005444687;1807.3381457141816;1922.6827573450503;1928.3154480159621;757.3865169212845;998.6404894238068;1047.3820445936933;1070.309650275568;1097.6816723150357;17340.30638774435;21618.56762864734;22230.444238893833;22622.208222712456;22697.88651056767;941.5527624378366;961.0101595356793;975.3611384543135;1001.3641337750581;1039.2465462539749;11693.941530292293;11888.702782430508;12100;12138.211016283913;12200.877991220152;372088;444871;448891;601607;603802;107488;140935;141895.29052354672;150059;151234;973.9805203895883;985.1626117799956;1012.2357619997002;1014.2190513304862;1029.130384824822;18871;19269.710954335416;19818.702719459507;19891;19912.203511859363;54634.726826365615;56192.15711764245;56470.588235294446;56973.860522788484;58580.12129818142;75255;79136;80138.5993070031;81913.59043204984;83948.74076888974;8154;8256.25693687571;8358.540280284642;8492.617832197442;8502.319814414956;10135.695929122137;11109;12516.9360604346;13050.4127314273;13726.86273137256;11403.828942565702;11535.134864885;11740.823887641522;12009.819852702041;12072;11146.275492092987;11194.552217911518;11534.961853433231;11703.707407314545;12031.518739250332;11574.594889178838;11693.532258709556;11806.232594881305;12020.519179232733;12096.274223546616;8302.626381812954;8324.375671824517;8409.915900840913;8568.100349463466;8604.655813767378;11626.476808543466;11682.70793230176;11697.122715796178;12042.578509752468;12060.276383417024 16:22:05 INFO - PROCESS | 2212 | |3;mootools.html;1361.5574938145105;1373.8626137386264;1497.0718154744056;1641.9425320113799;1846.6491366640337;7475.626218689071;7936.246056624619;8262.710805121822;8504.744857654281;8504.95747521263;8297.087320394752;8368.20502052304;8384.329253659707;8390.66437342507;8391.66433342667;2343.437574982009;2374.7031621047367;2377.7622237776172;2381.273711517986;2382.4163080045414;2373.038919237703;2406.74729153439;2422.467057247403;2428.878556072198;2431.781139697427;2366.0299277296226;2369.8222633302485;2392.0670938334065;2394.6527753475734;2399.328188107324;2311.05246848792;2343.7773411525877;2373.9643905341263;2377.5007248477755;2380.27401642499;2316.664083707853;2337.1819863047967;2373.596488596943;2381.297517232403;2387.570237357275;8234.217749313866;8423.199796019368;8436.240738333518;8439.83120337596;8447.155284471564;5093.363329583802;5278.838655495785;5285.312909321802;5315.893682126374;5323.0152421802095;3472.322897035079;3575.3921833288405;3617.1318883468043;3647.7264205184715;3649.124210189562;1083.1659622091024;1091.4106382553412;1104.5913012185542;1129.7006293332274;1132.1904838040757;9135.862962055575;10931.398773067478;10940.960608742156;10968.17738669611;11008;4297.613214810682;4426.22541055314;4533.659975501851;4540.069285796404;4546.749928753884;8640.351973602004;8647.610857511427;8651.740447786577;8657.307415406753;8659.220670139717;5161.200013997836;5163.122269214243;5164.431912489623;5165.690058596496;5172.431032586413;4212.557681443465;4399.868003959887;4455.813350486417;4495.370648109268;4887.120318342661;3090.3664748726906;3188.3942051010235;3703.4444833275224;3796.354619714655;3800.9737370909697;1141.5319718915205;1144.3076938452282;1146.4382452598168;1156.2715489241723;1161.3380373187372;777.6111944027986;849.9022612399654;899.5592159841631;914.5655813488539;932.9253659707207;5545.168224766237;5567;5603;5841.7371218295275;5923.259592550931;741.7397167902882;852.7868032991752;909.1499448016126;945.9006804285589;969.3747532841278;3602.1354874829854;3628.9092772680365;3645.54430696163;3763.8118094095184;3774.1319496515957;9793.559289831976;10265.589376425009;10292.536835842406;10293.94853025745;10298.433586152683;10225.130863876506;10249.077583017564;10251.743706407251;10274.126699230648;10287;7615.743402338663;7710.653020614086;7877.842443151219;8033.718819841278;8052.436329456999;5320.308359913187;5394.433584473573;5506.889862202654;5523.116301391758;5678.063119585222;9417.340786145178;9470.289728270545;9478.85781713261;9487.905120948702;9554.808903822024;8905.599248033983;9191.954040229755;9381.639662249072;9461.526923653928;9581.329306948446;6473.8705225896165;6586;6595.8021259362295;6607.768728094494;6611;7903.81442783587;8030.678772849021;8091.98850143732;8116.147804480444;8144.633491492778;7223.386012188813;7248.130224373109;7274.781756547312;7310;7324.926750732425;7089.82275443118;7115.715371385294;7151;7212.206657267801;7295.52579082358;6754.797356079325;6761.459083273425;6858.279880612464;6860;6871.553349032297;4596.172688915894;4828.155072862165;4851.490593487633;4870.512948705101;4982.078315511642;4755.809767609257;4803.327534145153;4852.830150944841;4867.050925069578;4937.1113199624415 16:22:05 INFO - PROCESS | 2212 | |4;prototype.html;262.2120527813919;302.828901670556;309.26857980875224;313.9044733878761;314.07035175879395;4513.458384993801;4982.551570358667;5186.792528298868;5191.299174611427;5247.737613119339;4475.686701930867;4724.31497432872;4873.5379386184095;4952.9752351238285;5162.096633089213;3644.599094099647;3754.361758501048;3943.2113577284513;3949.7432666876634;3989.8005099744896;3937.7637341759587;3964.425158352037;3968.305546529346;3976.8409263629565;3983.1436241208135;3163.825989570573;3670.963290367102;3917.334053210947;3928.9017774555723;3944.644981951624;3712.851485940559;3933.3903244997073;3952.5454572724216;3961.861334853295;3984.4421780950547;3452.3613131570487;3463.2554000889677;3466.7053300469493;3487.430656204718;3493.4235851084795;4172.290710579209;4215.515215750197;4349.69552131351;4572.788211124055;5047.570956468705;3663.7435379523445;3850.249201405727;4425.1149770045795;4435.911281774346;4462.620677242438;3930.508686414198;4190.434291370687;5170.948290517122;5384.67691938481;5405.729713514348;3256.5766450361302;3693.3351996640595;3712.888613341604;3728.9813550932345;3744.363458212083;4497;5553.644859813084;5574.49147883454;5618.438156184349;5637.267155269829;3172.413103575846;3790.5261842269715;3795.981020094882;3800.9809950950066;3808.4673691994512;3841.8079096045085;3842.423636454554;3856.325143099946;3858.3826587745825;3858.594847541024;4273.252180868336;4460.620847228022;4475.299386233276;4477.634321531899;4482.327650852399;4819.734914579662;5362.460775887973;5384.892302154013;5393.709836999427;5446.8910621787345;1101.3612104979093;1175.735459521618;1210.8365370675021;1227.5826219085554;1237.3689418396682;705.1291654806311;791.9683212671429;799.7960520067346;824.3322908444179;829.813292009293;4657.905392232822;4780.8008316174255;4798.688085274446;4825.686330388584;4900.730459824744;4940.961308795065;5080.263361812516;5245.921311180336;5262.394824595144;5262.631915574036;4203.516595591485;4242.406063151161;4476.955230447719;4601.194790911577;4821.783019764119;2593.8314009589317;2729.5359788835945;2737.7809775217934;2746.588011798246;2749.477599256135;4829.95170048302;5299.231611416323;5418.322709661293;5429.981813458013;5453.263809385761;4606.5854073132905;4677.672562920563;4897.510248975074;4953.43035550909;5364.436734142937;5033.798648054183;5351.839444816662;5368.617770804368;5387.784488620411;5427.267318911975;4461.167158854086;4756.096341695067;4857.635677324285;5155.355580552431;5169.922451163311;3980.5223373195404;4432.778361081998;4940.431850337257;4948.480409556944;5112.897742045064;4927.433345165352;5352.518273355261;5423.864403389947;5426.852425593225;5459.836204913859;3535.8232088395994;3554.786712797137;3560.590532088843;3570;3584.15772293516;4483.686141970031;4507.414036175276;4938.358013458371;5060.797568097235;5117.667351622133;5012.498750124958;5033.785134540791;5039.3448851649055;5049.2930989660745;5074.797008119634;4498.482674492475;4547.499325222735;5014.799408023784;5069.9746501267255;5084.41529224144;4474.356272088815;4659.627229821674;4803.871090293708;4835.975820120877;4943.134951383566;4856.514348565115;4908.410990680998;4940.629452791127;5261;5413.945860541502;4487.865364039084;5307.840764777063;5321.494458026481;5324.7870085196155;5333 16:22:05 INFO - PROCESS | 2212 | |5;yui.html;638.961662300262;721.668032704956;749.6326799868066;781.679511400326;782.7886470652924;14273.929455290843;14553.78169327461;15572.143532105729;15595.766063509056;15615.84384156158;13247.735045299089;14134.434622615108;14169.645758856008;14194.716105677906;14281.143131412122;676.4858707382375;701.4738945790657;823.4194892600732;853.9274161696233;858.3991206155684;844.3456321350972;851.1105894340399;857.9871301930476;859.1623167411786;863.2748491267334;918.2470374293082;918.669279059538;919.4023884475112;920.1580553793272;921.7925966657516;908.9181973622406;911.5533388639585;913.3880300198816;914.6752902719505;914.9496777677225;675.1088563096714;676.1514299554077;676.9932300676979;678.0575000748963;678.4131726056975;14294.285285735776;14341.21123338216;14358.425662973468;14365.784513232205;15018.324175412023;14071.341451222654;14141.505047323295;14356.784648230285;14414.62010363521;14454.132752034911;11265.959359827333;11687.649370518813;11702.765944681143;11709;11823.586174483939;3785.0348161218712;3833.137544052594;3882.592327805596;3905.9218815623813;3966.9884179534324;72478.4632537864;90131.54934225352;92361;93107.60338594926;96998;10591.629292974709;10721.517531711092;10752.677419677422;11044.613438529774;11060.557577696964;21028.579428411347;21365;21389.14443422277;21397.57204855894;21448;7850.646720897574;7929.44493885434;8039.47743396689;8085.878711819328;8130.796730081677;4380.167768124046;4388.2320593896575;4544.772761361919;4583.72497650142;4665.836695715701;3475.4265546184597;3558.3061303046175;3570.285942811448;3576.445650924111;3606.3688854450365;644.9064885591563;653.0987237612065;655.1417642887832;661.1306132435832;671.5265737654942;588.3733823477983;614.4592758372603;690.0471665187507;698.448225901532;702.7329614746363;9309.534523273946;9637.132658060807;9701.70894873155;9703.660371887092;9929.007099290158;610.3377835049022;651.6839332923528;655.9672016399161;681.2880539835884;689.6827459368747;3915.295246855593;4310.50429200646;4571.611413029929;4572.862814115582;4606.539346065367;114550;117160;117286.8271317293;117803;118789;64902;69258.96111558331;70575.64712176406;101145;102667.48666256621;86902;90457;92470;92740.53629731807;93263;7168.856622867618;8707.303415726854;9078.182963533314;9086.90913090887;9090.090990900857;54235.91528169336;54268;56213.718931406715;56303.15545266742;57187.42812571821;79283.60358198172;79626.6018669903;80457.19542804497;81967;82451.5877420633;11808.291502509877;11819;11832.58585949522;11839.644810655695;12027.398630068286;12332.81500777507;12700.110992230455;12853.807192891927;13108.672283192996;13524.256165910969;11701.941490292495;11810.704732381759;12562.43469043877;12700.174488658577;12759.87240127624;11678.25560993183;11786.116041296766;12539.122261441611;12594.370281485706;12610.243385396905;11423.714407139889;11524.884751152382;12285;12291.75416491683;12348.814767778671;10128.544215510467;10562.788744225227;10811.945940270249;10831.350118992885;11046.558137674403;9979.45113018791;10652.786944261226;10666.306690065121;10704.250702450754;10713.35719856811 16:22:05 INFO - PROCESS | 2212 | __end_tp_report 16:22:05 INFO - PROCESS | 2212 | __start_cc_report 16:22:05 INFO - PROCESS | 2212 | _x_x_mozilla_cycle_collect,1673 16:22:05 INFO - PROCESS | 2212 | __end_cc_report 16:22:05 INFO - PROCESS | 2212 | __startTimestamp1485562925338__endTimestamp 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | ------- Summary: start ------- 16:22:05 INFO - PROCESS | 2212 | Number of tests: 6 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | [#0] dojo.html Cycles:165 Average:5766.95 Median:6049.33 stddev:647.99 (10.7%) stddev-sans-first:623.22 16:22:05 INFO - PROCESS | 2212 | Values: 3417.8 3447.1 3453.7 3474.5 3515.8 5690.8 5734.3 5749.5 5766.0 5795.4 5758.4 5818.1 5831.9 5832.7 5838.8 5182.1 5215.0 5270.6 5274.7 5297.3 5122.7 5135.0 5153.5 5214.3 5313.6 5084.9 5222.3 5224.8 5226.3 5231.2 4796.2 5235.1 5243.4 5249.2 5260.1 5156.3 5186.2 5187.7 5239.1 5240.2 5646.6 5707.9 5811.9 5813.1 5898.9 6176.0 6194.1 6221.8 6222.0 6235.2 6251.2 6265.2 6276.8 6285.5 6288.4 5678.6 5863.6 5864.6 5868.1 5898.0 6191.5 6228.3 6232.6 6234.9 6255.9 6178.5 6197.5 6203.3 6208.5 6216.1 6138.7 6271.3 6277.5 6281.6 6317.5 6133.4 6160.3 6208.3 6211.9 6281.5 6228.3 6267.6 6281.6 6299.1 6301.7 4971.8 5012.8 5018.7 5022.1 5024.1 4447.3 4460.3 4464.7 4469.8 4500.5 4838.6 5948.9 5957.0 5959.0 5999.9 6246.1 6255.0 6268.2 6269.7 6275.7 5707.9 5710.8 5820.0 5898.3 5911.7 5439.0 5447.0 5480.8 5496.5 5516.4 6422.6 6439.9 6446.6 6451.9 6453.0 6140.2 6240.6 6251.1 6283.4 6305.5 4948.3 6256.8 6309.1 6313.1 6490.4 6245.1 6251.9 6260.6 6262.8 6267.2 5806.9 5922.9 6129.1 6224.5 6266.5 6020.2 6099.2 6125.6 6131.9 6143.9 6178.0 6208.7 6212.0 6213.8 6215.8 6073.9 6075.0 6081.4 6084.8 6113.4 4386.6 5939.4 5990.5 6049.3 6171.5 6060.0 6078.2 6082.7 6101.2 6120.3 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | [#1] ext.html Cycles:180 Average:72446.71 Median:39158.11 stddev:157620.84 (402.5%) stddev-sans-first:157970.30 16:22:05 INFO - PROCESS | 2212 | Values: 445.7 449.4 481.3 488.1 548.3 24903.0 33432.8 33450.0 33479.3 33488.0 42005.2 43164.6 43269.0 45697.0 45744.9 9596.5 9744.7 9745.1 9752.9 9772.2 8954.1 9664.9 9776.0 9788.3 9788.5 8828.4 9177.3 9194.7 9197.7 11645.6 11601.0 11940.8 12010.6 12041.9 12056.6 11710.6 11799.0 11801.1 11812.8 11817.5 41702.6 41757.4 41814.6 41836.8 41837.0 3347.0 3594.1 3804.4 3988.6 4073.0 29695.6 29971.9 30955.5 31920.2 32290.8 3251.9 3266.5 3408.3 3422.9 3461.5 508509.0 511756.0 512468.4 516491.0 517052.0 65057.0 65422.0 65463.7 65511.7 65625.7 57330.4 69120.0 69361.0 69374.0 69402.7 16356.2 16512.4 16535.3 16549.8 16553.0 13047.9 13128.3 13139.5 13147.2 13161.8 17969.8 18729.7 18770.0 18799.5 19015.8 5593.0 6648.8 7138.5 7203.6 7214.6 955.2 990.8 1003.4 1071.6 1125.9 30306.8 31839.7 33362.0 33498.2 33742.7 1057.0 1071.4 1078.0 1087.9 1178.1 15389.5 15870.0 15925.9 16120.4 16344.0 619270.0 623442.0 623853.0 627509.0 628079.0 60536.8 60727.0 60810.7 60833.1 60868.1 1257.9 1323.5 1324.2 1432.3 1452.9 25484.5 31762.7 32165.7 32827.7 32972.2 57289.7 57680.4 57828.0 57859.4 57949.4 621455.0 625689.0 625755.9 625998.0 626569.0 24470.0 24600.9 24819.8 25427.9 28048.7 40700.2 42142.6 42525.9 42887.4 47982.0 34142.3 36738.0 38977.6 40211.0 40820.0 39619.8 39850.6 40139.0 41554.8 41599.6 38585.4 39338.6 39820.6 39952.8 40002.2 31240.5 35208.8 35246.7 35491.3 35686.0 25479.0 26064.9 26193.2 26254.7 26735.9 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | [#2] jquery.html Cycles:180 Average:32974.00 Median:21512.41 stddev:85549.27 (397.7%) stddev-sans-first:85754.24 16:22:05 INFO - PROCESS | 2212 | Values: 375.4 381.2 388.2 389.2 415.6 13728.4 20437.5 21047.9 21389.6 21406.3 16134.8 17815.7 20119.5 20711.8 20850.5 5722.0 6013.3 6021.3 6031.2 6032.8 5746.2 5847.6 5991.3 5997.3 6050.9 5924.3 5925.9 5944.2 5948.9 5954.9 5694.8 5905.4 5941.6 5985.4 6003.6 5201.2 5228.2 5237.0 5237.5 5237.9 20826.7 20936.8 25155.6 26201.6 26619.7 2258.5 2374.5 2476.9 2761.0 2777.6 15908.8 16032.6 16066.4 16243.7 16736.8 1661.8 1880.3 1900.9 1930.1 1967.2 117999.4 118760.4 122123.0 127353.4 128624.7 10689.8 11028.2 11099.5 11361.7 11362.5 14155.1 14254.5 14258.3 14267.9 14269.6 7701.0 7750.2 8253.5 8775.5 8815.4 7128.8 7847.6 8761.3 8815.3 9081.4 6715.9 6745.8 6788.4 6831.4 6844.7 1767.5 1799.9 1807.3 1922.7 1928.3 757.4 998.6 1047.4 1070.3 1097.7 17340.3 21618.6 22230.4 22622.2 22697.9 941.6 961.0 975.4 1001.4 1039.2 11693.9 11888.7 12100.0 12138.2 12200.9 372088.0 444871.0 448891.0 601607.0 603802.0 107488.0 140935.0 141895.3 150059.0 151234.0 974.0 985.2 1012.2 1014.2 1029.1 18871.0 19269.7 19818.7 19891.0 19912.2 54634.7 56192.2 56470.6 56973.9 58580.1 75255.0 79136.0 80138.6 81913.6 83948.7 8154.0 8256.3 8358.5 8492.6 8502.3 10135.7 11109.0 12516.9 13050.4 13726.9 11403.8 11535.1 11740.8 12009.8 12072.0 11146.3 11194.6 11535.0 11703.7 12031.5 11574.6 11693.5 11806.2 12020.5 12096.3 8302.6 8324.4 8409.9 8568.1 8604.7 11626.5 11682.7 11697.1 12042.6 12060.3 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | [#3] mootools.html Cycles:180 Average:5433.66 Median:5163.78 stddev:2969.62 (57.5%) stddev-sans-first:2962.17 16:22:05 INFO - PROCESS | 2212 | Values: 1361.6 1373.9 1497.1 1641.9 1846.6 7475.6 7936.2 8262.7 8504.7 8505.0 8297.1 8368.2 8384.3 8390.7 8391.7 2343.4 2374.7 2377.8 2381.3 2382.4 2373.0 2406.7 2422.5 2428.9 2431.8 2366.0 2369.8 2392.1 2394.7 2399.3 2311.1 2343.8 2374.0 2377.5 2380.3 2316.7 2337.2 2373.6 2381.3 2387.6 8234.2 8423.2 8436.2 8439.8 8447.2 5093.4 5278.8 5285.3 5315.9 5323.0 3472.3 3575.4 3617.1 3647.7 3649.1 1083.2 1091.4 1104.6 1129.7 1132.2 9135.9 10931.4 10941.0 10968.2 11008.0 4297.6 4426.2 4533.7 4540.1 4546.7 8640.4 8647.6 8651.7 8657.3 8659.2 5161.2 5163.1 5164.4 5165.7 5172.4 4212.6 4399.9 4455.8 4495.4 4887.1 3090.4 3188.4 3703.4 3796.4 3801.0 1141.5 1144.3 1146.4 1156.3 1161.3 777.6 849.9 899.6 914.6 932.9 5545.2 5567.0 5603.0 5841.7 5923.3 741.7 852.8 909.1 945.9 969.4 3602.1 3628.9 3645.5 3763.8 3774.1 9793.6 10265.6 10292.5 10293.9 10298.4 10225.1 10249.1 10251.7 10274.1 10287.0 7615.7 7710.7 7877.8 8033.7 8052.4 5320.3 5394.4 5506.9 5523.1 5678.1 9417.3 9470.3 9478.9 9487.9 9554.8 8905.6 9192.0 9381.6 9461.5 9581.3 6473.9 6586.0 6595.8 6607.8 6611.0 7903.8 8030.7 8092.0 8116.1 8144.6 7223.4 7248.1 7274.8 7310.0 7324.9 7089.8 7115.7 7151.0 7212.2 7295.5 6754.8 6761.5 6858.3 6860.0 6871.6 4596.2 4828.2 4851.5 4870.5 4982.1 4755.8 4803.3 4852.8 4867.1 4937.1 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | [#4] prototype.html Cycles:180 Average:4209.09 Median:4586.99 stddev:1252.19 (27.3%) stddev-sans-first:1220.16 16:22:05 INFO - PROCESS | 2212 | Values: 262.2 302.8 309.3 313.9 314.1 4513.5 4982.6 5186.8 5191.3 5247.7 4475.7 4724.3 4873.5 4953.0 5162.1 3644.6 3754.4 3943.2 3949.7 3989.8 3937.8 3964.4 3968.3 3976.8 3983.1 3163.8 3671.0 3917.3 3928.9 3944.6 3712.9 3933.4 3952.5 3961.9 3984.4 3452.4 3463.3 3466.7 3487.4 3493.4 4172.3 4215.5 4349.7 4572.8 5047.6 3663.7 3850.2 4425.1 4435.9 4462.6 3930.5 4190.4 5170.9 5384.7 5405.7 3256.6 3693.3 3712.9 3729.0 3744.4 4497.0 5553.6 5574.5 5618.4 5637.3 3172.4 3790.5 3796.0 3801.0 3808.5 3841.8 3842.4 3856.3 3858.4 3858.6 4273.3 4460.6 4475.3 4477.6 4482.3 4819.7 5362.5 5384.9 5393.7 5446.9 1101.4 1175.7 1210.8 1227.6 1237.4 705.1 792.0 799.8 824.3 829.8 4657.9 4780.8 4798.7 4825.7 4900.7 4941.0 5080.3 5245.9 5262.4 5262.6 4203.5 4242.4 4477.0 4601.2 4821.8 2593.8 2729.5 2737.8 2746.6 2749.5 4830.0 5299.2 5418.3 5430.0 5453.3 4606.6 4677.7 4897.5 4953.4 5364.4 5033.8 5351.8 5368.6 5387.8 5427.3 4461.2 4756.1 4857.6 5155.4 5169.9 3980.5 4432.8 4940.4 4948.5 5112.9 4927.4 5352.5 5423.9 5426.9 5459.8 3535.8 3554.8 3560.6 3570.0 3584.2 4483.7 4507.4 4938.4 5060.8 5117.7 5012.5 5033.8 5039.3 5049.3 5074.8 4498.5 4547.5 5014.8 5070.0 5084.4 4474.4 4659.6 4803.9 4836.0 4943.1 4856.5 4908.4 4940.6 5261.0 5413.9 4487.9 5307.8 5321.5 5324.8 5333.0 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - PROCESS | 2212 | [#5] yui.html Cycles:180 Average:20808.19 Median:4558.19 stddev:30748.53 (674.6%) stddev-sans-first:30797.49 16:22:05 INFO - PROCESS | 2212 | Values: 639.0 721.7 749.6 781.7 782.8 14273.9 14553.8 15572.1 15595.8 15615.8 13247.7 14134.4 14169.6 14194.7 14281.1 676.5 701.5 823.4 853.9 858.4 844.3 851.1 858.0 859.2 863.3 918.2 918.7 919.4 920.2 921.8 908.9 911.6 913.4 914.7 914.9 675.1 676.2 677.0 678.1 678.4 14294.3 14341.2 14358.4 14365.8 15018.3 14071.3 14141.5 14356.8 14414.6 14454.1 11266.0 11687.6 11702.8 11709.0 11823.6 3785.0 3833.1 3882.6 3905.9 3967.0 72478.5 90131.5 92361.0 93107.6 96998.0 10591.6 10721.5 10752.7 11044.6 11060.6 21028.6 21365.0 21389.1 21397.6 21448.0 7850.6 7929.4 8039.5 8085.9 8130.8 4380.2 4388.2 4544.8 4583.7 4665.8 3475.4 3558.3 3570.3 3576.4 3606.4 644.9 653.1 655.1 661.1 671.5 588.4 614.5 690.0 698.4 702.7 9309.5 9637.1 9701.7 9703.7 9929.0 610.3 651.7 656.0 681.3 689.7 3915.3 4310.5 4571.6 4572.9 4606.5 114550.0 117160.0 117286.8 117803.0 118789.0 64902.0 69259.0 70575.6 101145.0 102667.5 86902.0 90457.0 92470.0 92740.5 93263.0 7168.9 8707.3 9078.2 9086.9 9090.1 54235.9 54268.0 56213.7 56303.2 57187.4 79283.6 79626.6 80457.2 81967.0 82451.6 11808.3 11819.0 11832.6 11839.6 12027.4 12332.8 12700.1 12853.8 13108.7 13524.3 11701.9 11810.7 12562.4 12700.2 12759.9 11678.3 11786.1 12539.1 12594.4 12610.2 11423.7 11524.9 12285.0 12291.8 12348.8 10128.5 10562.8 10811.9 10831.4 11046.6 9979.5 10652.8 10666.3 10704.3 10713.4 16:22:05 INFO - PROCESS | 2212 | -------- Summary: end -------- 16:22:05 INFO - PROCESS | 2212 | 16:22:05 INFO - TEST-INFO | 2212: exit 0 16:22:05 INFO - TEST-OK | dromaeo_css | took 1117739ms 16:22:05 INFO - TEST-START | kraken 16:22:05 INFO - operating with platform_type : mac_ 16:22:05 INFO - Initialising browser for kraken test... 16:22:05 INFO - TEST-INFO | started process 2214 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpx_E_MU/profile http://localhost:51755/getInfo.html) 16:22:08 INFO - PROCESS | 2214 | __metrics Screen width/height:1600/1200 16:22:08 INFO - PROCESS | 2214 | colorDepth:24 16:22:08 INFO - PROCESS | 2214 | Browser inner width/height: 1024/689 16:22:08 INFO - PROCESS | 2214 | __metrics 16:22:08 INFO - PROCESS | 2214 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:22:08 INFO - PROCESS | 2214 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:22:09 INFO - TEST-INFO | 2214: exit 0 16:22:09 INFO - Browser initialized. 16:22:09 INFO - Running cycle 1/1 for kraken test... 16:22:09 INFO - TEST-INFO | started process 2216 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/tmpx_E_MU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:21 INFO - PROCESS | 2216 | RSS: Main: 171745280 16:22:21 INFO - PROCESS | 2216 | 16:22:24 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51755/tests/kraken/driver.html?testName=audio-beat-detection) 16:22:24 INFO - PROCESS | 2216 | RSS: Main: 221437952 16:22:24 INFO - PROCESS | 2216 | 16:22:27 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51755/tests/kraken/driver.html?testName=audio-dft) 16:22:28 INFO - PROCESS | 2216 | RSS: Main: 233414656 16:22:28 INFO - PROCESS | 2216 | 16:22:31 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51755/tests/kraken/driver.html?testName=audio-fft) 16:22:32 INFO - PROCESS | 2216 | RSS: Main: 331902976 16:22:32 INFO - PROCESS | 2216 | 16:22:33 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51755/tests/kraken/driver.html?testName=audio-oscillator) 16:22:34 INFO - PROCESS | 2216 | RSS: Main: 233803776 16:22:34 INFO - PROCESS | 2216 | 16:22:36 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:22:37 INFO - PROCESS | 2216 | RSS: Main: 234770432 16:22:37 INFO - PROCESS | 2216 | 16:22:39 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51755/tests/kraken/driver.html?testName=imaging-darkroom) 16:22:40 INFO - PROCESS | 2216 | RSS: Main: 276025344 16:22:40 INFO - PROCESS | 2216 | 16:22:43 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51755/tests/kraken/driver.html?testName=imaging-desaturate) 16:22:44 INFO - PROCESS | 2216 | RSS: Main: 275562496 16:22:44 INFO - PROCESS | 2216 | 16:22:46 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51755/tests/kraken/driver.html?testName=json-parse-financial) 16:22:47 INFO - PROCESS | 2216 | RSS: Main: 274968576 16:22:47 INFO - PROCESS | 2216 | 16:22:48 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:22:49 INFO - PROCESS | 2216 | RSS: Main: 248086528 16:22:49 INFO - PROCESS | 2216 | 16:22:51 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51755/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:22:52 INFO - PROCESS | 2216 | RSS: Main: 252514304 16:22:52 INFO - PROCESS | 2216 | 16:22:54 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:22:54 INFO - PROCESS | 2216 | RSS: Main: 254664704 16:22:54 INFO - PROCESS | 2216 | 16:22:57 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:22:58 INFO - PROCESS | 2216 | RSS: Main: 267546624 16:22:58 INFO - PROCESS | 2216 | 16:23:01 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:23:01 INFO - PROCESS | 2216 | RSS: Main: 267550720 16:23:01 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | Cycle 1(1): loaded http://localhost:51755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51755/tests/kraken/driver.html?testName=ai-astar) 16:23:03 INFO - PROCESS | 2216 | RSS: Main: 311205888 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | __start_tp_report 16:23:03 INFO - PROCESS | 2216 | _x_x_mozilla_page_load 16:23:03 INFO - PROCESS | 2216 | _x_x_mozilla_page_load_details 16:23:03 INFO - PROCESS | 2216 | |i|pagename|runs| 16:23:03 INFO - PROCESS | 2216 | |0;ai-astar;115;113;114;114;114;114;114;114;114;114 16:23:03 INFO - PROCESS | 2216 | |1;audio-beat-detection;143;132;141;175;110;105;106;106;164;110 16:23:03 INFO - PROCESS | 2216 | |2;audio-dft;180;184;180;185;195;260;204;185;185;181 16:23:03 INFO - PROCESS | 2216 | |3;audio-fft;82;57;58;88;59;58;60;58;80;58 16:23:03 INFO - PROCESS | 2216 | |4;audio-oscillator;88;72;93;69;66;69;88;66;68;90 16:23:03 INFO - PROCESS | 2216 | |5;imaging-gaussian-blur;89;85;134;129;94;86;90;86;90;86 16:23:03 INFO - PROCESS | 2216 | |6;imaging-darkroom;95;96;94;92;129;146;94;96;94;94 16:23:03 INFO - PROCESS | 2216 | |7;imaging-desaturate;83;81;78;82;83;83;84;82;81;83 16:23:03 INFO - PROCESS | 2216 | |8;json-parse-financial;57;56;56;56;58;59;59;58;59;59 16:23:03 INFO - PROCESS | 2216 | |9;json-stringify-tinderbox;62;69;71;82;75;70;71;72;68;69 16:23:03 INFO - PROCESS | 2216 | |10;stanford-crypto-aes;81;83;82;82;81;81;82;81;82;82 16:23:03 INFO - PROCESS | 2216 | |11;stanford-crypto-ccm;137;135;135;139;144;149;143;140;194;164 16:23:03 INFO - PROCESS | 2216 | |12;stanford-crypto-pbkdf2;159;160;161;160;163;162;162;162;144;192 16:23:03 INFO - PROCESS | 2216 | |13;stanford-crypto-sha256-iterative;66;65;66;68;62;58;67;80;83;85 16:23:03 INFO - PROCESS | 2216 | __end_tp_report 16:23:03 INFO - PROCESS | 2216 | __start_cc_report 16:23:03 INFO - PROCESS | 2216 | _x_x_mozilla_cycle_collect,1842 16:23:03 INFO - PROCESS | 2216 | __end_cc_report 16:23:03 INFO - PROCESS | 2216 | __startTimestamp1485562983796__endTimestamp 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | ------- Summary: start ------- 16:23:03 INFO - PROCESS | 2216 | Number of tests: 14 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 16:23:03 INFO - PROCESS | 2216 | Values: 115.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:136.50 stddev:25.92 (19.0%) stddev-sans-first:27.00 16:23:03 INFO - PROCESS | 2216 | Values: 143.0 132.0 141.0 175.0 110.0 105.0 106.0 106.0 164.0 110.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#2] audio-dft Cycles:10 Average:193.90 Median:185.00 stddev:24.41 (13.2%) stddev-sans-first:25.36 16:23:03 INFO - PROCESS | 2216 | Values: 180.0 184.0 180.0 185.0 195.0 260.0 204.0 185.0 185.0 181.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#3] audio-fft Cycles:10 Average:65.80 Median:59.50 stddev:12.28 (20.6%) stddev-sans-first:11.54 16:23:03 INFO - PROCESS | 2216 | Values: 82.0 57.0 58.0 88.0 59.0 58.0 60.0 58.0 80.0 58.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:80.00 stddev:11.27 (14.1%) stddev-sans-first:11.21 16:23:03 INFO - PROCESS | 2216 | Values: 88.0 72.0 93.0 69.0 66.0 69.0 88.0 66.0 68.0 90.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#5] imaging-gaussian-blur Cycles:10 Average:96.90 Median:87.50 stddev:18.47 (21.1%) stddev-sans-first:19.37 16:23:03 INFO - PROCESS | 2216 | Values: 89.0 85.0 134.0 129.0 94.0 86.0 90.0 86.0 90.0 86.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:94.00 stddev:18.65 (19.8%) stddev-sans-first:19.56 16:23:03 INFO - PROCESS | 2216 | Values: 95.0 96.0 94.0 92.0 129.0 146.0 94.0 96.0 94.0 94.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#7] imaging-desaturate Cycles:10 Average:82.00 Median:83.00 stddev:1.70 (2.0%) stddev-sans-first:1.76 16:23:03 INFO - PROCESS | 2216 | Values: 83.0 81.0 78.0 82.0 83.0 83.0 84.0 82.0 81.0 83.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.50 stddev:1.34 (2.3%) stddev-sans-first:1.39 16:23:03 INFO - PROCESS | 2216 | Values: 57.0 56.0 56.0 56.0 58.0 59.0 59.0 58.0 59.0 59.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:5.13 (7.2%) stddev-sans-first:4.31 16:23:03 INFO - PROCESS | 2216 | Values: 62.0 69.0 71.0 82.0 75.0 70.0 71.0 72.0 68.0 69.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 16:23:03 INFO - PROCESS | 2216 | Values: 81.0 83.0 82.0 82.0 81.0 81.0 82.0 81.0 82.0 82.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:143.50 stddev:18.31 (12.8%) stddev-sans-first:18.99 16:23:03 INFO - PROCESS | 2216 | Values: 137.0 135.0 135.0 139.0 144.0 149.0 143.0 140.0 194.0 164.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.00 stddev:11.74 (7.2%) stddev-sans-first:12.38 16:23:03 INFO - PROCESS | 2216 | Values: 159.0 160.0 161.0 160.0 163.0 162.0 162.0 162.0 144.0 192.0 16:23:03 INFO - PROCESS | 2216 | 16:23:03 INFO - PROCESS | 2216 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:67.50 stddev:9.26 (13.7%) stddev-sans-first:9.71 16:23:03 INFO - PROCESS | 2216 | Values: 66.0 65.0 66.0 68.0 62.0 58.0 67.0 80.0 83.0 85.0 16:23:03 INFO - PROCESS | 2216 | -------- Summary: end -------- 16:23:03 INFO - PROCESS | 2216 | 16:23:04 INFO - TEST-INFO | 2216: exit 0 16:23:04 INFO - TEST-OK | kraken | took 59019ms 16:23:04 INFO - SUITE-END | took 1176s 16:23:05 INFO - Completed test suite (00:19:37) 16:23:05 INFO - javascript benchmark 16:23:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3417.794932304062, 3447.103753024213, 3453.7064349530297, 3474.513568100468, 3515.8417871195793, 5690.772369105236, 5734.311882574097, 5749.540036797057, 5766.0, 5795.420457954207, 5758.395368486312, 5818.1272809078655, 5831.883362332761, 5832.6792026438525, 5838.795642152526, 5182.144946083901, 5215.0, 5270.604704647148, 5274.736263186845, 5297.311349524556, 5122.743862806863, 5135.024345374386, 5153.458886816887, 5214.270002199695, 5313.601479889005, 5084.949150508503, 5222.294990176316, 5224.817131400402, 5226.320578324831, 5231.189165679307, 4796.232602783555, 5235.057689615867, 5243.397009343936, 5249.186376111708, 5260.079486089919, 5156.329677141947, 5186.170212765977, 5187.662801917863, 5239.13554263546, 5240.240165176028, 5646.632968857011, 5707.914381284284, 5811.883762324772, 5813.128030795372, 5898.911516327215, 6176.042713379434, 6194.101855230966, 6221.844453888643, 6221.96889015552, 6235.220597425322, 6251.218597675291, 6265.216847894013, 6276.843078923063, 6285.465735412449, 6288.434040936338, 5678.630888992202, 5863.618864773776, 5864.618799778001, 5868.09044598088, 5898.0, 6191.504679625709, 6228.283747369111, 6232.59488133279, 6234.906476402857, 6255.937440625627, 6178.5366097542865, 6197.5351848610635, 6203.31763506014, 6208.4722798562625, 6216.098665693539, 6138.725610151984, 6271.310155882849, 6277.497800175975, 6281.623102613858, 6317.4946004319545, 6133.4264757247465, 6160.260768707783, 6208.255009398901, 6211.875762484725, 6281.466075383552, 6228.252609686776, 6267.561270711007, 6281.560290779693, 6299.118123462719, 6301.653409062454, 4971.751412429364, 5012.774425150877, 5018.723970181675, 5022.096022715873, 5024.145895197825, 4447.332900064951, 4460.286354183315, 4464.732116073046, 4469.7988590513505, 4500.459944806578, 4838.588719958772, 5948.851278718067, 5957.0, 5958.970205148947, 5999.850003749942, 6246.094316324107, 6254.9687251563455, 6268.1851359323, 6269.655168965751, 6275.748970041239, 5707.942920570824, 5710.771569137188, 5820.0, 5898.292204935436, 5911.704414779244, 5439.0, 5447.0, 5480.808171713971, 5496.477834605706, 5516.365617953907, 6422.614643121427, 6439.9356006440275, 6446.645434501147, 6451.903221451588, 6453.0, 6140.17107690456, 6240.637799155055, 6251.0623406487575, 6283.37166283368, 6305.5270854687, 4948.331975183304, 6256.7810126645345, 6309.148264984168, 6313.1477250572425, 6490.350964903472, 6245.094461302995, 6251.9062214067735, 6260.561760676709, 6262.780802672067, 6267.185265915584, 5806.925718742046, 5922.911156332744, 6129.111278864629, 6224.502039836892, 6266.498680105672, 6020.217371741645, 6099.176611157614, 6125.571210015256, 6131.938680613137, 6143.877122457437, 6177.96911015442, 6208.658523781235, 6211.9689401552705, 6213.813585592439, 6215.751369945152, 6073.878522429615, 6075.0, 6081.391860813883, 6084.847878803065, 6113.358097399887, 4386.561343865588, 5939.376365481735, 5990.4908082813445, 6049.334573197033, 6171.537134714825, 6059.96980513305, 6078.240219972504, 6082.7262773174425, 6101.2068431105445, 6120.296165940796], "value": 5727.579619581424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.68579151698077, 449.4269805997354, 481.3309499795285, 488.0799692579487, 548.3091304955759, 24903.0, 33432.82985095522, 33450.0, 33479.33041339178, 33488.0, 42005.15989680212, 43164.56835431645, 43269.0, 45697.0, 45744.85637859047, 9596.472194029308, 9744.707658770249, 9745.074217949283, 9752.853707194397, 9772.169365603932, 8954.14935581122, 9664.903350966506, 9775.951120244388, 9788.265880058989, 9788.461634610094, 8828.382013259074, 9177.265818734486, 9194.724158275229, 9197.724068277963, 11645.592404265852, 11601.013913817336, 11940.820887686692, 12010.579629713005, 12041.879581204163, 12056.63830085099, 11710.648680539598, 11799.0, 11801.055915526736, 11812.822807657893, 11817.468213930393, 41702.582974170175, 41757.37363939543, 41814.58185418168, 41836.79081604572, 41837.0, 3346.9665303346897, 3594.0835087052633, 3804.353259945816, 3988.6011398859882, 4072.9817545613596, 29695.554566681516, 29971.850140749375, 30955.535666965014, 31920.20199495008, 32290.838545807357, 3251.9349613007607, 3266.5426840242385, 3408.3183363327435, 3422.8801991930413, 3461.5153878457036, 508509.0, 511756.0, 512468.43765780935, 516491.0, 517052.0, 65057.0, 65422.0, 65463.672681636286, 65511.672441637485, 65625.67187164034, 57330.426695733346, 69120.0, 69361.0, 69374.0, 69402.65298673576, 16356.182190890408, 16512.42206522766, 16535.338586456408, 16549.83450165507, 16553.0, 13047.934760326327, 13128.34358282082, 13139.54011609589, 13147.211167329991, 13161.802572961413, 17969.82700036895, 18729.719054214198, 18769.967651779283, 18799.530011749543, 19015.809841901682, 5593.0, 6648.800535983928, 7138.500304978602, 7203.567785932861, 7214.639268036577, 955.1737746848926, 990.846418805072, 1003.3929472669076, 1071.603506702525, 1125.932444053343, 30306.786488998772, 31839.68160318367, 33362.0, 33498.162545936546, 33742.66257337395, 1056.9524371403306, 1071.3518321415588, 1077.9730506737237, 1087.9347239165675, 1178.0869825884836, 15389.538313850602, 15870.0, 15925.920370398075, 16120.415644881328, 16344.0, 619270.0, 623442.0, 623853.0, 627509.0, 628079.0, 60536.78926421535, 60727.0, 60810.69594652087, 60833.08750368748, 60868.086978695355, 1257.9245245285313, 1323.4772264955095, 1324.198859689893, 1432.2695425333154, 1452.8547145285597, 25484.490310193323, 31762.682373176896, 32165.678343216267, 32827.67172328246, 32972.1756956078, 57289.713551431974, 57680.42319576751, 57828.0, 57859.421405787085, 57949.420505796086, 621455.0, 625689.0, 625755.871220641, 625998.0, 626569.0, 24470.021199152547, 24600.876995614908, 24819.751802481744, 25427.87286063558, 28048.71951280461, 40700.1859962805, 42142.57857421509, 42525.93685157896, 42887.3566896503, 47982.0, 34142.317153657285, 36738.0, 38977.6102238974, 40211.0, 40819.97950051272, 39619.80190099031, 39850.60149398469, 40139.0, 41554.79222603868, 41599.58400415957, 38585.42121868118, 39338.606613933494, 39820.601793982845, 39952.800235998635, 40002.1999560013, 31240.531392028683, 35208.823955880056, 35246.655601991886, 35491.29017419689, 35686.0, 25479.0, 26064.869675651502, 26193.153949434763, 26254.737452625228, 26735.866320668272], "value": 20529.89559747999, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.3862434918907, 381.2470371017241, 388.22979735945967, 389.23321057516694, 415.5512046989252, 13728.382222799974, 20437.48906277342, 21047.894760526175, 21389.572208555837, 21406.25078122266, 16134.75797863033, 17815.732764008517, 20119.49701257469, 20711.792882071175, 20850.478738031557, 5722.0, 6013.278406591194, 6021.337652858182, 6031.215941927543, 6032.758689652431, 5746.1668058131545, 5847.590668653196, 5991.3109992351, 5997.340292567814, 6050.939490605082, 5924.289085309769, 5925.851853703671, 5944.197533333009, 5948.910766338508, 5954.851128721773, 5694.829155125353, 5905.350411454758, 5941.643501389909, 5985.401459854023, 6003.639781613074, 5201.1678131498775, 5228.189630607262, 5237.0, 5237.47625237477, 5237.947620523784, 20826.687599686018, 20936.790632093787, 25155.62266566003, 26201.606975895378, 26619.733802662115, 2258.4692597239637, 2374.513224788914, 2476.9009239630395, 2760.9723902760916, 2777.6111344411597, 15908.76136857948, 16032.599185020352, 16066.357345706274, 16243.675126497405, 16736.83263167377, 1661.8338166183405, 1880.3230836898706, 1900.9239630414904, 1930.1217945834612, 1967.2131147540954, 117999.41000295029, 118760.43718688366, 122123.0, 127353.36323318323, 128624.71375286221, 10689.770676372316, 11028.22802403824, 11099.500522476508, 11361.715957100972, 11362.48868800906, 14155.079919805386, 14254.501092461715, 14258.287085645676, 14267.85732142686, 14269.571912842632, 7701.0, 7750.224977502317, 8253.546054966915, 8775.517346545874, 8815.382923195315, 7128.821779455555, 7847.568383738949, 8761.25529330014, 8815.338849586307, 9081.409708369067, 6715.899261511081, 6745.763898263537, 6788.389044985975, 6831.351021652935, 6844.657767111625, 1767.5139336682514, 1799.901005444687, 1807.3381457141816, 1922.6827573450503, 1928.3154480159621, 757.3865169212845, 998.6404894238068, 1047.3820445936933, 1070.309650275568, 1097.6816723150357, 17340.30638774435, 21618.56762864734, 22230.444238893833, 22622.208222712456, 22697.88651056767, 941.5527624378366, 961.0101595356793, 975.3611384543135, 1001.3641337750581, 1039.2465462539749, 11693.941530292293, 11888.702782430508, 12100.0, 12138.211016283913, 12200.877991220152, 372088.0, 444871.0, 448891.0, 601607.0, 603802.0, 107488.0, 140935.0, 141895.29052354672, 150059.0, 151234.0, 973.9805203895883, 985.1626117799956, 1012.2357619997002, 1014.2190513304862, 1029.130384824822, 18871.0, 19269.710954335416, 19818.702719459507, 19891.0, 19912.203511859363, 54634.726826365615, 56192.15711764245, 56470.588235294446, 56973.860522788484, 58580.12129818142, 75255.0, 79136.0, 80138.5993070031, 81913.59043204984, 83948.74076888974, 8154.0, 8256.25693687571, 8358.540280284642, 8492.617832197442, 8502.319814414956, 10135.695929122137, 11109.0, 12516.9360604346, 13050.4127314273, 13726.86273137256, 11403.828942565702, 11535.134864885, 11740.823887641522, 12009.819852702041, 12072.0, 11146.275492092987, 11194.552217911518, 11534.961853433231, 11703.707407314545, 12031.518739250332, 11574.594889178838, 11693.532258709556, 11806.232594881305, 12020.519179232733, 12096.274223546616, 8302.626381812954, 8324.375671824517, 8409.915900840913, 8568.100349463466, 8604.655813767378, 11626.476808543466, 11682.70793230176, 11697.122715796178, 12042.578509752468, 12060.276383417024], "value": 9908.953482611903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.5574938145105, 1373.8626137386264, 1497.0718154744056, 1641.9425320113799, 1846.6491366640337, 7475.626218689071, 7936.246056624619, 8262.710805121822, 8504.744857654281, 8504.95747521263, 8297.087320394752, 8368.20502052304, 8384.329253659707, 8390.66437342507, 8391.66433342667, 2343.437574982009, 2374.7031621047367, 2377.7622237776172, 2381.273711517986, 2382.4163080045414, 2373.038919237703, 2406.74729153439, 2422.467057247403, 2428.878556072198, 2431.781139697427, 2366.0299277296226, 2369.8222633302485, 2392.0670938334065, 2394.6527753475734, 2399.328188107324, 2311.05246848792, 2343.7773411525877, 2373.9643905341263, 2377.5007248477755, 2380.27401642499, 2316.664083707853, 2337.1819863047967, 2373.596488596943, 2381.297517232403, 2387.570237357275, 8234.217749313866, 8423.199796019368, 8436.240738333518, 8439.83120337596, 8447.155284471564, 5093.363329583802, 5278.838655495785, 5285.312909321802, 5315.893682126374, 5323.0152421802095, 3472.322897035079, 3575.3921833288405, 3617.1318883468043, 3647.7264205184715, 3649.124210189562, 1083.1659622091024, 1091.4106382553412, 1104.5913012185542, 1129.7006293332274, 1132.1904838040757, 9135.862962055575, 10931.398773067478, 10940.960608742156, 10968.17738669611, 11008.0, 4297.613214810682, 4426.22541055314, 4533.659975501851, 4540.069285796404, 4546.749928753884, 8640.351973602004, 8647.610857511427, 8651.740447786577, 8657.307415406753, 8659.220670139717, 5161.200013997836, 5163.122269214243, 5164.431912489623, 5165.690058596496, 5172.431032586413, 4212.557681443465, 4399.868003959887, 4455.813350486417, 4495.370648109268, 4887.120318342661, 3090.3664748726906, 3188.3942051010235, 3703.4444833275224, 3796.354619714655, 3800.9737370909697, 1141.5319718915205, 1144.3076938452282, 1146.4382452598168, 1156.2715489241723, 1161.3380373187372, 777.6111944027986, 849.9022612399654, 899.5592159841631, 914.5655813488539, 932.9253659707207, 5545.168224766237, 5567.0, 5603.0, 5841.7371218295275, 5923.259592550931, 741.7397167902882, 852.7868032991752, 909.1499448016126, 945.9006804285589, 969.3747532841278, 3602.1354874829854, 3628.9092772680365, 3645.54430696163, 3763.8118094095184, 3774.1319496515957, 9793.559289831976, 10265.589376425009, 10292.536835842406, 10293.94853025745, 10298.433586152683, 10225.130863876506, 10249.077583017564, 10251.743706407251, 10274.126699230648, 10287.0, 7615.743402338663, 7710.653020614086, 7877.842443151219, 8033.718819841278, 8052.436329456999, 5320.308359913187, 5394.433584473573, 5506.889862202654, 5523.116301391758, 5678.063119585222, 9417.340786145178, 9470.289728270545, 9478.85781713261, 9487.905120948702, 9554.808903822024, 8905.599248033983, 9191.954040229755, 9381.639662249072, 9461.526923653928, 9581.329306948446, 6473.8705225896165, 6586.0, 6595.8021259362295, 6607.768728094494, 6611.0, 7903.81442783587, 8030.678772849021, 8091.98850143732, 8116.147804480444, 8144.633491492778, 7223.386012188813, 7248.130224373109, 7274.781756547312, 7310.0, 7324.926750732425, 7089.82275443118, 7115.715371385294, 7151.0, 7212.206657267801, 7295.52579082358, 6754.797356079325, 6761.459083273425, 6858.279880612464, 6860.0, 6871.553349032297, 4596.172688915894, 4828.155072862165, 4851.490593487633, 4870.512948705101, 4982.078315511642, 4755.809767609257, 4803.327534145153, 4852.830150944841, 4867.050925069578, 4937.1113199624415], "value": 4406.159518302859, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.2120527813919, 302.828901670556, 309.26857980875224, 313.9044733878761, 314.07035175879395, 4513.458384993801, 4982.551570358667, 5186.792528298868, 5191.299174611427, 5247.737613119339, 4475.686701930867, 4724.31497432872, 4873.5379386184095, 4952.9752351238285, 5162.096633089213, 3644.599094099647, 3754.361758501048, 3943.2113577284513, 3949.7432666876634, 3989.8005099744896, 3937.7637341759587, 3964.425158352037, 3968.305546529346, 3976.8409263629565, 3983.1436241208135, 3163.825989570573, 3670.963290367102, 3917.334053210947, 3928.9017774555723, 3944.644981951624, 3712.851485940559, 3933.3903244997073, 3952.5454572724216, 3961.861334853295, 3984.4421780950547, 3452.3613131570487, 3463.2554000889677, 3466.7053300469493, 3487.430656204718, 3493.4235851084795, 4172.290710579209, 4215.515215750197, 4349.69552131351, 4572.788211124055, 5047.570956468705, 3663.7435379523445, 3850.249201405727, 4425.1149770045795, 4435.911281774346, 4462.620677242438, 3930.508686414198, 4190.434291370687, 5170.948290517122, 5384.67691938481, 5405.729713514348, 3256.5766450361302, 3693.3351996640595, 3712.888613341604, 3728.9813550932345, 3744.363458212083, 4497.0, 5553.644859813084, 5574.49147883454, 5618.438156184349, 5637.267155269829, 3172.413103575846, 3790.5261842269715, 3795.981020094882, 3800.9809950950066, 3808.4673691994512, 3841.8079096045085, 3842.423636454554, 3856.325143099946, 3858.3826587745825, 3858.594847541024, 4273.252180868336, 4460.620847228022, 4475.299386233276, 4477.634321531899, 4482.327650852399, 4819.734914579662, 5362.460775887973, 5384.892302154013, 5393.709836999427, 5446.8910621787345, 1101.3612104979093, 1175.735459521618, 1210.8365370675021, 1227.5826219085554, 1237.3689418396682, 705.1291654806311, 791.9683212671429, 799.7960520067346, 824.3322908444179, 829.813292009293, 4657.905392232822, 4780.8008316174255, 4798.688085274446, 4825.686330388584, 4900.730459824744, 4940.961308795065, 5080.263361812516, 5245.921311180336, 5262.394824595144, 5262.631915574036, 4203.516595591485, 4242.406063151161, 4476.955230447719, 4601.194790911577, 4821.783019764119, 2593.8314009589317, 2729.5359788835945, 2737.7809775217934, 2746.588011798246, 2749.477599256135, 4829.95170048302, 5299.231611416323, 5418.322709661293, 5429.981813458013, 5453.263809385761, 4606.5854073132905, 4677.672562920563, 4897.510248975074, 4953.43035550909, 5364.436734142937, 5033.798648054183, 5351.839444816662, 5368.617770804368, 5387.784488620411, 5427.267318911975, 4461.167158854086, 4756.096341695067, 4857.635677324285, 5155.355580552431, 5169.922451163311, 3980.5223373195404, 4432.778361081998, 4940.431850337257, 4948.480409556944, 5112.897742045064, 4927.433345165352, 5352.518273355261, 5423.864403389947, 5426.852425593225, 5459.836204913859, 3535.8232088395994, 3554.786712797137, 3560.590532088843, 3570.0, 3584.15772293516, 4483.686141970031, 4507.414036175276, 4938.358013458371, 5060.797568097235, 5117.667351622133, 5012.498750124958, 5033.785134540791, 5039.3448851649055, 5049.2930989660745, 5074.797008119634, 4498.482674492475, 4547.499325222735, 5014.799408023784, 5069.9746501267255, 5084.41529224144, 4474.356272088815, 4659.627229821674, 4803.871090293708, 4835.975820120877, 4943.134951383566, 4856.514348565115, 4908.410990680998, 4940.629452791127, 5261.0, 5413.945860541502, 4487.865364039084, 5307.840764777063, 5321.494458026481, 5324.7870085196155, 5333.0], "value": 3808.3700950411917, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.961662300262, 721.668032704956, 749.6326799868066, 781.679511400326, 782.7886470652924, 14273.929455290843, 14553.78169327461, 15572.143532105729, 15595.766063509056, 15615.84384156158, 13247.735045299089, 14134.434622615108, 14169.645758856008, 14194.716105677906, 14281.143131412122, 676.4858707382375, 701.4738945790657, 823.4194892600732, 853.9274161696233, 858.3991206155684, 844.3456321350972, 851.1105894340399, 857.9871301930476, 859.1623167411786, 863.2748491267334, 918.2470374293082, 918.669279059538, 919.4023884475112, 920.1580553793272, 921.7925966657516, 908.9181973622406, 911.5533388639585, 913.3880300198816, 914.6752902719505, 914.9496777677225, 675.1088563096714, 676.1514299554077, 676.9932300676979, 678.0575000748963, 678.4131726056975, 14294.285285735776, 14341.21123338216, 14358.425662973468, 14365.784513232205, 15018.324175412023, 14071.341451222654, 14141.505047323295, 14356.784648230285, 14414.62010363521, 14454.132752034911, 11265.959359827333, 11687.649370518813, 11702.765944681143, 11709.0, 11823.586174483939, 3785.0348161218712, 3833.137544052594, 3882.592327805596, 3905.9218815623813, 3966.9884179534324, 72478.4632537864, 90131.54934225352, 92361.0, 93107.60338594926, 96998.0, 10591.629292974709, 10721.517531711092, 10752.677419677422, 11044.613438529774, 11060.557577696964, 21028.579428411347, 21365.0, 21389.14443422277, 21397.57204855894, 21448.0, 7850.646720897574, 7929.44493885434, 8039.47743396689, 8085.878711819328, 8130.796730081677, 4380.167768124046, 4388.2320593896575, 4544.772761361919, 4583.72497650142, 4665.836695715701, 3475.4265546184597, 3558.3061303046175, 3570.285942811448, 3576.445650924111, 3606.3688854450365, 644.9064885591563, 653.0987237612065, 655.1417642887832, 661.1306132435832, 671.5265737654942, 588.3733823477983, 614.4592758372603, 690.0471665187507, 698.448225901532, 702.7329614746363, 9309.534523273946, 9637.132658060807, 9701.70894873155, 9703.660371887092, 9929.007099290158, 610.3377835049022, 651.6839332923528, 655.9672016399161, 681.2880539835884, 689.6827459368747, 3915.295246855593, 4310.50429200646, 4571.611413029929, 4572.862814115582, 4606.539346065367, 114550.0, 117160.0, 117286.8271317293, 117803.0, 118789.0, 64902.0, 69258.96111558331, 70575.64712176406, 101145.0, 102667.48666256621, 86902.0, 90457.0, 92470.0, 92740.53629731807, 93263.0, 7168.856622867618, 8707.303415726854, 9078.182963533314, 9086.90913090887, 9090.090990900857, 54235.91528169336, 54268.0, 56213.718931406715, 56303.15545266742, 57187.42812571821, 79283.60358198172, 79626.6018669903, 80457.19542804497, 81967.0, 82451.5877420633, 11808.291502509877, 11819.0, 11832.58585949522, 11839.644810655695, 12027.398630068286, 12332.81500777507, 12700.110992230455, 12853.807192891927, 13108.672283192996, 13524.256165910969, 11701.941490292495, 11810.704732381759, 12562.43469043877, 12700.174488658577, 12759.87240127624, 11678.25560993183, 11786.116041296766, 12539.122261441611, 12594.370281485706, 12610.243385396905, 11423.714407139889, 11524.884751152382, 12285.0, 12291.75416491683, 12348.814767778671, 10128.544215510467, 10562.788744225227, 10811.945940270249, 10831.350118992885, 11046.558137674403, 9979.45113018791, 10652.786944261226, 10666.306690065121, 10704.250702450754, 10713.35719856811], "value": 7390.647154088078, "unit": "score"}], "name": "dromaeo_css", "value": 7244.137048102911, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 141.0, 175.0, 110.0, 105.0, 106.0, 106.0, 164.0, 110.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 184.0, 180.0, 185.0, 195.0, 260.0, 204.0, 185.0, 185.0, 181.0], "value": 193.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 58.0, 88.0, 59.0, 58.0, 60.0, 58.0, 80.0, 58.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 93.0, 69.0, 66.0, 69.0, 88.0, 66.0, 68.0, 90.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 134.0, 129.0, 94.0, 86.0, 90.0, 86.0, 90.0, 86.0], "value": 96.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 92.0, 129.0, 146.0, 94.0, 96.0, 94.0, 94.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 78.0, 82.0, 83.0, 83.0, 84.0, 82.0, 81.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 58.0, 59.0, 59.0, 58.0, 59.0, 59.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 69.0, 71.0, 82.0, 75.0, 70.0, 71.0, 72.0, 68.0, 69.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 82.0, 82.0, 81.0, 81.0, 82.0, 81.0, 82.0, 82.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 135.0, 139.0, 144.0, 149.0, 143.0, 140.0, 194.0, 164.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 160.0, 163.0, 162.0, 162.0, 162.0, 144.0, 192.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 68.0, 62.0, 58.0, 67.0, 80.0, 83.0, 85.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1452.5, "alertThreshold": 2.0}]} 16:23:05 INFO - Return code: 0 16:23:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:23:05 INFO - # TBPL SUCCESS # 16:23:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:23:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:23:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:23:05 INFO - 2017-01-27 16:23:05.587 screenresolution[2220:18137] starting screenresolution argv=screenresolution get 16:23:05 INFO - 2017-01-27 16:23:05.590 screenresolution[2220:18137] Display 0: 1600x1200x32@60 16:23:05 INFO - 2017-01-27 16:23:05.595 screenresolution[2221:18140] starting screenresolution argv=screenresolution list 16:23:05 INFO - Available Modes on Display 0 16:23:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:23:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:23:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:23:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:23:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:23:05 INFO - Intel Iris: 16:23:05 INFO - Chipset Model: Intel Iris 16:23:05 INFO - Type: GPU 16:23:05 INFO - Bus: Built-In 16:23:05 INFO - VRAM (Dynamic, Max): 1536 MB 16:23:05 INFO - Vendor: Intel (0x8086) 16:23:05 INFO - Device ID: 0x0a2e 16:23:05 INFO - Revision ID: 0x0009 16:23:05 INFO - Displays: 16:23:05 INFO - Display: 16:23:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:23:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:23:05 INFO - Display Serial Number: 1600x1200 60 16:23:05 INFO - Main Display: Yes 16:23:05 INFO - Mirror: Off 16:23:05 INFO - Online: Yes 16:23:05 INFO - Rotation: Supported 16:23:05 INFO - Return code: 0 16:23:05 INFO - Running post-action listener: _resource_record_post_action 16:23:05 INFO - [mozharness: 2017-01-28 00:23:05.830292Z] Finished run-tests step (success) 16:23:05 INFO - Running post-run listener: _resource_record_post_run 16:23:05 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 282624; Write bytes: 499863040; Read time: 5; Write time: 1570 16:23:05 INFO - TinderboxPrint: CPU usage
53.3% 16:23:05 INFO - TinderboxPrint: I/O read bytes / time
282,624 / 5 16:23:05 INFO - TinderboxPrint: I/O write bytes / time
499,863,040 / 1,570 16:23:05 INFO - TinderboxPrint: CPU idle
2,242.3 (46.7%) 16:23:05 INFO - TinderboxPrint: CPU system
956.7 (19.9%) 16:23:05 INFO - TinderboxPrint: CPU user
1,598.7 (33.3%) 16:23:05 INFO - TinderboxPrint: Swap in / out
191,291,392 / 0 16:23:05 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 178745856; Write bytes: 177587712; Read time: 16558; Write time: 377 16:23:05 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 282624; Write bytes: 304543744; Read time: 5; Write time: 1136 16:23:06 INFO - Running post-run listener: _upload_blobber_files 16:23:06 INFO - Blob upload gear active. 16:23:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:23:06 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 16:23:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:23:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:23:06 INFO - (blobuploader) - INFO - Open directory for files ... 16:23:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:23:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:23:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:23:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:07 INFO - (blobuploader) - INFO - Done attempting. 16:23:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:23:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:23:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:23:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:08 INFO - (blobuploader) - INFO - Done attempting. 16:23:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:23:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:23:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:23:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:11 INFO - (blobuploader) - INFO - Done attempting. 16:23:11 INFO - (blobuploader) - INFO - Iteration through files over. 16:23:11 INFO - Return code: 0 16:23:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:23:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:23:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e20e11f9bf095d2eed48561b8215a46afc3019528e7e2bbc2214776344215cde1e3d93e35258e2f28f99664eab838c60b98b4e48bb81a2469dbf70d8a2641a67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cab9f7680541f67af71902e3cbcf0847bad4d6ccf440fd30de6dd1825f39b8db4c48ac0f78afdba3352d1f68106f15eb76cc982af69fa87de9ebe84e9fa486bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dfab653924bba7832fd4cf4a1b06a1a0f7a033f0190f684e8e0bfa6b2cd8b7b6f85e5578b2ba7173997cf0a51f76036d9edbac1117663e2b49de9bf4a1b93a9"} 16:23:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:23:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:23:11 INFO - Contents: 16:23:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e20e11f9bf095d2eed48561b8215a46afc3019528e7e2bbc2214776344215cde1e3d93e35258e2f28f99664eab838c60b98b4e48bb81a2469dbf70d8a2641a67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cab9f7680541f67af71902e3cbcf0847bad4d6ccf440fd30de6dd1825f39b8db4c48ac0f78afdba3352d1f68106f15eb76cc982af69fa87de9ebe84e9fa486bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dfab653924bba7832fd4cf4a1b06a1a0f7a033f0190f684e8e0bfa6b2cd8b7b6f85e5578b2ba7173997cf0a51f76036d9edbac1117663e2b49de9bf4a1b93a9"} 16:23:11 INFO - Running post-run listener: copy_logs_to_upload_dir 16:23:11 INFO - Copying logs to upload dir... 16:23:11 INFO - mkdir: /builds/slave/test/build/upload/logs 16:23:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.482182 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-27 16:23:11.103249) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 16:23:11.109306) ========= 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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e20e11f9bf095d2eed48561b8215a46afc3019528e7e2bbc2214776344215cde1e3d93e35258e2f28f99664eab838c60b98b4e48bb81a2469dbf70d8a2641a67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cab9f7680541f67af71902e3cbcf0847bad4d6ccf440fd30de6dd1825f39b8db4c48ac0f78afdba3352d1f68106f15eb76cc982af69fa87de9ebe84e9fa486bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dfab653924bba7832fd4cf4a1b06a1a0f7a033f0190f684e8e0bfa6b2cd8b7b6f85e5578b2ba7173997cf0a51f76036d9edbac1117663e2b49de9bf4a1b93a9"} build_url:https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010732 build_url: 'https://queue.taskcluster.net/v1/task/LwUcc_NjQWyO7FQdJUpLxw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e20e11f9bf095d2eed48561b8215a46afc3019528e7e2bbc2214776344215cde1e3d93e35258e2f28f99664eab838c60b98b4e48bb81a2469dbf70d8a2641a67", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cab9f7680541f67af71902e3cbcf0847bad4d6ccf440fd30de6dd1825f39b8db4c48ac0f78afdba3352d1f68106f15eb76cc982af69fa87de9ebe84e9fa486bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3dfab653924bba7832fd4cf4a1b06a1a0f7a033f0190f684e8e0bfa6b2cd8b7b6f85e5578b2ba7173997cf0a51f76036d9edbac1117663e2b49de9bf4a1b93a9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 16:23:11.143481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 16:23:11.143859) ========= 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.IbuRwZQrEL/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.j0NFvC1UDt/Listeners TMPDIR=/var/folders/rf/yw1ztqxx66vgykp7w510cksc00000w/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.005277 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 16:23:11.196248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 16:23:11.196700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 16:23:11.197217) ========= ========= Total master_lag: 0.19 =========