builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0311 starttime: 1479398020.2 results: success (0) buildid: 20161117053528 builduid: 1c1ce754a7964182b1e6446fffc6c00f revision: 41fe2fa4ddabb611c4da3cdb0585d6e1cd9722c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:40.202443) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:40.202881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:40.203172) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:40.226631) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:40.227007) ========= 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.sDltijzq55/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.L5uxTpgi9a/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-17 07:53:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-11-17 07:53:40 (47.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104162 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:40.356534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:40.356846) ========= 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.sDltijzq55/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.L5uxTpgi9a/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.019966 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:40.404929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 07:53:40.408303) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 41fe2fa4ddabb611c4da3cdb0585d6e1cd9722c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 41fe2fa4ddabb611c4da3cdb0585d6e1cd9722c4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sDltijzq55/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.L5uxTpgi9a/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-17 07:53:40,492 truncating revision to first 12 chars 2016-11-17 07:53:40,492 Setting DEBUG logging. 2016-11-17 07:53:40,492 attempt 1/10 2016-11-17 07:53:40,492 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/41fe2fa4ddab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 07:53:41,639 unpacking tar archive at: mozilla-central-41fe2fa4ddab/testing/mozharness/ program finished with exit code 0 elapsedTime=1.413819 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 07:53:41.843911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:41.844250) ========= script_repo_revision: 41fe2fa4ddabb611c4da3cdb0585d6e1cd9722c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:41.844633) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:41.844899) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 07:53:41.864960) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-17 07:53:41.865291) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sDltijzq55/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.L5uxTpgi9a/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:53:42 INFO - MultiFileLogger online at 20161117 07:53:42 in /builds/slave/test 07:53:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:53:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:53:42 INFO - {'append_to_log': False, 07:53:42 INFO - 'base_work_dir': '/builds/slave/test', 07:53:42 INFO - 'blob_upload_branch': 'Firefox', 07:53:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:53:42 INFO - 'branch': 'Firefox', 07:53:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:53:42 INFO - 'config_files': ('talos/mac_config.py',), 07:53:42 INFO - 'default_actions': ('clobber', 07:53:42 INFO - 'read-buildbot-config', 07:53:42 INFO - 'download-and-extract', 07:53:42 INFO - 'populate-webroot', 07:53:42 INFO - 'create-virtualenv', 07:53:42 INFO - 'install', 07:53:42 INFO - 'run-tests'), 07:53:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:53:42 INFO - 'download_minidump_stackwalk': True, 07:53:42 INFO - 'download_symbols': 'ondemand', 07:53:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:53:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:53:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:53:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:53:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:53:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:53:42 INFO - 'installer_path': 'installer.exe', 07:53:42 INFO - 'log_level': 'info', 07:53:42 INFO - 'log_name': 'talos', 07:53:42 INFO - 'log_to_console': True, 07:53:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:53:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:53:42 INFO - 'opt_config_files': (), 07:53:42 INFO - 'pip_index': False, 07:53:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:53:42 INFO - 'cmd': ('bash', 07:53:42 INFO - '-c', 07:53:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:53:42 INFO - 'enabled': True, 07:53:42 INFO - 'halt_on_failure': False, 07:53:42 INFO - 'name': 'check_screen_resolution'},), 07:53:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:53:42 INFO - 'cmd': ('bash', 07:53:42 INFO - '-c', 07:53:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:53:42 INFO - 'enabled': True, 07:53:42 INFO - 'halt_on_failure': False, 07:53:42 INFO - 'name': 'check_screen_resolution'},), 07:53:42 INFO - 'run_cmd_checks_enabled': True, 07:53:42 INFO - 'sps_profile': False, 07:53:42 INFO - 'sps_profile_interval': 0, 07:53:42 INFO - 'suite': 'dromaeojs-e10s', 07:53:42 INFO - 'system_bits': '32', 07:53:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:53:42 INFO - 'title': 't-yosemite-r7-0311', 07:53:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:53:42 INFO - 'use_talos_json': True, 07:53:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:53:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:53:42 INFO - 'work_dir': 'build'} 07:53:42 INFO - [mozharness: 2016-11-17 15:53:42.070098Z] Running clobber step. 07:53:42 INFO - Running pre-action listener: _resource_record_pre_action 07:53:42 INFO - Running main action method: clobber 07:53:42 INFO - rmtree: /builds/slave/test/build 07:53:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:53:43 INFO - Running post-action listener: _resource_record_post_action 07:53:43 INFO - [mozharness: 2016-11-17 15:53:43.703837Z] Finished clobber step (success) 07:53:43 INFO - [mozharness: 2016-11-17 15:53:43.703971Z] Running read-buildbot-config step. 07:53:43 INFO - Running pre-action listener: _resource_record_pre_action 07:53:43 INFO - Running main action method: read_buildbot_config 07:53:43 INFO - Using buildbot properties: 07:53:43 INFO - { 07:53:43 INFO - "project": "", 07:53:43 INFO - "product": "firefox", 07:53:43 INFO - "script_repo_revision": "production", 07:53:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:53:43 INFO - "repository": "", 07:53:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:53:43 INFO - "buildid": "20161117053528", 07:53:43 INFO - "pgo_build": "False", 07:53:43 INFO - "basedir": "/builds/slave/test", 07:53:43 INFO - "buildnumber": 170, 07:53:43 INFO - "slavename": "t-yosemite-r7-0311", 07:53:43 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:53:43 INFO - "platform": "yosemite_r7", 07:53:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:53:43 INFO - "branch": "mozilla-central", 07:53:43 INFO - "repo_path": "mozilla-central", 07:53:43 INFO - "revision": "41fe2fa4ddabb611c4da3cdb0585d6e1cd9722c4", 07:53:43 INFO - "stage_platform": "macosx64", 07:53:43 INFO - "builduid": "1c1ce754a7964182b1e6446fffc6c00f", 07:53:43 INFO - "slavebuilddir": "test" 07:53:43 INFO - } 07:53:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:53:43 INFO - Running post-action listener: _resource_record_post_action 07:53:43 INFO - [mozharness: 2016-11-17 15:53:43.707323Z] Finished read-buildbot-config step (success) 07:53:43 INFO - [mozharness: 2016-11-17 15:53:43.707450Z] Running download-and-extract step. 07:53:43 INFO - Running pre-action listener: _resource_record_pre_action 07:53:43 INFO - Running main action method: download_and_extract 07:53:43 INFO - mkdir: /builds/slave/test/build/tests 07:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:43 INFO - trying https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:53:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:53:45 INFO - Downloaded 1199 bytes. 07:53:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:53:45 INFO - Using the following test package requirements: 07:53:45 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:53:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:53:45 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:53:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:53:45 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:53:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:53:45 INFO - u'jsshell-mac.zip'], 07:53:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:53:45 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:53:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:53:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:53:45 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:53:45 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:53:45 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:53:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:53:45 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:53:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:53:45 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:53:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:53:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:53:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:53:45 INFO - Fetch https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:53:45 INFO - Http code: 200 07:53:45 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 07:53:45 INFO - x-amz-cf-id: Lim92qjlEGn9NFul61mqWt5QHEGljmB6DNYaEMP670QpS9DBdwFZTw== 07:53:45 INFO - x-amz-version-id: gZ7k4hDZ0tS1lwO38bMbXmm6O5osDDNe 07:53:46 INFO - Expected file size: 16274849 07:53:46 INFO - Obtained file size: 16274849 07:53:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:53:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:53:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:53:52 INFO - Fetch https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:53:53 INFO - Http code: 200 07:53:53 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 07:53:53 INFO - x-amz-cf-id: wO18YvvNt30YQihgqkajcCdiz14rqJQnutPJLjScxaOIojcUscruzA== 07:53:53 INFO - x-amz-version-id: gZ7k4hDZ0tS1lwO38bMbXmm6O5osDDNe 07:53:53 INFO - Expected file size: 16274849 07:53:53 INFO - Obtained file size: 16274849 07:53:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:53:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:53:59 INFO - Fetch https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:54:00 INFO - Http code: 200 07:54:00 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 07:54:00 INFO - x-amz-cf-id: kDuNmgllRsPVX5yak4UB2O1Ces13waa1dh-skYKquJvDVlTaNgZaNQ== 07:54:00 INFO - x-amz-version-id: T8VJspVNit74YrtoWUDjYRe7rtGfr_Nt 07:54:01 INFO - Expected file size: 14409392 07:54:01 INFO - Obtained file size: 14409392 07:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:01 INFO - trying https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:54:01 INFO - Downloading https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:54:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:54:04 INFO - Downloaded 110976482 bytes. 07:54:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:54:04 INFO - mkdir: /builds/slave/test/properties 07:54:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:54:04 INFO - Writing to file /builds/slave/test/properties/build_url 07:54:04 INFO - Contents: 07:54:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:54:05 INFO - Running post-action listener: _resource_record_post_action 07:54:05 INFO - Running post-action listener: set_extra_try_arguments 07:54:05 INFO - [mozharness: 2016-11-17 15:54:05.255976Z] Finished download-and-extract step (success) 07:54:05 INFO - [mozharness: 2016-11-17 15:54:05.256116Z] Running populate-webroot step. 07:54:05 INFO - Running pre-action listener: _resource_record_pre_action 07:54:05 INFO - Running main action method: populate_webroot 07:54:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:54:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:54:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:54:05 INFO - '--tppagecycles', 07:54:05 INFO - '7'], 07:54:05 INFO - 'tests': ['tsvgm']}}, 07:54:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:54:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:54:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:54:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:54:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:54:05 INFO - 'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:54:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:54:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:54:05 INFO - 'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['damp', 'tps']}, 07:54:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:54:05 INFO - 'tests': ['damp', 'tps']}, 07:54:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['dromaeo_dom']}, 07:54:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:54:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['basic_compositor_video']}, 07:54:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:54:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['a11yr', 07:54:05 INFO - 'ts_paint', 07:54:05 INFO - 'tpaint', 07:54:05 INFO - 'sessionrestore', 07:54:05 INFO - 'sessionrestore_no_auto_restore', 07:54:05 INFO - 'tabpaint']}, 07:54:05 INFO - 'other-e10s': {'tests': ['a11yr', 07:54:05 INFO - 'ts_paint', 07:54:05 INFO - 'tpaint', 07:54:05 INFO - 'sessionrestore', 07:54:05 INFO - 'sessionrestore_no_auto_restore', 07:54:05 INFO - 'tabpaint']}, 07:54:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:54:05 INFO - 'ts_paint', 07:54:05 INFO - 'tpaint', 07:54:05 INFO - 'sessionrestore', 07:54:05 INFO - 'sessionrestore_no_auto_restore', 07:54:05 INFO - 'tabpaint']}, 07:54:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:54:05 INFO - 'ts_paint', 07:54:05 INFO - 'tpaint', 07:54:05 INFO - 'sessionrestore', 07:54:05 INFO - 'sessionrestore_no_auto_restore', 07:54:05 INFO - 'tabpaint']}, 07:54:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['a11yr', 07:54:05 INFO - 'ts_paint', 07:54:05 INFO - 'tpaint', 07:54:05 INFO - 'sessionrestore', 07:54:05 INFO - 'sessionrestore_no_auto_restore', 07:54:05 INFO - 'tabpaint']}, 07:54:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['a11yr', 07:54:05 INFO - 'ts_paint', 07:54:05 INFO - 'tpaint', 07:54:05 INFO - 'sessionrestore', 07:54:05 INFO - 'sessionrestore_no_auto_restore', 07:54:05 INFO - 'tabpaint']}, 07:54:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['tsvgx', 07:54:05 INFO - 'tsvgr_opacity', 07:54:05 INFO - 'tart', 07:54:05 INFO - 'tscrollx', 07:54:05 INFO - 'cart']}, 07:54:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:54:05 INFO - 'tsvgr_opacity', 07:54:05 INFO - 'tart', 07:54:05 INFO - 'tscrollx', 07:54:05 INFO - 'cart']}, 07:54:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:54:05 INFO - 'talos_options': ['--disable-e10s'], 07:54:05 INFO - 'tests': ['tp5o']}, 07:54:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:54:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:54:05 INFO - 'talos_options': ['--disable-e10s', 07:54:05 INFO - '--xperf_path', 07:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:05 INFO - 'tests': ['tp5n']}, 07:54:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:54:05 INFO - 'talos_options': ['--xperf_path', 07:54:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:54:05 INFO - 'tests': ['tp5n']}}, 07:54:05 INFO - 'talos.zip': {'path': '', 07:54:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:54:05 INFO - Running post-action listener: _resource_record_post_action 07:54:05 INFO - [mozharness: 2016-11-17 15:54:05.273860Z] Finished populate-webroot step (success) 07:54:05 INFO - [mozharness: 2016-11-17 15:54:05.273965Z] Running create-virtualenv step. 07:54:05 INFO - Running pre-action listener: _resource_record_pre_action 07:54:05 INFO - Running main action method: create_virtualenv 07:54:05 INFO - Creating virtualenv /builds/slave/test/build/venv 07:54:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:54:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:54:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:54:05 INFO - Using real prefix '/tools/python27' 07:54:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:54:06 INFO - Installing distribute.............................................................................................................................................................................................done. 07:54:09 INFO - Installing pip.................done. 07:54:09 INFO - Return code: 0 07:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:54:09 INFO - Reading from file tmpfile_stdout 07:54:09 INFO - Output received: 07:54:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:54:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:09 INFO - 'HOME': '/Users/cltbld', 07:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:09 INFO - 'LOGNAME': 'cltbld', 07:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:09 INFO - 'MOZ_NO_REMOTE': '1', 07:54:09 INFO - 'NO_EM_RESTART': '1', 07:54:09 INFO - 'PAGER': '/bin/cat', 07:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:09 INFO - 'PWD': '/builds/slave/test', 07:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:09 INFO - 'SHELL': '/bin/bash', 07:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:09 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:09 INFO - 'USER': 'cltbld', 07:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:09 INFO - 'XPC_FLAGS': '0x0', 07:54:09 INFO - 'XPC_SERVICE_NAME': '0', 07:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:54:09 INFO - Cleaning up... 07:54:09 INFO - Return code: 0 07:54:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:09 INFO - 'HOME': '/Users/cltbld', 07:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:09 INFO - 'LOGNAME': 'cltbld', 07:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:09 INFO - 'MOZ_NO_REMOTE': '1', 07:54:09 INFO - 'NO_EM_RESTART': '1', 07:54:09 INFO - 'PAGER': '/bin/cat', 07:54:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:09 INFO - 'PWD': '/builds/slave/test', 07:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:09 INFO - 'SHELL': '/bin/bash', 07:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:09 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:09 INFO - 'USER': 'cltbld', 07:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:09 INFO - 'XPC_FLAGS': '0x0', 07:54:09 INFO - 'XPC_SERVICE_NAME': '0', 07:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:09 INFO - Downloading/unpacking psutil>=3.1.1 07:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:54:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:13 INFO - Installing collected packages: psutil 07:54:13 INFO - Running setup.py install for psutil 07:54:13 INFO - building 'psutil._psutil_osx' extension 07:54:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:54:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:54:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:54:13 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 07:54:13 INFO - building 'psutil._psutil_posix' extension 07:54:13 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 07:54:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:54:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:54:13 INFO - ^ 07:54:13 INFO - 1 warning generated. 07:54:13 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 07:54:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:54:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:54:14 INFO - Successfully installed psutil 07:54:14 INFO - Cleaning up... 07:54:14 INFO - Return code: 0 07:54:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:54:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:14 INFO - 'HOME': '/Users/cltbld', 07:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:14 INFO - 'LOGNAME': 'cltbld', 07:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:14 INFO - 'MOZ_NO_REMOTE': '1', 07:54:14 INFO - 'NO_EM_RESTART': '1', 07:54:14 INFO - 'PAGER': '/bin/cat', 07:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:14 INFO - 'PWD': '/builds/slave/test', 07:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:14 INFO - 'SHELL': '/bin/bash', 07:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:14 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:14 INFO - 'USER': 'cltbld', 07:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:14 INFO - 'XPC_FLAGS': '0x0', 07:54:14 INFO - 'XPC_SERVICE_NAME': '0', 07:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:54:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:54:16 INFO - Installing collected packages: mozsystemmonitor 07:54:16 INFO - Running setup.py install for mozsystemmonitor 07:54:17 INFO - Successfully installed mozsystemmonitor 07:54:17 INFO - Cleaning up... 07:54:17 INFO - Return code: 0 07:54:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:54:17 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')]} 07:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:17 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')]} 07:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:17 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 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:17 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 07:54:17 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 07:54:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:17 INFO - 'HOME': '/Users/cltbld', 07:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:17 INFO - 'LOGNAME': 'cltbld', 07:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:17 INFO - 'MOZ_NO_REMOTE': '1', 07:54:17 INFO - 'NO_EM_RESTART': '1', 07:54:17 INFO - 'PAGER': '/bin/cat', 07:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:17 INFO - 'PWD': '/builds/slave/test', 07:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:17 INFO - 'SHELL': '/bin/bash', 07:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:17 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:17 INFO - 'USER': 'cltbld', 07:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:17 INFO - 'XPC_FLAGS': '0x0', 07:54:17 INFO - 'XPC_SERVICE_NAME': '0', 07:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:17 INFO - Downloading/unpacking jsonschema==2.5.1 07:54:17 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 07:54:17 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 07:54:17 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 07:54:17 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 07:54:17 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 07:54:17 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 07:54:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:54:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:54:19 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 07:54:19 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 07:54:19 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 07:54:19 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 07:54:19 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 07:54:19 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 07:54:20 INFO - Downloading functools32-3.2.3-2.tar.gz 07:54:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:54:20 INFO - warning: no files found matching '*.txt' 07:54:20 INFO - no previously-included directories found matching 'build' 07:54:20 INFO - no previously-included directories found matching 'dist' 07:54:20 INFO - no previously-included directories found matching '.git*' 07:54:20 INFO - Installing collected packages: jsonschema, functools32 07:54:20 INFO - Running setup.py install for functools32 07:54:20 INFO - warning: no files found matching '*.txt' 07:54:20 INFO - no previously-included directories found matching 'build' 07:54:20 INFO - no previously-included directories found matching 'dist' 07:54:20 INFO - no previously-included directories found matching '.git*' 07:54:20 INFO - Successfully installed jsonschema functools32 07:54:20 INFO - Cleaning up... 07:54:20 INFO - Return code: 0 07:54:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:54:20 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')]} 07:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:20 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')]} 07:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:20 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 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:20 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 07:54:20 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 07:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:20 INFO - 'HOME': '/Users/cltbld', 07:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:20 INFO - 'LOGNAME': 'cltbld', 07:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:20 INFO - 'MOZ_NO_REMOTE': '1', 07:54:20 INFO - 'NO_EM_RESTART': '1', 07:54:20 INFO - 'PAGER': '/bin/cat', 07:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:20 INFO - 'PWD': '/builds/slave/test', 07:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:20 INFO - 'SHELL': '/bin/bash', 07:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:20 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:20 INFO - 'USER': 'cltbld', 07:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:20 INFO - 'XPC_FLAGS': '0x0', 07:54:20 INFO - 'XPC_SERVICE_NAME': '0', 07:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:54:20 INFO - Cleaning up... 07:54:20 INFO - Return code: 0 07:54:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:54:20 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')]} 07:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:20 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')]} 07:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:20 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 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:20 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 07:54:20 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 07:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:20 INFO - 'HOME': '/Users/cltbld', 07:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:20 INFO - 'LOGNAME': 'cltbld', 07:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:20 INFO - 'MOZ_NO_REMOTE': '1', 07:54:20 INFO - 'NO_EM_RESTART': '1', 07:54:20 INFO - 'PAGER': '/bin/cat', 07:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:20 INFO - 'PWD': '/builds/slave/test', 07:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:20 INFO - 'SHELL': '/bin/bash', 07:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:20 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:20 INFO - 'USER': 'cltbld', 07:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:20 INFO - 'XPC_FLAGS': '0x0', 07:54:20 INFO - 'XPC_SERVICE_NAME': '0', 07:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:21 INFO - Downloading/unpacking blobuploader==1.2.4 07:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:54:23 INFO - Downloading blobuploader-1.2.4.tar.gz 07:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:54:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:54:23 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 07:54:23 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 07:54:23 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 07:54:23 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 07:54:23 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 07:54:23 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 07:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:54:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:54:24 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 07:54:24 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 07:54:24 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 07:54:24 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 07:54:24 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 07:54:24 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 07:54:24 INFO - Downloading docopt-0.6.1.tar.gz 07:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:54:25 INFO - Installing collected packages: blobuploader, requests, docopt 07:54:25 INFO - Running setup.py install for blobuploader 07:54:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:54:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:54:25 INFO - Running setup.py install for requests 07:54:25 INFO - Running setup.py install for docopt 07:54:25 INFO - Successfully installed blobuploader requests docopt 07:54:25 INFO - Cleaning up... 07:54:25 INFO - Return code: 0 07:54:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:25 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')]} 07:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:25 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')]} 07:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:25 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 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:25 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 07:54:25 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 07:54:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:25 INFO - 'HOME': '/Users/cltbld', 07:54:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:25 INFO - 'LOGNAME': 'cltbld', 07:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:25 INFO - 'MOZ_NO_REMOTE': '1', 07:54:25 INFO - 'NO_EM_RESTART': '1', 07:54:25 INFO - 'PAGER': '/bin/cat', 07:54:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:25 INFO - 'PWD': '/builds/slave/test', 07:54:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:25 INFO - 'SHELL': '/bin/bash', 07:54:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:25 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:25 INFO - 'USER': 'cltbld', 07:54:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:25 INFO - 'XPC_FLAGS': '0x0', 07:54:25 INFO - 'XPC_SERVICE_NAME': '0', 07:54:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:26 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-D3XuVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:26 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-p3QYES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:26 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-OwHHXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:26 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-eoUQDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:26 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-1_3oMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:26 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Sb5kGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:26 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-1y5Znv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:26 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-cFkEe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-BGdlU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-YaM_0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-IEyD8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-hh9Zp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-I80aVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-LFCoIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-RE3ZPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-1Ji0iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:27 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-vjW1yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:54:27 INFO - Running setup.py install for manifestparser 07:54:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:54:28 INFO - Running setup.py install for mozcrash 07:54:28 INFO - Running setup.py install for mozdebug 07:54:28 INFO - Running setup.py install for mozdevice 07:54:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:54:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:54:28 INFO - Running setup.py install for mozfile 07:54:28 INFO - Running setup.py install for mozhttpd 07:54:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:54:28 INFO - Running setup.py install for mozinfo 07:54:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:54:28 INFO - Running setup.py install for mozInstall 07:54:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Running setup.py install for mozleak 07:54:29 INFO - Running setup.py install for mozlog 07:54:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Running setup.py install for moznetwork 07:54:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Running setup.py install for mozprocess 07:54:29 INFO - Running setup.py install for mozprofile 07:54:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:54:29 INFO - Running setup.py install for mozrunner 07:54:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:54:30 INFO - Running setup.py install for mozscreenshot 07:54:30 INFO - Running setup.py install for moztest 07:54:30 INFO - Running setup.py install for mozversion 07:54:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:54:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:54:30 INFO - Cleaning up... 07:54:30 INFO - Return code: 0 07:54:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:30 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 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:30 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 07:54:30 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 07:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:30 INFO - 'HOME': '/Users/cltbld', 07:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:30 INFO - 'LOGNAME': 'cltbld', 07:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:30 INFO - 'MOZ_NO_REMOTE': '1', 07:54:30 INFO - 'NO_EM_RESTART': '1', 07:54:30 INFO - 'PAGER': '/bin/cat', 07:54:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:30 INFO - 'PWD': '/builds/slave/test', 07:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:30 INFO - 'SHELL': '/bin/bash', 07:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:30 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:30 INFO - 'USER': 'cltbld', 07:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:30 INFO - 'XPC_FLAGS': '0x0', 07:54:30 INFO - 'XPC_SERVICE_NAME': '0', 07:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:54:30 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-pfmPW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:54:30 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)) 07:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:54:30 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-t8Em03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-jpxl70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-lDRyoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-9d_ShR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-mygxcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-iRG4Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-QrLK5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Pg88ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Xd927Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:54:31 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-TQ8quF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:54:31 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)) 07:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:54:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-KFs3rT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:54:32 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)) 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:54:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-zYwYaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:54:32 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)) 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:54:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-v1y1w9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:54:32 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)) 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-6camNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:54:32 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)) 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:54:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-y9IC8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:54:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:54:32 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-4HWS4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:54:32 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)) 07:54:32 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)) 07:54:32 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)) 07:54:32 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)) 07:54:32 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)) 07:54:32 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)) 07:54:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:54:32 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 07:54:32 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 07:54:32 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 07:54:32 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 07:54:32 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 07:54:32 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 07:54:35 INFO - Downloading blessings-1.6.tar.gz 07:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:54:35 INFO - Installing collected packages: blessings 07:54:35 INFO - Running setup.py install for blessings 07:54:35 INFO - Successfully installed blessings 07:54:35 INFO - Cleaning up... 07:54:35 INFO - Return code: 0 07:54:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:54:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:35 INFO - Reading from file tmpfile_stdout 07:54:35 INFO - Current package versions: 07:54:35 INFO - blessings == 1.6 07:54:35 INFO - blobuploader == 1.2.4 07:54:35 INFO - docopt == 0.6.1 07:54:35 INFO - functools32 == 3.2.3-2 07:54:35 INFO - jsonschema == 2.5.1 07:54:35 INFO - manifestparser == 1.1 07:54:35 INFO - mozInstall == 1.12 07:54:35 INFO - mozcrash == 1.0 07:54:35 INFO - mozdebug == 0.1 07:54:35 INFO - mozdevice == 0.48 07:54:35 INFO - mozfile == 1.2 07:54:35 INFO - mozhttpd == 0.7 07:54:35 INFO - mozinfo == 0.9 07:54:35 INFO - mozleak == 0.1 07:54:35 INFO - mozlog == 3.4 07:54:35 INFO - moznetwork == 0.27 07:54:35 INFO - mozprocess == 0.23 07:54:35 INFO - mozprofile == 0.28 07:54:35 INFO - mozrunner == 6.13 07:54:35 INFO - mozscreenshot == 0.1 07:54:35 INFO - mozsystemmonitor == 0.3 07:54:35 INFO - moztest == 0.7 07:54:35 INFO - mozversion == 1.4 07:54:35 INFO - psutil == 3.1.1 07:54:35 INFO - requests == 1.2.3 07:54:35 INFO - wsgiref == 0.1.2 07:54:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:54:35 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')]} 07:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54:36 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 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54:36 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 07:54:36 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 07:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:36 INFO - 'HOME': '/Users/cltbld', 07:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:36 INFO - 'LOGNAME': 'cltbld', 07:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:36 INFO - 'MOZ_NO_REMOTE': '1', 07:54:36 INFO - 'NO_EM_RESTART': '1', 07:54:36 INFO - 'PAGER': '/bin/cat', 07:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:36 INFO - 'PWD': '/builds/slave/test', 07:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:36 INFO - 'SHELL': '/bin/bash', 07:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:36 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:36 INFO - 'USER': 'cltbld', 07:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:36 INFO - 'XPC_FLAGS': '0x0', 07:54:36 INFO - 'XPC_SERVICE_NAME': '0', 07:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 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)) 07:54:36 INFO - Cleaning up... 07:54:36 INFO - Return code: 0 07:54:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:54: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')]} 07:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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')]} 07:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:54: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105d833f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cf9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb18d87da0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, '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.sDltijzq55/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.L5uxTpgi9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 07:54: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'] in /builds/slave/test/build 07:54: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 07:54:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:54:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:54:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:54:36 INFO - 'HOME': '/Users/cltbld', 07:54:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:54:36 INFO - 'LOGNAME': 'cltbld', 07:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:54:36 INFO - 'MOZ_NO_REMOTE': '1', 07:54:36 INFO - 'NO_EM_RESTART': '1', 07:54:36 INFO - 'PAGER': '/bin/cat', 07:54:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:54:36 INFO - 'PWD': '/builds/slave/test', 07:54:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:54:36 INFO - 'SHELL': '/bin/bash', 07:54:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:54:36 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:54:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:54:36 INFO - 'USER': 'cltbld', 07:54:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:54:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:54:36 INFO - 'XPC_FLAGS': '0x0', 07:54:36 INFO - 'XPC_SERVICE_NAME': '0', 07:54:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:54:36 INFO - Cleaning up... 07:54:36 INFO - Return code: 0 07:54:36 INFO - Running post-action listener: _resource_record_post_action 07:54:36 INFO - Running post-action listener: _start_resource_monitoring 07:54:36 INFO - Starting resource monitoring. 07:54:36 INFO - [mozharness: 2016-11-17 15:54:36.699957Z] Finished create-virtualenv step (success) 07:54:36 INFO - [mozharness: 2016-11-17 15:54:36.700804Z] Running install step. 07:54:36 INFO - Running pre-action listener: _resource_record_pre_action 07:54:36 INFO - Running main action method: install 07:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:54:36 INFO - Reading from file tmpfile_stdout 07:54:36 INFO - Detecting whether we're running mozinstall >=1.0... 07:54:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:54:37 INFO - Reading from file tmpfile_stdout 07:54:37 INFO - Output received: 07:54:37 INFO - Usage: mozinstall [options] installer 07:54:37 INFO - Options: 07:54:37 INFO - -h, --help show this help message and exit 07:54:37 INFO - -d DEST, --destination=DEST 07:54:37 INFO - Directory to install application into. [default: 07:54:37 INFO - "/builds/slave/test"] 07:54:37 INFO - --app=APP Application being installed. [default: firefox] 07:54:37 INFO - mkdir: /builds/slave/test/build/application 07:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:55:10 INFO - Reading from file tmpfile_stdout 07:55:10 INFO - Output received: 07:55:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:55:10 INFO - Running post-action listener: _resource_record_post_action 07:55:10 INFO - [mozharness: 2016-11-17 15:55:10.961260Z] Finished install step (success) 07:55:10 INFO - [mozharness: 2016-11-17 15:55:10.961379Z] Running run-tests step. 07:55:10 INFO - Running pre-action listener: _resource_record_pre_action 07:55:10 INFO - Running main action method: run_tests 07:55:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:10 INFO - 2016-11-17 07:55:10.976 screenresolution[1897:15587] starting screenresolution argv=screenresolution get 07:55:10 INFO - 2016-11-17 07:55:10.979 screenresolution[1897:15587] Display 0: 1600x1200x32@60 07:55:10 INFO - 2016-11-17 07:55:10.984 screenresolution[1898:15589] starting screenresolution argv=screenresolution list 07:55:10 INFO - Available Modes on Display 0 07:55:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:11 INFO - Intel Iris: 07:55:11 INFO - Chipset Model: Intel Iris 07:55:11 INFO - Type: GPU 07:55:11 INFO - Bus: Built-In 07:55:11 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:11 INFO - Vendor: Intel (0x8086) 07:55:11 INFO - Device ID: 0x0a2e 07:55:11 INFO - Revision ID: 0x0009 07:55:11 INFO - Displays: 07:55:11 INFO - Display: 07:55:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:11 INFO - Display Serial Number: 1600x1200 60 07:55:11 INFO - Main Display: Yes 07:55:11 INFO - Mirror: Off 07:55:11 INFO - Online: Yes 07:55:11 INFO - Rotation: Supported 07:55:11 INFO - Return code: 0 07:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:55:11 INFO - Python 2.7.3 07:55:11 INFO - Return code: 0 07:55:11 INFO - grabbing minidump binary from tooltool 07:55:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:55:11 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 0x105b99d30>, '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 0x105a00db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b91b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:55:11 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 07:55:11 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 07:55:11 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 07:55:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:55:11 INFO - Return code: 0 07:55:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:55:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:55:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:55:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:55:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:55:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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 07:55:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0311 --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 07:55:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDltijzq55/Render', 07:55:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:11 INFO - 'HOME': '/Users/cltbld', 07:55:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:11 INFO - 'LOGNAME': 'cltbld', 07:55:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:55:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:55:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:11 INFO - 'MOZ_NO_REMOTE': '1', 07:55:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:55:11 INFO - 'NO_EM_RESTART': '1', 07:55:11 INFO - 'PAGER': '/bin/cat', 07:55:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:11 INFO - 'PWD': '/builds/slave/test', 07:55:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:55:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:11 INFO - 'SHELL': '/bin/bash', 07:55:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L5uxTpgi9a/Listeners', 07:55:11 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 07:55:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:11 INFO - 'USER': 'cltbld', 07:55:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:11 INFO - 'XPC_FLAGS': '0x0', 07:55:11 INFO - 'XPC_SERVICE_NAME': '0', 07:55:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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 07:55:11 INFO - mozversion application_buildid: 20161117053528 07:55:11 INFO - mozversion application_changeset: 41fe2fa4ddabb611c4da3cdb0585d6e1cd9722c4 07:55:11 INFO - mozversion application_display_name: Nightly 07:55:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:55:11 INFO - mozversion application_name: Firefox 07:55:11 INFO - mozversion application_remotingname: firefox 07:55:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:55:11 INFO - mozversion application_vendor: Mozilla 07:55:11 INFO - mozversion application_version: 53.0a1 07:55:11 INFO - mozversion platform_buildid: 20161117053528 07:55:11 INFO - mozversion platform_changeset: 41fe2fa4ddabb611c4da3cdb0585d6e1cd9722c4 07:55:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:55:11 INFO - mozversion platform_version: 53.0a1 07:55:11 INFO - using testdate: 1479398111 07:55:11 INFO - actual date: 1479398111 07:55:11 INFO - starting webserver on 'localhost:53448' 07:55:11 INFO - SUITE-START | Running 2 tests 07:55:11 INFO - TEST-START | dromaeo_css 07:55:11 INFO - operating with platform_type : mac_ 07:55:11 INFO - Initialising browser for dromaeo_css test... 07:55:11 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpqP6URj/profile http://localhost:53448/getInfo.html) 07:55:14 INFO - PROCESS | 1908 | 2016-11-17 07:55:14.273 plugin-container[1910:15743] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3b, name = 'com.apple.tsm.portname' 07:55:14 INFO - PROCESS | 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:14 INFO - PROCESS | 1908 | 2016-11-17 07:55:14.275 plugin-container[1910:15743] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 07:55:14 INFO - PROCESS | 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:14 INFO - PROCESS | 1908 | 2016-11-17 07:55:14.275 plugin-container[1910:15743] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:55:14 INFO - PROCESS | 1908 | __metrics Screen width/height:1600/1200 07:55:14 INFO - PROCESS | 1908 | colorDepth:24 07:55:14 INFO - PROCESS | 1908 | Browser inner width/height: 1024/689 07:55:14 INFO - PROCESS | 1908 | __metrics 07:55:14 ERROR - PROCESS | 1908 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 07:55:15 INFO - TEST-INFO | 1908: exit 0 07:55:15 INFO - Browser initialized. 07:55:15 INFO - Running cycle 1/1 for dromaeo_css test... 07:55:15 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpqP6URj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:55:17 INFO - PROCESS | 1911 | 2016-11-17 07:55:17.590 plugin-container[1912:15863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 07:55:17 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:17 INFO - PROCESS | 1911 | 2016-11-17 07:55:17.591 plugin-container[1912:15863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 07:55:17 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:55:17 INFO - PROCESS | 1911 | 2016-11-17 07:55:17.591 plugin-container[1912:15863] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:55:27 INFO - PROCESS | 1911 | RSS: Main: 238018560 07:55:27 INFO - PROCESS | 1911 | 07:56:16 INFO - PROCESS | 1911 | 1479398176924 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:58:29 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53448/tests/dromaeo/cssquery-ext.html) 07:58:31 INFO - PROCESS | 1911 | RSS: Main: 253104128 07:58:31 INFO - PROCESS | 1911 | 08:01:34 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-ext.html (next: http://localhost:53448/tests/dromaeo/cssquery-jquery.html) 08:01:34 INFO - PROCESS | 1911 | RSS: Main: 261574656 08:01:34 INFO - PROCESS | 1911 | 08:04:36 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53448/tests/dromaeo/cssquery-mootools.html) 08:04:37 INFO - PROCESS | 1911 | RSS: Main: 266162176 08:04:37 INFO - PROCESS | 1911 | 08:07:39 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53448/tests/dromaeo/cssquery-prototype.html) 08:07:40 INFO - PROCESS | 1911 | RSS: Main: 264634368 08:07:40 INFO - PROCESS | 1911 | 08:10:42 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53448/tests/dromaeo/cssquery-yui.html) 08:10:43 INFO - PROCESS | 1911 | RSS: Main: 273092608 08:10:43 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:53448/tests/dromaeo/cssquery-yui.html (next: http://localhost:53448/tests/dromaeo/cssquery-dojo.html) 08:13:46 INFO - PROCESS | 1911 | RSS: Main: 275410944 08:13:46 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | __start_tp_report 08:13:46 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 08:13:46 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 08:13:46 INFO - PROCESS | 1911 | |i|pagename|runs| 08:13:46 INFO - PROCESS | 1911 | |0;dojo.html;3306.355260724158;3314.4365457872173;3314.9005529834103;3319.7344212463004;3363.6972672459474;5584.776608935643;5596.860078498034;5618.438156184379;5618.915716264254;5652.858678533039;4380.780960951947;5582.665040097587;5593.8321850344455;5624.775008999645;5628.32460104787;5057.6965382077005;5093.668911520739;5146.099432599299;5147.845564633067;5180.093483640348;5064.797408103672;5164.690118592877;5205;5234.319538460014;5297.046531624306;5076.64463487556;5177.145770947789;5183.714895680736;5206.635535512516;5216.478352164772;5083.517065878736;5132.974335128338;5147.588192944556;5147.871303217412;5208.869778255536;5066.341375621182;5078.619103567247;5095.439501654815;5162.199859021857;5172.379314482248;5402.837914862561;5506.311711036121;5574.637648552831;5658.264425624642;5692.57305702074;4960.404751429815;5804.332501762267;5816.651000939957;6140.815775526741;6159.599626024294;5928.584999050068;5932.822015339547;5947.732352044169;5953.58324917256;5954.55340849438;5476.698781567012;5502.642328248651;5502.8349149525575;5509.972450137724;5514.503694667459;6035.517158627299;6151.384861513813;6167.229096362955;6196.690165491707;6226.626402415779;6102.216595924314;6105.338445949952;6117.021276595723;6130.092410195535;6139.355367686418;5320.547753441001;6117.785877494355;6172.629642221481;6187.659678717714;6229.127922090911;5030.522100400456;5521.702399936012;5617.522510586564;5751.511121554715;5883.558733095035;6175.752969881244;6187.783427580013;6189.473894718909;6204.565680402328;6204.751809927552;4876.683015604045;4876.902461950741;4879.341288926021;4883.218685010453;4893.510648935078;3964.8810535683974;4178.456800615901;4358.215521206213;4360.106178233455;4430.933535996963;5035.496450355008;5763.682997435098;5803.593748437569;5823.767049318065;5823.767049318065;6190.133381326618;6211.223597050369;6239.344868788802;6250.749970001149;6250.74997000124;5625.6905870176715;5695.487406133468;5703.17303990919;5747.741351639186;5761.222234998221;5286.180642000496;5310.92033619496;5322.866928326823;5326.414094449608;5329.600279979017;6203.937960620336;6225.035119556476;6233.75064997395;6239.469645080128;6275.52933529978;6208.379162083756;6212.875742485035;6214.347493513116;6222.191115155001;6249.78125765596;6045.879082418415;6212.720427580679;6236.407541283571;6273.874522509615;6292.653904035322;6012.248468941382;6038.547108966933;6052.092186172109;6112.266528016667;6153.753849845956;5980.910286345621;6143.603994442082;6161.568690191643;6186.721597528032;6237.4698150657705;6047.002244629763;6070.059140833001;6085.543584231112;6092.603980741238;6115.296740874856;6078.787242446493;6087.604305720114;6092.147099405998;6098.725557349841;6108.053251745987;5700.144978253295;5720.313562372542;5728.255326807488;5825.883482330414;5881.147233651182;5980.760769569169;6066.484348830399;6079.817605471843;6088.208532890873;6101.694915254308;5841.18223448709;5870.735816888165;5884;5908.645481271137;5916.940830591639 08:13:46 INFO - PROCESS | 1911 | |1;ext.html;448.354369707621;488.21641265768443;531.8058908498397;543.052373608054;563.6223730100832;28611.9985800497;29484.852575737117;30555.08334749961;30634.38731225374;30752.846235768844;31585.526217106704;32112.839435802787;32226;32288.515672264875;32376.67623323766;7176.7846964591145;7445.478816482849;7452.925470745305;7457.179710231871;7480.102387713482;7508.286712762306;7591.164971853092;7607.923920760804;7617.124030736453;7623.2376762323875;7585.658645360944;7600.847983040364;7623.695052197905;7623.885641715378;7649.732259370923;7527.924720752777;7595.620218989028;7604.695812167534;7613.390928725688;7623.695052197905;7498.250174982512;7591.164971853092;7606;7606.581638009908;7620.580868052255;30384.8480757597;30563.2359191022;30583.92956246543;30618;30656.2335941601;2815.6480439945008;3249.6425393206728;3266.852991615383;3632.9999999999736;4005.7796821174825;16097.83902160975;18909.054547272583;19845.702314465296;20953.790462095338;21419.678704819442;2742.698303186648;2810.5924640927155;2830.8867645294163;2857.8571071446345;2873.1380585824168;508642;510981;511035.4448227735;514795;515769.4211528956;49221;58268.708656456445;58463.07684615752;58963.705181473815;59046.40953590495;56963;60008.39991600028;60386.69806650939;60871.391286087455;61422.69288653528;13463.596092117252;15471.381144754083;15767.896247262812;15947.362105515882;16001.839981600267;10237.641682541223;12270.631881043404;12315.44580493862;12366.010719142447;12404.875951240552;17142.485725428258;17847.28610855577;17876.19557119933;17923.820761792216;18066.819331806775;6304.968475157595;7362.300581444754;7576.886346704804;7598.35413989806;7674.846503070019;843.0094638799509;850.1328644782287;978.4716253223322;987.1017374189597;1039.5394470768583;22820.543589128458;24496.020159193788;29164.125076247747;29325;29961.85019074934;844.4975239732349;852.8869824878469;974.3179774158118;1118.2228351295935;1126.6957921361186;14441.85558144426;15013.849861501463;15110.828000119342;15208.543743687707;15620.375184992701;677740;678141;683097;683129;685068;50192.749036255314;50653.49346506488;50772;50952.74523627358;50990;1331.4807225182187;1336.7861142217198;1353.8916886648847;1370.6504841265612;1380.0753495158267;27388.589171162846;28317.292067698472;28384.290392740346;28505.714942850307;29473.557896631995;45622.54377456183;46276.843078923295;46385.304220436046;46459.53540464687;46504.53495465002;497120;499135;500203;502279;502443;24023.759762402853;24384.024639014242;24902.626460603467;24932.127375541768;25753.742462575883;40251;40422;40509.79745101256;41195.38206926839;41242.58757412388;26766;33914.3217135651;34365.82817085998;34382.2808859551;34634.653653463145;33913.66086339204;34265.486017709256;34710.65289347175;34964;35202.47196292109;30052.3989520204;33052.50421243635;33268.1682957928;34816.82591587026;34857.65142348544;28038;29749.851250743606;30066.54900176543;31624.841875791393;31648;23170.420739481648;23552.293431197093;23786.286411407684;23956.92193851246;24134.275971720876 08:13:46 INFO - PROCESS | 1911 | |2;jquery.html;356.5365025466893;368.73819588092437;377.2157694106876;378.37945768938937;396.31833246815484;15456.304466299016;15797.842021579781;16044.59888502788;16330.938488998221;16552;18244.452666420028;18861.622767544643;18875.905620471913;19082;19399.418017459462;4130.318497447933;4620.145273124474;4903.141950158726;4906.165951788204;4913.238448040559;4831.782569784351;4867.975660121694;4879.170541008037;5259.6055295852775;5304.973475132619;5280.762365693534;5282.894342113174;5284.497972692608;5289.338832645919;5302.3637163540425;5024.397072351323;5256.8685782855355;5293.073712100387;5313.57491400687;5320.201969704536;4672.112298663277;4723.622110231207;4745.549172828576;4748.097861406356;4753.500882407332;12242.326672033034;12357.25856448616;12454.688632784162;12468.81296780549;20090.493213009082;2274.727032756063;2308.7691230876944;2323.548656167742;2331.4521087544413;2618.48939456806;9080.580101314266;9378.812423751488;9566.47384393858;11384;13715.862841371658;1672.991635041829;1699.3882202407124;1713.254734190631;1749.4664127441126;1772.1227992143972;102171.48914255455;107348.38977415345;109243.45378273138;127353.36323318323;128519;9145.908540914506;9228.723138305862;9775.657851975147;11404.657860264206;11736.530538778354;14525.491607793676;14550.927245363706;14565.490207842675;14569.708605828037;14571.562853114423;6904.447644188453;8311.584420778936;8485.745427637181;8505.95747021261;8548.615312310962;8311.542865142354;8318.8336233275;8362.665493380318;8466.153384661608;8481.067082620906;4503.819847206075;4530.320451932236;4542.1597004553605;4625.098105869323;4626.259798432235;1927.267638297438;1950.8731932424348;1964.5972575621963;1977.1498255750166;1982.682770756672;675.1122274209399;788.3707834372318;794.8330850521339;920.9723708288763;959.9136077752896;18409.723854142198;19133.8086619132;19763.40709778709;20685.276015339692;20723.648033912745;834.7537476444463;886.7364006291009;905.4929239625831;907.9909200908038;986.487026746088;10191.7452063699;10860.728481788019;10873.510692018877;10889.346639201673;10942.288751231144;600306;602307;609200;612656.9367153224;615573;118921;119691;124560.37719811524;128221.43557128991;134453.3277333607;872.7032808845023;981.6417007792104;1050.417018554694;1052.0636633396284;1056.5668076088766;17146.485605431855;17556.82443175603;17898.91050544739;18045.81954180494;18828.811711882707;36043.639563604025;43882.780586096866;46632.83417914443;49419.50580494293;52059.73970130125;73766;74018.62990685228;74296.14259643336;75974;76302;7763.573003484863;7892.644830982505;8036.718714844952;8130.959345203472;8225.218604232588;9175.724728258163;12224.511019559119;12758;12982;13103.344832758134;10831.566737330419;10869.782604348027;10992.28550144238;11195.552177912792;11259.380734059705;9057;10870.945645271722;10943.984694563855;11213.887861121284;11276.75955644862;11015.944920275348;11259.268147570381;11424.828627570427;11525.366104864313;11531.019863311712;7787.221277872394;7856.567888765944;8035;8040;8248.54632995191;8180.550069746221;9896.356736812084;10752.301100428447;10853.837192442277;10983.50574224146 08:13:46 INFO - PROCESS | 1911 | |3;mootools.html;1403.7122389910069;1468.4126349460212;1641.9655616961313;1739.6433731085128;1774.8225177482245;7309.744158954438;7561.432892533055;7701.730439434621;8153.959230203848;8163.836723265531;7722.227777222275;8064.91935080649;8069;8121.390895682833;8132.227438393358;2027.4019164346553;2058.1458694641706;2058.670612701968;2061.6495195816674;2070.234013415031;1987.4534503011644;2023.1098316740588;2031.0758604834764;2083.364573804989;2083.4583008417844;1587.626907676695;1630.4130513015305;1638.131790151216;1773.538879891231;1888.6694828405043;2043.785402532735;2075.823554997827;2083.645780217367;2084.937451876446;2085.5620319732875;2046.2735728816353;2063.793620637939;2069.224040984631;2074.7510298764096;2087.1651339464183;7977.122516523178;8010.679572817138;8030.036395632503;8052.637631306605;8067.112617612058;5040.319556859814;5233.502817232395;5234.97382513085;5237.947620523784;5246.344206974129;3127.6403213630497;3260.4620237660756;3409.1988382730037;3411.9317613647586;3418.060033490785;930.3115694386173;963.1812958984876;982.1111893736108;987.0672214757058;990.1633120013577;10811.945940270249;10903.509342079626;10956.28784129029;10960.342379457257;10977.725556861062;4465.419495465569;4489.775511224426;4625.329327247598;4684.601808846286;4709.858704238878;9395.530223488935;9429.811403771886;9444;9456.810863782686;9458.621655133855;4599.770011499479;5071.782772134735;5275.57795376369;5289.523942845085;5302.125149350314;4261.786910654455;4644.465886423104;4763.880902977384;4816.686915350491;4821.397325334333;3128.6089238845143;3794.6395092466173;3848.7113466490127;3858.9228215436096;3893.4549163117185;1268.9619311420672;1271.879171478708;1276.6489215465635;1286.1318609938442;1292.4571679894466;675.6756756756785;824.468217999387;844.4173520270994;866.1381924984555;888.8977767556813;5500.58745594082;5513.2005859150195;5524.889502209933;5661.575381846295;5819.79630712923;410.5586494518405;410.57505481826166;417.76396336070025;419.1554018652418;434.4482507215818;3754.774713517143;3807.6573108420375;3808.6572208501366;3866.1107945172766;3888.51393575803;9921.255905807093;10225.642102526375;10264.43545604984;10274.33216840903;10303.793924121475;10214.489275536194;10223.875373708886;10248.333858299336;10280.588776448858;10284.948575257076;7349.375303099189;7608.087029556378;7707;7722.3049925506975;7726.575038372831;5390.110631745718;5510.91733624004;5520.089185284383;5647.576431767552;5701.144828275792;9079.863802043106;9178.586963586788;9240.445573265626;9271.165595096474;9388.67139650109;7883.448158628841;9505.239580833379;9549.188318992963;9640;9737.8576713123;6561.278259391559;6766.594004359754;7009.929900701131;7081.539699919489;7256.96371518139;7931.246531579491;8061;8151.144129866516;8162.979627546557;8175.468594541336;7105.218425973036;7112.928870711434;7226.638668066681;7283.417326613964;7367.889481657672;6998.685059172248;7162;7167.928320716935;7263.745768898275;7264.091988501437;5651.689157096399;6771.6614169292325;6796.76211332601;6800.489963252875;6832.111825462658;3567.8216089194916;4139.254934111768;4448.5551444855255;4726.574608285271;4795.304680821331;4894.33926419943;4945.530174633404;4987.102321582005;5007.198848184273;5093.821716239914 08:13:46 INFO - PROCESS | 1911 | |4;prototype.html;293.2375822860561;300.36922462828056;305.8165100939435;308.31400134700294;310.98289594072315;4468.731876087437;5294.258803767476;5452.010016344036;5623.240862483563;5647.350554686207;3889.727719059667;4394.824207031715;5260.684828792801;5377.731113444322;5453.972730136354;4144.647704945083;4145.937810932838;4153.003279212982;4156.771377574232;4207.957920420795;3453.6373680763536;4039;4149.004238982652;4156.792160391983;4203.180379825935;3440.552728145338;4089.2230476209575;4127.885470922849;4147.419361289422;4155.37940203321;4104.6716262699065;4119.258533463975;4147.232761939051;4149.605787450188;4149.83400663973;3495.0777072609962;3588.9641103588892;3596.7482276240676;3603.3874241378767;3633.6729694327637;4265.829366825324;5006.89986200274;5071.670341427795;5221.71280579568;5314.149736042254;4658.833642356287;4704.647151463654;4706.294055891643;4767.951050768826;4784.760761961888;4165.500139983222;4728.865072382638;5421.430749771257;5704.515116215127;5846.298444186725;3605.7656252343777;3820.789856557888;3865.246276975991;3910.530736311661;3924.058226025762;5990.251218597676;6073.331933487313;6116.388361163892;6129.846753831145;6171.907421388682;3328.7170590500077;3958.485396898385;3977.204559088194;3977.900552486153;3987.940180897289;3645.2709458108484;3759.154190307159;3820;4031.9395209071886;4041.7372870763306;3973.304671682444;4323.7621930793475;4649.326242552746;4687.390639216948;4750.078701598492;5816.389279125716;5876.382979787147;5885.735141918538;5893.410658934158;5954.523638108941;1122.0014187373245;1198.4606926882936;1238.990222968278;1293.2499150492692;1299.811527328532;702.5363260248314;787.0712559180222;871.5859966515854;879.6921077622909;882.4043770454917;4617.937874288865;4932.556069953722;5085.949140508622;5119.846404607868;5192.350956130484;4731.881702957385;5144.588432925432;5671.300343155102;5674.120511320752;5709.172170035322;4341.848035318749;4471.731696098244;5175.301334319819;5179.611529135254;5186.299849520342;2517.483915797257;2593.6757905261843;2787.5261205595098;2804.8176868503483;3012.171652795455;4953.405591329064;5867.325257595346;5890.376054796964;5910.508013909373;5939.762409503658;4709.81160753566;5476.561875049986;5782.306123265235;5913.349531551526;5922.792702255487;5653.632513886584;5822.854428639318;5827;5858.736356863951;5896.850114227685;5001.24981252815;5320.733963301896;5572.192032155396;5647.237622921018;5738.225339579103;5181.896362072813;5196.220566914993;5472.808451704331;5521.239380309845;5562.637153897159;5622.465865742748;5634.718264086861;5703.173039909273;5753.482186603226;5783.652980821164;3452.309538092442;3541.309444658267;3692.630736926393;3727.2918145552258;3763.8682646107254;5491.6819963207745;5925.466707996128;5967.627445687429;6002.148979235003;6010.459058684739;4826.734529600905;5300.867478313073;5577.2191893135805;5586.876986745011;5628.324601047901;4654.557817007379;4938.827141050189;5307.57539396855;5371.113766228685;6025.246844144482;4885.560299573055;5096.337476128079;5639.802606908738;5677.347105082803;5693.629914055573;4894.339264199288;5154.948450515597;5426.67439953604;5835.766569337179;5918.467337939606;5715.656820647061;5762.481376676119;5808.680522571299;5815.505682017076;5843 08:13:46 INFO - PROCESS | 1911 | |5;yui.html;621.7077973352524;696.1124566178122;757.7802437293185;772.972945946892;781.9482795639866;12333.444994975225;12895.161814482051;12936.28850413227;12971.416286267116;12982.870171298284;12205.511779528808;12324.938375308133;12337.753244935097;12356.382180890965;12379.504819807196;639.2009987515605;660.8810414125455;755.8072691463683;775.6044417347138;795.757294025322;793.2820797178563;815.1848151848152;816.2694388522299;816.808050108224;819.8647223208163;843.5950743643054;850.3324889961382;858.7895965488464;858.9871151932726;862.6808081010004;806.4677312973439;850.3919697416377;850.8766228896807;852.7228650688551;853.0318088969003;622.3527531367373;629.6883042893797;637.6747858592105;638.1480723234488;639.8738220731547;11365.772684546346;11463.598774042868;11607.245529040585;11625.825612615818;11635.709107272301;10209.081182693593;10267.897321026769;10290.228232882564;10298.845517317246;10481.318714283547;8971.910280897238;9114.498702571356;9157.725268241897;9163.35856490046;9398.67104651334;2990.1627544287635;3030.6666266710645;3033.272014716474;3045.284358175827;3083.3679095785533;78485.82271265936;80369;84683.15316846814;85099.14900851036;85366.57316713501;7747.186545412763;7787.922120778833;7843.7254696085365;7859;7915.366770658334;13539.59381218565;16445.342186312413;16556.42052528156;17719.379821706178;17721.29114835392;7128.358447739728;7195.856082878313;7205.2434494378385;7321.450891183076;7326.633668316563;3997.540282867449;4057.6753859691153;4071.2671719090254;4097.2010457961005;4108.979455102705;2621.9905336445604;3076.0618011506704;3161.8577164027674;3166.0976621662717;3184.729298009695;584.8742520358059;589.8849724303719;595.4700316718124;603.7403916316026;608.7777961044187;615.1756646094256;638.7221558622015;640.3916279534461;658.4962503684685;661.5369241530948;8198.814545418487;8459.111793261742;8545.615447304886;8571.528565928933;8741.956290218508;603.484021161909;644.3556443556444;648.6335220600346;656.3436563436563;658.0226419609139;4029.879103626837;4137.751734895915;4247.957520424818;4306.181825453154;4388.473383193973;112039;113596;114123.42938285421;114968.42515787535;115907.84092158971;85855.57072214599;99578;100593.99406005992;101740.49129754303;102816.97183028223;89407;90100;90698.63952040725;91893.54053229824;92614.53692731628;7970.960145199237;8263.710770123016;8310.97990439229;8440.831183376175;8440.915590844013;50072;57790;57907.65692573158;57916;58737;78851.60574197093;80010;81381.59309203416;82121;82330;10203.795924081625;10596.417197054236;10898.237123401603;11024.834627480433;11482.655520334403;9486.810263794547;11439.861891409286;11746.119041072125;11804.645860624196;11930.105242106703;9260.888693356841;10576.524056417633;10733.087687546646;11194.720131996764;11309.943450282695;11438.142139339749;11505.884941150816;11600.6519804406;11743.706407339885;12116.939415302868;10735.194860385345;10809.729756756144;10820.458977051274;10844;10904.7273818152;9373.29700272496;9609.135177834029;9656.806863862825;9795.412275263507;9947.950260248652;9288;9330.346875718635;9427.670031548863;9481.57332920034;9639.373440726331 08:13:46 INFO - PROCESS | 1911 | __end_tp_report 08:13:46 INFO - PROCESS | 1911 | __start_cc_report 08:13:46 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,373 08:13:46 INFO - PROCESS | 1911 | __end_cc_report 08:13:46 INFO - PROCESS | 1911 | __startTimestamp1479399226520__endTimestamp 08:13:46 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | ------- Summary: start ------- 08:13:46 INFO - PROCESS | 1911 | Number of tests: 6 08:13:46 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5627.01 Median:5804.33 stddev:643.75 (11.1%) stddev-sans-first:619.45 08:13:46 INFO - PROCESS | 1911 | Values: 3306.4 3314.4 3314.9 3319.7 3363.7 5584.8 5596.9 5618.4 5618.9 5652.9 4380.8 5582.7 5593.8 5624.8 5628.3 5057.7 5093.7 5146.1 5147.8 5180.1 5064.8 5164.7 5205.0 5234.3 5297.0 5076.6 5177.1 5183.7 5206.6 5216.5 5083.5 5133.0 5147.6 5147.9 5208.9 5066.3 5078.6 5095.4 5162.2 5172.4 5402.8 5506.3 5574.6 5658.3 5692.6 4960.4 5804.3 5816.7 6140.8 6159.6 5928.6 5932.8 5947.7 5953.6 5954.6 5476.7 5502.6 5502.8 5510.0 5514.5 6035.5 6151.4 6167.2 6196.7 6226.6 6102.2 6105.3 6117.0 6130.1 6139.4 5320.5 6117.8 6172.6 6187.7 6229.1 5030.5 5521.7 5617.5 5751.5 5883.6 6175.8 6187.8 6189.5 6204.6 6204.8 4876.7 4876.9 4879.3 4883.2 4893.5 3964.9 4178.5 4358.2 4360.1 4430.9 5035.5 5763.7 5803.6 5823.8 5823.8 6190.1 6211.2 6239.3 6250.7 6250.7 5625.7 5695.5 5703.2 5747.7 5761.2 5286.2 5310.9 5322.9 5326.4 5329.6 6203.9 6225.0 6233.8 6239.5 6275.5 6208.4 6212.9 6214.3 6222.2 6249.8 6045.9 6212.7 6236.4 6273.9 6292.7 6012.2 6038.5 6052.1 6112.3 6153.8 5980.9 6143.6 6161.6 6186.7 6237.5 6047.0 6070.1 6085.5 6092.6 6115.3 6078.8 6087.6 6092.1 6098.7 6108.1 5700.1 5720.3 5728.3 5825.9 5881.1 5980.8 6066.5 6079.8 6088.2 6101.7 5841.2 5870.7 5884.0 5908.6 5916.9 08:13:46 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:66961.16 Median:34672.65 stddev:153211.54 (441.9%) stddev-sans-first:153559.95 08:13:46 INFO - PROCESS | 1911 | Values: 448.4 488.2 531.8 543.1 563.6 28612.0 29484.9 30555.1 30634.4 30752.8 31585.5 32112.8 32226.0 32288.5 32376.7 7176.8 7445.5 7452.9 7457.2 7480.1 7508.3 7591.2 7607.9 7617.1 7623.2 7585.7 7600.8 7623.7 7623.9 7649.7 7527.9 7595.6 7604.7 7613.4 7623.7 7498.3 7591.2 7606.0 7606.6 7620.6 30384.8 30563.2 30583.9 30618.0 30656.2 2815.6 3249.6 3266.9 3633.0 4005.8 16097.8 18909.1 19845.7 20953.8 21419.7 2742.7 2810.6 2830.9 2857.9 2873.1 508642.0 510981.0 511035.4 514795.0 515769.4 49221.0 58268.7 58463.1 58963.7 59046.4 56963.0 60008.4 60386.7 60871.4 61422.7 13463.6 15471.4 15767.9 15947.4 16001.8 10237.6 12270.6 12315.4 12366.0 12404.9 17142.5 17847.3 17876.2 17923.8 18066.8 6305.0 7362.3 7576.9 7598.4 7674.8 843.0 850.1 978.5 987.1 1039.5 22820.5 24496.0 29164.1 29325.0 29961.9 844.5 852.9 974.3 1118.2 1126.7 14441.9 15013.8 15110.8 15208.5 15620.4 677740.0 678141.0 683097.0 683129.0 685068.0 50192.7 50653.5 50772.0 50952.7 50990.0 1331.5 1336.8 1353.9 1370.7 1380.1 27388.6 28317.3 28384.3 28505.7 29473.6 45622.5 46276.8 46385.3 46459.5 46504.5 497120.0 499135.0 500203.0 502279.0 502443.0 24023.8 24384.0 24902.6 24932.1 25753.7 40251.0 40422.0 40509.8 41195.4 41242.6 26766.0 33914.3 34365.8 34382.3 34634.7 33913.7 34265.5 34710.7 34964.0 35202.5 30052.4 33052.5 33268.2 34816.8 34857.7 28038.0 29749.9 30066.5 31624.8 31648.0 23170.4 23552.3 23786.3 23956.9 24134.3 08:13:46 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:34104.30 Median:372.98 stddev:101346.10 (27172.2%) stddev-sans-first:101598.72 08:13:46 INFO - PROCESS | 1911 | Values: 356.5 368.7 377.2 378.4 396.3 15456.3 15797.8 16044.6 16330.9 16552.0 18244.5 18861.6 18875.9 19082.0 19399.4 4130.3 4620.1 4903.1 4906.2 4913.2 4831.8 4868.0 4879.2 5259.6 5305.0 5280.8 5282.9 5284.5 5289.3 5302.4 5024.4 5256.9 5293.1 5313.6 5320.2 4672.1 4723.6 4745.5 4748.1 4753.5 12242.3 12357.3 12454.7 12468.8 20090.5 2274.7 2308.8 2323.5 2331.5 2618.5 9080.6 9378.8 9566.5 11384.0 13715.9 1673.0 1699.4 1713.3 1749.5 1772.1 102171.5 107348.4 109243.5 127353.4 128519.0 9145.9 9228.7 9775.7 11404.7 11736.5 14525.5 14550.9 14565.5 14569.7 14571.6 6904.4 8311.6 8485.7 8506.0 8548.6 8311.5 8318.8 8362.7 8466.2 8481.1 4503.8 4530.3 4542.2 4625.1 4626.3 1927.3 1950.9 1964.6 1977.1 1982.7 675.1 788.4 794.8 921.0 959.9 18409.7 19133.8 19763.4 20685.3 20723.6 834.8 886.7 905.5 908.0 986.5 10191.7 10860.7 10873.5 10889.3 10942.3 600306.0 602307.0 609200.0 612656.9 615573.0 118921.0 119691.0 124560.4 128221.4 134453.3 872.7 981.6 1050.4 1052.1 1056.6 17146.5 17556.8 17898.9 18045.8 18828.8 36043.6 43882.8 46632.8 49419.5 52059.7 73766.0 74018.6 74296.1 75974.0 76302.0 7763.6 7892.6 8036.7 8131.0 8225.2 9175.7 12224.5 12758.0 12982.0 13103.3 10831.6 10869.8 10992.3 11195.6 11259.4 9057.0 10870.9 10944.0 11213.9 11276.8 11015.9 11259.3 11424.8 11525.4 11531.0 7787.2 7856.6 8035.0 8040.0 8248.5 8180.6 9896.4 10752.3 10853.8 10983.5 08:13:46 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:5352.23 Median:5082.80 stddev:3052.53 (60.1%) stddev-sans-first:3046.67 08:13:46 INFO - PROCESS | 1911 | Values: 1403.7 1468.4 1642.0 1739.6 1774.8 7309.7 7561.4 7701.7 8154.0 8163.8 7722.2 8064.9 8069.0 8121.4 8132.2 2027.4 2058.1 2058.7 2061.6 2070.2 1987.5 2023.1 2031.1 2083.4 2083.5 1587.6 1630.4 1638.1 1773.5 1888.7 2043.8 2075.8 2083.6 2084.9 2085.6 2046.3 2063.8 2069.2 2074.8 2087.2 7977.1 8010.7 8030.0 8052.6 8067.1 5040.3 5233.5 5235.0 5237.9 5246.3 3127.6 3260.5 3409.2 3411.9 3418.1 930.3 963.2 982.1 987.1 990.2 10811.9 10903.5 10956.3 10960.3 10977.7 4465.4 4489.8 4625.3 4684.6 4709.9 9395.5 9429.8 9444.0 9456.8 9458.6 4599.8 5071.8 5275.6 5289.5 5302.1 4261.8 4644.5 4763.9 4816.7 4821.4 3128.6 3794.6 3848.7 3858.9 3893.5 1269.0 1271.9 1276.6 1286.1 1292.5 675.7 824.5 844.4 866.1 888.9 5500.6 5513.2 5524.9 5661.6 5819.8 410.6 410.6 417.8 419.2 434.4 3754.8 3807.7 3808.7 3866.1 3888.5 9921.3 10225.6 10264.4 10274.3 10303.8 10214.5 10223.9 10248.3 10280.6 10284.9 7349.4 7608.1 7707.0 7722.3 7726.6 5390.1 5510.9 5520.1 5647.6 5701.1 9079.9 9178.6 9240.4 9271.2 9388.7 7883.4 9505.2 9549.2 9640.0 9737.9 6561.3 6766.6 7009.9 7081.5 7257.0 7931.2 8061.0 8151.1 8163.0 8175.5 7105.2 7112.9 7226.6 7283.4 7367.9 6998.7 7162.0 7167.9 7263.7 7264.1 5651.7 6771.7 6796.8 6800.5 6832.1 3567.8 4139.3 4448.6 4726.6 4795.3 4894.3 4945.5 4987.1 5007.2 5093.8 08:13:46 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4546.55 Median:5078.81 stddev:1424.11 (28.0%) stddev-sans-first:1391.86 08:13:46 INFO - PROCESS | 1911 | Values: 293.2 300.4 305.8 308.3 311.0 4468.7 5294.3 5452.0 5623.2 5647.4 3889.7 4394.8 5260.7 5377.7 5454.0 4144.6 4145.9 4153.0 4156.8 4208.0 3453.6 4039.0 4149.0 4156.8 4203.2 3440.6 4089.2 4127.9 4147.4 4155.4 4104.7 4119.3 4147.2 4149.6 4149.8 3495.1 3589.0 3596.7 3603.4 3633.7 4265.8 5006.9 5071.7 5221.7 5314.1 4658.8 4704.6 4706.3 4768.0 4784.8 4165.5 4728.9 5421.4 5704.5 5846.3 3605.8 3820.8 3865.2 3910.5 3924.1 5990.3 6073.3 6116.4 6129.8 6171.9 3328.7 3958.5 3977.2 3977.9 3987.9 3645.3 3759.2 3820.0 4031.9 4041.7 3973.3 4323.8 4649.3 4687.4 4750.1 5816.4 5876.4 5885.7 5893.4 5954.5 1122.0 1198.5 1239.0 1293.2 1299.8 702.5 787.1 871.6 879.7 882.4 4617.9 4932.6 5085.9 5119.8 5192.4 4731.9 5144.6 5671.3 5674.1 5709.2 4341.8 4471.7 5175.3 5179.6 5186.3 2517.5 2593.7 2787.5 2804.8 3012.2 4953.4 5867.3 5890.4 5910.5 5939.8 4709.8 5476.6 5782.3 5913.3 5922.8 5653.6 5822.9 5827.0 5858.7 5896.9 5001.2 5320.7 5572.2 5647.2 5738.2 5181.9 5196.2 5472.8 5521.2 5562.6 5622.5 5634.7 5703.2 5753.5 5783.7 3452.3 3541.3 3692.6 3727.3 3763.9 5491.7 5925.5 5967.6 6002.1 6010.5 4826.7 5300.9 5577.2 5586.9 5628.3 4654.6 4938.8 5307.6 5371.1 6025.2 4885.6 5096.3 5639.8 5677.3 5693.6 4894.3 5154.9 5426.7 5835.8 5918.5 5715.7 5762.5 5808.7 5815.5 5843.0 08:13:46 INFO - PROCESS | 1911 | 08:13:46 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:20083.68 Median:633.68 stddev:31303.11 (4939.9%) stddev-sans-first:31356.81 08:13:46 INFO - PROCESS | 1911 | Values: 621.7 696.1 757.8 773.0 781.9 12333.4 12895.2 12936.3 12971.4 12982.9 12205.5 12324.9 12337.8 12356.4 12379.5 639.2 660.9 755.8 775.6 795.8 793.3 815.2 816.3 816.8 819.9 843.6 850.3 858.8 859.0 862.7 806.5 850.4 850.9 852.7 853.0 622.4 629.7 637.7 638.1 639.9 11365.8 11463.6 11607.2 11625.8 11635.7 10209.1 10267.9 10290.2 10298.8 10481.3 8971.9 9114.5 9157.7 9163.4 9398.7 2990.2 3030.7 3033.3 3045.3 3083.4 78485.8 80369.0 84683.2 85099.1 85366.6 7747.2 7787.9 7843.7 7859.0 7915.4 13539.6 16445.3 16556.4 17719.4 17721.3 7128.4 7195.9 7205.2 7321.5 7326.6 3997.5 4057.7 4071.3 4097.2 4109.0 2622.0 3076.1 3161.9 3166.1 3184.7 584.9 589.9 595.5 603.7 608.8 615.2 638.7 640.4 658.5 661.5 8198.8 8459.1 8545.6 8571.5 8742.0 603.5 644.4 648.6 656.3 658.0 4029.9 4137.8 4248.0 4306.2 4388.5 112039.0 113596.0 114123.4 114968.4 115907.8 85855.6 99578.0 100594.0 101740.5 102817.0 89407.0 90100.0 90698.6 91893.5 92614.5 7971.0 8263.7 8311.0 8440.8 8440.9 50072.0 57790.0 57907.7 57916.0 58737.0 78851.6 80010.0 81381.6 82121.0 82330.0 10203.8 10596.4 10898.2 11024.8 11482.7 9486.8 11439.9 11746.1 11804.6 11930.1 9260.9 10576.5 10733.1 11194.7 11309.9 11438.1 11505.9 11600.7 11743.7 12116.9 10735.2 10809.7 10820.5 10844.0 10904.7 9373.3 9609.1 9656.8 9795.4 9948.0 9288.0 9330.3 9427.7 9481.6 9639.4 08:13:46 INFO - PROCESS | 1911 | -------- Summary: end -------- 08:13:46 INFO - PROCESS | 1911 | 08:13:47 INFO - TEST-INFO | 1911: exit 0 08:13:47 INFO - TEST-OK | dromaeo_css | took 1115587ms 08:13:47 INFO - TEST-START | kraken 08:13:47 INFO - operating with platform_type : mac_ 08:13:47 INFO - Initialising browser for kraken test... 08:13:47 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpdHx64a/profile http://localhost:53448/getInfo.html) 08:13:49 INFO - PROCESS | 1916 | 2016-11-17 08:13:49.715 plugin-container[1917:17923] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 08:13:49 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:13:49 INFO - PROCESS | 1916 | 2016-11-17 08:13:49.718 plugin-container[1917:17923] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 08:13:49 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:13:49 INFO - PROCESS | 1916 | 2016-11-17 08:13:49.718 plugin-container[1917:17923] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:13:49 INFO - PROCESS | 1916 | __metrics Screen width/height:1600/1200 08:13:49 INFO - PROCESS | 1916 | colorDepth:24 08:13:49 INFO - PROCESS | 1916 | Browser inner width/height: 1024/689 08:13:49 INFO - PROCESS | 1916 | __metrics 08:13:49 ERROR - PROCESS | 1916 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 08:13:50 INFO - TEST-INFO | 1916: exit 0 08:13:50 INFO - Browser initialized. 08:13:50 INFO - Running cycle 1/1 for kraken test... 08:13:50 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpdHx64a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:52 INFO - PROCESS | 1918 | 2016-11-17 08:13:52.799 plugin-container[1919:18037] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 08:13:52 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:13:52 INFO - PROCESS | 1918 | 2016-11-17 08:13:52.799 plugin-container[1919:18037] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 08:13:52 INFO - PROCESS | 1918 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:13:52 INFO - PROCESS | 1918 | 2016-11-17 08:13:52.799 plugin-container[1919:18037] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:14:02 INFO - PROCESS | 1918 | RSS: Main: 238239744 08:14:02 INFO - PROCESS | 1918 | 08:14:05 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53448/tests/kraken/driver.html?testName=audio-beat-detection) 08:14:06 INFO - PROCESS | 1918 | RSS: Main: 250519552 08:14:06 INFO - PROCESS | 1918 | 08:14:09 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53448/tests/kraken/driver.html?testName=audio-dft) 08:14:09 INFO - PROCESS | 1918 | RSS: Main: 258211840 08:14:09 INFO - PROCESS | 1918 | 08:14:13 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53448/tests/kraken/driver.html?testName=audio-fft) 08:14:13 INFO - PROCESS | 1918 | RSS: Main: 260685824 08:14:13 INFO - PROCESS | 1918 | 08:14:15 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53448/tests/kraken/driver.html?testName=audio-oscillator) 08:14:16 INFO - PROCESS | 1918 | RSS: Main: 262971392 08:14:16 INFO - PROCESS | 1918 | 08:14:18 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:14:19 INFO - PROCESS | 1918 | RSS: Main: 263516160 08:14:19 INFO - PROCESS | 1918 | 08:14:22 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53448/tests/kraken/driver.html?testName=imaging-darkroom) 08:14:22 INFO - PROCESS | 1918 | RSS: Main: 269062144 08:14:22 INFO - PROCESS | 1918 | 08:14:25 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53448/tests/kraken/driver.html?testName=imaging-desaturate) 08:14:26 INFO - PROCESS | 1918 | RSS: Main: 268849152 08:14:26 INFO - PROCESS | 1918 | 08:14:29 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53448/tests/kraken/driver.html?testName=json-parse-financial) 08:14:29 INFO - PROCESS | 1918 | RSS: Main: 269017088 08:14:29 INFO - PROCESS | 1918 | 08:14:31 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:14:32 INFO - PROCESS | 1918 | RSS: Main: 268238848 08:14:32 INFO - PROCESS | 1918 | 08:14:34 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:14:34 INFO - PROCESS | 1918 | RSS: Main: 268267520 08:14:34 INFO - PROCESS | 1918 | 08:14:37 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:14:37 INFO - PROCESS | 1918 | RSS: Main: 268255232 08:14:37 INFO - PROCESS | 1918 | 08:14:40 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:14:41 INFO - PROCESS | 1918 | RSS: Main: 268517376 08:14:41 INFO - PROCESS | 1918 | 08:14:44 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:14:45 INFO - PROCESS | 1918 | RSS: Main: 268439552 08:14:45 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | Cycle 1(1): loaded http://localhost:53448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53448/tests/kraken/driver.html?testName=ai-astar) 08:14:47 INFO - PROCESS | 1918 | RSS: Main: 270331904 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | __start_tp_report 08:14:47 INFO - PROCESS | 1918 | _x_x_mozilla_page_load 08:14:47 INFO - PROCESS | 1918 | _x_x_mozilla_page_load_details 08:14:47 INFO - PROCESS | 1918 | |i|pagename|runs| 08:14:47 INFO - PROCESS | 1918 | |0;ai-astar;106;169;129;113;117;119;128;175;119;118 08:14:47 INFO - PROCESS | 1918 | |1;audio-beat-detection;179;157;142;154;116;126;117;118;144;115 08:14:47 INFO - PROCESS | 1918 | |2;audio-dft;204;236;198;198;196;196;198;196;192;195 08:14:47 INFO - PROCESS | 1918 | |3;audio-fft;83;58;59;85;52;71;84;63;103;59 08:14:47 INFO - PROCESS | 1918 | |4;audio-oscillator;95;70;82;78;94;103;112;70;71;89 08:14:47 INFO - PROCESS | 1918 | |5;imaging-gaussian-blur;99;110;89;92;106;110;138;88;90;86 08:14:47 INFO - PROCESS | 1918 | |6;imaging-darkroom;102;98;97;112;97;96;96;96;100;156 08:14:47 INFO - PROCESS | 1918 | |7;imaging-desaturate;99;90;100;92;94;92;121;149;92;95 08:14:47 INFO - PROCESS | 1918 | |8;json-parse-financial;59;57;55;57;58;61;56;58;57;58 08:14:47 INFO - PROCESS | 1918 | |9;json-stringify-tinderbox;78;76;112;69;67;89;90;105;103;104 08:14:47 INFO - PROCESS | 1918 | |10;stanford-crypto-aes;91;88;91;89;83;87;81;109;108;109 08:14:47 INFO - PROCESS | 1918 | |11;stanford-crypto-ccm;151;165;141;136;151;165;148;153;219;187 08:14:47 INFO - PROCESS | 1918 | |12;stanford-crypto-pbkdf2;179;178;178;177;162;235;242;165;235;219 08:14:47 INFO - PROCESS | 1918 | |13;stanford-crypto-sha256-iterative;68;70;67;67;70;67;70;68;69;69 08:14:47 INFO - PROCESS | 1918 | __end_tp_report 08:14:47 INFO - PROCESS | 1918 | __start_cc_report 08:14:47 INFO - PROCESS | 1918 | _x_x_mozilla_cycle_collect,959 08:14:47 INFO - PROCESS | 1918 | __end_cc_report 08:14:47 INFO - PROCESS | 1918 | __startTimestamp1479399287468__endTimestamp 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | ------- Summary: start ------- 08:14:47 INFO - PROCESS | 1918 | Number of tests: 14 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#0] ai-astar Cycles:10 Average:129.30 Median:123.50 stddev:23.49 (19.0%) stddev-sans-first:23.35 08:14:47 INFO - PROCESS | 1918 | Values: 106.0 169.0 129.0 113.0 117.0 119.0 128.0 175.0 119.0 118.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:143.00 stddev:21.94 (15.3%) stddev-sans-first:17.16 08:14:47 INFO - PROCESS | 1918 | Values: 179.0 157.0 142.0 154.0 116.0 126.0 117.0 118.0 144.0 115.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#2] audio-dft Cycles:10 Average:200.90 Median:198.00 stddev:12.71 (6.4%) stddev-sans-first:13.43 08:14:47 INFO - PROCESS | 1918 | Values: 204.0 236.0 198.0 198.0 196.0 196.0 198.0 196.0 192.0 195.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#3] audio-fft Cycles:10 Average:71.70 Median:67.00 stddev:16.36 (24.4%) stddev-sans-first:16.84 08:14:47 INFO - PROCESS | 1918 | Values: 83.0 58.0 59.0 85.0 52.0 71.0 84.0 63.0 103.0 59.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:80.00 stddev:14.66 (18.3%) stddev-sans-first:15.22 08:14:47 INFO - PROCESS | 1918 | Values: 95.0 70.0 82.0 78.0 94.0 103.0 112.0 70.0 71.0 89.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#5] imaging-gaussian-blur Cycles:10 Average:100.80 Median:88.50 stddev:15.98 (18.1%) stddev-sans-first:16.94 08:14:47 INFO - PROCESS | 1918 | Values: 99.0 110.0 89.0 92.0 106.0 110.0 138.0 88.0 90.0 86.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:96.00 stddev:18.57 (19.3%) stddev-sans-first:19.67 08:14:47 INFO - PROCESS | 1918 | Values: 102.0 98.0 97.0 112.0 97.0 96.0 96.0 96.0 100.0 156.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#7] imaging-desaturate Cycles:10 Average:102.40 Median:92.00 stddev:18.67 (20.3%) stddev-sans-first:19.77 08:14:47 INFO - PROCESS | 1918 | Values: 99.0 90.0 100.0 92.0 94.0 92.0 121.0 149.0 92.0 95.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.65 (2.8%) stddev-sans-first:1.67 08:14:47 INFO - PROCESS | 1918 | Values: 59.0 57.0 55.0 57.0 58.0 61.0 56.0 58.0 57.0 58.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#9] json-stringify-tinderbox Cycles:10 Average:89.30 Median:72.50 stddev:16.26 (22.4%) stddev-sans-first:16.73 08:14:47 INFO - PROCESS | 1918 | Values: 78.0 76.0 112.0 69.0 67.0 89.0 90.0 105.0 103.0 104.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:87.50 stddev:10.86 (12.4%) stddev-sans-first:11.48 08:14:47 INFO - PROCESS | 1918 | Values: 91.0 88.0 91.0 89.0 83.0 87.0 81.0 109.0 108.0 109.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#11] stanford-crypto-ccm Cycles:10 Average:161.60 Median:159.00 stddev:24.78 (15.6%) stddev-sans-first:25.98 08:14:47 INFO - PROCESS | 1918 | Values: 151.0 165.0 141.0 136.0 151.0 165.0 148.0 153.0 219.0 187.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.00 Median:199.00 stddev:31.78 (16.0%) stddev-sans-first:33.04 08:14:47 INFO - PROCESS | 1918 | Values: 179.0 178.0 178.0 177.0 162.0 235.0 242.0 165.0 235.0 219.0 08:14:47 INFO - PROCESS | 1918 | 08:14:47 INFO - PROCESS | 1918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.27 (1.8%) stddev-sans-first:1.33 08:14:47 INFO - PROCESS | 1918 | Values: 68.0 70.0 67.0 67.0 70.0 67.0 70.0 68.0 69.0 69.0 08:14:47 INFO - PROCESS | 1918 | -------- Summary: end -------- 08:14:47 INFO - PROCESS | 1918 | 08:14:48 INFO - TEST-INFO | 1918: exit 0 08:14:48 INFO - TEST-OK | kraken | took 61213ms 08:14:48 INFO - SUITE-END | took 1176s 08:14:48 INFO - Completed test suite (00:19:37) 08:14:48 INFO - javascript benchmark 08:14:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6828.10404052809, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.355260724158, 3314.4365457872173, 3314.9005529834103, 3319.7344212463004, 3363.6972672459474, 5584.776608935643, 5596.860078498034, 5618.438156184379, 5618.915716264254, 5652.858678533039, 4380.780960951947, 5582.665040097587, 5593.8321850344455, 5624.775008999645, 5628.32460104787, 5057.6965382077005, 5093.668911520739, 5146.099432599299, 5147.845564633067, 5180.093483640348, 5064.797408103672, 5164.690118592877, 5205.0, 5234.319538460014, 5297.046531624306, 5076.64463487556, 5177.145770947789, 5183.714895680736, 5206.635535512516, 5216.478352164772, 5083.517065878736, 5132.974335128338, 5147.588192944556, 5147.871303217412, 5208.869778255536, 5066.341375621182, 5078.619103567247, 5095.439501654815, 5162.199859021857, 5172.379314482248, 5402.837914862561, 5506.311711036121, 5574.637648552831, 5658.264425624642, 5692.57305702074, 4960.404751429815, 5804.332501762267, 5816.651000939957, 6140.815775526741, 6159.599626024294, 5928.584999050068, 5932.822015339547, 5947.732352044169, 5953.58324917256, 5954.55340849438, 5476.698781567012, 5502.642328248651, 5502.8349149525575, 5509.972450137724, 5514.503694667459, 6035.517158627299, 6151.384861513813, 6167.229096362955, 6196.690165491707, 6226.626402415779, 6102.216595924314, 6105.338445949952, 6117.021276595723, 6130.092410195535, 6139.355367686418, 5320.547753441001, 6117.785877494355, 6172.629642221481, 6187.659678717714, 6229.127922090911, 5030.522100400456, 5521.702399936012, 5617.522510586564, 5751.511121554715, 5883.558733095035, 6175.752969881244, 6187.783427580013, 6189.473894718909, 6204.565680402328, 6204.751809927552, 4876.683015604045, 4876.902461950741, 4879.341288926021, 4883.218685010453, 4893.510648935078, 3964.8810535683974, 4178.456800615901, 4358.215521206213, 4360.106178233455, 4430.933535996963, 5035.496450355008, 5763.682997435098, 5803.593748437569, 5823.767049318065, 5823.767049318065, 6190.133381326618, 6211.223597050369, 6239.344868788802, 6250.749970001149, 6250.74997000124, 5625.6905870176715, 5695.487406133468, 5703.17303990919, 5747.741351639186, 5761.222234998221, 5286.180642000496, 5310.92033619496, 5322.866928326823, 5326.414094449608, 5329.600279979017, 6203.937960620336, 6225.035119556476, 6233.75064997395, 6239.469645080128, 6275.52933529978, 6208.379162083756, 6212.875742485035, 6214.347493513116, 6222.191115155001, 6249.78125765596, 6045.879082418415, 6212.720427580679, 6236.407541283571, 6273.874522509615, 6292.653904035322, 6012.248468941382, 6038.547108966933, 6052.092186172109, 6112.266528016667, 6153.753849845956, 5980.910286345621, 6143.603994442082, 6161.568690191643, 6186.721597528032, 6237.4698150657705, 6047.002244629763, 6070.059140833001, 6085.543584231112, 6092.603980741238, 6115.296740874856, 6078.787242446493, 6087.604305720114, 6092.147099405998, 6098.725557349841, 6108.053251745987, 5700.144978253295, 5720.313562372542, 5728.255326807488, 5825.883482330414, 5881.147233651182, 5980.760769569169, 6066.484348830399, 6079.817605471843, 6088.208532890873, 6101.694915254308, 5841.18223448709, 5870.735816888165, 5884.0, 5908.645481271137, 5916.940830591639], "value": 5586.288901036397, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.354369707621, 488.21641265768443, 531.8058908498397, 543.052373608054, 563.6223730100832, 28611.9985800497, 29484.852575737117, 30555.08334749961, 30634.38731225374, 30752.846235768844, 31585.526217106704, 32112.839435802787, 32226.0, 32288.515672264875, 32376.67623323766, 7176.7846964591145, 7445.478816482849, 7452.925470745305, 7457.179710231871, 7480.102387713482, 7508.286712762306, 7591.164971853092, 7607.923920760804, 7617.124030736453, 7623.2376762323875, 7585.658645360944, 7600.847983040364, 7623.695052197905, 7623.885641715378, 7649.732259370923, 7527.924720752777, 7595.620218989028, 7604.695812167534, 7613.390928725688, 7623.695052197905, 7498.250174982512, 7591.164971853092, 7606.0, 7606.581638009908, 7620.580868052255, 30384.8480757597, 30563.2359191022, 30583.92956246543, 30618.0, 30656.2335941601, 2815.6480439945008, 3249.6425393206728, 3266.852991615383, 3632.9999999999736, 4005.7796821174825, 16097.83902160975, 18909.054547272583, 19845.702314465296, 20953.790462095338, 21419.678704819442, 2742.698303186648, 2810.5924640927155, 2830.8867645294163, 2857.8571071446345, 2873.1380585824168, 508642.0, 510981.0, 511035.4448227735, 514795.0, 515769.4211528956, 49221.0, 58268.708656456445, 58463.07684615752, 58963.705181473815, 59046.40953590495, 56963.0, 60008.39991600028, 60386.69806650939, 60871.391286087455, 61422.69288653528, 13463.596092117252, 15471.381144754083, 15767.896247262812, 15947.362105515882, 16001.839981600267, 10237.641682541223, 12270.631881043404, 12315.44580493862, 12366.010719142447, 12404.875951240552, 17142.485725428258, 17847.28610855577, 17876.19557119933, 17923.820761792216, 18066.819331806775, 6304.968475157595, 7362.300581444754, 7576.886346704804, 7598.35413989806, 7674.846503070019, 843.0094638799509, 850.1328644782287, 978.4716253223322, 987.1017374189597, 1039.5394470768583, 22820.543589128458, 24496.020159193788, 29164.125076247747, 29325.0, 29961.85019074934, 844.4975239732349, 852.8869824878469, 974.3179774158118, 1118.2228351295935, 1126.6957921361186, 14441.85558144426, 15013.849861501463, 15110.828000119342, 15208.543743687707, 15620.375184992701, 677740.0, 678141.0, 683097.0, 683129.0, 685068.0, 50192.749036255314, 50653.49346506488, 50772.0, 50952.74523627358, 50990.0, 1331.4807225182187, 1336.7861142217198, 1353.8916886648847, 1370.6504841265612, 1380.0753495158267, 27388.589171162846, 28317.292067698472, 28384.290392740346, 28505.714942850307, 29473.557896631995, 45622.54377456183, 46276.843078923295, 46385.304220436046, 46459.53540464687, 46504.53495465002, 497120.0, 499135.0, 500203.0, 502279.0, 502443.0, 24023.759762402853, 24384.024639014242, 24902.626460603467, 24932.127375541768, 25753.742462575883, 40251.0, 40422.0, 40509.79745101256, 41195.38206926839, 41242.58757412388, 26766.0, 33914.3217135651, 34365.82817085998, 34382.2808859551, 34634.653653463145, 33913.66086339204, 34265.486017709256, 34710.65289347175, 34964.0, 35202.47196292109, 30052.3989520204, 33052.50421243635, 33268.1682957928, 34816.82591587026, 34857.65142348544, 28038.0, 29749.851250743606, 30066.54900176543, 31624.841875791393, 31648.0, 23170.420739481648, 23552.293431197093, 23786.286411407684, 23956.92193851246, 24134.275971720876], "value": 17741.759760418696, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5365025466893, 368.73819588092437, 377.2157694106876, 378.37945768938937, 396.31833246815484, 15456.304466299016, 15797.842021579781, 16044.59888502788, 16330.938488998221, 16552.0, 18244.452666420028, 18861.622767544643, 18875.905620471913, 19082.0, 19399.418017459462, 4130.318497447933, 4620.145273124474, 4903.141950158726, 4906.165951788204, 4913.238448040559, 4831.782569784351, 4867.975660121694, 4879.170541008037, 5259.6055295852775, 5304.973475132619, 5280.762365693534, 5282.894342113174, 5284.497972692608, 5289.338832645919, 5302.3637163540425, 5024.397072351323, 5256.8685782855355, 5293.073712100387, 5313.57491400687, 5320.201969704536, 4672.112298663277, 4723.622110231207, 4745.549172828576, 4748.097861406356, 4753.500882407332, 12242.326672033034, 12357.25856448616, 12454.688632784162, 12468.81296780549, 20090.493213009082, 2274.727032756063, 2308.7691230876944, 2323.548656167742, 2331.4521087544413, 2618.48939456806, 9080.580101314266, 9378.812423751488, 9566.47384393858, 11384.0, 13715.862841371658, 1672.991635041829, 1699.3882202407124, 1713.254734190631, 1749.4664127441126, 1772.1227992143972, 102171.48914255455, 107348.38977415345, 109243.45378273138, 127353.36323318323, 128519.0, 9145.908540914506, 9228.723138305862, 9775.657851975147, 11404.657860264206, 11736.530538778354, 14525.491607793676, 14550.927245363706, 14565.490207842675, 14569.708605828037, 14571.562853114423, 6904.447644188453, 8311.584420778936, 8485.745427637181, 8505.95747021261, 8548.615312310962, 8311.542865142354, 8318.8336233275, 8362.665493380318, 8466.153384661608, 8481.067082620906, 4503.819847206075, 4530.320451932236, 4542.1597004553605, 4625.098105869323, 4626.259798432235, 1927.267638297438, 1950.8731932424348, 1964.5972575621963, 1977.1498255750166, 1982.682770756672, 675.1122274209399, 788.3707834372318, 794.8330850521339, 920.9723708288763, 959.9136077752896, 18409.723854142198, 19133.8086619132, 19763.40709778709, 20685.276015339692, 20723.648033912745, 834.7537476444463, 886.7364006291009, 905.4929239625831, 907.9909200908038, 986.487026746088, 10191.7452063699, 10860.728481788019, 10873.510692018877, 10889.346639201673, 10942.288751231144, 600306.0, 602307.0, 609200.0, 612656.9367153224, 615573.0, 118921.0, 119691.0, 124560.37719811524, 128221.43557128991, 134453.3277333607, 872.7032808845023, 981.6417007792104, 1050.417018554694, 1052.0636633396284, 1056.5668076088766, 17146.485605431855, 17556.82443175603, 17898.91050544739, 18045.81954180494, 18828.811711882707, 36043.639563604025, 43882.780586096866, 46632.83417914443, 49419.50580494293, 52059.73970130125, 73766.0, 74018.62990685228, 74296.14259643336, 75974.0, 76302.0, 7763.573003484863, 7892.644830982505, 8036.718714844952, 8130.959345203472, 8225.218604232588, 9175.724728258163, 12224.511019559119, 12758.0, 12982.0, 13103.344832758134, 10831.566737330419, 10869.782604348027, 10992.28550144238, 11195.552177912792, 11259.380734059705, 9057.0, 10870.945645271722, 10943.984694563855, 11213.887861121284, 11276.75955644862, 11015.944920275348, 11259.268147570381, 11424.828627570427, 11525.366104864313, 11531.019863311712, 7787.221277872394, 7856.567888765944, 8035.0, 8040.0, 8248.54632995191, 8180.550069746221, 9896.356736812084, 10752.301100428447, 10853.837192442277, 10983.50574224146], "value": 8935.465002800403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.7122389910069, 1468.4126349460212, 1641.9655616961313, 1739.6433731085128, 1774.8225177482245, 7309.744158954438, 7561.432892533055, 7701.730439434621, 8153.959230203848, 8163.836723265531, 7722.227777222275, 8064.91935080649, 8069.0, 8121.390895682833, 8132.227438393358, 2027.4019164346553, 2058.1458694641706, 2058.670612701968, 2061.6495195816674, 2070.234013415031, 1987.4534503011644, 2023.1098316740588, 2031.0758604834764, 2083.364573804989, 2083.4583008417844, 1587.626907676695, 1630.4130513015305, 1638.131790151216, 1773.538879891231, 1888.6694828405043, 2043.785402532735, 2075.823554997827, 2083.645780217367, 2084.937451876446, 2085.5620319732875, 2046.2735728816353, 2063.793620637939, 2069.224040984631, 2074.7510298764096, 2087.1651339464183, 7977.122516523178, 8010.679572817138, 8030.036395632503, 8052.637631306605, 8067.112617612058, 5040.319556859814, 5233.502817232395, 5234.97382513085, 5237.947620523784, 5246.344206974129, 3127.6403213630497, 3260.4620237660756, 3409.1988382730037, 3411.9317613647586, 3418.060033490785, 930.3115694386173, 963.1812958984876, 982.1111893736108, 987.0672214757058, 990.1633120013577, 10811.945940270249, 10903.509342079626, 10956.28784129029, 10960.342379457257, 10977.725556861062, 4465.419495465569, 4489.775511224426, 4625.329327247598, 4684.601808846286, 4709.858704238878, 9395.530223488935, 9429.811403771886, 9444.0, 9456.810863782686, 9458.621655133855, 4599.770011499479, 5071.782772134735, 5275.57795376369, 5289.523942845085, 5302.125149350314, 4261.786910654455, 4644.465886423104, 4763.880902977384, 4816.686915350491, 4821.397325334333, 3128.6089238845143, 3794.6395092466173, 3848.7113466490127, 3858.9228215436096, 3893.4549163117185, 1268.9619311420672, 1271.879171478708, 1276.6489215465635, 1286.1318609938442, 1292.4571679894466, 675.6756756756785, 824.468217999387, 844.4173520270994, 866.1381924984555, 888.8977767556813, 5500.58745594082, 5513.2005859150195, 5524.889502209933, 5661.575381846295, 5819.79630712923, 410.5586494518405, 410.57505481826166, 417.76396336070025, 419.1554018652418, 434.4482507215818, 3754.774713517143, 3807.6573108420375, 3808.6572208501366, 3866.1107945172766, 3888.51393575803, 9921.255905807093, 10225.642102526375, 10264.43545604984, 10274.33216840903, 10303.793924121475, 10214.489275536194, 10223.875373708886, 10248.333858299336, 10280.588776448858, 10284.948575257076, 7349.375303099189, 7608.087029556378, 7707.0, 7722.3049925506975, 7726.575038372831, 5390.110631745718, 5510.91733624004, 5520.089185284383, 5647.576431767552, 5701.144828275792, 9079.863802043106, 9178.586963586788, 9240.445573265626, 9271.165595096474, 9388.67139650109, 7883.448158628841, 9505.239580833379, 9549.188318992963, 9640.0, 9737.8576713123, 6561.278259391559, 6766.594004359754, 7009.929900701131, 7081.539699919489, 7256.96371518139, 7931.246531579491, 8061.0, 8151.144129866516, 8162.979627546557, 8175.468594541336, 7105.218425973036, 7112.928870711434, 7226.638668066681, 7283.417326613964, 7367.889481657672, 6998.685059172248, 7162.0, 7167.928320716935, 7263.745768898275, 7264.091988501437, 5651.689157096399, 6771.6614169292325, 6796.76211332601, 6800.489963252875, 6832.111825462658, 3567.8216089194916, 4139.254934111768, 4448.5551444855255, 4726.574608285271, 4795.304680821331, 4894.33926419943, 4945.530174633404, 4987.102321582005, 5007.198848184273, 5093.821716239914], "value": 4191.991655435656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2375822860561, 300.36922462828056, 305.8165100939435, 308.31400134700294, 310.98289594072315, 4468.731876087437, 5294.258803767476, 5452.010016344036, 5623.240862483563, 5647.350554686207, 3889.727719059667, 4394.824207031715, 5260.684828792801, 5377.731113444322, 5453.972730136354, 4144.647704945083, 4145.937810932838, 4153.003279212982, 4156.771377574232, 4207.957920420795, 3453.6373680763536, 4039.0, 4149.004238982652, 4156.792160391983, 4203.180379825935, 3440.552728145338, 4089.2230476209575, 4127.885470922849, 4147.419361289422, 4155.37940203321, 4104.6716262699065, 4119.258533463975, 4147.232761939051, 4149.605787450188, 4149.83400663973, 3495.0777072609962, 3588.9641103588892, 3596.7482276240676, 3603.3874241378767, 3633.6729694327637, 4265.829366825324, 5006.89986200274, 5071.670341427795, 5221.71280579568, 5314.149736042254, 4658.833642356287, 4704.647151463654, 4706.294055891643, 4767.951050768826, 4784.760761961888, 4165.500139983222, 4728.865072382638, 5421.430749771257, 5704.515116215127, 5846.298444186725, 3605.7656252343777, 3820.789856557888, 3865.246276975991, 3910.530736311661, 3924.058226025762, 5990.251218597676, 6073.331933487313, 6116.388361163892, 6129.846753831145, 6171.907421388682, 3328.7170590500077, 3958.485396898385, 3977.204559088194, 3977.900552486153, 3987.940180897289, 3645.2709458108484, 3759.154190307159, 3820.0, 4031.9395209071886, 4041.7372870763306, 3973.304671682444, 4323.7621930793475, 4649.326242552746, 4687.390639216948, 4750.078701598492, 5816.389279125716, 5876.382979787147, 5885.735141918538, 5893.410658934158, 5954.523638108941, 1122.0014187373245, 1198.4606926882936, 1238.990222968278, 1293.2499150492692, 1299.811527328532, 702.5363260248314, 787.0712559180222, 871.5859966515854, 879.6921077622909, 882.4043770454917, 4617.937874288865, 4932.556069953722, 5085.949140508622, 5119.846404607868, 5192.350956130484, 4731.881702957385, 5144.588432925432, 5671.300343155102, 5674.120511320752, 5709.172170035322, 4341.848035318749, 4471.731696098244, 5175.301334319819, 5179.611529135254, 5186.299849520342, 2517.483915797257, 2593.6757905261843, 2787.5261205595098, 2804.8176868503483, 3012.171652795455, 4953.405591329064, 5867.325257595346, 5890.376054796964, 5910.508013909373, 5939.762409503658, 4709.81160753566, 5476.561875049986, 5782.306123265235, 5913.349531551526, 5922.792702255487, 5653.632513886584, 5822.854428639318, 5827.0, 5858.736356863951, 5896.850114227685, 5001.24981252815, 5320.733963301896, 5572.192032155396, 5647.237622921018, 5738.225339579103, 5181.896362072813, 5196.220566914993, 5472.808451704331, 5521.239380309845, 5562.637153897159, 5622.465865742748, 5634.718264086861, 5703.173039909273, 5753.482186603226, 5783.652980821164, 3452.309538092442, 3541.309444658267, 3692.630736926393, 3727.2918145552258, 3763.8682646107254, 5491.6819963207745, 5925.466707996128, 5967.627445687429, 6002.148979235003, 6010.459058684739, 4826.734529600905, 5300.867478313073, 5577.2191893135805, 5586.876986745011, 5628.324601047901, 4654.557817007379, 4938.827141050189, 5307.57539396855, 5371.113766228685, 6025.246844144482, 4885.560299573055, 5096.337476128079, 5639.802606908738, 5677.347105082803, 5693.629914055573, 4894.339264199288, 5154.948450515597, 5426.67439953604, 5835.766569337179, 5918.467337939606, 5715.656820647061, 5762.481376676119, 5808.680522571299, 5815.505682017076, 5843.0], "value": 4084.023977855859, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.7077973352524, 696.1124566178122, 757.7802437293185, 772.972945946892, 781.9482795639866, 12333.444994975225, 12895.161814482051, 12936.28850413227, 12971.416286267116, 12982.870171298284, 12205.511779528808, 12324.938375308133, 12337.753244935097, 12356.382180890965, 12379.504819807196, 639.2009987515605, 660.8810414125455, 755.8072691463683, 775.6044417347138, 795.757294025322, 793.2820797178563, 815.1848151848152, 816.2694388522299, 816.808050108224, 819.8647223208163, 843.5950743643054, 850.3324889961382, 858.7895965488464, 858.9871151932726, 862.6808081010004, 806.4677312973439, 850.3919697416377, 850.8766228896807, 852.7228650688551, 853.0318088969003, 622.3527531367373, 629.6883042893797, 637.6747858592105, 638.1480723234488, 639.8738220731547, 11365.772684546346, 11463.598774042868, 11607.245529040585, 11625.825612615818, 11635.709107272301, 10209.081182693593, 10267.897321026769, 10290.228232882564, 10298.845517317246, 10481.318714283547, 8971.910280897238, 9114.498702571356, 9157.725268241897, 9163.35856490046, 9398.67104651334, 2990.1627544287635, 3030.6666266710645, 3033.272014716474, 3045.284358175827, 3083.3679095785533, 78485.82271265936, 80369.0, 84683.15316846814, 85099.14900851036, 85366.57316713501, 7747.186545412763, 7787.922120778833, 7843.7254696085365, 7859.0, 7915.366770658334, 13539.59381218565, 16445.342186312413, 16556.42052528156, 17719.379821706178, 17721.29114835392, 7128.358447739728, 7195.856082878313, 7205.2434494378385, 7321.450891183076, 7326.633668316563, 3997.540282867449, 4057.6753859691153, 4071.2671719090254, 4097.2010457961005, 4108.979455102705, 2621.9905336445604, 3076.0618011506704, 3161.8577164027674, 3166.0976621662717, 3184.729298009695, 584.8742520358059, 589.8849724303719, 595.4700316718124, 603.7403916316026, 608.7777961044187, 615.1756646094256, 638.7221558622015, 640.3916279534461, 658.4962503684685, 661.5369241530948, 8198.814545418487, 8459.111793261742, 8545.615447304886, 8571.528565928933, 8741.956290218508, 603.484021161909, 644.3556443556444, 648.6335220600346, 656.3436563436563, 658.0226419609139, 4029.879103626837, 4137.751734895915, 4247.957520424818, 4306.181825453154, 4388.473383193973, 112039.0, 113596.0, 114123.42938285421, 114968.42515787535, 115907.84092158971, 85855.57072214599, 99578.0, 100593.99406005992, 101740.49129754303, 102816.97183028223, 89407.0, 90100.0, 90698.63952040725, 91893.54053229824, 92614.53692731628, 7970.960145199237, 8263.710770123016, 8310.97990439229, 8440.831183376175, 8440.915590844013, 50072.0, 57790.0, 57907.65692573158, 57916.0, 58737.0, 78851.60574197093, 80010.0, 81381.59309203416, 82121.0, 82330.0, 10203.795924081625, 10596.417197054236, 10898.237123401603, 11024.834627480433, 11482.655520334403, 9486.810263794547, 11439.861891409286, 11746.119041072125, 11804.645860624196, 11930.105242106703, 9260.888693356841, 10576.524056417633, 10733.087687546646, 11194.720131996764, 11309.943450282695, 11438.142139339749, 11505.884941150816, 11600.6519804406, 11743.706407339885, 12116.939415302868, 10735.194860385345, 10809.729756756144, 10820.458977051274, 10844.0, 10904.7273818152, 9373.29700272496, 9609.135177834029, 9656.806863862825, 9795.412275263507, 9947.950260248652, 9288.0, 9330.346875718635, 9427.670031548863, 9481.57332920034, 9639.373440726331], "value": 6683.604361225672, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 169.0, 129.0, 113.0, 117.0, 119.0, 128.0, 175.0, 119.0, 118.0], "value": 129.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 157.0, 142.0, 154.0, 116.0, 126.0, 117.0, 118.0, 144.0, 115.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 236.0, 198.0, 198.0, 196.0, 196.0, 198.0, 196.0, 192.0, 195.0], "value": 200.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 85.0, 52.0, 71.0, 84.0, 63.0, 103.0, 59.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 70.0, 82.0, 78.0, 94.0, 103.0, 112.0, 70.0, 71.0, 89.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 89.0, 92.0, 106.0, 110.0, 138.0, 88.0, 90.0, 86.0], "value": 100.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 98.0, 97.0, 112.0, 97.0, 96.0, 96.0, 96.0, 100.0, 156.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 90.0, 100.0, 92.0, 94.0, 92.0, 121.0, 149.0, 92.0, 95.0], "value": 102.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 55.0, 57.0, 58.0, 61.0, 56.0, 58.0, 57.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 112.0, 69.0, 67.0, 89.0, 90.0, 105.0, 103.0, 104.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 89.0, 83.0, 87.0, 81.0, 109.0, 108.0, 109.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 165.0, 141.0, 136.0, 151.0, 165.0, 148.0, 153.0, 219.0, 187.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 178.0, 177.0, 162.0, 235.0, 242.0, 165.0, 235.0, 219.0], "value": 197.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 67.0, 70.0, 67.0, 70.0, 68.0, 69.0, 69.0], "value": 68.5, "unit": "score"}]}]} 08:14:48 INFO - Return code: 0 08:14:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:14:48 ERROR - # TBPL SUCCESS # 08:14:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:14:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:14:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:14:48 INFO - 2016-11-17 08:14:48.809 screenresolution[1923:18421] starting screenresolution argv=screenresolution get 08:14:48 INFO - 2016-11-17 08:14:48.812 screenresolution[1923:18421] Display 0: 1600x1200x32@60 08:14:48 INFO - 2016-11-17 08:14:48.818 screenresolution[1924:18425] starting screenresolution argv=screenresolution list 08:14:48 INFO - Available Modes on Display 0 08:14:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:14:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:14:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:14:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:14:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:14:49 INFO - Intel Iris: 08:14:49 INFO - Chipset Model: Intel Iris 08:14:49 INFO - Type: GPU 08:14:49 INFO - Bus: Built-In 08:14:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:14:49 INFO - Vendor: Intel (0x8086) 08:14:49 INFO - Device ID: 0x0a2e 08:14:49 INFO - Revision ID: 0x0009 08:14:49 INFO - Displays: 08:14:49 INFO - Display: 08:14:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:14:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:14:49 INFO - Display Serial Number: 1600x1200 60 08:14:49 INFO - Main Display: Yes 08:14:49 INFO - Mirror: Off 08:14:49 INFO - Online: Yes 08:14:49 INFO - Rotation: Supported 08:14:49 INFO - Return code: 0 08:14:49 INFO - Running post-action listener: _resource_record_post_action 08:14:49 INFO - [mozharness: 2016-11-17 16:14:49.053959Z] Finished run-tests step (success) 08:14:49 INFO - Running post-run listener: _resource_record_post_run 08:14:49 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 1545728; Write bytes: 699914752; Read time: 15; Write time: 2005 08:14:49 INFO - TinderboxPrint: CPU usage
54.8% 08:14:49 INFO - TinderboxPrint: I/O read bytes / time
1,545,728 / 15 08:14:49 INFO - TinderboxPrint: I/O write bytes / time
699,914,752 / 2,005 08:14:49 INFO - TinderboxPrint: CPU idle
2,190.9 (45.2%) 08:14:49 INFO - TinderboxPrint: CPU system
982.2 (20.3%) 08:14:49 INFO - TinderboxPrint: CPU user
1,672.6 (34.5%) 08:14:49 INFO - TinderboxPrint: Swap in / out
400,510,976 / 0 08:14:49 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395545088; Write bytes: 390757888; Read time: 29702; Write time: 826 08:14:49 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 1508864; Write bytes: 296877056; Read time: 15; Write time: 1139 08:14:49 INFO - Running post-run listener: _upload_blobber_files 08:14:49 INFO - Blob upload gear active. 08:14:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:14:49 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 08:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:14:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:14:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:50 INFO - (blobuploader) - INFO - Done attempting. 08:14:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:14:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:14:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:51 INFO - (blobuploader) - INFO - Done attempting. 08:14:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:14:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:14:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:14:54 INFO - (blobuploader) - INFO - Done attempting. 08:14:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:14:54 INFO - Return code: 0 08:14:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:14:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:14:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0258f473dd84e31b25724fa320cb176c4dab562e0a22837eeb7e653511793beef78f873bc48faf61d82931270565346dee3461a225808930c45f14d5b96cf46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc99e4717554ec1480de98ab9ec3c0c5fe52ed2c0534b0135e056ded7c4b2ea40c27534a3fafdc3aff81cf02fe0fdb8404d0edf178bad5d2bb5f0a2187e077ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98a1b54c86278821b0fcea8a8439e477215c52bf0e26647d4cf0abb043f258e46ca2a95c38cac9feafbace2bb561c0391f60bc7b9e72318b029d7d8651a52089"} 08:14:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:14:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:14:54 INFO - Contents: 08:14:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0258f473dd84e31b25724fa320cb176c4dab562e0a22837eeb7e653511793beef78f873bc48faf61d82931270565346dee3461a225808930c45f14d5b96cf46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc99e4717554ec1480de98ab9ec3c0c5fe52ed2c0534b0135e056ded7c4b2ea40c27534a3fafdc3aff81cf02fe0fdb8404d0edf178bad5d2bb5f0a2187e077ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98a1b54c86278821b0fcea8a8439e477215c52bf0e26647d4cf0abb043f258e46ca2a95c38cac9feafbace2bb561c0391f60bc7b9e72318b029d7d8651a52089"} 08:14:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:14:54 INFO - Copying logs to upload dir... 08:14:54 INFO - mkdir: /builds/slave/test/build/upload/logs 08:14:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.277592 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-17 08:14:54.199280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 08:14:54.203617) ========= 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.sDltijzq55/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.L5uxTpgi9a/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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/Firefox/sha512/b0258f473dd84e31b25724fa320cb176c4dab562e0a22837eeb7e653511793beef78f873bc48faf61d82931270565346dee3461a225808930c45f14d5b96cf46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc99e4717554ec1480de98ab9ec3c0c5fe52ed2c0534b0135e056ded7c4b2ea40c27534a3fafdc3aff81cf02fe0fdb8404d0edf178bad5d2bb5f0a2187e077ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98a1b54c86278821b0fcea8a8439e477215c52bf0e26647d4cf0abb043f258e46ca2a95c38cac9feafbace2bb561c0391f60bc7b9e72318b029d7d8651a52089"} build_url:https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/ROTCbxGgQq2Z-SOg2bwDHQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0258f473dd84e31b25724fa320cb176c4dab562e0a22837eeb7e653511793beef78f873bc48faf61d82931270565346dee3461a225808930c45f14d5b96cf46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc99e4717554ec1480de98ab9ec3c0c5fe52ed2c0534b0135e056ded7c4b2ea40c27534a3fafdc3aff81cf02fe0fdb8404d0edf178bad5d2bb5f0a2187e077ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98a1b54c86278821b0fcea8a8439e477215c52bf0e26647d4cf0abb043f258e46ca2a95c38cac9feafbace2bb561c0391f60bc7b9e72318b029d7d8651a52089"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 08:14:54.240647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:14:54.241050) ========= 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.sDltijzq55/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.L5uxTpgi9a/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.004692 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 08:14:54.293052) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 08:14:54.293420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 08:14:54.293743) ========= ========= Total master_lag: 0.20 =========