builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0001 starttime: 1485810238.92 results: success (0) buildid: 20170130115108 builduid: 19f5cfcb49cd4bb68030b6a2f0254512 revision: 787766dd27b7373797a3fa6ab7115c85f27c04f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:58.921446) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:58.921971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:58.922269) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:58.948863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:58.949575) ========= 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.52FjUhP35s/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.MC0bENQLlC/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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-30 13:03:58-- 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% 20.6M=0.001s 2017-01-30 13:03:59 (20.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139623 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:59.115109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:59.115462) ========= 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.52FjUhP35s/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.MC0bENQLlC/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.027071 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:03:59.164593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 13:03:59.165013) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 787766dd27b7373797a3fa6ab7115c85f27c04f2 --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 787766dd27b7373797a3fa6ab7115c85f27c04f2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.52FjUhP35s/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.MC0bENQLlC/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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-30 13:03:59,258 truncating revision to first 12 chars 2017-01-30 13:03:59,258 Setting DEBUG logging. 2017-01-30 13:03:59,258 attempt 1/10 2017-01-30 13:03:59,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/787766dd27b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 13:04:00,726 unpacking tar archive at: mozilla-beta-787766dd27b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.717451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 13:04:00.905796) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 13:04:00.906126) ========= script_repo_revision: 787766dd27b7373797a3fa6ab7115c85f27c04f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 13:04:00.906579) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 13:04:00.906998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 13:04:00.926632) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-30 13:04:00.927019) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.52FjUhP35s/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.MC0bENQLlC/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:01 INFO - MultiFileLogger online at 20170130 13:04:01 in /builds/slave/test 13:04:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:04:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:04:01 INFO - {'append_to_log': False, 13:04:01 INFO - 'base_work_dir': '/builds/slave/test', 13:04:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:04:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:04:01 INFO - 'branch': 'Mozilla-Beta', 13:04:01 INFO - 'buildbot_json_path': 'buildprops.json', 13:04:01 INFO - 'config_files': ('talos/mac_config.py',), 13:04:01 INFO - 'default_actions': ('clobber', 13:04:01 INFO - 'read-buildbot-config', 13:04:01 INFO - 'download-and-extract', 13:04:01 INFO - 'populate-webroot', 13:04:01 INFO - 'create-virtualenv', 13:04:01 INFO - 'install', 13:04:01 INFO - 'run-tests'), 13:04:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:04:01 INFO - 'download_minidump_stackwalk': True, 13:04:01 INFO - 'download_symbols': 'ondemand', 13:04:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:04:01 INFO - 'tooltool.py': '/tools/tooltool.py', 13:04:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:04:01 INFO - '/tools/misc-python/virtualenv.py')}, 13:04:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:04:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:04:01 INFO - 'installer_path': 'installer.exe', 13:04:01 INFO - 'log_level': 'info', 13:04:01 INFO - 'log_name': 'talos', 13:04:01 INFO - 'log_to_console': True, 13:04:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:04:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:04:01 INFO - 'opt_config_files': (), 13:04:01 INFO - 'pip_index': False, 13:04:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:04:01 INFO - 'cmd': ('bash', 13:04:01 INFO - '-c', 13:04:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:04:01 INFO - 'enabled': True, 13:04:01 INFO - 'halt_on_failure': False, 13:04:01 INFO - 'name': 'check_screen_resolution'},), 13:04:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:04:01 INFO - 'cmd': ('bash', 13:04:01 INFO - '-c', 13:04:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:04:01 INFO - 'enabled': True, 13:04:01 INFO - 'halt_on_failure': False, 13:04:01 INFO - 'name': 'check_screen_resolution'},), 13:04:01 INFO - 'run_cmd_checks_enabled': True, 13:04:01 INFO - 'sps_profile': False, 13:04:01 INFO - 'sps_profile_interval': 0, 13:04:01 INFO - 'suite': 'dromaeojs-e10s', 13:04:01 INFO - 'system_bits': '32', 13:04:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:04:01 INFO - 'title': 't-yosemite-r7-0001', 13:04:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:04:01 INFO - 'use_talos_json': True, 13:04:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:04:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:04:01 INFO - 'work_dir': 'build'} 13:04:01 INFO - [mozharness: 2017-01-30 21:04:01.131558Z] Running clobber step. 13:04:01 INFO - Running pre-action listener: _resource_record_pre_action 13:04:01 INFO - Running main action method: clobber 13:04:01 INFO - rmtree: /builds/slave/test/build 13:04:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:04:03 INFO - Running post-action listener: _resource_record_post_action 13:04:03 INFO - [mozharness: 2017-01-30 21:04:03.649446Z] Finished clobber step (success) 13:04:03 INFO - [mozharness: 2017-01-30 21:04:03.649578Z] Running read-buildbot-config step. 13:04:03 INFO - Running pre-action listener: _resource_record_pre_action 13:04:03 INFO - Running main action method: read_buildbot_config 13:04:03 INFO - Using buildbot properties: 13:04:03 INFO - { 13:04:03 INFO - "project": "", 13:04:03 INFO - "product": "firefox", 13:04:03 INFO - "script_repo_revision": "production", 13:04:03 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:04:03 INFO - "repository": "", 13:04:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:04:03 INFO - "buildid": "20170130115108", 13:04:03 INFO - "pgo_build": "False", 13:04:03 INFO - "basedir": "/builds/slave/test", 13:04:03 INFO - "buildnumber": 1, 13:04:03 INFO - "slavename": "t-yosemite-r7-0001", 13:04:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:04:03 INFO - "platform": "yosemite_r7", 13:04:03 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:04:03 INFO - "branch": "mozilla-beta", 13:04:03 INFO - "repo_path": "releases/mozilla-beta", 13:04:03 INFO - "revision": "787766dd27b7373797a3fa6ab7115c85f27c04f2", 13:04:03 INFO - "stage_platform": "macosx64", 13:04:03 INFO - "builduid": "19f5cfcb49cd4bb68030b6a2f0254512", 13:04:03 INFO - "slavebuilddir": "test" 13:04:03 INFO - } 13:04:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 13:04:03 INFO - Running post-action listener: _resource_record_post_action 13:04:03 INFO - [mozharness: 2017-01-30 21:04:03.655271Z] Finished read-buildbot-config step (success) 13:04:03 INFO - [mozharness: 2017-01-30 21:04:03.655422Z] Running download-and-extract step. 13:04:03 INFO - Running pre-action listener: _resource_record_pre_action 13:04:03 INFO - Running main action method: download_and_extract 13:04:03 INFO - mkdir: /builds/slave/test/build/tests 13:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:03 INFO - trying https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 13:04:03 INFO - Downloading https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/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 13:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/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 13:04:04 INFO - Downloaded 1165 bytes. 13:04:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 13:04:04 INFO - Using the following test package requirements: 13:04:04 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:04:04 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:04:04 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 13:04:04 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:04:04 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 13:04:04 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:04:04 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:04:04 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 13:04:04 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 13:04:04 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:04:04 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 13:04:04 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:04:04 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 13:04:04 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:04:04 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 13:04:04 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 13:04:04 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 13:04:04 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 13:04:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:04:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:04:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:04:05 INFO - Http code: 200 13:04:05 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 13:04:05 INFO - x-amz-cf-id: 9qduvEYXAoCAwz5wnVQzVPSc_tjthoVGMR2Ww1afXjaAPpTAkvq2Kw== 13:04:05 INFO - x-amz-version-id: O.QwiRg.DXPM1Xe0GxIJ_eiR_U0VauG9 13:04:05 INFO - Expected file size: 16088018 13:04:05 INFO - Obtained file size: 16088018 13:04:12 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 13:04:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 13:04:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 13:04:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 13:04:13 INFO - Http code: 200 13:04:13 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 13:04:13 INFO - x-amz-cf-id: 9xDQnII0nOqz_VDxF9kYtz6qIM1WhKF5syPn9lkiMw34xsZ5kNpRFg== 13:04:13 INFO - x-amz-version-id: O.QwiRg.DXPM1Xe0GxIJ_eiR_U0VauG9 13:04:13 INFO - Expected file size: 16088018 13:04:13 INFO - Obtained file size: 16088018 13:04:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 13:04:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 13:04:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 13:04:20 INFO - Http code: 200 13:04:20 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 13:04:20 INFO - x-amz-cf-id: Kl0NTjt6EPONq12Y9KhaRrl_vtewI_ZSl90Q5XSYwRQGO4mdRyQffA== 13:04:20 INFO - x-amz-version-id: 6Z2kMnpiH0ZgKWOgDqJn4PRJdaZ_7SP3 13:04:20 INFO - Expected file size: 14402992 13:04:20 INFO - Obtained file size: 14402992 13:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:21 INFO - trying https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:04:21 INFO - Downloading https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 13:04:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/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 13:04:23 INFO - Downloaded 82138451 bytes. 13:04:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:04:23 INFO - mkdir: /builds/slave/test/properties 13:04:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:04:23 INFO - Writing to file /builds/slave/test/properties/build_url 13:04:23 INFO - Contents: 13:04:23 INFO - build_url:https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg 13:04:24 INFO - Running post-action listener: _resource_record_post_action 13:04:24 INFO - Running post-action listener: set_extra_try_arguments 13:04:24 INFO - [mozharness: 2017-01-30 21:04:24.143010Z] Finished download-and-extract step (success) 13:04:24 INFO - [mozharness: 2017-01-30 21:04:24.143165Z] Running populate-webroot step. 13:04:24 INFO - Running pre-action listener: _resource_record_pre_action 13:04:24 INFO - Running main action method: populate_webroot 13:04:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:04:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:04:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:04:24 INFO - '--tppagecycles', 13:04:24 INFO - '7'], 13:04:24 INFO - 'tests': ['tsvgm']}}, 13:04:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:04:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:04:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:04:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:04:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:24 INFO - 'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:04:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:24 INFO - 'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['damp', 'tps']}, 13:04:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:24 INFO - 'tests': ['damp', 'tps']}, 13:04:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['dromaeo_dom']}, 13:04:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:04:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['basic_compositor_video']}, 13:04:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:04:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['a11yr', 13:04:24 INFO - 'ts_paint', 13:04:24 INFO - 'tpaint', 13:04:24 INFO - 'sessionrestore', 13:04:24 INFO - 'sessionrestore_no_auto_restore', 13:04:24 INFO - 'tabpaint']}, 13:04:24 INFO - 'other-e10s': {'tests': ['a11yr', 13:04:24 INFO - 'ts_paint', 13:04:24 INFO - 'tpaint', 13:04:24 INFO - 'sessionrestore', 13:04:24 INFO - 'sessionrestore_no_auto_restore', 13:04:24 INFO - 'tabpaint']}, 13:04:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:04:24 INFO - 'ts_paint', 13:04:24 INFO - 'tpaint', 13:04:24 INFO - 'sessionrestore', 13:04:24 INFO - 'sessionrestore_no_auto_restore', 13:04:24 INFO - 'tabpaint']}, 13:04:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:04:24 INFO - 'ts_paint', 13:04:24 INFO - 'tpaint', 13:04:24 INFO - 'sessionrestore', 13:04:24 INFO - 'sessionrestore_no_auto_restore', 13:04:24 INFO - 'tabpaint']}, 13:04:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['a11yr', 13:04:24 INFO - 'ts_paint', 13:04:24 INFO - 'tpaint', 13:04:24 INFO - 'sessionrestore', 13:04:24 INFO - 'sessionrestore_no_auto_restore', 13:04:24 INFO - 'tabpaint']}, 13:04:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['a11yr', 13:04:24 INFO - 'ts_paint', 13:04:24 INFO - 'tpaint', 13:04:24 INFO - 'sessionrestore', 13:04:24 INFO - 'sessionrestore_no_auto_restore', 13:04:24 INFO - 'tabpaint']}, 13:04:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['tsvgx', 13:04:24 INFO - 'tsvgr_opacity', 13:04:24 INFO - 'tart', 13:04:24 INFO - 'tscrollx', 13:04:24 INFO - 'cart']}, 13:04:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:04:24 INFO - 'tsvgr_opacity', 13:04:24 INFO - 'tart', 13:04:24 INFO - 'tscrollx', 13:04:24 INFO - 'cart']}, 13:04:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:24 INFO - 'talos_options': ['--disable-e10s'], 13:04:24 INFO - 'tests': ['tp5o']}, 13:04:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:24 INFO - 'tests': ['tp5o']}, 13:04:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:24 INFO - 'talos_options': ['--disable-e10s', 13:04:24 INFO - '--xperf_path', 13:04:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:24 INFO - 'tests': ['tp5n']}, 13:04:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:04:24 INFO - 'talos_options': ['--xperf_path', 13:04:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:04:24 INFO - 'tests': ['tp5n']}}, 13:04:24 INFO - 'talos.zip': {'path': '', 13:04:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:04:24 INFO - Running post-action listener: _resource_record_post_action 13:04:24 INFO - [mozharness: 2017-01-30 21:04:24.162554Z] Finished populate-webroot step (success) 13:04:24 INFO - [mozharness: 2017-01-30 21:04:24.162633Z] Running create-virtualenv step. 13:04:24 INFO - Running pre-action listener: _resource_record_pre_action 13:04:24 INFO - Running main action method: create_virtualenv 13:04:24 INFO - Creating virtualenv /builds/slave/test/build/venv 13:04:24 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 13:04:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:04:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:04:24 INFO - Using real prefix '/tools/python27' 13:04:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:04:25 INFO - Installing distribute.............................................................................................................................................................................................done. 13:04:27 INFO - Installing pip.................done. 13:04:27 INFO - Return code: 0 13:04:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:04:28 INFO - Reading from file tmpfile_stdout 13:04:28 INFO - Output received: 13:04:28 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) 13:04:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:28 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:28 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 13:04:28 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 13:04:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:28 INFO - 'HOME': '/Users/cltbld', 13:04:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:28 INFO - 'LOGNAME': 'cltbld', 13:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:28 INFO - 'MOZ_NO_REMOTE': '1', 13:04:28 INFO - 'NO_EM_RESTART': '1', 13:04:28 INFO - 'PAGER': '/bin/cat', 13:04:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:28 INFO - 'PWD': '/builds/slave/test', 13:04:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:28 INFO - 'SHELL': '/bin/bash', 13:04:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:28 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:28 INFO - 'USER': 'cltbld', 13:04:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:28 INFO - 'XPC_FLAGS': '0x0', 13:04:28 INFO - 'XPC_SERVICE_NAME': '0', 13:04:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:28 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 13:04:28 INFO - Cleaning up... 13:04:28 INFO - Return code: 0 13:04:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:28 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:28 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 13:04:28 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 13:04:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:28 INFO - 'HOME': '/Users/cltbld', 13:04:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:28 INFO - 'LOGNAME': 'cltbld', 13:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:28 INFO - 'MOZ_NO_REMOTE': '1', 13:04:28 INFO - 'NO_EM_RESTART': '1', 13:04:28 INFO - 'PAGER': '/bin/cat', 13:04:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:28 INFO - 'PWD': '/builds/slave/test', 13:04:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:28 INFO - 'SHELL': '/bin/bash', 13:04:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:28 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:28 INFO - 'USER': 'cltbld', 13:04:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:28 INFO - 'XPC_FLAGS': '0x0', 13:04:28 INFO - 'XPC_SERVICE_NAME': '0', 13:04:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:28 INFO - Downloading/unpacking psutil>=3.1.1 13:04:28 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 13:04:28 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 13:04:28 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 13:04:28 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 13:04:28 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 13:04:28 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 13:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:32 INFO - Installing collected packages: psutil 13:04:32 INFO - Running setup.py install for psutil 13:04:32 INFO - building 'psutil._psutil_osx' extension 13:04:32 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 13:04:32 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 13:04:33 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 13:04:33 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 13:04:33 INFO - building 'psutil._psutil_posix' extension 13:04:33 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 13:04:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:04:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:04:33 INFO - ^ 13:04:33 INFO - 1 warning generated. 13:04:33 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 13:04:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:04:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:04:33 INFO - Successfully installed psutil 13:04:33 INFO - Cleaning up... 13:04:33 INFO - Return code: 0 13:04:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:04:33 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')]} 13:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:33 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')]} 13:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:33 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:33 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 13:04:33 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 13:04:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:33 INFO - 'HOME': '/Users/cltbld', 13:04:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:33 INFO - 'LOGNAME': 'cltbld', 13:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:33 INFO - 'MOZ_NO_REMOTE': '1', 13:04:33 INFO - 'NO_EM_RESTART': '1', 13:04:33 INFO - 'PAGER': '/bin/cat', 13:04:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:33 INFO - 'PWD': '/builds/slave/test', 13:04:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:33 INFO - 'SHELL': '/bin/bash', 13:04:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:33 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:33 INFO - 'USER': 'cltbld', 13:04:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:33 INFO - 'XPC_FLAGS': '0x0', 13:04:33 INFO - 'XPC_SERVICE_NAME': '0', 13:04:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:04:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:04:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:04:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:04:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:04:36 INFO - Installing collected packages: mozsystemmonitor 13:04:36 INFO - Running setup.py install for mozsystemmonitor 13:04:36 INFO - Successfully installed mozsystemmonitor 13:04:36 INFO - Cleaning up... 13:04:36 INFO - Return code: 0 13:04:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:04:36 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')]} 13:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:36 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')]} 13:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:36 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:36 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 13:04:36 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 13:04:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:36 INFO - 'HOME': '/Users/cltbld', 13:04:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:36 INFO - 'LOGNAME': 'cltbld', 13:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:36 INFO - 'MOZ_NO_REMOTE': '1', 13:04:36 INFO - 'NO_EM_RESTART': '1', 13:04:36 INFO - 'PAGER': '/bin/cat', 13:04:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:36 INFO - 'PWD': '/builds/slave/test', 13:04:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:36 INFO - 'SHELL': '/bin/bash', 13:04:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:36 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:36 INFO - 'USER': 'cltbld', 13:04:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:36 INFO - 'XPC_FLAGS': '0x0', 13:04:36 INFO - 'XPC_SERVICE_NAME': '0', 13:04:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:37 INFO - Downloading/unpacking jsonschema==2.5.1 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:37 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 13:04:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:04:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:04:39 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 13:04:39 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 13:04:39 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 13:04:39 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 13:04:39 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 13:04:39 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 13:04:40 INFO - Downloading functools32-3.2.3-2.tar.gz 13:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:04:40 INFO - warning: no files found matching '*.txt' 13:04:40 INFO - no previously-included directories found matching 'build' 13:04:40 INFO - no previously-included directories found matching 'dist' 13:04:40 INFO - no previously-included directories found matching '.git*' 13:04:40 INFO - Installing collected packages: jsonschema, functools32 13:04:40 INFO - Running setup.py install for functools32 13:04:40 INFO - warning: no files found matching '*.txt' 13:04:40 INFO - no previously-included directories found matching 'build' 13:04:40 INFO - no previously-included directories found matching 'dist' 13:04:40 INFO - no previously-included directories found matching '.git*' 13:04:40 INFO - Successfully installed jsonschema functools32 13:04:40 INFO - Cleaning up... 13:04:40 INFO - Return code: 0 13:04:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:40 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:40 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 13:04:40 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 13:04:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:40 INFO - 'HOME': '/Users/cltbld', 13:04:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:40 INFO - 'LOGNAME': 'cltbld', 13:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:40 INFO - 'MOZ_NO_REMOTE': '1', 13:04:40 INFO - 'NO_EM_RESTART': '1', 13:04:40 INFO - 'PAGER': '/bin/cat', 13:04:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:40 INFO - 'PWD': '/builds/slave/test', 13:04:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:40 INFO - 'SHELL': '/bin/bash', 13:04:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:40 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:40 INFO - 'USER': 'cltbld', 13:04:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:40 INFO - 'XPC_FLAGS': '0x0', 13:04:40 INFO - 'XPC_SERVICE_NAME': '0', 13:04:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:04:40 INFO - Cleaning up... 13:04:40 INFO - Return code: 0 13:04:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:40 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:40 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 13:04:40 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 13:04:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:40 INFO - 'HOME': '/Users/cltbld', 13:04:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:40 INFO - 'LOGNAME': 'cltbld', 13:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:40 INFO - 'MOZ_NO_REMOTE': '1', 13:04:40 INFO - 'NO_EM_RESTART': '1', 13:04:40 INFO - 'PAGER': '/bin/cat', 13:04:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:40 INFO - 'PWD': '/builds/slave/test', 13:04:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:40 INFO - 'SHELL': '/bin/bash', 13:04:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:40 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:40 INFO - 'USER': 'cltbld', 13:04:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:40 INFO - 'XPC_FLAGS': '0x0', 13:04:40 INFO - 'XPC_SERVICE_NAME': '0', 13:04:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:41 INFO - Downloading/unpacking blobuploader==1.2.4 13:04:41 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 13:04:41 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 13:04:41 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 13:04:41 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 13:04:41 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 13:04:41 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 13:04:43 INFO - Downloading blobuploader-1.2.4.tar.gz 13:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:04:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:04:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:04:44 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 13:04:44 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 13:04:44 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 13:04:44 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 13:04:44 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 13:04:44 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 13:04:44 INFO - Downloading docopt-0.6.1.tar.gz 13:04:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:04:44 INFO - Installing collected packages: blobuploader, requests, docopt 13:04:44 INFO - Running setup.py install for blobuploader 13:04:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:04:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:04:45 INFO - Running setup.py install for requests 13:04:45 INFO - Running setup.py install for docopt 13:04:45 INFO - Successfully installed blobuploader requests docopt 13:04:45 INFO - Cleaning up... 13:04:45 INFO - Return code: 0 13:04:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:45 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:45 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 13:04:45 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 13:04:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:45 INFO - 'HOME': '/Users/cltbld', 13:04:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:45 INFO - 'LOGNAME': 'cltbld', 13:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:45 INFO - 'MOZ_NO_REMOTE': '1', 13:04:45 INFO - 'NO_EM_RESTART': '1', 13:04:45 INFO - 'PAGER': '/bin/cat', 13:04:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:45 INFO - 'PWD': '/builds/slave/test', 13:04:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:45 INFO - 'SHELL': '/bin/bash', 13:04:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:45 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:45 INFO - 'USER': 'cltbld', 13:04:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:45 INFO - 'XPC_FLAGS': '0x0', 13:04:45 INFO - 'XPC_SERVICE_NAME': '0', 13:04:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-lT3Jck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-p4ZNrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-J0ImzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-UeaDIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-CEcaiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-QZWVxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-d7RnLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-H8NXkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:04:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:04:46 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-CD5s3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:04:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-LzdpZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:04:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Bd7g4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:04:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-HdrPUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:04:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-DnlhvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:04:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-NuzntI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-uBKUXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:04:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-gRMkWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:04:47 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-iP3Fqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:04:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:04:47 INFO - Running setup.py install for manifestparser 13:04:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:04:48 INFO - Running setup.py install for mozcrash 13:04:48 INFO - Running setup.py install for mozdebug 13:04:48 INFO - Running setup.py install for mozdevice 13:04:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:04:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:04:48 INFO - Running setup.py install for mozfile 13:04:48 INFO - Running setup.py install for mozhttpd 13:04:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:04:48 INFO - Running setup.py install for mozinfo 13:04:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:04:48 INFO - Running setup.py install for mozInstall 13:04:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Running setup.py install for mozleak 13:04:49 INFO - Running setup.py install for mozlog 13:04:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Running setup.py install for moznetwork 13:04:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Running setup.py install for mozprocess 13:04:49 INFO - Running setup.py install for mozprofile 13:04:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:04:49 INFO - Running setup.py install for mozrunner 13:04:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:04:50 INFO - Running setup.py install for mozscreenshot 13:04:50 INFO - Running setup.py install for moztest 13:04:50 INFO - Running setup.py install for mozversion 13:04:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:04:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:04:50 INFO - Cleaning up... 13:04:50 INFO - Return code: 0 13:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:50 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:50 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 13:04:50 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 13:04:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:50 INFO - 'HOME': '/Users/cltbld', 13:04:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:50 INFO - 'LOGNAME': 'cltbld', 13:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:50 INFO - 'MOZ_NO_REMOTE': '1', 13:04:50 INFO - 'NO_EM_RESTART': '1', 13:04:50 INFO - 'PAGER': '/bin/cat', 13:04:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:50 INFO - 'PWD': '/builds/slave/test', 13:04:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:50 INFO - 'SHELL': '/bin/bash', 13:04:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:50 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:50 INFO - 'USER': 'cltbld', 13:04:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:50 INFO - 'XPC_FLAGS': '0x0', 13:04:50 INFO - 'XPC_SERVICE_NAME': '0', 13:04:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:04:50 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-J8XcUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:04:50 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)) 13:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:04:50 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-QpFhCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:04:50 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)) 13:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:04:50 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-rHJNwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-pcC73_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-OkjXKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Aa_FkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-ms5cUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-CbJitN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-DA5oQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-NSYk9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Ffnjkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:04:51 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)) 13:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:04:51 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-vTkU8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:04:52 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)) 13:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:04:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-S8c99P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:04:52 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)) 13:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:04:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-6CHeXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:04:52 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)) 13:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-qCbBAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:04:52 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)) 13:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:04:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-o25k3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:04:52 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)) 13:04:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:04:52 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-z1wS1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:04:52 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)) 13:04:52 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)) 13:04:52 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)) 13:04:52 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)) 13:04:52 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)) 13:04:52 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)) 13:04:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04: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 13:04:55 INFO - Downloading blessings-1.6.tar.gz 13:04:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:04:55 INFO - Installing collected packages: blessings 13:04:55 INFO - Running setup.py install for blessings 13:04:55 INFO - Successfully installed blessings 13:04:55 INFO - Cleaning up... 13:04:55 INFO - Return code: 0 13:04:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:04:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:04:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:04:55 INFO - Reading from file tmpfile_stdout 13:04:55 INFO - Current package versions: 13:04:55 INFO - blessings == 1.6 13:04:55 INFO - blobuploader == 1.2.4 13:04:55 INFO - docopt == 0.6.1 13:04:55 INFO - functools32 == 3.2.3-2 13:04:55 INFO - jsonschema == 2.5.1 13:04:55 INFO - manifestparser == 1.1 13:04:55 INFO - mozInstall == 1.12 13:04:55 INFO - mozcrash == 1.0 13:04:55 INFO - mozdebug == 0.1 13:04:55 INFO - mozdevice == 0.48 13:04:55 INFO - mozfile == 1.2 13:04:55 INFO - mozhttpd == 0.7 13:04:55 INFO - mozinfo == 0.9 13:04:55 INFO - mozleak == 0.1 13:04:55 INFO - mozlog == 3.4 13:04:55 INFO - moznetwork == 0.27 13:04:55 INFO - mozprocess == 0.23 13:04:55 INFO - mozprofile == 0.28 13:04:55 INFO - mozrunner == 6.13 13:04:55 INFO - mozscreenshot == 0.1 13:04:55 INFO - mozsystemmonitor == 0.3 13:04:55 INFO - moztest == 0.8 13:04:55 INFO - mozversion == 1.4 13:04:55 INFO - psutil == 3.1.1 13:04:55 INFO - requests == 1.2.3 13:04:55 INFO - wsgiref == 0.1.2 13:04:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:04: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')]} 13:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:56 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:56 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 13:04:56 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 13:04:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:56 INFO - 'HOME': '/Users/cltbld', 13:04:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:56 INFO - 'LOGNAME': 'cltbld', 13:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:56 INFO - 'MOZ_NO_REMOTE': '1', 13:04:56 INFO - 'NO_EM_RESTART': '1', 13:04:56 INFO - 'PAGER': '/bin/cat', 13:04:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:56 INFO - 'PWD': '/builds/slave/test', 13:04:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:56 INFO - 'SHELL': '/bin/bash', 13:04:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:56 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:56 INFO - 'USER': 'cltbld', 13:04:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:56 INFO - 'XPC_FLAGS': '0x0', 13:04:56 INFO - 'XPC_SERVICE_NAME': '0', 13:04:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 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)) 13:04:56 INFO - Cleaning up... 13:04:56 INFO - Return code: 0 13:04:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:04:57 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 0x10be6f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bde5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcec2496e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, '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.52FjUhP35s/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.MC0bENQLlC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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 13:04:57 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 13:04:57 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 13:04:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:04:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:04:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:04:57 INFO - 'HOME': '/Users/cltbld', 13:04:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:04:57 INFO - 'LOGNAME': 'cltbld', 13:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:04:57 INFO - 'MOZ_NO_REMOTE': '1', 13:04:57 INFO - 'NO_EM_RESTART': '1', 13:04:57 INFO - 'PAGER': '/bin/cat', 13:04:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:04:57 INFO - 'PWD': '/builds/slave/test', 13:04:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:04:57 INFO - 'SHELL': '/bin/bash', 13:04:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:04:57 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:04:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:04:57 INFO - 'USER': 'cltbld', 13:04:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:04:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:04:57 INFO - 'XPC_FLAGS': '0x0', 13:04:57 INFO - 'XPC_SERVICE_NAME': '0', 13:04:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:04:57 INFO - Cleaning up... 13:04:57 INFO - Return code: 0 13:04:57 INFO - Running post-action listener: _resource_record_post_action 13:04:57 INFO - Running post-action listener: _start_resource_monitoring 13:04:57 INFO - Starting resource monitoring. 13:04:57 INFO - [mozharness: 2017-01-30 21:04:57.652810Z] Finished create-virtualenv step (success) 13:04:57 INFO - [mozharness: 2017-01-30 21:04:57.653835Z] Running install step. 13:04:57 INFO - Running pre-action listener: _resource_record_pre_action 13:04:57 INFO - Running main action method: install 13:04:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:04:57 INFO - Reading from file tmpfile_stdout 13:04:57 INFO - Detecting whether we're running mozinstall >=1.0... 13:04:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:04:58 INFO - Reading from file tmpfile_stdout 13:04:58 INFO - Output received: 13:04:58 INFO - Usage: mozinstall [options] installer 13:04:58 INFO - Options: 13:04:58 INFO - -h, --help show this help message and exit 13:04:58 INFO - -d DEST, --destination=DEST 13:04:58 INFO - Directory to install application into. [default: 13:04:58 INFO - "/builds/slave/test"] 13:04:58 INFO - --app=APP Application being installed. [default: firefox] 13:04:58 INFO - mkdir: /builds/slave/test/build/application 13:04:58 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'] 13:04:58 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 13:05:19 INFO - Reading from file tmpfile_stdout 13:05:19 INFO - Output received: 13:05:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:05:19 INFO - Running post-action listener: _resource_record_post_action 13:05:19 INFO - [mozharness: 2017-01-30 21:05:19.463130Z] Finished install step (success) 13:05:19 INFO - [mozharness: 2017-01-30 21:05:19.463310Z] Running run-tests step. 13:05:19 INFO - Running pre-action listener: _resource_record_pre_action 13:05:19 INFO - Running main action method: run_tests 13:05:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:05:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:05:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:05:19 INFO - 2017-01-30 13:05:19.476 screenresolution[1623:7365] starting screenresolution argv=screenresolution get 13:05:19 INFO - 2017-01-30 13:05:19.478 screenresolution[1623:7365] Display 0: 1600x1200x32@60 13:05:19 INFO - 2017-01-30 13:05:19.484 screenresolution[1624:7367] starting screenresolution argv=screenresolution list 13:05:19 INFO - Available Modes on Display 0 13:05:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:05:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:05:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:05:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:05:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:05:19 INFO - Intel Iris: 13:05:19 INFO - Chipset Model: Intel Iris 13:05:19 INFO - Type: GPU 13:05:19 INFO - Bus: Built-In 13:05:19 INFO - VRAM (Dynamic, Max): 1536 MB 13:05:19 INFO - Vendor: Intel (0x8086) 13:05:19 INFO - Device ID: 0x0a2e 13:05:19 INFO - Revision ID: 0x0009 13:05:19 INFO - Displays: 13:05:19 INFO - Display: 13:05:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:05:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:05:19 INFO - Display Serial Number: 1600x1200 60 13:05:19 INFO - Main Display: Yes 13:05:19 INFO - Mirror: Off 13:05:19 INFO - Online: Yes 13:05:19 INFO - Rotation: Supported 13:05:19 INFO - Return code: 0 13:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:05:19 INFO - Python 2.7.3 13:05:19 INFO - Return code: 0 13:05:19 INFO - grabbing minidump binary from tooltool 13:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:05:19 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 0x10bc83d30>, '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 0x10bae9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bc7bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:05:19 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 13:05:19 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 13:05:19 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 13:05:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:05:19 INFO - Return code: 0 13:05:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:05:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:05:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:05:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:05:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.52FjUhP35s/Render', 13:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:05:19 INFO - 'HOME': '/Users/cltbld', 13:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:05:19 INFO - 'LOGNAME': 'cltbld', 13:05:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:05:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:05:19 INFO - 'MOZ_NO_REMOTE': '1', 13:05:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:05:19 INFO - 'NO_EM_RESTART': '1', 13:05:19 INFO - 'PAGER': '/bin/cat', 13:05:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:05:19 INFO - 'PWD': '/builds/slave/test', 13:05:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:05:19 INFO - 'SHELL': '/bin/bash', 13:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MC0bENQLlC/Listeners', 13:05:19 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:05:19 INFO - 'USER': 'cltbld', 13:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:05:19 INFO - 'XPC_FLAGS': '0x0', 13:05:19 INFO - 'XPC_SERVICE_NAME': '0', 13:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:05:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:05:20 INFO - mozversion application_buildid: 20170130115108 13:05:20 INFO - mozversion application_changeset: 787766dd27b7373797a3fa6ab7115c85f27c04f2 13:05:20 INFO - mozversion application_display_name: Firefox 13:05:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:05:20 INFO - mozversion application_name: Firefox 13:05:20 INFO - mozversion application_remotingname: firefox 13:05:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:05:20 INFO - mozversion application_vendor: Mozilla 13:05:20 INFO - mozversion application_version: 52.0 13:05:20 INFO - mozversion platform_buildid: 20170130115108 13:05:20 INFO - mozversion platform_changeset: 787766dd27b7373797a3fa6ab7115c85f27c04f2 13:05:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:05:20 INFO - mozversion platform_version: 52.0 13:05:20 INFO - using testdate: 1485810320 13:05:20 INFO - actual date: 1485810320 13:05:20 INFO - starting webserver on 'localhost:49240' 13:05:20 INFO - SUITE-START | Running 2 tests 13:05:20 INFO - TEST-START | dromaeo_css 13:05:20 INFO - operating with platform_type : mac_ 13:05:20 INFO - Initialising browser for dromaeo_css test... 13:05:20 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmps1nlo6/profile http://localhost:49240/getInfo.html) 13:05:23 INFO - PROCESS | 1634 | 2017-01-30 13:05:23.312 plugin-container[1637:7546] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 13:05:23 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:05:23 INFO - PROCESS | 1634 | 2017-01-30 13:05:23.313 plugin-container[1637:7546] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b23, name = 'com.apple.CFPasteboardClient' 13:05:23 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:05:23 INFO - PROCESS | 1634 | 2017-01-30 13:05:23.313 plugin-container[1637:7546] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:05:23 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 13:05:23 INFO - PROCESS | 1634 | colorDepth:24 13:05:23 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 13:05:23 INFO - PROCESS | 1634 | __metrics 13:05:23 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:05:24 INFO - TEST-INFO | 1634: exit 0 13:05:24 INFO - Browser initialized. 13:05:24 INFO - Running cycle 1/1 for dromaeo_css test... 13:05:24 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmps1nlo6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:05:26 INFO - PROCESS | 1638 | 2017-01-30 13:05:26.643 plugin-container[1639:7677] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x884f, name = 'com.apple.tsm.portname' 13:05:26 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:05:26 INFO - PROCESS | 1638 | 2017-01-30 13:05:26.643 plugin-container[1639:7677] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 13:05:26 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:05:26 INFO - PROCESS | 1638 | 2017-01-30 13:05:26.643 plugin-container[1639:7677] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:05:36 INFO - PROCESS | 1638 | RSS: Main: 177192960 13:05:36 INFO - PROCESS | 1638 | 13:08:37 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 13:08:39 INFO - PROCESS | 1638 | RSS: Main: 183267328 13:08:39 INFO - PROCESS | 1638 | 13:11:41 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 13:11:42 INFO - PROCESS | 1638 | RSS: Main: 192012288 13:11:42 INFO - PROCESS | 1638 | 13:14:44 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:14:44 INFO - PROCESS | 1638 | RSS: Main: 195137536 13:14:44 INFO - PROCESS | 1638 | 13:17:46 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 13:17:47 INFO - PROCESS | 1638 | RSS: Main: 198148096 13:17:47 INFO - PROCESS | 1638 | 13:20:50 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 13:20:50 INFO - PROCESS | 1638 | RSS: Main: 199520256 13:20:50 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 13:23:53 INFO - PROCESS | 1638 | RSS: Main: 199925760 13:23:53 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | __start_tp_report 13:23:53 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 13:23:53 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 13:23:53 INFO - PROCESS | 1638 | |i|pagename|runs| 13:23:53 INFO - PROCESS | 1638 | |0;dojo.html;3593.5687717473897;3611.3680105981457;3612.4761909523104;3631.6913062389694;3664.2671465706867;5977.790777322794;6016.187814645022;6030.9396906030925;6081.574289799716;6087.695615219243;5483.7532311046;5596.132599447082;5679.687617181054;6032.457078862902;6104.542159338045;4487.618552423031;4723.48041715411;5401.135818269077;5428.4842939920845;5499.917501237484;5394.217838413428;5533.806316778913;5543.1408131739445;5544.63959842611;5563.304586926634;4515.300128480091;5349.411564727877;5360.008398446281;5532.502074813266;5542.944570554303;5387.515123638872;5438.782448702047;5514.924589704969;5566.109422492423;5587.720613969285;4563.498015218323;5396;5408.323959505062;5498.890022199534;5512.952539017614;4966.975165124151;5816.156657284712;6095.573309868311;6099.207103076572;6173;6182.505399568024;6198.318184999646;6202.4417802398;6211.68941552925;6239.781607643756;6311.93688063118;6346.809595712136;6351.142595749561;6407.103005579223;6422.614643121381;6121.510279177655;6137.140800287919;6137.631742095399;6148.292946311142;6162.198914141178;6443.581167224115;6482.060101285381;6521.347865213535;6560.081588577603;6588.73645054202;6251.874962500816;6254.312025677172;6254.437100660963;6258.311585725566;6275.654838983808;6178.073289006685;6203.8138855834395;6377.936220637827;6426.35736426363;6437.613743175424;6210.813675589739;6262.405071518198;6275.780347687901;6337.683115844282;6355.0785136155;5824.126381042877;5913.733881975321;6311.558190926683;6319.399657032574;6356.046593011085;5203.427622961472;5205.29728486657;5226.294450249244;5228.869278267997;5233.267342572043;4552.430946131733;4556.179887620194;4569.314602809605;4574.405327307429;4576.565226303496;5460.672359658433;5625.6905870176715;6104.969475152596;6184.412480814315;6199.876002479925;6395.456386207225;6395.513877199357;6425.550211485244;6447.258565265054;6493.480521558264;6077.969610151921;6123.130109042722;6134.110553969738;6152.876942461216;6181.1655426516845;5799.82600521985;5807.332156801937;5812.273465816773;5819.127130930395;5826.708664566755;5634.605577609528;6647.335266473314;6711.530192886451;6802.965985170043;6806.353396427331;6252.093446450148;6354.459870911024;6372.490200784019;6382.297947225708;6493.902591461037;6707.966460167668;6722.92433210684;6746.954222095583;6751.493637977073;6766.7969960901255;6306.306306306395;6389.361063893573;6406.487481001415;6409.9038514423255;6425.935740642721;4805.6155507558615;6219;6293.779717709858;6474.384933431316;6475.676216189266;6103.969480152571;6215.689215539295;6218.595791273553;6221.3156552780065;6231.345708700703;6214;6217.098520714561;6219.813405597839;6224.751009959551;6227.719752611053;5995.340512543529;6098.573099883143;6153;6181.938180618136;6207;6141.977005061692;6165;6174.969125154345;6216.098665693539;6235.625862448268;6166.260048794174;6196.1635179252025;6196.47329976957;6198.6280823150755;6252.1559589456665 13:23:53 INFO - PROCESS | 1638 | |1;ext.html;498.61357447977815;526.2290744059951;533.9786408543658;542.7259234086786;568.698589747434;30564.54153187701;40866.38700419496;40970;40988.565400210995;41032.17935641285;42195.36706949391;42328.57671423285;42749.35875961855;42757.57242427575;42798.358024629655;9480.525973701322;9674.322797404184;9677.177439917616;9710.805783884354;9727.708168754949;9589.616415343378;9617.278704097185;9637.373570717917;9646.324757266993;9671.854922176173;9630.614775408976;9659.855102173473;9686.66096686616;9688.709338719815;9694.03059694032;9587.376820506679;9644.90355096454;9647.951760241154;9660.613575456973;9695.078967498077;8337.666493340259;8346.624401901929;9566.904330956671;9655.517224138835;9704.75738106546;39581;39805;39830.20339593221;39902.40390384381;40060.19879602421;3282.146641873106;3423.9486407703903;3467.583889933199;3557.626449222846;3914.941275880864;31317.217069573217;31393.058208253788;31474.685253147403;31611.367772644648;31805.52291715626;2797.580362945554;3267.7059064684054;3359.8320083995704;3388.8983330500123;3389.813560254185;437557;440532;441238;443251.7837410825;443525;59677.80644387088;59915;60061.69969150214;60107.79784404375;60315;61467.38532614706;61745.382546174864;61783.69108154521;62072.75854482885;62238;16361.754573681405;16500.504984850475;16570.337186512646;16834.747478787827;16924.238409271613;12593.433295501725;12689.048321375749;12701.174423662433;12734.554290599785;12745.808812867814;13174.275414852083;14768.483103091341;16370.85090387683;16478;16503.009819410872;6128.693565321805;6706.463482921355;7393.445491588152;7541.283578060075;7630.160682324939;881.2817553693848;970.3013830042358;1060.4538662588773;1094.0973696700255;1121.9509758375946;31344.529832052536;32176.517352239734;32338.191545211557;32713.672863271062;32919;926.6756635177634;1072.2762135558467;1182.3152008388013;1183.8697743248235;1224.69994851262;14380.712385752226;15510.844891551165;15737.68524629501;15827.366905323657;15979.121148336953;675037;691619.5419022873;692480;693888;694509;57885.71057144687;58150;58429;58718.41281587129;58740.412595873495;1415.7380884536394;1418.652430154598;1436.2172615924137;1438.604383794444;1441.3297816515162;29534.261643459085;29953.550696740003;30639.621217045733;30652.84673576618;30753.384932301677;52011.73994130005;52259.47740522546;52330.738346308026;52367;52424.73787631038;608186;610503;612100;612613;614030;23442;23492;26434.603480947415;26621;26764.732352677;39762.60237397589;45787.54212457833;47645.28532071952;47731.28403074026;47979.28031079467;37942.074008220516;39224;39399.80300098481;39751.60248397479;40626.79686601548;28354.149375518766;38905.27663063672;39311.017224569616;39693.60306396899;40239.79280621586;37749.4337584942;38142.42786358151;38471.80764096162;38480.422793658676;38849.02877428087;34036.65963340434;34870.825645872625;34937.30125397529;35259;35261.64738352584;22237.66643500381;23986.920588573907;24235.303528753524;26129.60805587956;26258.978491414655 13:23:53 INFO - PROCESS | 1638 | |2;jquery.html;386.0214356606001;386.6018001458497;387.26419802375483;393.1527558112267;410.81718635207324;16308.592285192875;19760.407187784353;19838.30565930193;20984.37046888594;21181.258655947044;20149.29477468289;20385.980700964967;20534.5358556973;20734.585308293827;20914.163433462643;5888.29340479141;6119.694015299239;6164.938350616481;6167.290761562433;6182.196314479112;5959;6055.455009049185;6079.78720744774;6116.785912493064;6140.84647883802;6090.60411073281;6100.206973093514;6107.816765497042;6116.938830611703;6134.662593557353;5819.476247137757;5983.401659834003;6034.4568988791;6043.848903777397;6045.183900173508;5301.602379821529;5303.23103150045;5303.257543943851;5313.3092697949405;5319.547838433699;21882.89058554697;24335.756642433527;24573.38566535851;24974;25277.24168274936;2164.296603603835;2380.143148466551;2683.662198871605;2842.7299406556344;3150.5116706910467;12516.561920332835;15505.689886202326;15773.132477713722;16067.678646427123;16089.597760055975;1654.5780825889442;1707.274408376435;1850.4726153046317;1927.5373910261576;1958.5789055353168;111318.44340778244;113586.43206783995;114176.85823141746;114614.70770584542;114977;9290.581923813445;10744.462776861283;11174.832377514344;11261.324320540794;11390;12328.568500102454;13007.154534955198;13951.651208719863;13970;13972.510962116277;8166.510009399455;8449.408541402167;8567.657293708182;8582.27050700685;8623.051464338918;7712.5758083305955;8002.399820013406;8449.408541402043;8514.78713032179;8666.306695464347;5907.556933229939;6456.322086180978;6790.5925644461495;6835.008923706035;6838.21360543534;1652.2482270567104;1956.178405069874;1972.2406873353862;1974.644563978469;1983.1968052938582;880.7533890510667;937.2174234514121;940.191435365585;1049.8504137968912;1089.1885545268826;19006.429807105807;21839.126434942424;21898.79556624369;21959.560808783735;22053;890.8685968819692;932.4778124250441;980.2403137568441;982.7788747531748;993.9006099390148;10968.17738669603;11603.709907252387;11615.88384116148;11652.650420487398;11731.413429328499;514251.42874285387;514459;516821;601694;622068;141834.2908285452;144339.2783036078;145135;145950.5404945937;148678;971.4705485510414;1016.8881423043459;1018.0888105145852;1019.6278358399131;1054.0829478353728;18494.907525462288;19129.904350478715;19133.13900874436;19316.130774114918;19543.60912781765;56356;56501;56702.86594268174;58349.70825146017;58814.41185588089;82212;84817.57591212004;86050;86949;87159.56420217859;7882.684692612232;7936.761897143095;8058.113607503053;8071.071826739765;8182.22268884455;11322.26405283654;12201.816972745239;12238.265704057785;12517.436715348013;12588.559400420942;9839.704808855746;10655.348420994758;10672.786544269227;10786.73033174177;11013.394263315595;8340.29107525867;10591.570138031575;10591.576336946437;10616.522256498321;10628.202884783517;10997.560097596006;11081.118909083536;11088.889111108785;11153.776924461303;11203.15976301797;7875.212478752079;7893.526388416713;7906.367490600623;8130.918690813252;8193.672253110048;8197.385196110436;8793;10453.372797632166;10915.399653018843;11065.834012489659 13:23:53 INFO - PROCESS | 1638 | |3;mootools.html;1496.6333248354151;1536.3393740691502;1711.6918954588177;1805.2508209093228;1879.5019319880234;7268.764310067288;7697.923020769805;7981.880271795913;8378.790530236747;8634.654613815439;8198.262156405923;8441.873371899412;8465.407421480499;8526.786830329245;8532.573371331424;2382.28531440568;2433.2092070077206;2433.5741245282093;2433.9756602433927;2435.2207293666033;2413.1312727418117;2414.987925060381;2431.659567660529;2450.82844200906;2458.55745965727;2386.4630458146953;2390.7489713580085;2397.832151749378;2419.3104965084867;2425.466397392571;2022.373064350049;2376.869272190029;2385.6063749481314;2394.269747726951;2405.074046492113;2103.684447332897;2368.0882860098814;2400.615901455759;2417.4439878827966;2434.793042591382;7307.963460182665;8488.108748581371;8592.14078592142;8613.267872230868;8620.396572239946;4305.547917468683;5362.812301569426;5379.596530260207;5380.408155102936;5384.40771515133;3543.273628906068;3560.5549306336707;3568.411212149992;3620.6560376764164;3685.1892583631557;983.4689267795382;1085.3542142425244;1086.1582273737838;1115.8605174353206;1131.2138064045491;11162.832557511643;11220.99011089006;11222.775544489146;11259.493322800494;11354.375509346983;4531.660125490535;4695.483496815347;4789.473157952622;4814.325994360793;4823.975880120577;9621.615135394646;9628.518574071268;9636.180924621345;9643.324967252225;9725.513724313756;5339.14573668219;5345.839624811262;5352.759125839347;5388.164834450667;5416.160495123262;4416.050549131952;4443.800028998703;4857.951420485821;4886.560209581155;4922.458529561745;3925.528936527635;3967.5437324708028;4003.939940900889;4063.715539912178;4080.4695389599756;1153.9134564907665;1166.8716441191461;1288.4974859804684;1314.4545013819159;1325.1121748428577;850.5024560631975;931.4737173496952;938.8967213606497;945.3288165402504;946.3848498475908;5769.509591684669;5819.952408566414;5875;5944.910826337608;6141.508679305645;835.983280334402;859.574510617236;917.9678711245208;959.6689142245914;994.3735446668552;3745.5318085239346;3982.1040265939932;4074.1647962167685;4084.2852500812237;4103.625285529321;10236.48817559119;10420.739481513023;10431.791364172674;10434.634787782392;10585.41780202081;10008.449535275484;10214.131798797185;10322.329048611817;10367.533460994273;10371.274010819321;7833.686652533949;7930.1276859545405;8035.955325807725;8194.139615340422;8221.753347399588;5805.10020946754;5916.994111001054;5935.376785437639;5974.581779275409;5988.940110598838;9299.67451139207;9348.95325523368;9362.906370936476;9503.334766566273;9690.612375504901;9537.998510156334;9555.713328600154;9624.181944534514;9633.470159141314;9655.372400793925;6775.796726098225;6789.89815152783;7290.635468226674;7300.16048154469;7457.515261508202;8050.87923681157;8150.4294699370475;8153.592320384076;8155.184481551797;8161.4695044824275;7223.097112860893;7327.2672732726305;7382.5570465772225;7494.962525187339;7516.887246691414;7202.53183543068;7278.6724597392185;7279.1628962667855;7304.977303177666;7318.560886346836;5728.484436400744;6833.282505336868;6842.007908853089;6878.209005964178;6878.38094571491;4829.541193586604;4862.6839255448285;4939.456659767351;4990.351254336913;5029.823956161516;4984.551390374883;5015.448300686849;5071.416787069535;5108.182690769459;5111.977604479045 13:23:53 INFO - PROCESS | 1638 | |4;prototype.html;277.23344951209907;309.30406585183323;319.2465780757412;322.1334609899372;324.1830586920959;4321.827126914924;4347.934780978288;5370.865728356793;5558.499735023847;5597.804076857311;5012.7744251508675;5425.3760817506;5544.390117087117;5555.971920357739;5585.804496842611;3575.3028159508776;3721.9255614887684;4258.723182993111;4266.381374700659;4314.611684948354;3150.6219253689587;3996.840126394941;4325.740455572675;4336.436263285768;4395.340698895159;3197.6322722886935;4163.250614889319;4167.208230436223;4194.601512856274;4208.242516347072;3497.7901325920398;4181;4205.3902184183125;4217.325227963526;4233.428487154226;3618.294432585647;3637.9818100909592;3647;3647.598764135943;3649.6532829381167;5094.9110864545355;5414.424811034709;5421.241026256327;5431.456854314576;5468.851541176357;4035.9910022494378;4649.744264065475;4772.260299653559;4819.807207711688;4850.9272360914265;5349.358077030743;5775.191473193714;5778.451047150514;5865.237519122486;5958.40415958405;3367;3744.756590821588;3977.2244412339605;3992.40113982902;4011.7191796574252;6115.6330620162935;6181.3509581493745;6206.6586337751405;6231.4391704746795;6234.18955535782;3941.0541470046983;4016.3172260715746;4031.6169963853386;4051.758593125488;4064.573219811877;3696.6303369663356;3750.9062273443383;3829.5064924679396;3840.2895464339185;4051.372037334218;4250.914981700349;4413.44831896013;4506.459224893034;4716.669833111718;4783.856484305476;5063.8480845574695;5832.212651292106;5849.6782676952325;5904.439078287556;5908.852278692981;1125.454154734953;1252.757211071668;1261.2054405724334;1311.7245378470436;1322.6032190342858;733.2996987876566;893.2942975049768;908.6683360573476;912.0833562269876;913.2876356441986;4719.551642593948;4756.381670382828;4867.951320486821;5175.637705360588;5200.791968321225;5578;5598.356189038313;5611.551075913917;5619.43805619443;5636.943630563642;4639.559241872017;4719.268513380432;4998.00257445962;5170.560502357342;5244.580433565382;2596.675415573053;2607.9877741208934;2698.5007773561956;2850.2067973385783;2976.940461190764;5547.889042219133;5794.770621581816;5926.229590153339;5977.372375900468;5978.432048955342;4895.926561101586;4937.876553086202;5750.6262092963825;5878.500982249499;6184.752609895644;5097.680555347308;5988.730507127103;6437.5815571988605;6448.451881590117;6454.1609590752905;5063.620228482952;5397.463192299613;5868.647881127146;6080.695965201634;6147.200863887666;5970.910436343545;6005.759769609167;6110.663913484801;6119.204503414706;6120.540959427972;5973.462388385066;6362.300146983735;6473.741050358121;6479.185827968176;6485.513586481127;3687.3731465650367;3815.9281778167733;3933.272344616255;4026;4067.7152599317765;5053.84838454847;5839.686070634073;6113.113598528277;6122.438778111731;6130.325664177026;5792.944938543121;5844.883102337844;5929.703514824328;5964.105384192406;6011.489023432882;5880.529557635465;5930.436608522184;5941.0394569791;5950.315713692808;5983.217803721291;5505.678637126981;5754.971225143848;5758.424157584208;5770.740316685843;5834.679092649775;5436.7281635918835;5882.882162421439;5908.641012567219;5936.643801371932;5952.73212705438;5558.694271815089;5601.29983752031;5776.277965254343;5788.942110579009;5798.768049277982 13:23:53 INFO - PROCESS | 1638 | |5;yui.html;655.2726473614288;727.6761840980762;744.7467860927284;783.3693876429476;798.1778767869097;14716.484923027696;15091.84908150918;15534.145621990787;15550.611234719137;15701.214939253048;13984.230867302294;14215.857841421583;14311.212883291415;14317.856821431782;14321.57035288943;850.3027517435705;875.6322344615245;879.226280872831;879.9880137841469;882.0209567380202;850.2857599616322;879.5909901895617;882.0341725810259;886.5921676029035;887.1572006593761;909.5725009245645;937.203377129438;941.6986564299427;941.7739742461829;941.9576119074624;813.3818298093462;930.9767255818625;931.1154403316876;935.4527601353217;935.5602866652663;666.340323080152;680.1532092544765;681.5876394781136;684.3669605614837;694.187800273681;13091;14152.6554977277;14879.851201487954;14971.77542336855;15232.086074835544;13283.3358332083;14005.29973501331;14289.64275893111;14521.56435306932;14582.416703331854;12287.93856030714;12490.188137771107;12961.222326660336;13002.739945201138;13111.934440327832;3448.6723761242642;3529;3781.8487260509546;3887.8250478728523;3928;74458;89715.10284897132;94146.23415063389;94299.52850235705;95118.52440737821;10643.46782660864;10670.679879603624;10839.295445795999;10916.781664366668;11039.06167975715;17486.912565437346;18337.908310458628;21274.680879786814;21321.573568528544;21372.251971180933;7823.569703666353;7932.21991711567;7948.046234451903;7989.400794940403;8050.11448740638;4359.960400177072;4458.464984201852;4561.110583436264;4594.954050459452;4631.8842028948875;3499.545059142295;3614.6204648512053;3620.963790362063;3622.619624939396;3635.8000309982676;628.7862126876884;653.9182602174728;661.7121552124842;670.2660586657602;685.6092027544252;566.4399250709272;575.0052409331879;579.794173068563;624.2041397218492;682.5938566552893;8971.22136870814;9579;9591.90408095924;9631.518424078768;9829.262805289489;583.215575051555;618.3692633513881;632.7595513704855;642.9616169885694;646.9353064693493;4410.757408342508;4675.836345727883;4677.4854765975715;4722.574968252805;4729.196036673774;74096.88854667185;112211.43894280476;117870;119590;123875.38062309811;87009.56495217483;101338;107913;107934;109831.45084274528;91826.54086729657;92393.61409578862;92842;94755;99162.51256231162;9713.222942164468;9975.850362244717;10208.387496750218;10427.582896684047;10444.112250458797;44763.77618111888;49536;52627.73686131545;53857.46142538524;56284.43715562792;64831.67584162049;77799;79428.60285698535;80265.59867200861;81649.18350816416;13022.804657930328;13043.413046412745;13055;13231.404586793426;13266.137701049402;14187.574372768833;14382.884367602519;14441.49454769078;14757.335919883846;15178.696426071196;13697.657558561115;13904.374303156585;13945.372458239606;14111;14550.927245363706;13662.521811736542;13717.588472345846;13808.447662093404;13862.792058118934;13925.721485570435;13391.306943400812;13400.06199566021;13539.86460135386;13552.661183470493;13621.318934053455;11278.266912650652;11646.534138634699;11656.125790565911;11902.761944761229;11927.165098443025;11425.600103996652;11642.068634509389;11730.70673233176;11759.882401175879;11761.059115270587 13:23:53 INFO - PROCESS | 1638 | __end_tp_report 13:23:53 INFO - PROCESS | 1638 | __start_cc_report 13:23:53 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,356 13:23:53 INFO - PROCESS | 1638 | __end_cc_report 13:23:53 INFO - PROCESS | 1638 | __startTimestamp1485811433496__endTimestamp 13:23:53 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | ------- Summary: start ------- 13:23:53 INFO - PROCESS | 1638 | Number of tests: 6 13:23:53 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5917.21 Median:6173.00 stddev:660.58 (10.7%) stddev-sans-first:636.96 13:23:53 INFO - PROCESS | 1638 | Values: 3593.6 3611.4 3612.5 3631.7 3664.3 5977.8 6016.2 6030.9 6081.6 6087.7 5483.8 5596.1 5679.7 6032.5 6104.5 4487.6 4723.5 5401.1 5428.5 5499.9 5394.2 5533.8 5543.1 5544.6 5563.3 4515.3 5349.4 5360.0 5532.5 5542.9 5387.5 5438.8 5514.9 5566.1 5587.7 4563.5 5396.0 5408.3 5498.9 5513.0 4967.0 5816.2 6095.6 6099.2 6173.0 6182.5 6198.3 6202.4 6211.7 6239.8 6311.9 6346.8 6351.1 6407.1 6422.6 6121.5 6137.1 6137.6 6148.3 6162.2 6443.6 6482.1 6521.3 6560.1 6588.7 6251.9 6254.3 6254.4 6258.3 6275.7 6178.1 6203.8 6377.9 6426.4 6437.6 6210.8 6262.4 6275.8 6337.7 6355.1 5824.1 5913.7 6311.6 6319.4 6356.0 5203.4 5205.3 5226.3 5228.9 5233.3 4552.4 4556.2 4569.3 4574.4 4576.6 5460.7 5625.7 6105.0 6184.4 6199.9 6395.5 6395.5 6425.6 6447.3 6493.5 6078.0 6123.1 6134.1 6152.9 6181.2 5799.8 5807.3 5812.3 5819.1 5826.7 5634.6 6647.3 6711.5 6803.0 6806.4 6252.1 6354.5 6372.5 6382.3 6493.9 6708.0 6722.9 6747.0 6751.5 6766.8 6306.3 6389.4 6406.5 6409.9 6425.9 4805.6 6219.0 6293.8 6474.4 6475.7 6104.0 6215.7 6218.6 6221.3 6231.3 6214.0 6217.1 6219.8 6224.8 6227.7 5995.3 6098.6 6153.0 6181.9 6207.0 6142.0 6165.0 6175.0 6216.1 6235.6 6166.3 6196.2 6196.5 6198.6 6252.2 13:23:53 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:71159.22 Median:39981.30 stddev:157998.72 (395.2%) stddev-sans-first:158352.88 13:23:53 INFO - PROCESS | 1638 | Values: 498.6 526.2 534.0 542.7 568.7 30564.5 40866.4 40970.0 40988.6 41032.2 42195.4 42328.6 42749.4 42757.6 42798.4 9480.5 9674.3 9677.2 9710.8 9727.7 9589.6 9617.3 9637.4 9646.3 9671.9 9630.6 9659.9 9686.7 9688.7 9694.0 9587.4 9644.9 9648.0 9660.6 9695.1 8337.7 8346.6 9566.9 9655.5 9704.8 39581.0 39805.0 39830.2 39902.4 40060.2 3282.1 3423.9 3467.6 3557.6 3914.9 31317.2 31393.1 31474.7 31611.4 31805.5 2797.6 3267.7 3359.8 3388.9 3389.8 437557.0 440532.0 441238.0 443251.8 443525.0 59677.8 59915.0 60061.7 60107.8 60315.0 61467.4 61745.4 61783.7 62072.8 62238.0 16361.8 16500.5 16570.3 16834.7 16924.2 12593.4 12689.0 12701.2 12734.6 12745.8 13174.3 14768.5 16370.9 16478.0 16503.0 6128.7 6706.5 7393.4 7541.3 7630.2 881.3 970.3 1060.5 1094.1 1122.0 31344.5 32176.5 32338.2 32713.7 32919.0 926.7 1072.3 1182.3 1183.9 1224.7 14380.7 15510.8 15737.7 15827.4 15979.1 675037.0 691619.5 692480.0 693888.0 694509.0 57885.7 58150.0 58429.0 58718.4 58740.4 1415.7 1418.7 1436.2 1438.6 1441.3 29534.3 29953.6 30639.6 30652.8 30753.4 52011.7 52259.5 52330.7 52367.0 52424.7 608186.0 610503.0 612100.0 612613.0 614030.0 23442.0 23492.0 26434.6 26621.0 26764.7 39762.6 45787.5 47645.3 47731.3 47979.3 37942.1 39224.0 39399.8 39751.6 40626.8 28354.1 38905.3 39311.0 39693.6 40239.8 37749.4 38142.4 38471.8 38480.4 38849.0 34036.7 34870.8 34937.3 35259.0 35261.6 22237.7 23986.9 24235.3 26129.6 26259.0 13:23:53 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:34552.00 Median:24773.69 stddev:93751.32 (378.4%) stddev-sans-first:93979.22 13:23:53 INFO - PROCESS | 1638 | Values: 386.0 386.6 387.3 393.2 410.8 16308.6 19760.4 19838.3 20984.4 21181.3 20149.3 20386.0 20534.5 20734.6 20914.2 5888.3 6119.7 6164.9 6167.3 6182.2 5959.0 6055.5 6079.8 6116.8 6140.8 6090.6 6100.2 6107.8 6116.9 6134.7 5819.5 5983.4 6034.5 6043.8 6045.2 5301.6 5303.2 5303.3 5313.3 5319.5 21882.9 24335.8 24573.4 24974.0 25277.2 2164.3 2380.1 2683.7 2842.7 3150.5 12516.6 15505.7 15773.1 16067.7 16089.6 1654.6 1707.3 1850.5 1927.5 1958.6 111318.4 113586.4 114176.9 114614.7 114977.0 9290.6 10744.5 11174.8 11261.3 11390.0 12328.6 13007.2 13951.7 13970.0 13972.5 8166.5 8449.4 8567.7 8582.3 8623.1 7712.6 8002.4 8449.4 8514.8 8666.3 5907.6 6456.3 6790.6 6835.0 6838.2 1652.2 1956.2 1972.2 1974.6 1983.2 880.8 937.2 940.2 1049.9 1089.2 19006.4 21839.1 21898.8 21959.6 22053.0 890.9 932.5 980.2 982.8 993.9 10968.2 11603.7 11615.9 11652.7 11731.4 514251.4 514459.0 516821.0 601694.0 622068.0 141834.3 144339.3 145135.0 145950.5 148678.0 971.5 1016.9 1018.1 1019.6 1054.1 18494.9 19129.9 19133.1 19316.1 19543.6 56356.0 56501.0 56702.9 58349.7 58814.4 82212.0 84817.6 86050.0 86949.0 87159.6 7882.7 7936.8 8058.1 8071.1 8182.2 11322.3 12201.8 12238.3 12517.4 12588.6 9839.7 10655.3 10672.8 10786.7 11013.4 8340.3 10591.6 10591.6 10616.5 10628.2 10997.6 11081.1 11088.9 11153.8 11203.2 7875.2 7893.5 7906.4 8130.9 8193.7 8197.4 8793.0 10453.4 10915.4 11065.8 13:23:53 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5586.98 Median:5342.49 stddev:3037.30 (56.9%) stddev-sans-first:3030.27 13:23:53 INFO - PROCESS | 1638 | Values: 1496.6 1536.3 1711.7 1805.3 1879.5 7268.8 7697.9 7981.9 8378.8 8634.7 8198.3 8441.9 8465.4 8526.8 8532.6 2382.3 2433.2 2433.6 2434.0 2435.2 2413.1 2415.0 2431.7 2450.8 2458.6 2386.5 2390.7 2397.8 2419.3 2425.5 2022.4 2376.9 2385.6 2394.3 2405.1 2103.7 2368.1 2400.6 2417.4 2434.8 7308.0 8488.1 8592.1 8613.3 8620.4 4305.5 5362.8 5379.6 5380.4 5384.4 3543.3 3560.6 3568.4 3620.7 3685.2 983.5 1085.4 1086.2 1115.9 1131.2 11162.8 11221.0 11222.8 11259.5 11354.4 4531.7 4695.5 4789.5 4814.3 4824.0 9621.6 9628.5 9636.2 9643.3 9725.5 5339.1 5345.8 5352.8 5388.2 5416.2 4416.1 4443.8 4858.0 4886.6 4922.5 3925.5 3967.5 4003.9 4063.7 4080.5 1153.9 1166.9 1288.5 1314.5 1325.1 850.5 931.5 938.9 945.3 946.4 5769.5 5820.0 5875.0 5944.9 6141.5 836.0 859.6 918.0 959.7 994.4 3745.5 3982.1 4074.2 4084.3 4103.6 10236.5 10420.7 10431.8 10434.6 10585.4 10008.4 10214.1 10322.3 10367.5 10371.3 7833.7 7930.1 8036.0 8194.1 8221.8 5805.1 5917.0 5935.4 5974.6 5988.9 9299.7 9349.0 9362.9 9503.3 9690.6 9538.0 9555.7 9624.2 9633.5 9655.4 6775.8 6789.9 7290.6 7300.2 7457.5 8050.9 8150.4 8153.6 8155.2 8161.5 7223.1 7327.3 7382.6 7495.0 7516.9 7202.5 7278.7 7279.2 7305.0 7318.6 5728.5 6833.3 6842.0 6878.2 6878.4 4829.5 4862.7 4939.5 4990.4 5029.8 4984.6 5015.4 5071.4 5108.2 5112.0 13:23:53 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4700.44 Median:5360.11 stddev:1506.41 (28.1%) stddev-sans-first:1473.60 13:23:53 INFO - PROCESS | 1638 | Values: 277.2 309.3 319.2 322.1 324.2 4321.8 4347.9 5370.9 5558.5 5597.8 5012.8 5425.4 5544.4 5556.0 5585.8 3575.3 3721.9 4258.7 4266.4 4314.6 3150.6 3996.8 4325.7 4336.4 4395.3 3197.6 4163.3 4167.2 4194.6 4208.2 3497.8 4181.0 4205.4 4217.3 4233.4 3618.3 3638.0 3647.0 3647.6 3649.7 5094.9 5414.4 5421.2 5431.5 5468.9 4036.0 4649.7 4772.3 4819.8 4850.9 5349.4 5775.2 5778.5 5865.2 5958.4 3367.0 3744.8 3977.2 3992.4 4011.7 6115.6 6181.4 6206.7 6231.4 6234.2 3941.1 4016.3 4031.6 4051.8 4064.6 3696.6 3750.9 3829.5 3840.3 4051.4 4250.9 4413.4 4506.5 4716.7 4783.9 5063.8 5832.2 5849.7 5904.4 5908.9 1125.5 1252.8 1261.2 1311.7 1322.6 733.3 893.3 908.7 912.1 913.3 4719.6 4756.4 4868.0 5175.6 5200.8 5578.0 5598.4 5611.6 5619.4 5636.9 4639.6 4719.3 4998.0 5170.6 5244.6 2596.7 2608.0 2698.5 2850.2 2976.9 5547.9 5794.8 5926.2 5977.4 5978.4 4895.9 4937.9 5750.6 5878.5 6184.8 5097.7 5988.7 6437.6 6448.5 6454.2 5063.6 5397.5 5868.6 6080.7 6147.2 5970.9 6005.8 6110.7 6119.2 6120.5 5973.5 6362.3 6473.7 6479.2 6485.5 3687.4 3815.9 3933.3 4026.0 4067.7 5053.8 5839.7 6113.1 6122.4 6130.3 5792.9 5844.9 5929.7 5964.1 6011.5 5880.5 5930.4 5941.0 5950.3 5983.2 5505.7 5755.0 5758.4 5770.7 5834.7 5436.7 5882.9 5908.6 5936.6 5952.7 5558.7 5601.3 5776.3 5788.9 5798.8 13:23:53 INFO - PROCESS | 1638 | 13:23:53 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:21372.09 Median:4143.98 stddev:31339.47 (756.3%) stddev-sans-first:31388.78 13:23:53 INFO - PROCESS | 1638 | Values: 655.3 727.7 744.7 783.4 798.2 14716.5 15091.8 15534.1 15550.6 15701.2 13984.2 14215.9 14311.2 14317.9 14321.6 850.3 875.6 879.2 880.0 882.0 850.3 879.6 882.0 886.6 887.2 909.6 937.2 941.7 941.8 942.0 813.4 931.0 931.1 935.5 935.6 666.3 680.2 681.6 684.4 694.2 13091.0 14152.7 14879.9 14971.8 15232.1 13283.3 14005.3 14289.6 14521.6 14582.4 12287.9 12490.2 12961.2 13002.7 13111.9 3448.7 3529.0 3781.8 3887.8 3928.0 74458.0 89715.1 94146.2 94299.5 95118.5 10643.5 10670.7 10839.3 10916.8 11039.1 17486.9 18337.9 21274.7 21321.6 21372.3 7823.6 7932.2 7948.0 7989.4 8050.1 4360.0 4458.5 4561.1 4595.0 4631.9 3499.5 3614.6 3621.0 3622.6 3635.8 628.8 653.9 661.7 670.3 685.6 566.4 575.0 579.8 624.2 682.6 8971.2 9579.0 9591.9 9631.5 9829.3 583.2 618.4 632.8 643.0 646.9 4410.8 4675.8 4677.5 4722.6 4729.2 74096.9 112211.4 117870.0 119590.0 123875.4 87009.6 101338.0 107913.0 107934.0 109831.5 91826.5 92393.6 92842.0 94755.0 99162.5 9713.2 9975.9 10208.4 10427.6 10444.1 44763.8 49536.0 52627.7 53857.5 56284.4 64831.7 77799.0 79428.6 80265.6 81649.2 13022.8 13043.4 13055.0 13231.4 13266.1 14187.6 14382.9 14441.5 14757.3 15178.7 13697.7 13904.4 13945.4 14111.0 14550.9 13662.5 13717.6 13808.4 13862.8 13925.7 13391.3 13400.1 13539.9 13552.7 13621.3 11278.3 11646.5 11656.1 11902.8 11927.2 11425.6 11642.1 11730.7 11759.9 11761.1 13:23:53 INFO - PROCESS | 1638 | -------- Summary: end -------- 13:23:53 INFO - PROCESS | 1638 | 13:23:54 INFO - TEST-INFO | 1638: exit 0 13:23:54 INFO - TEST-OK | dromaeo_css | took 1113976ms 13:23:54 INFO - TEST-START | kraken 13:23:54 INFO - operating with platform_type : mac_ 13:23:54 INFO - Initialising browser for kraken test... 13:23:54 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpK4lIrB/profile http://localhost:49240/getInfo.html) 13:23:56 INFO - PROCESS | 1649 | 2017-01-30 13:23:56.789 plugin-container[1651:9871] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x874b, name = 'com.apple.tsm.portname' 13:23:56 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:23:56 INFO - PROCESS | 1649 | 2017-01-30 13:23:56.790 plugin-container[1651:9871] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 13:23:56 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:23:56 INFO - PROCESS | 1649 | 2017-01-30 13:23:56.790 plugin-container[1651:9871] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:23:56 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 13:23:56 INFO - PROCESS | 1649 | colorDepth:24 13:23:56 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 13:23:56 INFO - PROCESS | 1649 | __metrics 13:23:56 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 13:23:57 INFO - TEST-INFO | 1649: exit 0 13:23:57 INFO - Browser initialized. 13:23:57 INFO - Running cycle 1/1 for kraken test... 13:23:57 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpK4lIrB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:24:00 INFO - PROCESS | 1652 | 2017-01-30 13:24:00.169 plugin-container[1653:9994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8437, name = 'com.apple.tsm.portname' 13:24:00 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:24:00 INFO - PROCESS | 1652 | 2017-01-30 13:24:00.170 plugin-container[1653:9994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 13:24:00 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:24:00 INFO - PROCESS | 1652 | 2017-01-30 13:24:00.170 plugin-container[1653:9994] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:24:09 INFO - PROCESS | 1652 | RSS: Main: 177168384 13:24:09 INFO - PROCESS | 1652 | 13:24:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 13:24:13 INFO - PROCESS | 1652 | RSS: Main: 190230528 13:24:13 INFO - PROCESS | 1652 | 13:24:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 13:24:17 INFO - PROCESS | 1652 | RSS: Main: 199290880 13:24:17 INFO - PROCESS | 1652 | 13:24:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 13:24:20 INFO - PROCESS | 1652 | RSS: Main: 202153984 13:24:20 INFO - PROCESS | 1652 | 13:24:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 13:24:23 INFO - PROCESS | 1652 | RSS: Main: 203411456 13:24:23 INFO - PROCESS | 1652 | 13:24:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:24:26 INFO - PROCESS | 1652 | RSS: Main: 203472896 13:24:26 INFO - PROCESS | 1652 | 13:24:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 13:24:29 INFO - PROCESS | 1652 | RSS: Main: 207704064 13:24:29 INFO - PROCESS | 1652 | 13:24:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 13:24:33 INFO - PROCESS | 1652 | RSS: Main: 207413248 13:24:33 INFO - PROCESS | 1652 | 13:24:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 13:24:36 INFO - PROCESS | 1652 | RSS: Main: 206843904 13:24:36 INFO - PROCESS | 1652 | 13:24:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:24:39 INFO - PROCESS | 1652 | RSS: Main: 206155776 13:24:39 INFO - PROCESS | 1652 | 13:24:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:24:41 INFO - PROCESS | 1652 | RSS: Main: 206118912 13:24:41 INFO - PROCESS | 1652 | 13:24:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:24:44 INFO - PROCESS | 1652 | RSS: Main: 206131200 13:24:44 INFO - PROCESS | 1652 | 13:24:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:24:47 INFO - PROCESS | 1652 | RSS: Main: 206180352 13:24:47 INFO - PROCESS | 1652 | 13:24:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:24:51 INFO - PROCESS | 1652 | RSS: Main: 206495744 13:24:51 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 13:24:53 INFO - PROCESS | 1652 | RSS: Main: 208322560 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | __start_tp_report 13:24:53 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 13:24:53 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 13:24:53 INFO - PROCESS | 1652 | |i|pagename|runs| 13:24:53 INFO - PROCESS | 1652 | |0;ai-astar;109;117;118;119;116;131;173;167;118;120 13:24:53 INFO - PROCESS | 1652 | |1;audio-beat-detection;156;144;140;166;113;109;108;109;138;110 13:24:53 INFO - PROCESS | 1652 | |2;audio-dft;199;196;198;199;196;198;197;196;195;197 13:24:53 INFO - PROCESS | 1652 | |3;audio-fft;85;60;59;97;83;82;80;81;77;57 13:24:53 INFO - PROCESS | 1652 | |4;audio-oscillator;87;72;90;72;69;69;85;66;65;84 13:24:53 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;135;132;89;85;88;87;89;98;90;86 13:24:53 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;99;95;100;152;152;95;95;105;90 13:24:53 INFO - PROCESS | 1652 | |7;imaging-desaturate;89;139;118;112;106;132;77;137;140;92 13:24:53 INFO - PROCESS | 1652 | |8;json-parse-financial;57;57;56;58;59;60;59;59;67;64 13:24:53 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;69;75;68;81;76;75;94;57;68;88 13:24:53 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;83;83;81;87;86;85;82;88;87;85 13:24:53 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;139;165;149;150;150;152;160;153;194;150 13:24:53 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;164;165;162;164;165;167;163;167;163;163 13:24:53 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;68;66;68;66;67;67;68;65;67;66 13:24:53 INFO - PROCESS | 1652 | __end_tp_report 13:24:53 INFO - PROCESS | 1652 | __start_cc_report 13:24:53 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,896 13:24:53 INFO - PROCESS | 1652 | __end_cc_report 13:24:53 INFO - PROCESS | 1652 | __startTimestamp1485811493277__endTimestamp 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | ------- Summary: start ------- 13:24:53 INFO - PROCESS | 1652 | Number of tests: 14 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:128.80 Median:119.50 stddev:22.41 (18.8%) stddev-sans-first:22.59 13:24:53 INFO - PROCESS | 1652 | Values: 109.0 117.0 118.0 119.0 116.0 131.0 173.0 167.0 118.0 120.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:139.00 stddev:22.07 (15.9%) stddev-sans-first:21.18 13:24:53 INFO - PROCESS | 1652 | Values: 156.0 144.0 140.0 166.0 113.0 109.0 108.0 109.0 138.0 110.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:197.10 Median:197.50 stddev:1.37 (0.7%) stddev-sans-first:1.27 13:24:53 INFO - PROCESS | 1652 | Values: 199.0 196.0 198.0 199.0 196.0 198.0 197.0 196.0 195.0 197.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:76.10 Median:81.50 stddev:13.14 (16.1%) stddev-sans-first:13.54 13:24:53 INFO - PROCESS | 1652 | Values: 85.0 60.0 59.0 97.0 83.0 82.0 80.0 81.0 77.0 57.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:78.00 stddev:9.50 (12.2%) stddev-sans-first:9.19 13:24:53 INFO - PROCESS | 1652 | Values: 87.0 72.0 90.0 72.0 69.0 69.0 85.0 66.0 65.0 84.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:88.50 stddev:19.10 (21.6%) stddev-sans-first:14.81 13:24:53 INFO - PROCESS | 1652 | Values: 135.0 132.0 89.0 85.0 88.0 87.0 89.0 98.0 90.0 86.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:107.80 Median:95.00 stddev:23.63 (24.9%) stddev-sans-first:24.61 13:24:53 INFO - PROCESS | 1652 | Values: 95.0 99.0 95.0 100.0 152.0 152.0 95.0 95.0 105.0 90.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:114.20 Median:139.50 stddev:22.89 (16.4%) stddev-sans-first:22.39 13:24:53 INFO - PROCESS | 1652 | Values: 89.0 139.0 118.0 112.0 106.0 132.0 77.0 137.0 140.0 92.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.00 stddev:3.41 (5.8%) stddev-sans-first:3.48 13:24:53 INFO - PROCESS | 1652 | Values: 57.0 57.0 56.0 58.0 59.0 60.0 59.0 59.0 67.0 64.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:75.50 stddev:10.67 (14.1%) stddev-sans-first:11.09 13:24:53 INFO - PROCESS | 1652 | Values: 69.0 75.0 68.0 81.0 76.0 75.0 94.0 57.0 68.0 88.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.50 stddev:2.36 (2.8%) stddev-sans-first:2.42 13:24:53 INFO - PROCESS | 1652 | Values: 83.0 83.0 81.0 87.0 86.0 85.0 82.0 88.0 87.0 85.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:152.50 stddev:14.95 (9.8%) stddev-sans-first:14.50 13:24:53 INFO - PROCESS | 1652 | Values: 139.0 165.0 149.0 150.0 150.0 152.0 160.0 153.0 194.0 150.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:164.50 stddev:1.70 (1.0%) stddev-sans-first:1.80 13:24:53 INFO - PROCESS | 1652 | Values: 164.0 165.0 162.0 164.0 165.0 167.0 163.0 167.0 163.0 163.0 13:24:53 INFO - PROCESS | 1652 | 13:24:53 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 13:24:53 INFO - PROCESS | 1652 | Values: 68.0 66.0 68.0 66.0 67.0 67.0 68.0 65.0 67.0 66.0 13:24:53 INFO - PROCESS | 1652 | -------- Summary: end -------- 13:24:53 INFO - PROCESS | 1652 | 13:24:54 INFO - TEST-INFO | 1652: exit 0 13:24:54 INFO - TEST-OK | kraken | took 60197ms 13:24:54 INFO - SUITE-END | took 1174s 13:24:54 INFO - Completed test suite (00:19:34) 13:24:54 INFO - javascript benchmark 13:24:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7426.700639612963, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3593.5687717473897, 3611.3680105981457, 3612.4761909523104, 3631.6913062389694, 3664.2671465706867, 5977.790777322794, 6016.187814645022, 6030.9396906030925, 6081.574289799716, 6087.695615219243, 5483.7532311046, 5596.132599447082, 5679.687617181054, 6032.457078862902, 6104.542159338045, 4487.618552423031, 4723.48041715411, 5401.135818269077, 5428.4842939920845, 5499.917501237484, 5394.217838413428, 5533.806316778913, 5543.1408131739445, 5544.63959842611, 5563.304586926634, 4515.300128480091, 5349.411564727877, 5360.008398446281, 5532.502074813266, 5542.944570554303, 5387.515123638872, 5438.782448702047, 5514.924589704969, 5566.109422492423, 5587.720613969285, 4563.498015218323, 5396.0, 5408.323959505062, 5498.890022199534, 5512.952539017614, 4966.975165124151, 5816.156657284712, 6095.573309868311, 6099.207103076572, 6173.0, 6182.505399568024, 6198.318184999646, 6202.4417802398, 6211.68941552925, 6239.781607643756, 6311.93688063118, 6346.809595712136, 6351.142595749561, 6407.103005579223, 6422.614643121381, 6121.510279177655, 6137.140800287919, 6137.631742095399, 6148.292946311142, 6162.198914141178, 6443.581167224115, 6482.060101285381, 6521.347865213535, 6560.081588577603, 6588.73645054202, 6251.874962500816, 6254.312025677172, 6254.437100660963, 6258.311585725566, 6275.654838983808, 6178.073289006685, 6203.8138855834395, 6377.936220637827, 6426.35736426363, 6437.613743175424, 6210.813675589739, 6262.405071518198, 6275.780347687901, 6337.683115844282, 6355.0785136155, 5824.126381042877, 5913.733881975321, 6311.558190926683, 6319.399657032574, 6356.046593011085, 5203.427622961472, 5205.29728486657, 5226.294450249244, 5228.869278267997, 5233.267342572043, 4552.430946131733, 4556.179887620194, 4569.314602809605, 4574.405327307429, 4576.565226303496, 5460.672359658433, 5625.6905870176715, 6104.969475152596, 6184.412480814315, 6199.876002479925, 6395.456386207225, 6395.513877199357, 6425.550211485244, 6447.258565265054, 6493.480521558264, 6077.969610151921, 6123.130109042722, 6134.110553969738, 6152.876942461216, 6181.1655426516845, 5799.82600521985, 5807.332156801937, 5812.273465816773, 5819.127130930395, 5826.708664566755, 5634.605577609528, 6647.335266473314, 6711.530192886451, 6802.965985170043, 6806.353396427331, 6252.093446450148, 6354.459870911024, 6372.490200784019, 6382.297947225708, 6493.902591461037, 6707.966460167668, 6722.92433210684, 6746.954222095583, 6751.493637977073, 6766.7969960901255, 6306.306306306395, 6389.361063893573, 6406.487481001415, 6409.9038514423255, 6425.935740642721, 4805.6155507558615, 6219.0, 6293.779717709858, 6474.384933431316, 6475.676216189266, 6103.969480152571, 6215.689215539295, 6218.595791273553, 6221.3156552780065, 6231.345708700703, 6214.0, 6217.098520714561, 6219.813405597839, 6224.751009959551, 6227.719752611053, 5995.340512543529, 6098.573099883143, 6153.0, 6181.938180618136, 6207.0, 6141.977005061692, 6165.0, 6174.969125154345, 6216.098665693539, 6235.625862448268, 6166.260048794174, 6196.1635179252025, 6196.47329976957, 6198.6280823150755, 6252.1559589456665], "value": 5878.706707893408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.61357447977815, 526.2290744059951, 533.9786408543658, 542.7259234086786, 568.698589747434, 30564.54153187701, 40866.38700419496, 40970.0, 40988.565400210995, 41032.17935641285, 42195.36706949391, 42328.57671423285, 42749.35875961855, 42757.57242427575, 42798.358024629655, 9480.525973701322, 9674.322797404184, 9677.177439917616, 9710.805783884354, 9727.708168754949, 9589.616415343378, 9617.278704097185, 9637.373570717917, 9646.324757266993, 9671.854922176173, 9630.614775408976, 9659.855102173473, 9686.66096686616, 9688.709338719815, 9694.03059694032, 9587.376820506679, 9644.90355096454, 9647.951760241154, 9660.613575456973, 9695.078967498077, 8337.666493340259, 8346.624401901929, 9566.904330956671, 9655.517224138835, 9704.75738106546, 39581.0, 39805.0, 39830.20339593221, 39902.40390384381, 40060.19879602421, 3282.146641873106, 3423.9486407703903, 3467.583889933199, 3557.626449222846, 3914.941275880864, 31317.217069573217, 31393.058208253788, 31474.685253147403, 31611.367772644648, 31805.52291715626, 2797.580362945554, 3267.7059064684054, 3359.8320083995704, 3388.8983330500123, 3389.813560254185, 437557.0, 440532.0, 441238.0, 443251.7837410825, 443525.0, 59677.80644387088, 59915.0, 60061.69969150214, 60107.79784404375, 60315.0, 61467.38532614706, 61745.382546174864, 61783.69108154521, 62072.75854482885, 62238.0, 16361.754573681405, 16500.504984850475, 16570.337186512646, 16834.747478787827, 16924.238409271613, 12593.433295501725, 12689.048321375749, 12701.174423662433, 12734.554290599785, 12745.808812867814, 13174.275414852083, 14768.483103091341, 16370.85090387683, 16478.0, 16503.009819410872, 6128.693565321805, 6706.463482921355, 7393.445491588152, 7541.283578060075, 7630.160682324939, 881.2817553693848, 970.3013830042358, 1060.4538662588773, 1094.0973696700255, 1121.9509758375946, 31344.529832052536, 32176.517352239734, 32338.191545211557, 32713.672863271062, 32919.0, 926.6756635177634, 1072.2762135558467, 1182.3152008388013, 1183.8697743248235, 1224.69994851262, 14380.712385752226, 15510.844891551165, 15737.68524629501, 15827.366905323657, 15979.121148336953, 675037.0, 691619.5419022873, 692480.0, 693888.0, 694509.0, 57885.71057144687, 58150.0, 58429.0, 58718.41281587129, 58740.412595873495, 1415.7380884536394, 1418.652430154598, 1436.2172615924137, 1438.604383794444, 1441.3297816515162, 29534.261643459085, 29953.550696740003, 30639.621217045733, 30652.84673576618, 30753.384932301677, 52011.73994130005, 52259.47740522546, 52330.738346308026, 52367.0, 52424.73787631038, 608186.0, 610503.0, 612100.0, 612613.0, 614030.0, 23442.0, 23492.0, 26434.603480947415, 26621.0, 26764.732352677, 39762.60237397589, 45787.54212457833, 47645.28532071952, 47731.28403074026, 47979.28031079467, 37942.074008220516, 39224.0, 39399.80300098481, 39751.60248397479, 40626.79686601548, 28354.149375518766, 38905.27663063672, 39311.017224569616, 39693.60306396899, 40239.79280621586, 37749.4337584942, 38142.42786358151, 38471.80764096162, 38480.422793658676, 38849.02877428087, 34036.65963340434, 34870.825645872625, 34937.30125397529, 35259.0, 35261.64738352584, 22237.66643500381, 23986.920588573907, 24235.303528753524, 26129.60805587956, 26258.978491414655], "value": 19998.1432499173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.0214356606001, 386.6018001458497, 387.26419802375483, 393.1527558112267, 410.81718635207324, 16308.592285192875, 19760.407187784353, 19838.30565930193, 20984.37046888594, 21181.258655947044, 20149.29477468289, 20385.980700964967, 20534.5358556973, 20734.585308293827, 20914.163433462643, 5888.29340479141, 6119.694015299239, 6164.938350616481, 6167.290761562433, 6182.196314479112, 5959.0, 6055.455009049185, 6079.78720744774, 6116.785912493064, 6140.84647883802, 6090.60411073281, 6100.206973093514, 6107.816765497042, 6116.938830611703, 6134.662593557353, 5819.476247137757, 5983.401659834003, 6034.4568988791, 6043.848903777397, 6045.183900173508, 5301.602379821529, 5303.23103150045, 5303.257543943851, 5313.3092697949405, 5319.547838433699, 21882.89058554697, 24335.756642433527, 24573.38566535851, 24974.0, 25277.24168274936, 2164.296603603835, 2380.143148466551, 2683.662198871605, 2842.7299406556344, 3150.5116706910467, 12516.561920332835, 15505.689886202326, 15773.132477713722, 16067.678646427123, 16089.597760055975, 1654.5780825889442, 1707.274408376435, 1850.4726153046317, 1927.5373910261576, 1958.5789055353168, 111318.44340778244, 113586.43206783995, 114176.85823141746, 114614.70770584542, 114977.0, 9290.581923813445, 10744.462776861283, 11174.832377514344, 11261.324320540794, 11390.0, 12328.568500102454, 13007.154534955198, 13951.651208719863, 13970.0, 13972.510962116277, 8166.510009399455, 8449.408541402167, 8567.657293708182, 8582.27050700685, 8623.051464338918, 7712.5758083305955, 8002.399820013406, 8449.408541402043, 8514.78713032179, 8666.306695464347, 5907.556933229939, 6456.322086180978, 6790.5925644461495, 6835.008923706035, 6838.21360543534, 1652.2482270567104, 1956.178405069874, 1972.2406873353862, 1974.644563978469, 1983.1968052938582, 880.7533890510667, 937.2174234514121, 940.191435365585, 1049.8504137968912, 1089.1885545268826, 19006.429807105807, 21839.126434942424, 21898.79556624369, 21959.560808783735, 22053.0, 890.8685968819692, 932.4778124250441, 980.2403137568441, 982.7788747531748, 993.9006099390148, 10968.17738669603, 11603.709907252387, 11615.88384116148, 11652.650420487398, 11731.413429328499, 514251.42874285387, 514459.0, 516821.0, 601694.0, 622068.0, 141834.2908285452, 144339.2783036078, 145135.0, 145950.5404945937, 148678.0, 971.4705485510414, 1016.8881423043459, 1018.0888105145852, 1019.6278358399131, 1054.0829478353728, 18494.907525462288, 19129.904350478715, 19133.13900874436, 19316.130774114918, 19543.60912781765, 56356.0, 56501.0, 56702.86594268174, 58349.70825146017, 58814.41185588089, 82212.0, 84817.57591212004, 86050.0, 86949.0, 87159.56420217859, 7882.684692612232, 7936.761897143095, 8058.113607503053, 8071.071826739765, 8182.22268884455, 11322.26405283654, 12201.816972745239, 12238.265704057785, 12517.436715348013, 12588.559400420942, 9839.704808855746, 10655.348420994758, 10672.786544269227, 10786.73033174177, 11013.394263315595, 8340.29107525867, 10591.570138031575, 10591.576336946437, 10616.522256498321, 10628.202884783517, 10997.560097596006, 11081.118909083536, 11088.889111108785, 11153.776924461303, 11203.15976301797, 7875.212478752079, 7893.526388416713, 7906.367490600623, 8130.918690813252, 8193.672253110048, 8197.385196110436, 8793.0, 10453.372797632166, 10915.399653018843, 11065.834012489659], "value": 9796.351381045572, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.6333248354151, 1536.3393740691502, 1711.6918954588177, 1805.2508209093228, 1879.5019319880234, 7268.764310067288, 7697.923020769805, 7981.880271795913, 8378.790530236747, 8634.654613815439, 8198.262156405923, 8441.873371899412, 8465.407421480499, 8526.786830329245, 8532.573371331424, 2382.28531440568, 2433.2092070077206, 2433.5741245282093, 2433.9756602433927, 2435.2207293666033, 2413.1312727418117, 2414.987925060381, 2431.659567660529, 2450.82844200906, 2458.55745965727, 2386.4630458146953, 2390.7489713580085, 2397.832151749378, 2419.3104965084867, 2425.466397392571, 2022.373064350049, 2376.869272190029, 2385.6063749481314, 2394.269747726951, 2405.074046492113, 2103.684447332897, 2368.0882860098814, 2400.615901455759, 2417.4439878827966, 2434.793042591382, 7307.963460182665, 8488.108748581371, 8592.14078592142, 8613.267872230868, 8620.396572239946, 4305.547917468683, 5362.812301569426, 5379.596530260207, 5380.408155102936, 5384.40771515133, 3543.273628906068, 3560.5549306336707, 3568.411212149992, 3620.6560376764164, 3685.1892583631557, 983.4689267795382, 1085.3542142425244, 1086.1582273737838, 1115.8605174353206, 1131.2138064045491, 11162.832557511643, 11220.99011089006, 11222.775544489146, 11259.493322800494, 11354.375509346983, 4531.660125490535, 4695.483496815347, 4789.473157952622, 4814.325994360793, 4823.975880120577, 9621.615135394646, 9628.518574071268, 9636.180924621345, 9643.324967252225, 9725.513724313756, 5339.14573668219, 5345.839624811262, 5352.759125839347, 5388.164834450667, 5416.160495123262, 4416.050549131952, 4443.800028998703, 4857.951420485821, 4886.560209581155, 4922.458529561745, 3925.528936527635, 3967.5437324708028, 4003.939940900889, 4063.715539912178, 4080.4695389599756, 1153.9134564907665, 1166.8716441191461, 1288.4974859804684, 1314.4545013819159, 1325.1121748428577, 850.5024560631975, 931.4737173496952, 938.8967213606497, 945.3288165402504, 946.3848498475908, 5769.509591684669, 5819.952408566414, 5875.0, 5944.910826337608, 6141.508679305645, 835.983280334402, 859.574510617236, 917.9678711245208, 959.6689142245914, 994.3735446668552, 3745.5318085239346, 3982.1040265939932, 4074.1647962167685, 4084.2852500812237, 4103.625285529321, 10236.48817559119, 10420.739481513023, 10431.791364172674, 10434.634787782392, 10585.41780202081, 10008.449535275484, 10214.131798797185, 10322.329048611817, 10367.533460994273, 10371.274010819321, 7833.686652533949, 7930.1276859545405, 8035.955325807725, 8194.139615340422, 8221.753347399588, 5805.10020946754, 5916.994111001054, 5935.376785437639, 5974.581779275409, 5988.940110598838, 9299.67451139207, 9348.95325523368, 9362.906370936476, 9503.334766566273, 9690.612375504901, 9537.998510156334, 9555.713328600154, 9624.181944534514, 9633.470159141314, 9655.372400793925, 6775.796726098225, 6789.89815152783, 7290.635468226674, 7300.16048154469, 7457.515261508202, 8050.87923681157, 8150.4294699370475, 8153.592320384076, 8155.184481551797, 8161.4695044824275, 7223.097112860893, 7327.2672732726305, 7382.5570465772225, 7494.962525187339, 7516.887246691414, 7202.53183543068, 7278.6724597392185, 7279.1628962667855, 7304.977303177666, 7318.560886346836, 5728.484436400744, 6833.282505336868, 6842.007908853089, 6878.209005964178, 6878.38094571491, 4829.541193586604, 4862.6839255448285, 4939.456659767351, 4990.351254336913, 5029.823956161516, 4984.551390374883, 5015.448300686849, 5071.416787069535, 5108.182690769459, 5111.977604479045], "value": 4540.044858383042, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.23344951209907, 309.30406585183323, 319.2465780757412, 322.1334609899372, 324.1830586920959, 4321.827126914924, 4347.934780978288, 5370.865728356793, 5558.499735023847, 5597.804076857311, 5012.7744251508675, 5425.3760817506, 5544.390117087117, 5555.971920357739, 5585.804496842611, 3575.3028159508776, 3721.9255614887684, 4258.723182993111, 4266.381374700659, 4314.611684948354, 3150.6219253689587, 3996.840126394941, 4325.740455572675, 4336.436263285768, 4395.340698895159, 3197.6322722886935, 4163.250614889319, 4167.208230436223, 4194.601512856274, 4208.242516347072, 3497.7901325920398, 4181.0, 4205.3902184183125, 4217.325227963526, 4233.428487154226, 3618.294432585647, 3637.9818100909592, 3647.0, 3647.598764135943, 3649.6532829381167, 5094.9110864545355, 5414.424811034709, 5421.241026256327, 5431.456854314576, 5468.851541176357, 4035.9910022494378, 4649.744264065475, 4772.260299653559, 4819.807207711688, 4850.9272360914265, 5349.358077030743, 5775.191473193714, 5778.451047150514, 5865.237519122486, 5958.40415958405, 3367.0, 3744.756590821588, 3977.2244412339605, 3992.40113982902, 4011.7191796574252, 6115.6330620162935, 6181.3509581493745, 6206.6586337751405, 6231.4391704746795, 6234.18955535782, 3941.0541470046983, 4016.3172260715746, 4031.6169963853386, 4051.758593125488, 4064.573219811877, 3696.6303369663356, 3750.9062273443383, 3829.5064924679396, 3840.2895464339185, 4051.372037334218, 4250.914981700349, 4413.44831896013, 4506.459224893034, 4716.669833111718, 4783.856484305476, 5063.8480845574695, 5832.212651292106, 5849.6782676952325, 5904.439078287556, 5908.852278692981, 1125.454154734953, 1252.757211071668, 1261.2054405724334, 1311.7245378470436, 1322.6032190342858, 733.2996987876566, 893.2942975049768, 908.6683360573476, 912.0833562269876, 913.2876356441986, 4719.551642593948, 4756.381670382828, 4867.951320486821, 5175.637705360588, 5200.791968321225, 5578.0, 5598.356189038313, 5611.551075913917, 5619.43805619443, 5636.943630563642, 4639.559241872017, 4719.268513380432, 4998.00257445962, 5170.560502357342, 5244.580433565382, 2596.675415573053, 2607.9877741208934, 2698.5007773561956, 2850.2067973385783, 2976.940461190764, 5547.889042219133, 5794.770621581816, 5926.229590153339, 5977.372375900468, 5978.432048955342, 4895.926561101586, 4937.876553086202, 5750.6262092963825, 5878.500982249499, 6184.752609895644, 5097.680555347308, 5988.730507127103, 6437.5815571988605, 6448.451881590117, 6454.1609590752905, 5063.620228482952, 5397.463192299613, 5868.647881127146, 6080.695965201634, 6147.200863887666, 5970.910436343545, 6005.759769609167, 6110.663913484801, 6119.204503414706, 6120.540959427972, 5973.462388385066, 6362.300146983735, 6473.741050358121, 6479.185827968176, 6485.513586481127, 3687.3731465650367, 3815.9281778167733, 3933.272344616255, 4026.0, 4067.7152599317765, 5053.84838454847, 5839.686070634073, 6113.113598528277, 6122.438778111731, 6130.325664177026, 5792.944938543121, 5844.883102337844, 5929.703514824328, 5964.105384192406, 6011.489023432882, 5880.529557635465, 5930.436608522184, 5941.0394569791, 5950.315713692808, 5983.217803721291, 5505.678637126981, 5754.971225143848, 5758.424157584208, 5770.740316685843, 5834.679092649775, 5436.7281635918835, 5882.882162421439, 5908.641012567219, 5936.643801371932, 5952.73212705438, 5558.694271815089, 5601.29983752031, 5776.277965254343, 5788.942110579009, 5798.768049277982], "value": 4210.896072883975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.2726473614288, 727.6761840980762, 744.7467860927284, 783.3693876429476, 798.1778767869097, 14716.484923027696, 15091.84908150918, 15534.145621990787, 15550.611234719137, 15701.214939253048, 13984.230867302294, 14215.857841421583, 14311.212883291415, 14317.856821431782, 14321.57035288943, 850.3027517435705, 875.6322344615245, 879.226280872831, 879.9880137841469, 882.0209567380202, 850.2857599616322, 879.5909901895617, 882.0341725810259, 886.5921676029035, 887.1572006593761, 909.5725009245645, 937.203377129438, 941.6986564299427, 941.7739742461829, 941.9576119074624, 813.3818298093462, 930.9767255818625, 931.1154403316876, 935.4527601353217, 935.5602866652663, 666.340323080152, 680.1532092544765, 681.5876394781136, 684.3669605614837, 694.187800273681, 13091.0, 14152.6554977277, 14879.851201487954, 14971.77542336855, 15232.086074835544, 13283.3358332083, 14005.29973501331, 14289.64275893111, 14521.56435306932, 14582.416703331854, 12287.93856030714, 12490.188137771107, 12961.222326660336, 13002.739945201138, 13111.934440327832, 3448.6723761242642, 3529.0, 3781.8487260509546, 3887.8250478728523, 3928.0, 74458.0, 89715.10284897132, 94146.23415063389, 94299.52850235705, 95118.52440737821, 10643.46782660864, 10670.679879603624, 10839.295445795999, 10916.781664366668, 11039.06167975715, 17486.912565437346, 18337.908310458628, 21274.680879786814, 21321.573568528544, 21372.251971180933, 7823.569703666353, 7932.21991711567, 7948.046234451903, 7989.400794940403, 8050.11448740638, 4359.960400177072, 4458.464984201852, 4561.110583436264, 4594.954050459452, 4631.8842028948875, 3499.545059142295, 3614.6204648512053, 3620.963790362063, 3622.619624939396, 3635.8000309982676, 628.7862126876884, 653.9182602174728, 661.7121552124842, 670.2660586657602, 685.6092027544252, 566.4399250709272, 575.0052409331879, 579.794173068563, 624.2041397218492, 682.5938566552893, 8971.22136870814, 9579.0, 9591.90408095924, 9631.518424078768, 9829.262805289489, 583.215575051555, 618.3692633513881, 632.7595513704855, 642.9616169885694, 646.9353064693493, 4410.757408342508, 4675.836345727883, 4677.4854765975715, 4722.574968252805, 4729.196036673774, 74096.88854667185, 112211.43894280476, 117870.0, 119590.0, 123875.38062309811, 87009.56495217483, 101338.0, 107913.0, 107934.0, 109831.45084274528, 91826.54086729657, 92393.61409578862, 92842.0, 94755.0, 99162.51256231162, 9713.222942164468, 9975.850362244717, 10208.387496750218, 10427.582896684047, 10444.112250458797, 44763.77618111888, 49536.0, 52627.73686131545, 53857.46142538524, 56284.43715562792, 64831.67584162049, 77799.0, 79428.60285698535, 80265.59867200861, 81649.18350816416, 13022.804657930328, 13043.413046412745, 13055.0, 13231.404586793426, 13266.137701049402, 14187.574372768833, 14382.884367602519, 14441.49454769078, 14757.335919883846, 15178.696426071196, 13697.657558561115, 13904.374303156585, 13945.372458239606, 14111.0, 14550.927245363706, 13662.521811736542, 13717.588472345846, 13808.447662093404, 13862.792058118934, 13925.721485570435, 13391.306943400812, 13400.06199566021, 13539.86460135386, 13552.661183470493, 13621.318934053455, 11278.266912650652, 11646.534138634699, 11656.125790565911, 11902.761944761229, 11927.165098443025, 11425.600103996652, 11642.068634509389, 11730.70673233176, 11759.882401175879, 11761.059115270587], "value": 7620.091476186477, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 118.0, 119.0, 116.0, 131.0, 173.0, 167.0, 118.0, 120.0], "value": 128.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 144.0, 140.0, 166.0, 113.0, 109.0, 108.0, 109.0, 138.0, 110.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 196.0, 198.0, 199.0, 196.0, 198.0, 197.0, 196.0, 195.0, 197.0], "value": 197.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 59.0, 97.0, 83.0, 82.0, 80.0, 81.0, 77.0, 57.0], "value": 76.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 90.0, 72.0, 69.0, 69.0, 85.0, 66.0, 65.0, 84.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 89.0, 85.0, 88.0, 87.0, 89.0, 98.0, 90.0, 86.0], "value": 97.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 95.0, 100.0, 152.0, 152.0, 95.0, 95.0, 105.0, 90.0], "value": 107.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 139.0, 118.0, 112.0, 106.0, 132.0, 77.0, 137.0, 140.0, 92.0], "value": 114.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 58.0, 59.0, 60.0, 59.0, 59.0, 67.0, 64.0], "value": 59.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 75.0, 68.0, 81.0, 76.0, 75.0, 94.0, 57.0, 68.0, 88.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 87.0, 86.0, 85.0, 82.0, 88.0, 87.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 165.0, 149.0, 150.0, 150.0, 152.0, 160.0, 153.0, 194.0, 150.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 164.0, 165.0, 167.0, 163.0, 167.0, 163.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 66.0, 67.0, 67.0, 68.0, 65.0, 67.0, 66.0], "value": 66.8, "unit": "score"}]}]} 13:24:54 INFO - Return code: 0 13:24:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:24:54 ERROR - # TBPL SUCCESS # 13:24:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:24:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:24:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:24:54 INFO - 2017-01-30 13:24:54.621 screenresolution[1657:10384] starting screenresolution argv=screenresolution get 13:24:54 INFO - 2017-01-30 13:24:54.624 screenresolution[1657:10384] Display 0: 1600x1200x32@60 13:24:54 INFO - 2017-01-30 13:24:54.630 screenresolution[1658:10387] starting screenresolution argv=screenresolution list 13:24:54 INFO - Available Modes on Display 0 13:24:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:24:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:24:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:24:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:24:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:24:54 INFO - Intel Iris: 13:24:54 INFO - Chipset Model: Intel Iris 13:24:54 INFO - Type: GPU 13:24:54 INFO - Bus: Built-In 13:24:54 INFO - VRAM (Dynamic, Max): 1536 MB 13:24:54 INFO - Vendor: Intel (0x8086) 13:24:54 INFO - Device ID: 0x0a2e 13:24:54 INFO - Revision ID: 0x0009 13:24:54 INFO - Displays: 13:24:54 INFO - Display: 13:24:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:24:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:24:54 INFO - Display Serial Number: 1600x1200 60 13:24:54 INFO - Main Display: Yes 13:24:54 INFO - Mirror: Off 13:24:54 INFO - Online: Yes 13:24:54 INFO - Rotation: Supported 13:24:54 INFO - Return code: 0 13:24:54 INFO - Running post-action listener: _resource_record_post_action 13:24:54 INFO - [mozharness: 2017-01-30 21:24:54.869787Z] Finished run-tests step (success) 13:24:54 INFO - Running post-run listener: _resource_record_post_run 13:24:54 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39639040; Write bytes: 502174720; Read time: 387; Write time: 1797 13:24:54 INFO - TinderboxPrint: CPU usage
54.2% 13:24:54 INFO - TinderboxPrint: I/O read bytes / time
39,639,040 / 387 13:24:54 INFO - TinderboxPrint: I/O write bytes / time
502,174,720 / 1,797 13:24:54 INFO - TinderboxPrint: CPU idle
2,192.0 (45.8%) 13:24:54 INFO - TinderboxPrint: CPU system
967.5 (20.2%) 13:24:54 INFO - TinderboxPrint: CPU user
1,626.2 (34.0%) 13:24:54 INFO - TinderboxPrint: Swap in / out
231,198,720 / 0 13:24:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181096960; Write bytes: 174469120; Read time: 16508; Write time: 308 13:24:54 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 38684672; Write bytes: 309974016; Read time: 372; Write time: 1401 13:24:55 INFO - Running post-run listener: _upload_blobber_files 13:24:55 INFO - Blob upload gear active. 13:24:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:24:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:24:55 INFO - (blobuploader) - INFO - Open directory for files ... 13:24:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:24:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:56 INFO - (blobuploader) - INFO - Done attempting. 13:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:57 INFO - (blobuploader) - INFO - Done attempting. 13:24:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:24:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:24:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:24:59 INFO - (blobuploader) - INFO - Done attempting. 13:24:59 INFO - (blobuploader) - INFO - Iteration through files over. 13:24:59 INFO - Return code: 0 13:24:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:24:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:24:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59a9608d9354b6f3ad2fcf3e6d805d8c914027981b5bab1354c7b19a18537fc976753c74b5bb0bd2fde9c7be3de7a0ab54907772e0c1f41994417e5f7eea0adc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ec4370785279b98cbcf886d85cb87cf12e1b2aacb2224a58528bf58f75b5ac42055118caf6a7eabe103439198f1f8fe2a45c7b2567c645651e2927a1d6e8755", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0447aa8eac02114e47abaffc577e2d967d8732192f1a405bb6492e3c971d77aa31e55eaad9ca9e1ccec774b0e759e48f18cf3c361d1765e393fd1dae7d53ed5c"} 13:24:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:24:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:24:59 INFO - Contents: 13:24:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59a9608d9354b6f3ad2fcf3e6d805d8c914027981b5bab1354c7b19a18537fc976753c74b5bb0bd2fde9c7be3de7a0ab54907772e0c1f41994417e5f7eea0adc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ec4370785279b98cbcf886d85cb87cf12e1b2aacb2224a58528bf58f75b5ac42055118caf6a7eabe103439198f1f8fe2a45c7b2567c645651e2927a1d6e8755", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0447aa8eac02114e47abaffc577e2d967d8732192f1a405bb6492e3c971d77aa31e55eaad9ca9e1ccec774b0e759e48f18cf3c361d1765e393fd1dae7d53ed5c"} 13:24:59 INFO - Running post-run listener: copy_logs_to_upload_dir 13:24:59 INFO - Copying logs to upload dir... 13:24:59 INFO - mkdir: /builds/slave/test/build/upload/logs 13:24:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.088314 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-30 13:25:00.053583) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 13:25:00.056678) ========= 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.52FjUhP35s/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.MC0bENQLlC/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59a9608d9354b6f3ad2fcf3e6d805d8c914027981b5bab1354c7b19a18537fc976753c74b5bb0bd2fde9c7be3de7a0ab54907772e0c1f41994417e5f7eea0adc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ec4370785279b98cbcf886d85cb87cf12e1b2aacb2224a58528bf58f75b5ac42055118caf6a7eabe103439198f1f8fe2a45c7b2567c645651e2927a1d6e8755", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0447aa8eac02114e47abaffc577e2d967d8732192f1a405bb6492e3c971d77aa31e55eaad9ca9e1ccec774b0e759e48f18cf3c361d1765e393fd1dae7d53ed5c"} build_url:https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011080 build_url: 'https://queue.taskcluster.net/v1/task/ZCdiI3DvQLymjvkMeojQ8w/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/59a9608d9354b6f3ad2fcf3e6d805d8c914027981b5bab1354c7b19a18537fc976753c74b5bb0bd2fde9c7be3de7a0ab54907772e0c1f41994417e5f7eea0adc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2ec4370785279b98cbcf886d85cb87cf12e1b2aacb2224a58528bf58f75b5ac42055118caf6a7eabe103439198f1f8fe2a45c7b2567c645651e2927a1d6e8755", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0447aa8eac02114e47abaffc577e2d967d8732192f1a405bb6492e3c971d77aa31e55eaad9ca9e1ccec774b0e759e48f18cf3c361d1765e393fd1dae7d53ed5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 13:25:00.090912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:25:00.091240) ========= 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.52FjUhP35s/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.MC0bENQLlC/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.005186 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 13:25:00.140240) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 13:25:00.140559) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 13:25:00.140893) ========= ========= Total master_lag: 0.18 =========