builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0291 starttime: 1477936379.18 results: success (0) buildid: 20161031084722 builduid: 67893dc2d0d5491496ae3cb1295160bf revision: 8c9eed5227f8681cf08d2ee8fb3bfd5d743e4096 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 10:52:59.185289) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 10:52:59.185735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 10:52:59.186009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 10:52:59.214970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 10:52:59.215329) ========= 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.orpOXxkme2/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.i9ZWWiqL9h/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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-10-31 10:52:59-- 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% 5.77M=0.002s 2016-10-31 10:52:59 (5.77 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109598 ========= master_lag: 1.63 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 10:53:00.956544) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:53:00.956916) ========= 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.orpOXxkme2/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.i9ZWWiqL9h/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.020282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 10:53:01.002434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 10:53:01.004835) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c9eed5227f8681cf08d2ee8fb3bfd5d743e4096 --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 8c9eed5227f8681cf08d2ee8fb3bfd5d743e4096 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.orpOXxkme2/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.i9ZWWiqL9h/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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-10-31 10:53:01,091 truncating revision to first 12 chars 2016-10-31 10:53:01,092 Setting DEBUG logging. 2016-10-31 10:53:01,092 attempt 1/10 2016-10-31 10:53:01,092 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c9eed5227f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 10:53:02,467 unpacking tar archive at: mozilla-central-8c9eed5227f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.635485 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 10:53:02.665967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 10:53:02.666303) ========= script_repo_revision: 8c9eed5227f8681cf08d2ee8fb3bfd5d743e4096 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 10:53:02.666710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 10:53:02.666975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 10:53:02.685444) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-31 10:53:02.685844) ========= /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.orpOXxkme2/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.i9ZWWiqL9h/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:02 INFO - MultiFileLogger online at 20161031 10:53:02 in /builds/slave/test 10:53:02 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 10:53:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:53:02 INFO - {'append_to_log': False, 10:53:02 INFO - 'base_work_dir': '/builds/slave/test', 10:53:02 INFO - 'blob_upload_branch': 'Firefox', 10:53:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:53:02 INFO - 'branch': 'Firefox', 10:53:02 INFO - 'buildbot_json_path': 'buildprops.json', 10:53:02 INFO - 'config_files': ('talos/mac_config.py',), 10:53:02 INFO - 'default_actions': ('clobber', 10:53:02 INFO - 'read-buildbot-config', 10:53:02 INFO - 'download-and-extract', 10:53:02 INFO - 'populate-webroot', 10:53:02 INFO - 'create-virtualenv', 10:53:02 INFO - 'install', 10:53:02 INFO - 'run-tests'), 10:53:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:53:02 INFO - 'download_minidump_stackwalk': True, 10:53:02 INFO - 'download_symbols': 'ondemand', 10:53:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:53:02 INFO - 'tooltool.py': '/tools/tooltool.py', 10:53:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:53:02 INFO - '/tools/misc-python/virtualenv.py')}, 10:53:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:53:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:53:02 INFO - 'installer_path': 'installer.exe', 10:53:02 INFO - 'log_level': 'info', 10:53:02 INFO - 'log_name': 'talos', 10:53:02 INFO - 'log_to_console': True, 10:53:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:53:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:53:02 INFO - 'opt_config_files': (), 10:53:02 INFO - 'pip_index': False, 10:53:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:02 INFO - 'cmd': ('bash', 10:53:02 INFO - '-c', 10:53:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:02 INFO - 'enabled': True, 10:53:02 INFO - 'halt_on_failure': False, 10:53:02 INFO - 'name': 'check_screen_resolution'},), 10:53:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:53:02 INFO - 'cmd': ('bash', 10:53:02 INFO - '-c', 10:53:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:53:02 INFO - 'enabled': True, 10:53:02 INFO - 'halt_on_failure': False, 10:53:02 INFO - 'name': 'check_screen_resolution'},), 10:53:02 INFO - 'run_cmd_checks_enabled': True, 10:53:02 INFO - 'sps_profile': False, 10:53:02 INFO - 'sps_profile_interval': 0, 10:53:02 INFO - 'suite': 'dromaeojs-e10s', 10:53:02 INFO - 'system_bits': '32', 10:53:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:53:02 INFO - 'title': 't-yosemite-r7-0291', 10:53:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:53:02 INFO - 'use_talos_json': True, 10:53:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:53:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:53:02 INFO - 'work_dir': 'build'} 10:53:02 INFO - [mozharness: 2016-10-31 17:53:02.892539Z] Running clobber step. 10:53:02 INFO - Running pre-action listener: _resource_record_pre_action 10:53:02 INFO - Running main action method: clobber 10:53:02 INFO - rmtree: /builds/slave/test/build 10:53:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:53:04 INFO - Running post-action listener: _resource_record_post_action 10:53:04 INFO - [mozharness: 2016-10-31 17:53:04.843530Z] Finished clobber step (success) 10:53:04 INFO - [mozharness: 2016-10-31 17:53:04.843675Z] Running read-buildbot-config step. 10:53:04 INFO - Running pre-action listener: _resource_record_pre_action 10:53:04 INFO - Running main action method: read_buildbot_config 10:53:04 INFO - Using buildbot properties: 10:53:04 INFO - { 10:53:04 INFO - "project": "", 10:53:04 INFO - "product": "firefox", 10:53:04 INFO - "script_repo_revision": "production", 10:53:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:53:04 INFO - "repository": "", 10:53:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:53:04 INFO - "buildid": "20161031084722", 10:53:04 INFO - "pgo_build": "False", 10:53:04 INFO - "basedir": "/builds/slave/test", 10:53:04 INFO - "buildnumber": 158, 10:53:04 INFO - "slavename": "t-yosemite-r7-0291", 10:53:04 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:53:04 INFO - "platform": "yosemite_r7", 10:53:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:53:04 INFO - "branch": "mozilla-central", 10:53:04 INFO - "repo_path": "mozilla-central", 10:53:04 INFO - "revision": "8c9eed5227f8681cf08d2ee8fb3bfd5d743e4096", 10:53:04 INFO - "stage_platform": "macosx64", 10:53:04 INFO - "builduid": "67893dc2d0d5491496ae3cb1295160bf", 10:53:04 INFO - "slavebuilddir": "test" 10:53:04 INFO - } 10:53:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:53:04 INFO - Running post-action listener: _resource_record_post_action 10:53:04 INFO - [mozharness: 2016-10-31 17:53:04.847053Z] Finished read-buildbot-config step (success) 10:53:04 INFO - [mozharness: 2016-10-31 17:53:04.847207Z] Running download-and-extract step. 10:53:04 INFO - Running pre-action listener: _resource_record_pre_action 10:53:04 INFO - Running main action method: download_and_extract 10:53:04 INFO - mkdir: /builds/slave/test/build/tests 10:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:04 INFO - trying https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:53:04 INFO - Downloading https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 10:53:05 INFO - Downloaded 1199 bytes. 10:53:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:53:05 INFO - Using the following test package requirements: 10:53:05 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:53:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:53:05 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:53:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:53:05 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:53:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:53:05 INFO - u'jsshell-mac.zip'], 10:53:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:53:05 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:53:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:53:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:53:05 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:53:05 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:53:05 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:53:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:53:05 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:53:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:53:05 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:53:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:53:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:53:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:05 INFO - Fetch https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:53:06 INFO - Http code: 200 10:53:06 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 10:53:06 INFO - x-amz-cf-id: DEmvzv-q_BH5XWcrO5NSGCRoupm2sPFH5w-zEGOHyuKZNbFw_VQJaA== 10:53:06 INFO - x-amz-version-id: hMu_fxVK.AuOgiZGYj578w09GIT1F4Na 10:53:06 INFO - Expected file size: 16404116 10:53:06 INFO - Obtained file size: 16404116 10:53:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:53:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:53:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:12 INFO - Fetch https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:53:13 INFO - Http code: 200 10:53:13 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 10:53:13 INFO - x-amz-cf-id: N_zzeraiwmYqUNRHnXSBlS9r6RiXSi6N4tCxRhf7gWLV43IwuqKLcg== 10:53:13 INFO - x-amz-version-id: hMu_fxVK.AuOgiZGYj578w09GIT1F4Na 10:53:13 INFO - Expected file size: 16404116 10:53:13 INFO - Obtained file size: 16404116 10:53:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:53:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:53:20 INFO - Fetch https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:53:20 INFO - Http code: 200 10:53:20 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 10:53:20 INFO - x-amz-cf-id: O9YvdnmF1p9F-aUKsNAYSRuLWqJ4D3TKhtjbfp9VaLchp2gs_1xFtQ== 10:53:20 INFO - x-amz-version-id: 10lUHbJDNB9QgTsspDyc.5RAaqCN7BZq 10:53:21 INFO - Expected file size: 14409038 10:53:21 INFO - Obtained file size: 14409038 10:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:22 INFO - trying https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:53:22 INFO - Downloading https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 10:53:24 INFO - Downloaded 112073077 bytes. 10:53:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:53:24 INFO - mkdir: /builds/slave/test/properties 10:53:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:24 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:24 INFO - Contents: 10:53:24 INFO - build_url:https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:53:25 INFO - Running post-action listener: _resource_record_post_action 10:53:25 INFO - Running post-action listener: set_extra_try_arguments 10:53:25 INFO - [mozharness: 2016-10-31 17:53:25.514815Z] Finished download-and-extract step (success) 10:53:25 INFO - [mozharness: 2016-10-31 17:53:25.514958Z] Running populate-webroot step. 10:53:25 INFO - Running pre-action listener: _resource_record_pre_action 10:53:25 INFO - Running main action method: populate_webroot 10:53:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:25 INFO - '--tppagecycles', 10:53:25 INFO - '7'], 10:53:25 INFO - 'tests': ['tsvgm']}}, 10:53:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:53:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:53:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:53:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:25 INFO - 'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:25 INFO - 'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['damp', 'tps']}, 10:53:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:25 INFO - 'tests': ['damp', 'tps']}, 10:53:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['dromaeo_dom']}, 10:53:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['basic_compositor_video']}, 10:53:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:53:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['a11yr', 10:53:25 INFO - 'ts_paint', 10:53:25 INFO - 'tpaint', 10:53:25 INFO - 'sessionrestore', 10:53:25 INFO - 'sessionrestore_no_auto_restore', 10:53:25 INFO - 'tabpaint']}, 10:53:25 INFO - 'other-e10s': {'tests': ['a11yr', 10:53:25 INFO - 'ts_paint', 10:53:25 INFO - 'tpaint', 10:53:25 INFO - 'sessionrestore', 10:53:25 INFO - 'sessionrestore_no_auto_restore', 10:53:25 INFO - 'tabpaint']}, 10:53:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:53:25 INFO - 'ts_paint', 10:53:25 INFO - 'tpaint', 10:53:25 INFO - 'sessionrestore', 10:53:25 INFO - 'sessionrestore_no_auto_restore', 10:53:25 INFO - 'tabpaint']}, 10:53:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:53:25 INFO - 'ts_paint', 10:53:25 INFO - 'tpaint', 10:53:25 INFO - 'sessionrestore', 10:53:25 INFO - 'sessionrestore_no_auto_restore', 10:53:25 INFO - 'tabpaint']}, 10:53:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['a11yr', 10:53:25 INFO - 'ts_paint', 10:53:25 INFO - 'tpaint', 10:53:25 INFO - 'sessionrestore', 10:53:25 INFO - 'sessionrestore_no_auto_restore', 10:53:25 INFO - 'tabpaint']}, 10:53:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['a11yr', 10:53:25 INFO - 'ts_paint', 10:53:25 INFO - 'tpaint', 10:53:25 INFO - 'sessionrestore', 10:53:25 INFO - 'sessionrestore_no_auto_restore', 10:53:25 INFO - 'tabpaint']}, 10:53:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['tsvgx', 10:53:25 INFO - 'tsvgr_opacity', 10:53:25 INFO - 'tart', 10:53:25 INFO - 'tscrollx', 10:53:25 INFO - 'cart']}, 10:53:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:53:25 INFO - 'tsvgr_opacity', 10:53:25 INFO - 'tart', 10:53:25 INFO - 'tscrollx', 10:53:25 INFO - 'cart']}, 10:53:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:25 INFO - 'talos_options': ['--disable-e10s'], 10:53:25 INFO - 'tests': ['tp5o']}, 10:53:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:25 INFO - 'tests': ['tp5o']}, 10:53:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:25 INFO - 'talos_options': ['--disable-e10s', 10:53:25 INFO - '--xperf_path', 10:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:25 INFO - 'tests': ['tp5n']}, 10:53:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:25 INFO - 'talos_options': ['--xperf_path', 10:53:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:25 INFO - 'tests': ['tp5n']}}, 10:53:25 INFO - 'talos.zip': {'path': '', 10:53:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:25 INFO - Running post-action listener: _resource_record_post_action 10:53:25 INFO - [mozharness: 2016-10-31 17:53:25.533499Z] Finished populate-webroot step (success) 10:53:25 INFO - [mozharness: 2016-10-31 17:53:25.533634Z] Running create-virtualenv step. 10:53:25 INFO - Running pre-action listener: _resource_record_pre_action 10:53:25 INFO - Running main action method: create_virtualenv 10:53:25 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:25 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 10:53:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:25 INFO - Using real prefix '/tools/python27' 10:53:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:29 INFO - Installing pip.................done. 10:53:29 INFO - Return code: 0 10:53:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:53:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:53:29 INFO - Reading from file tmpfile_stdout 10:53:29 INFO - Output received: 10:53:29 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) 10:53:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53:29 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')]} 10:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:29 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')]} 10:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:29 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 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:29 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 10:53:29 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 10:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:29 INFO - 'HOME': '/Users/cltbld', 10:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:29 INFO - 'LOGNAME': 'cltbld', 10:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:29 INFO - 'MOZ_NO_REMOTE': '1', 10:53:29 INFO - 'NO_EM_RESTART': '1', 10:53:29 INFO - 'PAGER': '/bin/cat', 10:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:29 INFO - 'PWD': '/builds/slave/test', 10:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:29 INFO - 'SHELL': '/bin/bash', 10:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:29 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:29 INFO - 'USER': 'cltbld', 10:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:29 INFO - 'XPC_FLAGS': '0x0', 10:53:29 INFO - 'XPC_SERVICE_NAME': '0', 10:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:29 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 10:53:29 INFO - Cleaning up... 10:53:29 INFO - Return code: 0 10:53:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:53:29 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')]} 10:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:29 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')]} 10:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:29 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 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:29 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 10:53:29 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 10:53:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:29 INFO - 'HOME': '/Users/cltbld', 10:53:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:29 INFO - 'LOGNAME': 'cltbld', 10:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:29 INFO - 'MOZ_NO_REMOTE': '1', 10:53:29 INFO - 'NO_EM_RESTART': '1', 10:53:29 INFO - 'PAGER': '/bin/cat', 10:53:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:29 INFO - 'PWD': '/builds/slave/test', 10:53:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:29 INFO - 'SHELL': '/bin/bash', 10:53:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:29 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:29 INFO - 'USER': 'cltbld', 10:53:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:29 INFO - 'XPC_FLAGS': '0x0', 10:53:29 INFO - 'XPC_SERVICE_NAME': '0', 10:53:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:29 INFO - Downloading/unpacking psutil>=3.1.1 10:53:29 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 10:53:29 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 10:53:29 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 10:53:29 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 10:53:29 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 10:53:29 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 10:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:33 INFO - Installing collected packages: psutil 10:53:33 INFO - Running setup.py install for psutil 10:53:33 INFO - building 'psutil._psutil_osx' extension 10:53:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:53:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:53:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:53:34 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 10:53:34 INFO - building 'psutil._psutil_posix' extension 10:53:34 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 10:53:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:53:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:53:34 INFO - ^ 10:53:34 INFO - 1 warning generated. 10:53:34 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 10:53:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:34 INFO - Successfully installed psutil 10:53:34 INFO - Cleaning up... 10:53:34 INFO - Return code: 0 10:53:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:53:34 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')]} 10:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:34 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')]} 10:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:34 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 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:34 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 10:53:34 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 10:53:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:34 INFO - 'HOME': '/Users/cltbld', 10:53:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:34 INFO - 'LOGNAME': 'cltbld', 10:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:34 INFO - 'MOZ_NO_REMOTE': '1', 10:53:34 INFO - 'NO_EM_RESTART': '1', 10:53:34 INFO - 'PAGER': '/bin/cat', 10:53:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:34 INFO - 'PWD': '/builds/slave/test', 10:53:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:34 INFO - 'SHELL': '/bin/bash', 10:53:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:34 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:34 INFO - 'USER': 'cltbld', 10:53:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:34 INFO - 'XPC_FLAGS': '0x0', 10:53:34 INFO - 'XPC_SERVICE_NAME': '0', 10:53:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:53:34 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 10:53:34 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 10:53:34 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 10:53:34 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 10:53:34 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 10:53:34 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 10:53:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:53:37 INFO - Installing collected packages: mozsystemmonitor 10:53:37 INFO - Running setup.py install for mozsystemmonitor 10:53:37 INFO - Successfully installed mozsystemmonitor 10:53:37 INFO - Cleaning up... 10:53:37 INFO - Return code: 0 10:53:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:37 INFO - 'HOME': '/Users/cltbld', 10:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:37 INFO - 'LOGNAME': 'cltbld', 10:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:37 INFO - 'MOZ_NO_REMOTE': '1', 10:53:37 INFO - 'NO_EM_RESTART': '1', 10:53:37 INFO - 'PAGER': '/bin/cat', 10:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:37 INFO - 'PWD': '/builds/slave/test', 10:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:37 INFO - 'SHELL': '/bin/bash', 10:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:37 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:37 INFO - 'USER': 'cltbld', 10:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:37 INFO - 'XPC_FLAGS': '0x0', 10:53:37 INFO - 'XPC_SERVICE_NAME': '0', 10:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:37 INFO - Downloading/unpacking jsonschema==2.5.1 10:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:53:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:53:40 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 10:53:40 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 10:53:40 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 10:53:40 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 10:53:40 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 10:53:40 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 10:53:40 INFO - Downloading functools32-3.2.3-2.tar.gz 10:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:53:40 INFO - warning: no files found matching '*.txt' 10:53:40 INFO - no previously-included directories found matching 'build' 10:53:40 INFO - no previously-included directories found matching 'dist' 10:53:40 INFO - no previously-included directories found matching '.git*' 10:53:40 INFO - Installing collected packages: jsonschema, functools32 10:53:40 INFO - Running setup.py install for functools32 10:53:40 INFO - warning: no files found matching '*.txt' 10:53:40 INFO - no previously-included directories found matching 'build' 10:53:40 INFO - no previously-included directories found matching 'dist' 10:53:40 INFO - no previously-included directories found matching '.git*' 10:53:40 INFO - Successfully installed jsonschema functools32 10:53:40 INFO - Cleaning up... 10:53:40 INFO - Return code: 0 10:53:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:40 INFO - 'HOME': '/Users/cltbld', 10:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:40 INFO - 'LOGNAME': 'cltbld', 10:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:40 INFO - 'MOZ_NO_REMOTE': '1', 10:53:40 INFO - 'NO_EM_RESTART': '1', 10:53:40 INFO - 'PAGER': '/bin/cat', 10:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:40 INFO - 'PWD': '/builds/slave/test', 10:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:40 INFO - 'SHELL': '/bin/bash', 10:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:40 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:40 INFO - 'USER': 'cltbld', 10:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:40 INFO - 'XPC_FLAGS': '0x0', 10:53:40 INFO - 'XPC_SERVICE_NAME': '0', 10:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:53:41 INFO - Cleaning up... 10:53:41 INFO - Return code: 0 10:53:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:53:41 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')]} 10:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:41 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')]} 10:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:41 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 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:41 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 10:53:41 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 10:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:41 INFO - 'HOME': '/Users/cltbld', 10:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:41 INFO - 'LOGNAME': 'cltbld', 10:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:41 INFO - 'MOZ_NO_REMOTE': '1', 10:53:41 INFO - 'NO_EM_RESTART': '1', 10:53:41 INFO - 'PAGER': '/bin/cat', 10:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:41 INFO - 'PWD': '/builds/slave/test', 10:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:41 INFO - 'SHELL': '/bin/bash', 10:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:41 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:41 INFO - 'USER': 'cltbld', 10:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:41 INFO - 'XPC_FLAGS': '0x0', 10:53:41 INFO - 'XPC_SERVICE_NAME': '0', 10:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:41 INFO - Downloading/unpacking blobuploader==1.2.4 10:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:43 INFO - Downloading blobuploader-1.2.4.tar.gz 10:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:53:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:53:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:45 INFO - Downloading docopt-0.6.1.tar.gz 10:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:53:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:53:45 INFO - Running setup.py install for blobuploader 10:53:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:53:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:53:45 INFO - Running setup.py install for requests 10:53:45 INFO - Running setup.py install for docopt 10:53:46 INFO - Successfully installed blobuploader requests docopt 10:53:46 INFO - Cleaning up... 10:53:46 INFO - Return code: 0 10:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:46 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 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:46 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 10:53:46 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 10:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:46 INFO - 'HOME': '/Users/cltbld', 10:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:46 INFO - 'LOGNAME': 'cltbld', 10:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:46 INFO - 'MOZ_NO_REMOTE': '1', 10:53:46 INFO - 'NO_EM_RESTART': '1', 10:53:46 INFO - 'PAGER': '/bin/cat', 10:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:46 INFO - 'PWD': '/builds/slave/test', 10:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:46 INFO - 'SHELL': '/bin/bash', 10:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:46 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:46 INFO - 'USER': 'cltbld', 10:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:46 INFO - 'XPC_FLAGS': '0x0', 10:53:46 INFO - 'XPC_SERVICE_NAME': '0', 10:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-siSko9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-gHf_XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-tgQ8dQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-yr1LrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-edxpgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:46 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-FC_G2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-rt0t0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-G2faUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-JRvPYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-VVuGLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-hwgy7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-d7hcO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-HeUP9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ZENp3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-Ic_gKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:47 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-whR0QC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:48 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-JG6IYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:53:48 INFO - Running setup.py install for manifestparser 10:53:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:53:48 INFO - Running setup.py install for mozcrash 10:53:48 INFO - Running setup.py install for mozdebug 10:53:48 INFO - Running setup.py install for mozdevice 10:53:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:53:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:53:48 INFO - Running setup.py install for mozfile 10:53:48 INFO - Running setup.py install for mozhttpd 10:53:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:53:49 INFO - Running setup.py install for mozinfo 10:53:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:53:49 INFO - Running setup.py install for mozInstall 10:53:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:53:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:53:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:53:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:53:49 INFO - Running setup.py install for mozleak 10:53:49 INFO - Running setup.py install for mozlog 10:53:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:53:49 INFO - Running setup.py install for moznetwork 10:53:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:53:49 INFO - Running setup.py install for mozprocess 10:53:49 INFO - Running setup.py install for mozprofile 10:53:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:53:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:53:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:53:50 INFO - Running setup.py install for mozrunner 10:53:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:53:50 INFO - Running setup.py install for mozscreenshot 10:53:50 INFO - Running setup.py install for moztest 10:53:50 INFO - Running setup.py install for mozversion 10:53:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:53:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:53:50 INFO - Cleaning up... 10:53:50 INFO - Return code: 0 10:53:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 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 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:51 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 10:53:51 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 10:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:51 INFO - 'HOME': '/Users/cltbld', 10:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:51 INFO - 'LOGNAME': 'cltbld', 10:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:51 INFO - 'MOZ_NO_REMOTE': '1', 10:53:51 INFO - 'NO_EM_RESTART': '1', 10:53:51 INFO - 'PAGER': '/bin/cat', 10:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:51 INFO - 'PWD': '/builds/slave/test', 10:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:51 INFO - 'SHELL': '/bin/bash', 10:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:51 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:51 INFO - 'USER': 'cltbld', 10:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:51 INFO - 'XPC_FLAGS': '0x0', 10:53:51 INFO - 'XPC_SERVICE_NAME': '0', 10:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:53:51 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-DqUkV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:53:51 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)) 10:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:53:51 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-StvVOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:53:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:53:51 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-5anrbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-pBU4HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-kM7abz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-lEDBbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-YzyAou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-TkbwvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-ujzC33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-oWfTI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-IzGbsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:53:52 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)) 10:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:53:52 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-PCwXr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:53:53 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)) 10:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:53:53 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-oc5Gso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:53:53 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)) 10:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:53:53 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-_2etvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:53 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-t_XdC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:53:53 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)) 10:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:53:53 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-2QTRQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:53:53 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)) 10:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:53:53 INFO - Running setup.py (path:/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/pip-KJ_uvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:53:53 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)) 10:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:53:53 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)) 10:53:53 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)) 10:53:53 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)) 10:53:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:56 INFO - Downloading blessings-1.6.tar.gz 10:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:53:56 INFO - Installing collected packages: blessings 10:53:56 INFO - Running setup.py install for blessings 10:53:56 INFO - Successfully installed blessings 10:53:56 INFO - Cleaning up... 10:53:56 INFO - Return code: 0 10:53:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:56 INFO - Reading from file tmpfile_stdout 10:53:56 INFO - Current package versions: 10:53:56 INFO - blessings == 1.6 10:53:56 INFO - blobuploader == 1.2.4 10:53:56 INFO - docopt == 0.6.1 10:53:56 INFO - functools32 == 3.2.3-2 10:53:56 INFO - jsonschema == 2.5.1 10:53:56 INFO - manifestparser == 1.1 10:53:56 INFO - mozInstall == 1.12 10:53:56 INFO - mozcrash == 0.17 10:53:56 INFO - mozdebug == 0.1 10:53:56 INFO - mozdevice == 0.48 10:53:56 INFO - mozfile == 1.2 10:53:56 INFO - mozhttpd == 0.7 10:53:56 INFO - mozinfo == 0.9 10:53:56 INFO - mozleak == 0.1 10:53:56 INFO - mozlog == 3.4 10:53:56 INFO - moznetwork == 0.27 10:53:56 INFO - mozprocess == 0.23 10:53:56 INFO - mozprofile == 0.28 10:53:56 INFO - mozrunner == 6.12 10:53:56 INFO - mozscreenshot == 0.1 10:53:56 INFO - mozsystemmonitor == 0.3 10:53:56 INFO - moztest == 0.7 10:53:56 INFO - mozversion == 1.4 10:53:56 INFO - psutil == 3.1.1 10:53:56 INFO - requests == 1.2.3 10:53:56 INFO - wsgiref == 0.1.2 10:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:56 INFO - 'HOME': '/Users/cltbld', 10:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:56 INFO - 'LOGNAME': 'cltbld', 10:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:56 INFO - 'MOZ_NO_REMOTE': '1', 10:53:56 INFO - 'NO_EM_RESTART': '1', 10:53:56 INFO - 'PAGER': '/bin/cat', 10:53:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:56 INFO - 'PWD': '/builds/slave/test', 10:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:56 INFO - 'SHELL': '/bin/bash', 10:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:56 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:56 INFO - 'USER': 'cltbld', 10:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:56 INFO - 'XPC_FLAGS': '0x0', 10:53:56 INFO - 'XPC_SERVICE_NAME': '0', 10:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 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)) 10:53:57 INFO - Cleaning up... 10:53:57 INFO - Return code: 0 10:53:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:53:57 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')]} 10:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:57 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')]} 10:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c1da490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c150570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd0c70250>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, '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.orpOXxkme2/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.i9ZWWiqL9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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 10:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:53:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:53:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:57 INFO - 'HOME': '/Users/cltbld', 10:53:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:57 INFO - 'LOGNAME': 'cltbld', 10:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:57 INFO - 'MOZ_NO_REMOTE': '1', 10:53:57 INFO - 'NO_EM_RESTART': '1', 10:53:57 INFO - 'PAGER': '/bin/cat', 10:53:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:57 INFO - 'PWD': '/builds/slave/test', 10:53:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:57 INFO - 'SHELL': '/bin/bash', 10:53:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:53:57 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:53:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:57 INFO - 'USER': 'cltbld', 10:53:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:57 INFO - 'XPC_FLAGS': '0x0', 10:53:57 INFO - 'XPC_SERVICE_NAME': '0', 10:53:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:53:57 INFO - Cleaning up... 10:53:57 INFO - Return code: 0 10:53:57 INFO - Running post-action listener: _resource_record_post_action 10:53:57 INFO - Running post-action listener: _start_resource_monitoring 10:53:57 INFO - Starting resource monitoring. 10:53:57 INFO - [mozharness: 2016-10-31 17:53:57.342490Z] Finished create-virtualenv step (success) 10:53:57 INFO - [mozharness: 2016-10-31 17:53:57.343515Z] Running install step. 10:53:57 INFO - Running pre-action listener: _resource_record_pre_action 10:53:57 INFO - Running main action method: install 10:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:53:57 INFO - Reading from file tmpfile_stdout 10:53:57 INFO - Detecting whether we're running mozinstall >=1.0... 10:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:57 INFO - Reading from file tmpfile_stdout 10:53:57 INFO - Output received: 10:53:57 INFO - Usage: mozinstall [options] installer 10:53:57 INFO - Options: 10:53:57 INFO - -h, --help show this help message and exit 10:53:57 INFO - -d DEST, --destination=DEST 10:53:57 INFO - Directory to install application into. [default: 10:53:57 INFO - "/builds/slave/test"] 10:53:57 INFO - --app=APP Application being installed. [default: firefox] 10:53:57 INFO - mkdir: /builds/slave/test/build/application 10:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:54:31 INFO - Reading from file tmpfile_stdout 10:54:31 INFO - Output received: 10:54:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:54:31 INFO - Running post-action listener: _resource_record_post_action 10:54:31 INFO - [mozharness: 2016-10-31 17:54:31.654865Z] Finished install step (success) 10:54:31 INFO - [mozharness: 2016-10-31 17:54:31.655008Z] Running run-tests step. 10:54:31 INFO - Running pre-action listener: _resource_record_pre_action 10:54:31 INFO - Running main action method: run_tests 10:54:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:54:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:54:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:54:31 INFO - 2016-10-31 10:54:31.669 screenresolution[1989:10803] starting screenresolution argv=screenresolution get 10:54:31 INFO - 2016-10-31 10:54:31.672 screenresolution[1989:10803] Display 0: 1600x1200x32@60 10:54:31 INFO - 2016-10-31 10:54:31.678 screenresolution[1990:10805] starting screenresolution argv=screenresolution list 10:54:31 INFO - Available Modes on Display 0 10:54:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:54:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:54:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:54:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:54:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:54:31 INFO - Intel Iris: 10:54:31 INFO - Chipset Model: Intel Iris 10:54:31 INFO - Type: GPU 10:54:31 INFO - Bus: Built-In 10:54:31 INFO - VRAM (Dynamic, Max): 1536 MB 10:54:31 INFO - Vendor: Intel (0x8086) 10:54:31 INFO - Device ID: 0x0a2e 10:54:31 INFO - Revision ID: 0x0009 10:54:31 INFO - Displays: 10:54:31 INFO - Display: 10:54:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:54:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:54:31 INFO - Display Serial Number: 1600x1200 60 10:54:31 INFO - Main Display: Yes 10:54:31 INFO - Mirror: Off 10:54:31 INFO - Online: Yes 10:54:31 INFO - Rotation: Supported 10:54:31 INFO - Return code: 0 10:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:31 INFO - Python 2.7.3 10:54:31 INFO - Return code: 0 10:54:31 INFO - grabbing minidump binary from tooltool 10:54:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:54:31 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 0x10bfeed30>, '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 0x10be14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10bfe6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:31 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 10:54:31 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 10:54:31 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 10:54:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:32 INFO - Return code: 0 10:54:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:54:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:54:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:32 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/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 10:54:32 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/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0291 --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 10:54:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.orpOXxkme2/Render', 10:54:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:32 INFO - 'HOME': '/Users/cltbld', 10:54:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:32 INFO - 'LOGNAME': 'cltbld', 10:54:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:32 INFO - 'MOZ_NO_REMOTE': '1', 10:54:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:32 INFO - 'NO_EM_RESTART': '1', 10:54:32 INFO - 'PAGER': '/bin/cat', 10:54:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:32 INFO - 'PWD': '/builds/slave/test', 10:54:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:32 INFO - 'SHELL': '/bin/bash', 10:54:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.i9ZWWiqL9h/Listeners', 10:54:32 INFO - 'TMPDIR': '/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/', 10:54:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:32 INFO - 'USER': 'cltbld', 10:54:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:32 INFO - 'XPC_FLAGS': '0x0', 10:54:32 INFO - 'XPC_SERVICE_NAME': '0', 10:54:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:32 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/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0291', '--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 10:54:32 INFO - mozversion application_buildid: 20161031084722 10:54:32 INFO - mozversion application_changeset: 8c9eed5227f8681cf08d2ee8fb3bfd5d743e4096 10:54:32 INFO - mozversion application_display_name: Nightly 10:54:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:32 INFO - mozversion application_name: Firefox 10:54:32 INFO - mozversion application_remotingname: firefox 10:54:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:54:32 INFO - mozversion application_vendor: Mozilla 10:54:32 INFO - mozversion application_version: 52.0a1 10:54:32 INFO - mozversion platform_buildid: 20161031084722 10:54:32 INFO - mozversion platform_changeset: 8c9eed5227f8681cf08d2ee8fb3bfd5d743e4096 10:54:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:54:32 INFO - mozversion platform_version: 52.0a1 10:54:32 INFO - using testdate: 1477936472 10:54:32 INFO - actual date: 1477936472 10:54:32 INFO - starting webserver on 'localhost:49392' 10:54:32 INFO - SUITE-START | Running 2 tests 10:54:32 INFO - TEST-START | dromaeo_css 10:54:32 INFO - operating with platform_type : mac_ 10:54:32 INFO - Initialising browser for dromaeo_css test... 10:54:32 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp3NBu9s/profile http://localhost:49392/getInfo.html) 10:54:35 INFO - PROCESS | 2000 | 2016-10-31 10:54:35.030 plugin-container[2002:10958] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 10:54:35 INFO - PROCESS | 2000 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:35 INFO - PROCESS | 2000 | 2016-10-31 10:54:35.032 plugin-container[2002:10958] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 10:54:35 INFO - PROCESS | 2000 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:35 INFO - PROCESS | 2000 | 2016-10-31 10:54:35.033 plugin-container[2002:10958] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:54:35 INFO - PROCESS | 2000 | __metrics Screen width/height:1600/1200 10:54:35 INFO - PROCESS | 2000 | colorDepth:24 10:54:35 INFO - PROCESS | 2000 | Browser inner width/height: 1024/689 10:54:35 INFO - PROCESS | 2000 | __metrics 10:54:35 ERROR - PROCESS | 2000 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 10:54:35 INFO - TEST-INFO | 2000: exit 0 10:54:35 INFO - Browser initialized. 10:54:35 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:35 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmp3NBu9s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:54:38 INFO - PROCESS | 2003 | 2016-10-31 10:54:38.318 plugin-container[2004:11076] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 10:54:38 INFO - PROCESS | 2003 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:38 INFO - PROCESS | 2003 | 2016-10-31 10:54:38.319 plugin-container[2004:11076] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 10:54:38 INFO - PROCESS | 2003 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:54:38 INFO - PROCESS | 2003 | 2016-10-31 10:54:38.319 plugin-container[2004:11076] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:54:47 INFO - PROCESS | 2003 | RSS: Main: 239620096 10:54:47 INFO - PROCESS | 2003 | 10:55:37 INFO - PROCESS | 2003 | 1477936537593 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] 10:57:50 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49392/tests/dromaeo/cssquery-ext.html) 10:57:52 INFO - PROCESS | 2003 | RSS: Main: 255684608 10:57:52 INFO - PROCESS | 2003 | 11:00:54 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-ext.html (next: http://localhost:49392/tests/dromaeo/cssquery-jquery.html) 11:00:55 INFO - PROCESS | 2003 | RSS: Main: 262606848 11:00:55 INFO - PROCESS | 2003 | 11:03:57 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49392/tests/dromaeo/cssquery-mootools.html) 11:03:57 INFO - PROCESS | 2003 | RSS: Main: 270450688 11:03:57 INFO - PROCESS | 2003 | 11:06:59 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49392/tests/dromaeo/cssquery-prototype.html) 11:07:00 INFO - PROCESS | 2003 | RSS: Main: 270004224 11:07:00 INFO - PROCESS | 2003 | 11:10:03 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49392/tests/dromaeo/cssquery-yui.html) 11:10:04 INFO - PROCESS | 2003 | RSS: Main: 275365888 11:10:04 INFO - PROCESS | 2003 | 11:13:06 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-yui.html (next: http://localhost:49392/tests/dromaeo/cssquery-dojo.html) 11:13:07 INFO - PROCESS | 2003 | RSS: Main: 277430272 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - PROCESS | 2003 | __start_tp_report 11:13:07 INFO - PROCESS | 2003 | _x_x_mozilla_page_load 11:13:07 INFO - PROCESS | 2003 | _x_x_mozilla_page_load_details 11:13:07 INFO - PROCESS | 2003 | |i|pagename|runs| 11:13:07 INFO - PROCESS | 2003 | |0;dojo.html;3282.048206020254;3289.0626171541116;3301.620313663929;3318.236805534726;3330.8334583270844;5539.030669632813;5569.832905012851;5597.160425936112;5597.916031259534;5601.719914004304;5440.238366628675;5575.2473416088815;5583.553315734742;5585.385607583163;5589.972050139754;5036.2949187113745;5139.640225184238;5147.305113809625;5165.81919632813;5201.55786758126;5143.099957507421;5165.457626949173;5176;5189.506996835314;5285.286486324355;4171.91656166875;5087.618428617869;5152.995165942642;5205.6616319939085;5214.270002199676;5058.519440653132;5124.205748109049;5151.330327057496;5175.45657705943;5193.169092945149;5096.770645320969;5100.821471248526;5117.6161787865685;5147.4080480744815;5152.330197074394;4382.868513944587;4670.509596492388;4796.824777929395;5043.3191519145175;5488.204210389511;6044.184035155242;6058.818235452944;6063.696815159225;6071.969640151815;6080.452759251644;6081.543884208658;6110.558759196641;6111.652512877612;6146.446819786196;6179.073139029137;4729.834455794065;5748.5688573357165;5765.423457654201;5772.740226689767;5783.884322313572;6082.452579267887;6117.908231376533;6160.507159427235;6180.289266734293;6192.68691250179;5979.641221526722;5984.820455386345;6021.759129634853;6030.849228769316;6087.8478038048515;6045.33501314855;6101.725422356005;6118.694065296718;6128.1726966858905;6138.14066030756;5978.730957106941;6032.54755893301;6045.727942242522;6048.395160483917;6108.664023478751;6089.604175728564;6093.177421048102;6129.756146212572;6131.682521312785;6143.573288550997;4816.614670826396;4835.153848076572;4847.854564363075;4850.1269771440775;4893;4303.33298338758;4351.912021994502;4381.78091095444;4407.405000324915;4425.845095421645;5620.91568626471;5625.184348269559;5705.686187259741;5750.942490575125;5795.739191736382;6021.096835474714;6079.665618391031;6108.236470441195;6139.6009259398;6150.015997440388;5536.944630553643;5724.771009159587;5740.225069615632;5744.281964754406;5764.884702306014;5245.554127899095;5275.287836142148;5292.52367286946;5337.2527846101575;5365.704886231295;6160.507159427325;6168.506519478431;6183.134361189347;6186.566940314135;6196.659183744938;5101.852083281232;6126.326104128631;6145.877082458415;6164.907526387197;6165.260168779775;6118.663473509;6120.051392034242;6129.601575897553;6139.798803208881;6292.811215663537;6088.4215999479975;6103.542234332532;6105.9694701526205;6106.915739268716;6112.694365281807;4234.809433575558;5952.345242023287;6099.573029887865;6144.262688477233;6144.631322120687;5888.735006924613;5954.166416701579;5963.224780778471;5986.820395388146;6049.213602231682;5896.410358964241;5925.851853703692;5993.580449368503;6013.3685962975005;6063.090536419572;5655.179998900054;5670.8015219467125;5850.707464626837;5864.32560255576;5921.881562368814;4759.714417134983;5797.30432348104;5913.91129133072;5980.611260268069;6070.028795392716;5881.235439392852;5926.67403292823;5933.317668468008;5947.732352044082;5954.46409823118 11:13:07 INFO - PROCESS | 2003 | |1;ext.html;492.10682611060923;498.26505903791934;506.0486285782732;507.1859665237294;547.3896605285107;39210.60789392105;40800;40822.59177408225;42498;42561;41904.161916761725;42097.57902420975;42107.94730131748;42302.15395692092;42324.57675423245;9448.811023779537;9481.47851868147;9529;9568.138867501924;9670.854937175913;9569.569369378394;9654.324197306192;9657.46883921384;9660.647509348697;9680.322377433582;9635.084666956664;9692;9700.660476883311;9706.272029597809;9745.463999480025;9555.18780903624;9582.185514231298;9605.95197024014;9673.467959262238;9683.41899486033;9443.15011648948;9446.716598501987;9473.66842160528;9475.815523059617;9531.094546018117;35059.4741078884;40142.799286003385;40212.59787402147;40358.39462408066;40359;3321.4353559894876;3334.816585087819;3368.1411240133853;3545.308664810363;4018.738781979191;30584;30688.38623227523;30968.690313096806;31692.573834177518;31762.888298909427;3165.7773194027227;3205.1506350817053;3210.165357007195;3241.9351612967607;3296.9835150824333;486889;489778.55110724573;491786.54106729594;493643;494199;60589.09116363258;60727;60776.08835867466;60792.696036519534;61103;63540.36459635344;63885.361146388874;64111;64171.358286417475;64263.678681606296;15891.205439728199;16031.19844007795;16106.677866442606;16138.677226455406;16173.919130404272;12275.140740148283;12291.754164916652;12398.5660501882;12426.94370978477;12442.626721198198;17398.67872370318;18732.81267187338;18803.905980470012;18896.71654925177;18942.242310307432;3138.952915706266;7462.701491940262;7710.922890771133;7733.729319473791;7756.961215193888;845.7970087179033;925.9999200863052;936.1995493852794;1041.1722680469045;1065.5098654618962;29218.707812922024;29572.96494622721;30362.240943976576;30387;30777.922772703296;992.6624947517879;1053.5417093564324;1106.8599342677055;1116.8827273136367;1134.8354488599107;15596;15698.843011569737;15704.60738481547;15815.604609884615;16059.277332520065;656164;662133;663103;668792;669062;46066;50396.24405633919;56564;57155.85688286211;57411;1327.4889167670517;1355.4171706166444;1358.3683587132032;1365.2627581106092;1374.4021350712471;25658.61512077358;29176.7082329174;29903.700962990093;29945.251368715955;30258.54612180863;50022;50321.49678503168;50574.988500229054;50756.492435075175;50792.74603627106;486590;611039;611360;615371.8462815493;619322;26177.607335889596;26355.736442636095;26652.466950661266;26692.733072669802;26720.19839404821;34831.47752783761;43503.78248108739;45831.77084114558;46079;47135;38551.42172867353;38739.03152421212;39478;39652.20695586014;40189;31962.52056219205;35064.82467587646;38145.61854381532;38588.80705596454;38656.03359915912;30838.845805770827;37521.2495750078;38180.80909595434;38926.80536597299;40279.59720402876;26904.865475672497;28282.85858570694;31323.68676313208;35033.94898153059;35054.64945350514;25391.61912571276;25808.09671661558;25829.354266142745;26003.479930400907;26373.868130659223 11:13:07 INFO - PROCESS | 2003 | |2;jquery.html;374.91002159481735;376.7720529079906;381.16144482139293;388.82891527727816;401.2817057467132;18237.996910169953;19844.702329465068;19896.900515497422;20162.68942518737;20391.490212744688;18865.905670471664;19647.803521964775;19807.603847923034;19893.502662433446;20237.392878213675;5700.144978253254;5713.8571535711735;5877.235959325281;6004.369541198177;6014.0678194879865;5805.071188609823;5810.1865738796605;5900.675462849542;5903.966805808987;5914.704264786765;5578.2748242728385;5833.82498525045;5845.941540584582;5847.678377689225;5918.763249470016;5737.2254745609225;5794.710264486801;5831.2419385479825;5885.4114588541015;5914.585978981473;4418.911621767579;4909.21452567591;5100.923486147711;5138.845834624967;5145.382554093495;24117.39706507334;24255.514889702285;24256.272311830675;24557.38606534833;24689;2208.558288342338;2229.108356657334;2325.453518423169;2429.6112621980574;2454.509098180371;15009.624759380993;15272.38910443592;15304.234788260543;15514.456994005268;15697.764533532007;1739.7912250529891;1830.4600142957859;1845.0866820923595;1916;1957.745493085904;113334;116856.99999999916;117055.8294417062;118030;119029.80970190273;9393.389429687048;9422.858657120149;11554.306741595363;11615;11797.646070617895;14285.071470354394;14472.914531410186;14742.189179595225;14752.40990360395;14756.778648320284;6396.776112836028;6464.612123272619;7782.64978075988;8296.004479462383;8559.186877246651;5869.706514674249;6440.677966101676;6860.799360112061;7947.284744373034;8091.797705057421;3452.464867945422;4380.452443444569;4543.432070991126;4604.309353596987;4644.744539050317;1908.740231447238;1953.540917884296;1973.3389314579777;1978.9208431662573;1982.4250967219634;821.5645707774889;888.3825741109996;944.607987685103;975.1272611013104;980.181548407088;20484.69272960907;21247;21296.467588310417;21484.462888427915;21540.35378938603;915.635702802819;931.9487428191379;934.9158575728217;944.8299306124826;986.4328011393334;10917.727056823644;11232.438378081064;11279.266847654877;11307.982281594695;11308.434578271053;513594;514581;518029;525480.3725981346;528716;117468;120397.39801300937;122316.38841805913;123619;124453;935.6304259817471;945.3902233059638;992.2310209587628;994.8308787506141;995.2833959549113;14982.550523484313;16394.508164755076;18863.24547018104;19072.61854762925;19117.522061948006;48344.54966351015;53942.46057539374;54151;54569.727151363986;54737.1789423151;73284;75092.62453687696;76113;76989.23010770045;84857.30285394134;6595.208574971034;8083;8093.231143041402;8276.751697449086;8311.916880831115;11710.590129345432;12584.30786306762;13166.868331316564;13182.143160694524;13333.399996999964;11010.50452729613;11106.888931110909;11394.145439091935;11505.309681419141;11661.475233614337;10727.517261723086;11096.668399792077;11177.273477223955;11310.208285419942;11499.942500287445;10204.948975255076;10881.510332035235;11593.768124637629;11819.231749936227;11839.644810655695;7074.080369551925;8232.958835205785;8277.503349799032;8314.919060522336;8387.119352467904;9277.953610231905;11360;11574.421278936188;11583.131265155316;11594 11:13:07 INFO - PROCESS | 2003 | |3;mootools.html;1319.5513525401361;1375.5529452927794;1643.3344495479334;1772.822717728228;1821.9817801821978;7599.316061554459;7799.454038217327;8068.193180681928;8567.485950842954;8624.698135565257;8072;8245.587720613976;8283.91716082839;8400.621972011259;8437.915620843805;2097.1401725292635;2200.8335582141412;2330.8951097200625;2350.15394457995;2357.422431504275;2065.7830927752593;2315.3632750993443;2348.2720356689397;2373.848683388555;2378.3221781792195;2136.6581346984485;2317.397476656073;2328.9534209315802;2339.1111377676543;2340.871252081135;2287.3595393289906;2298.425393651587;2303.2169062518824;2319.3273950554403;2322.988385058081;2278.9658155127686;2337.4222399880014;2340.1224540797202;2341.2273949596593;2344.402177444758;8409;8455.239028487404;8502.65989360431;8511.063782983867;8515.574221288973;5043.798248070073;5202.739863006872;5204.635675502716;5212.478752124795;5212.843614691566;3253.6908993645566;3494.930101397958;3500.5266191053497;3629.237860049393;3653.2510835278704;978.5156347607908;1014.7057353367514;1031.128696251666;1055.024102704995;1098.1379617000696;10986.890131098666;11045.889541104567;11090.500927458284;11119.777604447865;11120.054795342325;4460.487043989982;4578.336141259499;4660.766961651904;4672.556107169813;4755.191617425046;7943.64253608589;9434.764130896645;9486.430814151036;9515.04849515043;9528;5189.870253243699;5219.921701174486;5225.249541403672;5231.686098834082;5236.0575096483;4169.708120431601;4672.579467847842;4726.763661816895;4748.311494833299;4819.855404337875;3751.3247615429486;3797.7721336719887;3855.267499175148;3870.574236833946;3875.554311254242;1245.9252444853337;1255.0524354112586;1261.4071386448354;1261.4701825233424;1269.6571925580226;748.6818102306498;839.2321026260903;885.8981217159981;897.3673560140086;923.8660394242797;5671.177679236487;5732.369439361667;5819.301683797971;5852.4147585241135;6024.518038556905;919.793046564531;940.6801687426308;943.9056094390506;954.7756277274835;991.9782623897397;3832.80835958201;3865.16898866745;3881.378979363288;3949.170674158459;4007.939880901789;10006;10310.896891031143;10351.896481035094;10355.94822025885;10360.533775980099;9479.672845801593;10296.279260451696;10302.02130797573;10318.535665894902;10345.844812327821;7173.318534739192;7538.133114691771;7838.059432868093;7838.176991415933;7988.6804527819395;4470.859930717646;4984.37695288089;5718.1708652246025;5819.418058194146;5939.4357536034;7583.9620801895635;7662.923370766221;7900.960495197487;9224.40041397307;9565.569549370433;9225.21585665226;9438.056194380508;9461.905380946379;9582.329236953346;9595.13643772064;6637.568558043712;6759;7025.613591252531;7045.154581450259;7263.128424589083;7815.218478152139;7997;8036.397270204641;8037.437379383387;8049.993750781152;7162.713491460491;7171.354578087997;7218.314260145278;7272.418206543358;7404.407647388303;5686.260786097946;6414.935850641434;7018.789436316714;7140.250273721184;7581.962090189734;6485.935140648722;6534.346565343428;6614.867702645824;6623.205215374186;6624.768133115318;4903.5586797188425;4904.337914381513;5110.9488905110475;5172.767225474938;5192.169252919514;4208.842568293744;4842.685225460334;4882.096812089775;5229.215617657382;5277.630565860353 11:13:07 INFO - PROCESS | 2003 | |4;prototype.html;261.5893047914772;294.72737717611204;304.4990989821743;315.44166824720253;316.6722442272249;5226.118597304967;5299.5230429261355;5343.679379237239;5376.758045887935;5397.568194544437;4362.607365337119;4639.304104384344;4817.445993710716;5083.949160508394;5244.973775131119;3242.7081562659355;3440.883856428291;3724.0689827543047;4016.7790771507557;4095.5699651536456;3420.8289585520747;4067.227226826908;4092.570280120589;4109.486314210723;4113.588641135878;3233.611966564016;4012.2176175645614;4018.2164477926817;4031.9920019995;4053.3312003519386;3337.833108344585;3986.8604598839047;4028.8589899353383;4030.9395359069636;4050.2911990401562;3035.7267845893753;3154.6529881712995;3480.9825950870336;3491.4239150540384;3520.9823950880336;5135.3067335909545;5140.3060586820675;5140.7943682253035;5163.7676304566385;5164.535191832715;3820.605479000145;3923.9215215695526;4612.285095810154;4628.907421851578;4649.721016739007;5283.788648454057;5299.523042926116;5525.944740552583;5595.608307418483;5647.576431767634;3653.488511608377;3854.672352850011;3863.864764733249;3870.825812838401;3873.9031524211837;5349.465053494697;5728.02623554001;5874.765009399619;5924.466797988159;5928.703564821785;3257.413665540178;3312.635610082889;3682.9815850920572;3910.2961466936226;3918.216356728609;3922.4116382542848;3962.3660214365564;3978.3833505806647;3988.8659567131444;3991.4012898064943;3695.4456831474954;4626.629869610423;4638.83764068256;4645;4650.883727906829;5541.501264886099;5728.885422291531;5735.541156707537;5754.698120751733;5786.189933409326;1318.3737724580747;1342.1946831900782;1364.1951248763278;1364.208758919824;1371.9382627781774;670.1087553553762;778.9095266626655;820.5651004967377;835.8746188071838;838.0948575538404;4050.4936882889638;4539.117660285677;4543.795529201194;4561.498235194126;4567.401409506646;4446.377507149002;4483.7533935633855;4678.859209599529;4953.331300274489;4959.330490383752;4492.191405547033;4508.020803178356;4508.346289787963;4525.796339164745;4538.909221815546;2284.474570848714;2361.633946738258;2443.4343938864477;2618.9607155892677;2633.604959256127;4737.034130835734;4857.295692124622;4987.536155141129;5085.720285384339;5112.8721781955;4371.934420983688;4671.439427268681;4849.563539281411;5044.445111037783;5049.823256186016;4395.461588444019;4738.336632871332;4900.485449027872;4992.450830408579;5113.667611605234;4899.632527560519;4915.557599816034;4930.654854160174;4939.703617782944;4961.404631444249;4068.7762173080764;4085.8569950051606;4286.014216730232;4818.590419814355;4885.389326334208;4402.493713223021;4573.611243044378;4641.655963738291;4814.6870453420415;5072.721000345016;3027.5761393405382;3049.697478403791;3340.799552026886;3370.112736867362;3609.9819500902327;5537.833864984057;5797.797077102281;5798.76804927815;5938.881222375615;6008.639481631116;4606.6870941781435;5364.356277246756;5560.304961879765;5636.689982051026;5655.830325090254;4618.46887607916;4738.644601654821;4995.750212489434;5260.736963151904;5565.9721701392855;4353.934690979574;5457.345118585795;5468.496163555054;5489.258950041693;5520.613557050968;5045.077140793127;5393.352797664305;5609.363599108413;5627.774889004394;5639.7744090237575;4316;4992.800287988585;5125.589952803842;5204.516712736852;5446.509814116748 11:13:07 INFO - PROCESS | 2003 | |5;yui.html;700.982475438114;701.7543859649122;750.8723517002109;752.9533947812541;784.137673026562;14347.497837575687;15023.624409389771;15272.541823745305;15296.388144474207;15348.462803801869;13006.154599950996;13120.93439532801;13206.339683015858;13217.603471895834;13299.069065165442;645.2740666749906;667.0128210248811;795.5107608820591;820.2371794231377;821.6507984106761;832.5004997001811;837.6523742646795;839.5760141128721;841.9115992820757;842.1283971089923;851.6167724523958;877.2192748453881;881.2465342132481;889.937704360695;892.6920212526668;850.200811237438;866.9826603467958;884.5798245833242;888.338188049907;889.0398369760643;648.5719425179359;656.1207981305074;658.874813785384;659.5482094765101;663.1975309875057;13948.930255348658;14107.647308817259;14151.150930944073;14221.431142754278;14658.926705366404;13821.79267310991;13842.515511957034;14035.929820350935;14211.228810381876;14273.857261427356;10974.725631859188;11251;11464.828027579593;11503.712407189803;11734.765304693858;4375.299952007664;4424.557544245582;4425.690201685883;4428.734275943454;4593.19619066662;87449;87577.12422875753;88906;89252.66121008254;89273.10726892778;7813.687452501837;10364.844527332096;10422.5830966762;10595.682129536126;10727.19546034035;19206.135723892457;19242.807571924102;19350.709739353922;19351.225950961805;19559.31542396009;7562.848743025219;7643.579603121771;7724.536527808349;7896.763097107096;7901.407394445439;4298.914021719611;4356.172327257811;4363.7381757094045;4391.934120988188;4483.798229079699;2646.523625747384;3083.090488305955;3095.0250671038552;3244.4808830587463;3896.5129358830145;512.8769095417148;693.5400980935059;704.1761139466836;708.9468289878176;713.2439614009166;548.509084369487;577.4918072096528;612.788587937161;634.72706736103;675.42588799521;8774.649014039367;9269.304802139866;9334.346595738232;9370;9381.624735010522;631.4443289904855;662.086320877196;664.2925284571916;666.8232918276564;668.8060462465928;3770.3967365221433;3841.615838416136;4321.762303073361;4512.9774351128035;4662.300654901792;73247;102459;103094.96905030854;105514;116299;78055.43889122299;79060.20939790644;93049;94651.52674236585;96736;76008;83766;84190;84268.15731842726;84336.57831710803;8338.958305208678;9333.766655833659;9539.379940303857;9592.616295348107;9722.9027709722;47937.280940786615;51967.22049169341;52001.99999999849;55096.24518774125;56636.43363566476;60113.7977240444;78076;79684.60157699406;80781;81146.59426702828;11056.889431105586;12142.935700930686;12266.141370104364;12485.438155282853;12633.2420054797;13983.860161398256;14242.359093841009;14253.073550219202;14312.212828294543;14599.562013139623;13084.803727943898;13108.2135071896;13148.585785715986;13601.455941762219;13679.316034198051;12884.517652686034;13317.53388631432;13399.397027133607;13486.595402137951;13605.86394136046;12482.500699971899;13021.739565208452;13365.933170334087;13472.191668499921;13485.528006519724;10990.230683852054;11258.493367798632;11501.942490287494;11601.709957250798;11622.302661840316;7289.4168466523615;9513.762155946157;10494.68515944523;11060.336379817236;11464.770704586028 11:13:07 INFO - PROCESS | 2003 | __end_tp_report 11:13:07 INFO - PROCESS | 2003 | __start_cc_report 11:13:07 INFO - PROCESS | 2003 | _x_x_mozilla_cycle_collect,380 11:13:07 INFO - PROCESS | 2003 | __end_cc_report 11:13:07 INFO - PROCESS | 2003 | __startTimestamp1477937587249__endTimestamp 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - PROCESS | 2003 | ------- Summary: start ------- 11:13:07 INFO - PROCESS | 2003 | Number of tests: 6 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - PROCESS | 2003 | [#0] dojo.html Cycles:165 Average:5592.72 Median:5864.33 stddev:655.42 (11.2%) stddev-sans-first:631.86 11:13:07 INFO - PROCESS | 2003 | Values: 3282.0 3289.1 3301.6 3318.2 3330.8 5539.0 5569.8 5597.2 5597.9 5601.7 5440.2 5575.2 5583.6 5585.4 5590.0 5036.3 5139.6 5147.3 5165.8 5201.6 5143.1 5165.5 5176.0 5189.5 5285.3 4171.9 5087.6 5153.0 5205.7 5214.3 5058.5 5124.2 5151.3 5175.5 5193.2 5096.8 5100.8 5117.6 5147.4 5152.3 4382.9 4670.5 4796.8 5043.3 5488.2 6044.2 6058.8 6063.7 6072.0 6080.5 6081.5 6110.6 6111.7 6146.4 6179.1 4729.8 5748.6 5765.4 5772.7 5783.9 6082.5 6117.9 6160.5 6180.3 6192.7 5979.6 5984.8 6021.8 6030.8 6087.8 6045.3 6101.7 6118.7 6128.2 6138.1 5978.7 6032.5 6045.7 6048.4 6108.7 6089.6 6093.2 6129.8 6131.7 6143.6 4816.6 4835.2 4847.9 4850.1 4893.0 4303.3 4351.9 4381.8 4407.4 4425.8 5620.9 5625.2 5705.7 5750.9 5795.7 6021.1 6079.7 6108.2 6139.6 6150.0 5536.9 5724.8 5740.2 5744.3 5764.9 5245.6 5275.3 5292.5 5337.3 5365.7 6160.5 6168.5 6183.1 6186.6 6196.7 5101.9 6126.3 6145.9 6164.9 6165.3 6118.7 6120.1 6129.6 6139.8 6292.8 6088.4 6103.5 6106.0 6106.9 6112.7 4234.8 5952.3 6099.6 6144.3 6144.6 5888.7 5954.2 5963.2 5986.8 6049.2 5896.4 5925.9 5993.6 6013.4 6063.1 5655.2 5670.8 5850.7 5864.3 5921.9 4759.7 5797.3 5913.9 5980.6 6070.0 5881.2 5926.7 5933.3 5947.7 5954.5 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - PROCESS | 2003 | [#1] ext.html Cycles:180 Average:70936.07 Median:40246.10 stddev:156889.72 (389.8%) stddev-sans-first:157240.69 11:13:07 INFO - PROCESS | 2003 | Values: 492.1 498.3 506.0 507.2 547.4 39210.6 40800.0 40822.6 42498.0 42561.0 41904.2 42097.6 42107.9 42302.2 42324.6 9448.8 9481.5 9529.0 9568.1 9670.9 9569.6 9654.3 9657.5 9660.6 9680.3 9635.1 9692.0 9700.7 9706.3 9745.5 9555.2 9582.2 9606.0 9673.5 9683.4 9443.2 9446.7 9473.7 9475.8 9531.1 35059.5 40142.8 40212.6 40358.4 40359.0 3321.4 3334.8 3368.1 3545.3 4018.7 30584.0 30688.4 30968.7 31692.6 31762.9 3165.8 3205.2 3210.2 3241.9 3297.0 486889.0 489778.6 491786.5 493643.0 494199.0 60589.1 60727.0 60776.1 60792.7 61103.0 63540.4 63885.4 64111.0 64171.4 64263.7 15891.2 16031.2 16106.7 16138.7 16173.9 12275.1 12291.8 12398.6 12426.9 12442.6 17398.7 18732.8 18803.9 18896.7 18942.2 3139.0 7462.7 7710.9 7733.7 7757.0 845.8 926.0 936.2 1041.2 1065.5 29218.7 29573.0 30362.2 30387.0 30777.9 992.7 1053.5 1106.9 1116.9 1134.8 15596.0 15698.8 15704.6 15815.6 16059.3 656164.0 662133.0 663103.0 668792.0 669062.0 46066.0 50396.2 56564.0 57155.9 57411.0 1327.5 1355.4 1358.4 1365.3 1374.4 25658.6 29176.7 29903.7 29945.3 30258.5 50022.0 50321.5 50575.0 50756.5 50792.7 486590.0 611039.0 611360.0 615371.8 619322.0 26177.6 26355.7 26652.5 26692.7 26720.2 34831.5 43503.8 45831.8 46079.0 47135.0 38551.4 38739.0 39478.0 39652.2 40189.0 31962.5 35064.8 38145.6 38588.8 38656.0 30838.8 37521.2 38180.8 38926.8 40279.6 26904.9 28282.9 31323.7 35033.9 35054.6 25391.6 25808.1 25829.4 26003.5 26373.9 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - PROCESS | 2003 | [#2] jquery.html Cycles:180 Average:32603.28 Median:24623.19 stddev:87399.07 (354.9%) stddev-sans-first:87610.75 11:13:07 INFO - PROCESS | 2003 | Values: 374.9 376.8 381.2 388.8 401.3 18238.0 19844.7 19896.9 20162.7 20391.5 18865.9 19647.8 19807.6 19893.5 20237.4 5700.1 5713.9 5877.2 6004.4 6014.1 5805.1 5810.2 5900.7 5904.0 5914.7 5578.3 5833.8 5845.9 5847.7 5918.8 5737.2 5794.7 5831.2 5885.4 5914.6 4418.9 4909.2 5100.9 5138.8 5145.4 24117.4 24255.5 24256.3 24557.4 24689.0 2208.6 2229.1 2325.5 2429.6 2454.5 15009.6 15272.4 15304.2 15514.5 15697.8 1739.8 1830.5 1845.1 1916.0 1957.7 113334.0 116857.0 117055.8 118030.0 119029.8 9393.4 9422.9 11554.3 11615.0 11797.6 14285.1 14472.9 14742.2 14752.4 14756.8 6396.8 6464.6 7782.6 8296.0 8559.2 5869.7 6440.7 6860.8 7947.3 8091.8 3452.5 4380.5 4543.4 4604.3 4644.7 1908.7 1953.5 1973.3 1978.9 1982.4 821.6 888.4 944.6 975.1 980.2 20484.7 21247.0 21296.5 21484.5 21540.4 915.6 931.9 934.9 944.8 986.4 10917.7 11232.4 11279.3 11308.0 11308.4 513594.0 514581.0 518029.0 525480.4 528716.0 117468.0 120397.4 122316.4 123619.0 124453.0 935.6 945.4 992.2 994.8 995.3 14982.6 16394.5 18863.2 19072.6 19117.5 48344.5 53942.5 54151.0 54569.7 54737.2 73284.0 75092.6 76113.0 76989.2 84857.3 6595.2 8083.0 8093.2 8276.8 8311.9 11710.6 12584.3 13166.9 13182.1 13333.4 11010.5 11106.9 11394.1 11505.3 11661.5 10727.5 11096.7 11177.3 11310.2 11499.9 10204.9 10881.5 11593.8 11819.2 11839.6 7074.1 8233.0 8277.5 8314.9 8387.1 9278.0 11360.0 11574.4 11583.1 11594.0 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - PROCESS | 2003 | [#3] mootools.html Cycles:180 Average:5440.29 Median:5203.69 stddev:2973.04 (57.1%) stddev-sans-first:2965.25 11:13:07 INFO - PROCESS | 2003 | Values: 1319.6 1375.6 1643.3 1772.8 1822.0 7599.3 7799.5 8068.2 8567.5 8624.7 8072.0 8245.6 8283.9 8400.6 8437.9 2097.1 2200.8 2330.9 2350.2 2357.4 2065.8 2315.4 2348.3 2373.8 2378.3 2136.7 2317.4 2329.0 2339.1 2340.9 2287.4 2298.4 2303.2 2319.3 2323.0 2279.0 2337.4 2340.1 2341.2 2344.4 8409.0 8455.2 8502.7 8511.1 8515.6 5043.8 5202.7 5204.6 5212.5 5212.8 3253.7 3494.9 3500.5 3629.2 3653.3 978.5 1014.7 1031.1 1055.0 1098.1 10986.9 11045.9 11090.5 11119.8 11120.1 4460.5 4578.3 4660.8 4672.6 4755.2 7943.6 9434.8 9486.4 9515.0 9528.0 5189.9 5219.9 5225.2 5231.7 5236.1 4169.7 4672.6 4726.8 4748.3 4819.9 3751.3 3797.8 3855.3 3870.6 3875.6 1245.9 1255.1 1261.4 1261.5 1269.7 748.7 839.2 885.9 897.4 923.9 5671.2 5732.4 5819.3 5852.4 6024.5 919.8 940.7 943.9 954.8 992.0 3832.8 3865.2 3881.4 3949.2 4007.9 10006.0 10310.9 10351.9 10355.9 10360.5 9479.7 10296.3 10302.0 10318.5 10345.8 7173.3 7538.1 7838.1 7838.2 7988.7 4470.9 4984.4 5718.2 5819.4 5939.4 7584.0 7662.9 7901.0 9224.4 9565.6 9225.2 9438.1 9461.9 9582.3 9595.1 6637.6 6759.0 7025.6 7045.2 7263.1 7815.2 7997.0 8036.4 8037.4 8050.0 7162.7 7171.4 7218.3 7272.4 7404.4 5686.3 6414.9 7018.8 7140.3 7582.0 6485.9 6534.3 6614.9 6623.2 6624.8 4903.6 4904.3 5110.9 5172.8 5192.2 4208.8 4842.7 4882.1 5229.2 5277.6 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - PROCESS | 2003 | [#4] prototype.html Cycles:180 Average:4268.01 Median:4639.07 stddev:1317.89 (28.4%) stddev-sans-first:1286.82 11:13:07 INFO - PROCESS | 2003 | Values: 261.6 294.7 304.5 315.4 316.7 5226.1 5299.5 5343.7 5376.8 5397.6 4362.6 4639.3 4817.4 5083.9 5245.0 3242.7 3440.9 3724.1 4016.8 4095.6 3420.8 4067.2 4092.6 4109.5 4113.6 3233.6 4012.2 4018.2 4032.0 4053.3 3337.8 3986.9 4028.9 4030.9 4050.3 3035.7 3154.7 3481.0 3491.4 3521.0 5135.3 5140.3 5140.8 5163.8 5164.5 3820.6 3923.9 4612.3 4628.9 4649.7 5283.8 5299.5 5525.9 5595.6 5647.6 3653.5 3854.7 3863.9 3870.8 3873.9 5349.5 5728.0 5874.8 5924.5 5928.7 3257.4 3312.6 3683.0 3910.3 3918.2 3922.4 3962.4 3978.4 3988.9 3991.4 3695.4 4626.6 4638.8 4645.0 4650.9 5541.5 5728.9 5735.5 5754.7 5786.2 1318.4 1342.2 1364.2 1364.2 1371.9 670.1 778.9 820.6 835.9 838.1 4050.5 4539.1 4543.8 4561.5 4567.4 4446.4 4483.8 4678.9 4953.3 4959.3 4492.2 4508.0 4508.3 4525.8 4538.9 2284.5 2361.6 2443.4 2619.0 2633.6 4737.0 4857.3 4987.5 5085.7 5112.9 4371.9 4671.4 4849.6 5044.4 5049.8 4395.5 4738.3 4900.5 4992.5 5113.7 4899.6 4915.6 4930.7 4939.7 4961.4 4068.8 4085.9 4286.0 4818.6 4885.4 4402.5 4573.6 4641.7 4814.7 5072.7 3027.6 3049.7 3340.8 3370.1 3610.0 5537.8 5797.8 5798.8 5938.9 6008.6 4606.7 5364.4 5560.3 5636.7 5655.8 4618.5 4738.6 4995.8 5260.7 5566.0 4353.9 5457.3 5468.5 5489.3 5520.6 5045.1 5393.4 5609.4 5627.8 5639.8 4316.0 4992.8 5125.6 5204.5 5446.5 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - PROCESS | 2003 | [#5] yui.html Cycles:180 Average:20058.32 Median:26299.79 stddev:28804.60 (109.5%) stddev-sans-first:28848.73 11:13:07 INFO - PROCESS | 2003 | Values: 701.0 701.8 750.9 753.0 784.1 14347.5 15023.6 15272.5 15296.4 15348.5 13006.2 13120.9 13206.3 13217.6 13299.1 645.3 667.0 795.5 820.2 821.7 832.5 837.7 839.6 841.9 842.1 851.6 877.2 881.2 889.9 892.7 850.2 867.0 884.6 888.3 889.0 648.6 656.1 658.9 659.5 663.2 13948.9 14107.6 14151.2 14221.4 14658.9 13821.8 13842.5 14035.9 14211.2 14273.9 10974.7 11251.0 11464.8 11503.7 11734.8 4375.3 4424.6 4425.7 4428.7 4593.2 87449.0 87577.1 88906.0 89252.7 89273.1 7813.7 10364.8 10422.6 10595.7 10727.2 19206.1 19242.8 19350.7 19351.2 19559.3 7562.8 7643.6 7724.5 7896.8 7901.4 4298.9 4356.2 4363.7 4391.9 4483.8 2646.5 3083.1 3095.0 3244.5 3896.5 512.9 693.5 704.2 708.9 713.2 548.5 577.5 612.8 634.7 675.4 8774.6 9269.3 9334.3 9370.0 9381.6 631.4 662.1 664.3 666.8 668.8 3770.4 3841.6 4321.8 4513.0 4662.3 73247.0 102459.0 103095.0 105514.0 116299.0 78055.4 79060.2 93049.0 94651.5 96736.0 76008.0 83766.0 84190.0 84268.2 84336.6 8339.0 9333.8 9539.4 9592.6 9722.9 47937.3 51967.2 52002.0 55096.2 56636.4 60113.8 78076.0 79684.6 80781.0 81146.6 11056.9 12142.9 12266.1 12485.4 12633.2 13983.9 14242.4 14253.1 14312.2 14599.6 13084.8 13108.2 13148.6 13601.5 13679.3 12884.5 13317.5 13399.4 13486.6 13605.9 12482.5 13021.7 13365.9 13472.2 13485.5 10990.2 11258.5 11501.9 11601.7 11622.3 7289.4 9513.8 10494.7 11060.3 11464.8 11:13:07 INFO - PROCESS | 2003 | -------- Summary: end -------- 11:13:07 INFO - PROCESS | 2003 | 11:13:07 INFO - TEST-INFO | 2003: exit 0 11:13:07 INFO - TEST-OK | dromaeo_css | took 1115652ms 11:13:07 INFO - TEST-START | kraken 11:13:07 INFO - operating with platform_type : mac_ 11:13:07 INFO - Initialising browser for kraken test... 11:13:07 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpGXWrlE/profile http://localhost:49392/getInfo.html) 11:13:10 INFO - PROCESS | 2010 | 2016-10-31 11:13:10.643 plugin-container[2011:13102] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 11:13:10 INFO - PROCESS | 2010 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:13:10 INFO - PROCESS | 2010 | 2016-10-31 11:13:10.645 plugin-container[2011:13102] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 11:13:10 INFO - PROCESS | 2010 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:13:10 INFO - PROCESS | 2010 | 2016-10-31 11:13:10.646 plugin-container[2011:13102] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:13:10 INFO - PROCESS | 2010 | __metrics Screen width/height:1600/1200 11:13:10 INFO - PROCESS | 2010 | colorDepth:24 11:13:10 INFO - PROCESS | 2010 | Browser inner width/height: 1024/689 11:13:10 INFO - PROCESS | 2010 | __metrics 11:13:10 ERROR - PROCESS | 2010 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 11:13:11 INFO - TEST-INFO | 2010: exit 0 11:13:11 INFO - Browser initialized. 11:13:11 INFO - Running cycle 1/1 for kraken test... 11:13:11 INFO - TEST-INFO | started process 2012 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/T/tmpGXWrlE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:13 INFO - PROCESS | 2012 | 2016-10-31 11:13:13.797 plugin-container[2013:13217] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894f, name = 'com.apple.tsm.portname' 11:13:13 INFO - PROCESS | 2012 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:13:13 INFO - PROCESS | 2012 | 2016-10-31 11:13:13.798 plugin-container[2013:13217] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8953, name = 'com.apple.CFPasteboardClient' 11:13:13 INFO - PROCESS | 2012 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:13:13 INFO - PROCESS | 2012 | 2016-10-31 11:13:13.798 plugin-container[2013:13217] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:13:23 INFO - PROCESS | 2012 | RSS: Main: 240197632 11:13:23 INFO - PROCESS | 2012 | 11:13:26 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:27 INFO - PROCESS | 2012 | RSS: Main: 252727296 11:13:27 INFO - PROCESS | 2012 | 11:13:30 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-dft) 11:13:31 INFO - PROCESS | 2012 | RSS: Main: 260173824 11:13:31 INFO - PROCESS | 2012 | 11:13:34 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-fft) 11:13:35 INFO - PROCESS | 2012 | RSS: Main: 263118848 11:13:35 INFO - PROCESS | 2012 | 11:13:37 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-oscillator) 11:13:37 INFO - PROCESS | 2012 | RSS: Main: 265220096 11:13:37 INFO - PROCESS | 2012 | 11:13:39 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:40 INFO - PROCESS | 2012 | RSS: Main: 265560064 11:13:40 INFO - PROCESS | 2012 | 11:13:43 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-darkroom) 11:13:44 INFO - PROCESS | 2012 | RSS: Main: 265658368 11:13:44 INFO - PROCESS | 2012 | 11:13:47 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-desaturate) 11:13:47 INFO - PROCESS | 2012 | RSS: Main: 266436608 11:13:47 INFO - PROCESS | 2012 | 11:13:50 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49392/tests/kraken/driver.html?testName=json-parse-financial) 11:13:51 INFO - PROCESS | 2012 | RSS: Main: 266285056 11:13:51 INFO - PROCESS | 2012 | 11:13:53 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:13:53 INFO - PROCESS | 2012 | RSS: Main: 266153984 11:13:53 INFO - PROCESS | 2012 | 11:13:55 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:13:56 INFO - PROCESS | 2012 | RSS: Main: 266190848 11:13:56 INFO - PROCESS | 2012 | 11:13:58 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:13:59 INFO - PROCESS | 2012 | RSS: Main: 266268672 11:13:59 INFO - PROCESS | 2012 | 11:14:02 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:02 INFO - PROCESS | 2012 | RSS: Main: 266584064 11:14:02 INFO - PROCESS | 2012 | 11:14:05 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:06 INFO - PROCESS | 2012 | RSS: Main: 266358784 11:14:06 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49392/tests/kraken/driver.html?testName=ai-astar) 11:14:08 INFO - PROCESS | 2012 | RSS: Main: 268087296 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | __start_tp_report 11:14:08 INFO - PROCESS | 2012 | _x_x_mozilla_page_load 11:14:08 INFO - PROCESS | 2012 | _x_x_mozilla_page_load_details 11:14:08 INFO - PROCESS | 2012 | |i|pagename|runs| 11:14:08 INFO - PROCESS | 2012 | |0;ai-astar;148;174;161;117;125;104;177;104;166;173 11:14:08 INFO - PROCESS | 2012 | |1;audio-beat-detection;153;118;116;150;116;112;116;122;175;145 11:14:08 INFO - PROCESS | 2012 | |2;audio-dft;201;247;186;203;239;277;189;194;274;234 11:14:08 INFO - PROCESS | 2012 | |3;audio-fft;82;67;84;112;62;61;61;60;79;59 11:14:08 INFO - PROCESS | 2012 | |4;audio-oscillator;93;103;122;77;71;69;88;71;70;87 11:14:08 INFO - PROCESS | 2012 | |5;imaging-gaussian-blur;89;87;112;134;90;85;89;86;91;133 11:14:08 INFO - PROCESS | 2012 | |6;imaging-darkroom;154;155;96;95;94;95;116;96;95;96 11:14:08 INFO - PROCESS | 2012 | |7;imaging-desaturate;104;90;140;146;115;88;100;76;139;142 11:14:08 INFO - PROCESS | 2012 | |8;json-parse-financial;58;58;64;60;59;60;59;60;59;61 11:14:08 INFO - PROCESS | 2012 | |9;json-stringify-tinderbox;68;77;118;113;111;104;73;71;71;73 11:14:08 INFO - PROCESS | 2012 | |10;stanford-crypto-aes;86;87;88;86;84;89;91;91;85;86 11:14:08 INFO - PROCESS | 2012 | |11;stanford-crypto-ccm;167;167;150;163;163;166;163;168;195;154 11:14:08 INFO - PROCESS | 2012 | |12;stanford-crypto-pbkdf2;177;246;184;177;174;175;176;176;174;188 11:14:08 INFO - PROCESS | 2012 | |13;stanford-crypto-sha256-iterative;70;70;68;70;68;68;67;68;68;68 11:14:08 INFO - PROCESS | 2012 | __end_tp_report 11:14:08 INFO - PROCESS | 2012 | __start_cc_report 11:14:08 INFO - PROCESS | 2012 | _x_x_mozilla_cycle_collect,972 11:14:08 INFO - PROCESS | 2012 | __end_cc_report 11:14:08 INFO - PROCESS | 2012 | __startTimestamp1477937648549__endTimestamp 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | ------- Summary: start ------- 11:14:08 INFO - PROCESS | 2012 | Number of tests: 14 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#0] ai-astar Cycles:10 Average:144.90 Median:163.50 stddev:29.63 (18.1%) stddev-sans-first:31.41 11:14:08 INFO - PROCESS | 2012 | Values: 148.0 174.0 161.0 117.0 125.0 104.0 177.0 104.0 166.0 173.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:133.50 stddev:21.72 (16.3%) stddev-sans-first:21.71 11:14:08 INFO - PROCESS | 2012 | Values: 153.0 118.0 116.0 150.0 116.0 112.0 116.0 122.0 175.0 145.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#2] audio-dft Cycles:10 Average:224.40 Median:236.50 stddev:34.48 (14.6%) stddev-sans-first:35.52 11:14:08 INFO - PROCESS | 2012 | Values: 201.0 247.0 186.0 203.0 239.0 277.0 189.0 194.0 274.0 234.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#3] audio-fft Cycles:10 Average:72.70 Median:64.50 stddev:16.89 (26.2%) stddev-sans-first:17.58 11:14:08 INFO - PROCESS | 2012 | Values: 82.0 67.0 84.0 112.0 62.0 61.0 61.0 60.0 79.0 59.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:74.00 stddev:17.34 (23.4%) stddev-sans-first:18.16 11:14:08 INFO - PROCESS | 2012 | Values: 93.0 103.0 122.0 77.0 71.0 69.0 88.0 71.0 70.0 87.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#5] imaging-gaussian-blur Cycles:10 Average:99.60 Median:88.00 stddev:19.44 (22.1%) stddev-sans-first:20.23 11:14:08 INFO - PROCESS | 2012 | Values: 89.0 87.0 112.0 134.0 90.0 85.0 89.0 86.0 91.0 133.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#6] imaging-darkroom Cycles:10 Average:109.20 Median:95.00 stddev:24.74 (26.0%) stddev-sans-first:20.25 11:14:08 INFO - PROCESS | 2012 | Values: 154.0 155.0 96.0 95.0 94.0 95.0 116.0 96.0 95.0 96.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#7] imaging-desaturate Cycles:10 Average:114.00 Median:144.00 stddev:26.04 (18.1%) stddev-sans-first:27.37 11:14:08 INFO - PROCESS | 2012 | Values: 104.0 90.0 140.0 146.0 115.0 88.0 100.0 76.0 139.0 142.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:1.75 (2.9%) stddev-sans-first:1.73 11:14:08 INFO - PROCESS | 2012 | Values: 58.0 58.0 64.0 60.0 59.0 60.0 59.0 60.0 59.0 61.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#9] json-stringify-tinderbox Cycles:10 Average:87.90 Median:71.00 stddev:20.71 (29.2%) stddev-sans-first:20.67 11:14:08 INFO - PROCESS | 2012 | Values: 68.0 77.0 118.0 113.0 111.0 104.0 73.0 71.0 71.0 73.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.50 stddev:2.41 (2.7%) stddev-sans-first:2.51 11:14:08 INFO - PROCESS | 2012 | Values: 86.0 87.0 88.0 86.0 84.0 89.0 91.0 91.0 85.0 86.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#11] stanford-crypto-ccm Cycles:10 Average:165.60 Median:166.50 stddev:11.89 (7.1%) stddev-sans-first:12.60 11:14:08 INFO - PROCESS | 2012 | Values: 167.0 167.0 150.0 163.0 163.0 166.0 163.0 168.0 195.0 154.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:177.00 stddev:22.02 (12.4%) stddev-sans-first:23.17 11:14:08 INFO - PROCESS | 2012 | Values: 177.0 246.0 184.0 177.0 174.0 175.0 176.0 176.0 174.0 188.0 11:14:08 INFO - PROCESS | 2012 | 11:14:08 INFO - PROCESS | 2012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:1.08 (1.6%) stddev-sans-first:1.00 11:14:08 INFO - PROCESS | 2012 | Values: 70.0 70.0 68.0 70.0 68.0 68.0 67.0 68.0 68.0 68.0 11:14:08 INFO - PROCESS | 2012 | -------- Summary: end -------- 11:14:08 INFO - PROCESS | 2012 | 11:14:09 INFO - TEST-INFO | 2012: exit 0 11:14:09 INFO - TEST-OK | kraken | took 61538ms 11:14:09 INFO - SUITE-END | took 1177s 11:14:09 INFO - Completed test suite (00:19:37) 11:14:09 INFO - javascript benchmark 11:14:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7109.303677238464, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.048206020254, 3289.0626171541116, 3301.620313663929, 3318.236805534726, 3330.8334583270844, 5539.030669632813, 5569.832905012851, 5597.160425936112, 5597.916031259534, 5601.719914004304, 5440.238366628675, 5575.2473416088815, 5583.553315734742, 5585.385607583163, 5589.972050139754, 5036.2949187113745, 5139.640225184238, 5147.305113809625, 5165.81919632813, 5201.55786758126, 5143.099957507421, 5165.457626949173, 5176.0, 5189.506996835314, 5285.286486324355, 4171.91656166875, 5087.618428617869, 5152.995165942642, 5205.6616319939085, 5214.270002199676, 5058.519440653132, 5124.205748109049, 5151.330327057496, 5175.45657705943, 5193.169092945149, 5096.770645320969, 5100.821471248526, 5117.6161787865685, 5147.4080480744815, 5152.330197074394, 4382.868513944587, 4670.509596492388, 4796.824777929395, 5043.3191519145175, 5488.204210389511, 6044.184035155242, 6058.818235452944, 6063.696815159225, 6071.969640151815, 6080.452759251644, 6081.543884208658, 6110.558759196641, 6111.652512877612, 6146.446819786196, 6179.073139029137, 4729.834455794065, 5748.5688573357165, 5765.423457654201, 5772.740226689767, 5783.884322313572, 6082.452579267887, 6117.908231376533, 6160.507159427235, 6180.289266734293, 6192.68691250179, 5979.641221526722, 5984.820455386345, 6021.759129634853, 6030.849228769316, 6087.8478038048515, 6045.33501314855, 6101.725422356005, 6118.694065296718, 6128.1726966858905, 6138.14066030756, 5978.730957106941, 6032.54755893301, 6045.727942242522, 6048.395160483917, 6108.664023478751, 6089.604175728564, 6093.177421048102, 6129.756146212572, 6131.682521312785, 6143.573288550997, 4816.614670826396, 4835.153848076572, 4847.854564363075, 4850.1269771440775, 4893.0, 4303.33298338758, 4351.912021994502, 4381.78091095444, 4407.405000324915, 4425.845095421645, 5620.91568626471, 5625.184348269559, 5705.686187259741, 5750.942490575125, 5795.739191736382, 6021.096835474714, 6079.665618391031, 6108.236470441195, 6139.6009259398, 6150.015997440388, 5536.944630553643, 5724.771009159587, 5740.225069615632, 5744.281964754406, 5764.884702306014, 5245.554127899095, 5275.287836142148, 5292.52367286946, 5337.2527846101575, 5365.704886231295, 6160.507159427325, 6168.506519478431, 6183.134361189347, 6186.566940314135, 6196.659183744938, 5101.852083281232, 6126.326104128631, 6145.877082458415, 6164.907526387197, 6165.260168779775, 6118.663473509, 6120.051392034242, 6129.601575897553, 6139.798803208881, 6292.811215663537, 6088.4215999479975, 6103.542234332532, 6105.9694701526205, 6106.915739268716, 6112.694365281807, 4234.809433575558, 5952.345242023287, 6099.573029887865, 6144.262688477233, 6144.631322120687, 5888.735006924613, 5954.166416701579, 5963.224780778471, 5986.820395388146, 6049.213602231682, 5896.410358964241, 5925.851853703692, 5993.580449368503, 6013.3685962975005, 6063.090536419572, 5655.179998900054, 5670.8015219467125, 5850.707464626837, 5864.32560255576, 5921.881562368814, 4759.714417134983, 5797.30432348104, 5913.91129133072, 5980.611260268069, 6070.028795392716, 5881.235439392852, 5926.67403292823, 5933.317668468008, 5947.732352044082, 5954.46409823118], "value": 5552.422887392774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.10682611060923, 498.26505903791934, 506.0486285782732, 507.1859665237294, 547.3896605285107, 39210.60789392105, 40800.0, 40822.59177408225, 42498.0, 42561.0, 41904.161916761725, 42097.57902420975, 42107.94730131748, 42302.15395692092, 42324.57675423245, 9448.811023779537, 9481.47851868147, 9529.0, 9568.138867501924, 9670.854937175913, 9569.569369378394, 9654.324197306192, 9657.46883921384, 9660.647509348697, 9680.322377433582, 9635.084666956664, 9692.0, 9700.660476883311, 9706.272029597809, 9745.463999480025, 9555.18780903624, 9582.185514231298, 9605.95197024014, 9673.467959262238, 9683.41899486033, 9443.15011648948, 9446.716598501987, 9473.66842160528, 9475.815523059617, 9531.094546018117, 35059.4741078884, 40142.799286003385, 40212.59787402147, 40358.39462408066, 40359.0, 3321.4353559894876, 3334.816585087819, 3368.1411240133853, 3545.308664810363, 4018.738781979191, 30584.0, 30688.38623227523, 30968.690313096806, 31692.573834177518, 31762.888298909427, 3165.7773194027227, 3205.1506350817053, 3210.165357007195, 3241.9351612967607, 3296.9835150824333, 486889.0, 489778.55110724573, 491786.54106729594, 493643.0, 494199.0, 60589.09116363258, 60727.0, 60776.08835867466, 60792.696036519534, 61103.0, 63540.36459635344, 63885.361146388874, 64111.0, 64171.358286417475, 64263.678681606296, 15891.205439728199, 16031.19844007795, 16106.677866442606, 16138.677226455406, 16173.919130404272, 12275.140740148283, 12291.754164916652, 12398.5660501882, 12426.94370978477, 12442.626721198198, 17398.67872370318, 18732.81267187338, 18803.905980470012, 18896.71654925177, 18942.242310307432, 3138.952915706266, 7462.701491940262, 7710.922890771133, 7733.729319473791, 7756.961215193888, 845.7970087179033, 925.9999200863052, 936.1995493852794, 1041.1722680469045, 1065.5098654618962, 29218.707812922024, 29572.96494622721, 30362.240943976576, 30387.0, 30777.922772703296, 992.6624947517879, 1053.5417093564324, 1106.8599342677055, 1116.8827273136367, 1134.8354488599107, 15596.0, 15698.843011569737, 15704.60738481547, 15815.604609884615, 16059.277332520065, 656164.0, 662133.0, 663103.0, 668792.0, 669062.0, 46066.0, 50396.24405633919, 56564.0, 57155.85688286211, 57411.0, 1327.4889167670517, 1355.4171706166444, 1358.3683587132032, 1365.2627581106092, 1374.4021350712471, 25658.61512077358, 29176.7082329174, 29903.700962990093, 29945.251368715955, 30258.54612180863, 50022.0, 50321.49678503168, 50574.988500229054, 50756.492435075175, 50792.74603627106, 486590.0, 611039.0, 611360.0, 615371.8462815493, 619322.0, 26177.607335889596, 26355.736442636095, 26652.466950661266, 26692.733072669802, 26720.19839404821, 34831.47752783761, 43503.78248108739, 45831.77084114558, 46079.0, 47135.0, 38551.42172867353, 38739.03152421212, 39478.0, 39652.20695586014, 40189.0, 31962.52056219205, 35064.82467587646, 38145.61854381532, 38588.80705596454, 38656.03359915912, 30838.845805770827, 37521.2495750078, 38180.80909595434, 38926.80536597299, 40279.59720402876, 26904.865475672497, 28282.85858570694, 31323.68676313208, 35033.94898153059, 35054.64945350514, 25391.61912571276, 25808.09671661558, 25829.354266142745, 26003.479930400907, 26373.868130659223], "value": 19810.145529492234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.91002159481735, 376.7720529079906, 381.16144482139293, 388.82891527727816, 401.2817057467132, 18237.996910169953, 19844.702329465068, 19896.900515497422, 20162.68942518737, 20391.490212744688, 18865.905670471664, 19647.803521964775, 19807.603847923034, 19893.502662433446, 20237.392878213675, 5700.144978253254, 5713.8571535711735, 5877.235959325281, 6004.369541198177, 6014.0678194879865, 5805.071188609823, 5810.1865738796605, 5900.675462849542, 5903.966805808987, 5914.704264786765, 5578.2748242728385, 5833.82498525045, 5845.941540584582, 5847.678377689225, 5918.763249470016, 5737.2254745609225, 5794.710264486801, 5831.2419385479825, 5885.4114588541015, 5914.585978981473, 4418.911621767579, 4909.21452567591, 5100.923486147711, 5138.845834624967, 5145.382554093495, 24117.39706507334, 24255.514889702285, 24256.272311830675, 24557.38606534833, 24689.0, 2208.558288342338, 2229.108356657334, 2325.453518423169, 2429.6112621980574, 2454.509098180371, 15009.624759380993, 15272.38910443592, 15304.234788260543, 15514.456994005268, 15697.764533532007, 1739.7912250529891, 1830.4600142957859, 1845.0866820923595, 1916.0, 1957.745493085904, 113334.0, 116856.99999999916, 117055.8294417062, 118030.0, 119029.80970190273, 9393.389429687048, 9422.858657120149, 11554.306741595363, 11615.0, 11797.646070617895, 14285.071470354394, 14472.914531410186, 14742.189179595225, 14752.40990360395, 14756.778648320284, 6396.776112836028, 6464.612123272619, 7782.64978075988, 8296.004479462383, 8559.186877246651, 5869.706514674249, 6440.677966101676, 6860.799360112061, 7947.284744373034, 8091.797705057421, 3452.464867945422, 4380.452443444569, 4543.432070991126, 4604.309353596987, 4644.744539050317, 1908.740231447238, 1953.540917884296, 1973.3389314579777, 1978.9208431662573, 1982.4250967219634, 821.5645707774889, 888.3825741109996, 944.607987685103, 975.1272611013104, 980.181548407088, 20484.69272960907, 21247.0, 21296.467588310417, 21484.462888427915, 21540.35378938603, 915.635702802819, 931.9487428191379, 934.9158575728217, 944.8299306124826, 986.4328011393334, 10917.727056823644, 11232.438378081064, 11279.266847654877, 11307.982281594695, 11308.434578271053, 513594.0, 514581.0, 518029.0, 525480.3725981346, 528716.0, 117468.0, 120397.39801300937, 122316.38841805913, 123619.0, 124453.0, 935.6304259817471, 945.3902233059638, 992.2310209587628, 994.8308787506141, 995.2833959549113, 14982.550523484313, 16394.508164755076, 18863.24547018104, 19072.61854762925, 19117.522061948006, 48344.54966351015, 53942.46057539374, 54151.0, 54569.727151363986, 54737.1789423151, 73284.0, 75092.62453687696, 76113.0, 76989.23010770045, 84857.30285394134, 6595.208574971034, 8083.0, 8093.231143041402, 8276.751697449086, 8311.916880831115, 11710.590129345432, 12584.30786306762, 13166.868331316564, 13182.143160694524, 13333.399996999964, 11010.50452729613, 11106.888931110909, 11394.145439091935, 11505.309681419141, 11661.475233614337, 10727.517261723086, 11096.668399792077, 11177.273477223955, 11310.208285419942, 11499.942500287445, 10204.948975255076, 10881.510332035235, 11593.768124637629, 11819.231749936227, 11839.644810655695, 7074.080369551925, 8232.958835205785, 8277.503349799032, 8314.919060522336, 8387.119352467904, 9277.953610231905, 11360.0, 11574.421278936188, 11583.131265155316, 11594.0], "value": 9461.25839412857, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.5513525401361, 1375.5529452927794, 1643.3344495479334, 1772.822717728228, 1821.9817801821978, 7599.316061554459, 7799.454038217327, 8068.193180681928, 8567.485950842954, 8624.698135565257, 8072.0, 8245.587720613976, 8283.91716082839, 8400.621972011259, 8437.915620843805, 2097.1401725292635, 2200.8335582141412, 2330.8951097200625, 2350.15394457995, 2357.422431504275, 2065.7830927752593, 2315.3632750993443, 2348.2720356689397, 2373.848683388555, 2378.3221781792195, 2136.6581346984485, 2317.397476656073, 2328.9534209315802, 2339.1111377676543, 2340.871252081135, 2287.3595393289906, 2298.425393651587, 2303.2169062518824, 2319.3273950554403, 2322.988385058081, 2278.9658155127686, 2337.4222399880014, 2340.1224540797202, 2341.2273949596593, 2344.402177444758, 8409.0, 8455.239028487404, 8502.65989360431, 8511.063782983867, 8515.574221288973, 5043.798248070073, 5202.739863006872, 5204.635675502716, 5212.478752124795, 5212.843614691566, 3253.6908993645566, 3494.930101397958, 3500.5266191053497, 3629.237860049393, 3653.2510835278704, 978.5156347607908, 1014.7057353367514, 1031.128696251666, 1055.024102704995, 1098.1379617000696, 10986.890131098666, 11045.889541104567, 11090.500927458284, 11119.777604447865, 11120.054795342325, 4460.487043989982, 4578.336141259499, 4660.766961651904, 4672.556107169813, 4755.191617425046, 7943.64253608589, 9434.764130896645, 9486.430814151036, 9515.04849515043, 9528.0, 5189.870253243699, 5219.921701174486, 5225.249541403672, 5231.686098834082, 5236.0575096483, 4169.708120431601, 4672.579467847842, 4726.763661816895, 4748.311494833299, 4819.855404337875, 3751.3247615429486, 3797.7721336719887, 3855.267499175148, 3870.574236833946, 3875.554311254242, 1245.9252444853337, 1255.0524354112586, 1261.4071386448354, 1261.4701825233424, 1269.6571925580226, 748.6818102306498, 839.2321026260903, 885.8981217159981, 897.3673560140086, 923.8660394242797, 5671.177679236487, 5732.369439361667, 5819.301683797971, 5852.4147585241135, 6024.518038556905, 919.793046564531, 940.6801687426308, 943.9056094390506, 954.7756277274835, 991.9782623897397, 3832.80835958201, 3865.16898866745, 3881.378979363288, 3949.170674158459, 4007.939880901789, 10006.0, 10310.896891031143, 10351.896481035094, 10355.94822025885, 10360.533775980099, 9479.672845801593, 10296.279260451696, 10302.02130797573, 10318.535665894902, 10345.844812327821, 7173.318534739192, 7538.133114691771, 7838.059432868093, 7838.176991415933, 7988.6804527819395, 4470.859930717646, 4984.37695288089, 5718.1708652246025, 5819.418058194146, 5939.4357536034, 7583.9620801895635, 7662.923370766221, 7900.960495197487, 9224.40041397307, 9565.569549370433, 9225.21585665226, 9438.056194380508, 9461.905380946379, 9582.329236953346, 9595.13643772064, 6637.568558043712, 6759.0, 7025.613591252531, 7045.154581450259, 7263.128424589083, 7815.218478152139, 7997.0, 8036.397270204641, 8037.437379383387, 8049.993750781152, 7162.713491460491, 7171.354578087997, 7218.314260145278, 7272.418206543358, 7404.407647388303, 5686.260786097946, 6414.935850641434, 7018.789436316714, 7140.250273721184, 7581.962090189734, 6485.935140648722, 6534.346565343428, 6614.867702645824, 6623.205215374186, 6624.768133115318, 4903.5586797188425, 4904.337914381513, 5110.9488905110475, 5172.767225474938, 5192.169252919514, 4208.842568293744, 4842.685225460334, 4882.096812089775, 5229.215617657382, 5277.630565860353], "value": 4417.550612279111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.5893047914772, 294.72737717611204, 304.4990989821743, 315.44166824720253, 316.6722442272249, 5226.118597304967, 5299.5230429261355, 5343.679379237239, 5376.758045887935, 5397.568194544437, 4362.607365337119, 4639.304104384344, 4817.445993710716, 5083.949160508394, 5244.973775131119, 3242.7081562659355, 3440.883856428291, 3724.0689827543047, 4016.7790771507557, 4095.5699651536456, 3420.8289585520747, 4067.227226826908, 4092.570280120589, 4109.486314210723, 4113.588641135878, 3233.611966564016, 4012.2176175645614, 4018.2164477926817, 4031.9920019995, 4053.3312003519386, 3337.833108344585, 3986.8604598839047, 4028.8589899353383, 4030.9395359069636, 4050.2911990401562, 3035.7267845893753, 3154.6529881712995, 3480.9825950870336, 3491.4239150540384, 3520.9823950880336, 5135.3067335909545, 5140.3060586820675, 5140.7943682253035, 5163.7676304566385, 5164.535191832715, 3820.605479000145, 3923.9215215695526, 4612.285095810154, 4628.907421851578, 4649.721016739007, 5283.788648454057, 5299.523042926116, 5525.944740552583, 5595.608307418483, 5647.576431767634, 3653.488511608377, 3854.672352850011, 3863.864764733249, 3870.825812838401, 3873.9031524211837, 5349.465053494697, 5728.02623554001, 5874.765009399619, 5924.466797988159, 5928.703564821785, 3257.413665540178, 3312.635610082889, 3682.9815850920572, 3910.2961466936226, 3918.216356728609, 3922.4116382542848, 3962.3660214365564, 3978.3833505806647, 3988.8659567131444, 3991.4012898064943, 3695.4456831474954, 4626.629869610423, 4638.83764068256, 4645.0, 4650.883727906829, 5541.501264886099, 5728.885422291531, 5735.541156707537, 5754.698120751733, 5786.189933409326, 1318.3737724580747, 1342.1946831900782, 1364.1951248763278, 1364.208758919824, 1371.9382627781774, 670.1087553553762, 778.9095266626655, 820.5651004967377, 835.8746188071838, 838.0948575538404, 4050.4936882889638, 4539.117660285677, 4543.795529201194, 4561.498235194126, 4567.401409506646, 4446.377507149002, 4483.7533935633855, 4678.859209599529, 4953.331300274489, 4959.330490383752, 4492.191405547033, 4508.020803178356, 4508.346289787963, 4525.796339164745, 4538.909221815546, 2284.474570848714, 2361.633946738258, 2443.4343938864477, 2618.9607155892677, 2633.604959256127, 4737.034130835734, 4857.295692124622, 4987.536155141129, 5085.720285384339, 5112.8721781955, 4371.934420983688, 4671.439427268681, 4849.563539281411, 5044.445111037783, 5049.823256186016, 4395.461588444019, 4738.336632871332, 4900.485449027872, 4992.450830408579, 5113.667611605234, 4899.632527560519, 4915.557599816034, 4930.654854160174, 4939.703617782944, 4961.404631444249, 4068.7762173080764, 4085.8569950051606, 4286.014216730232, 4818.590419814355, 4885.389326334208, 4402.493713223021, 4573.611243044378, 4641.655963738291, 4814.6870453420415, 5072.721000345016, 3027.5761393405382, 3049.697478403791, 3340.799552026886, 3370.112736867362, 3609.9819500902327, 5537.833864984057, 5797.797077102281, 5798.76804927815, 5938.881222375615, 6008.639481631116, 4606.6870941781435, 5364.356277246756, 5560.304961879765, 5636.689982051026, 5655.830325090254, 4618.46887607916, 4738.644601654821, 4995.750212489434, 5260.736963151904, 5565.9721701392855, 4353.934690979574, 5457.345118585795, 5468.496163555054, 5489.258950041693, 5520.613557050968, 5045.077140793127, 5393.352797664305, 5609.363599108413, 5627.774889004394, 5639.7744090237575, 4316.0, 4992.800287988585, 5125.589952803842, 5204.516712736852, 5446.509814116748], "value": 3851.6257112032285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.982475438114, 701.7543859649122, 750.8723517002109, 752.9533947812541, 784.137673026562, 14347.497837575687, 15023.624409389771, 15272.541823745305, 15296.388144474207, 15348.462803801869, 13006.154599950996, 13120.93439532801, 13206.339683015858, 13217.603471895834, 13299.069065165442, 645.2740666749906, 667.0128210248811, 795.5107608820591, 820.2371794231377, 821.6507984106761, 832.5004997001811, 837.6523742646795, 839.5760141128721, 841.9115992820757, 842.1283971089923, 851.6167724523958, 877.2192748453881, 881.2465342132481, 889.937704360695, 892.6920212526668, 850.200811237438, 866.9826603467958, 884.5798245833242, 888.338188049907, 889.0398369760643, 648.5719425179359, 656.1207981305074, 658.874813785384, 659.5482094765101, 663.1975309875057, 13948.930255348658, 14107.647308817259, 14151.150930944073, 14221.431142754278, 14658.926705366404, 13821.79267310991, 13842.515511957034, 14035.929820350935, 14211.228810381876, 14273.857261427356, 10974.725631859188, 11251.0, 11464.828027579593, 11503.712407189803, 11734.765304693858, 4375.299952007664, 4424.557544245582, 4425.690201685883, 4428.734275943454, 4593.19619066662, 87449.0, 87577.12422875753, 88906.0, 89252.66121008254, 89273.10726892778, 7813.687452501837, 10364.844527332096, 10422.5830966762, 10595.682129536126, 10727.19546034035, 19206.135723892457, 19242.807571924102, 19350.709739353922, 19351.225950961805, 19559.31542396009, 7562.848743025219, 7643.579603121771, 7724.536527808349, 7896.763097107096, 7901.407394445439, 4298.914021719611, 4356.172327257811, 4363.7381757094045, 4391.934120988188, 4483.798229079699, 2646.523625747384, 3083.090488305955, 3095.0250671038552, 3244.4808830587463, 3896.5129358830145, 512.8769095417148, 693.5400980935059, 704.1761139466836, 708.9468289878176, 713.2439614009166, 548.509084369487, 577.4918072096528, 612.788587937161, 634.72706736103, 675.42588799521, 8774.649014039367, 9269.304802139866, 9334.346595738232, 9370.0, 9381.624735010522, 631.4443289904855, 662.086320877196, 664.2925284571916, 666.8232918276564, 668.8060462465928, 3770.3967365221433, 3841.615838416136, 4321.762303073361, 4512.9774351128035, 4662.300654901792, 73247.0, 102459.0, 103094.96905030854, 105514.0, 116299.0, 78055.43889122299, 79060.20939790644, 93049.0, 94651.52674236585, 96736.0, 76008.0, 83766.0, 84190.0, 84268.15731842726, 84336.57831710803, 8338.958305208678, 9333.766655833659, 9539.379940303857, 9592.616295348107, 9722.9027709722, 47937.280940786615, 51967.22049169341, 52001.99999999849, 55096.24518774125, 56636.43363566476, 60113.7977240444, 78076.0, 79684.60157699406, 80781.0, 81146.59426702828, 11056.889431105586, 12142.935700930686, 12266.141370104364, 12485.438155282853, 12633.2420054797, 13983.860161398256, 14242.359093841009, 14253.073550219202, 14312.212828294543, 14599.562013139623, 13084.803727943898, 13108.2135071896, 13148.585785715986, 13601.455941762219, 13679.316034198051, 12884.517652686034, 13317.53388631432, 13399.397027133607, 13486.595402137951, 13605.86394136046, 12482.500699971899, 13021.739565208452, 13365.933170334087, 13472.191668499921, 13485.528006519724, 10990.230683852054, 11258.493367798632, 11501.942490287494, 11601.709957250798, 11622.302661840316, 7289.4168466523615, 9513.762155946157, 10494.68515944523, 11060.336379817236, 11464.770704586028], "value": 7290.671711268832, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1636.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 174.0, 161.0, 117.0, 125.0, 104.0, 177.0, 104.0, 166.0, 173.0], "value": 144.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 116.0, 150.0, 116.0, 112.0, 116.0, 122.0, 175.0, 145.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 247.0, 186.0, 203.0, 239.0, 277.0, 189.0, 194.0, 274.0, 234.0], "value": 224.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 67.0, 84.0, 112.0, 62.0, 61.0, 61.0, 60.0, 79.0, 59.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 103.0, 122.0, 77.0, 71.0, 69.0, 88.0, 71.0, 70.0, 87.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 112.0, 134.0, 90.0, 85.0, 89.0, 86.0, 91.0, 133.0], "value": 99.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 96.0, 95.0, 94.0, 95.0, 116.0, 96.0, 95.0, 96.0], "value": 109.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 90.0, 140.0, 146.0, 115.0, 88.0, 100.0, 76.0, 139.0, 142.0], "value": 114.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 64.0, 60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 61.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 118.0, 113.0, 111.0, 104.0, 73.0, 71.0, 71.0, 73.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 88.0, 86.0, 84.0, 89.0, 91.0, 91.0, 85.0, 86.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 150.0, 163.0, 163.0, 166.0, 163.0, 168.0, 195.0, 154.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 246.0, 184.0, 177.0, 174.0, 175.0, 176.0, 176.0, 174.0, 188.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 68.0, 70.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0], "value": 68.5, "unit": "score"}]}]} 11:14:09 INFO - Return code: 0 11:14:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:14:09 ERROR - # TBPL SUCCESS # 11:14:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:14:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:14:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:14:09 INFO - 2016-10-31 11:14:09.903 screenresolution[2017:13603] starting screenresolution argv=screenresolution get 11:14:09 INFO - 2016-10-31 11:14:09.905 screenresolution[2017:13603] Display 0: 1600x1200x32@60 11:14:09 INFO - 2016-10-31 11:14:09.911 screenresolution[2018:13606] starting screenresolution argv=screenresolution list 11:14:09 INFO - Available Modes on Display 0 11:14:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:14:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:14:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:14:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:14:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:14:10 INFO - Intel Iris: 11:14:10 INFO - Chipset Model: Intel Iris 11:14:10 INFO - Type: GPU 11:14:10 INFO - Bus: Built-In 11:14:10 INFO - VRAM (Dynamic, Max): 1536 MB 11:14:10 INFO - Vendor: Intel (0x8086) 11:14:10 INFO - Device ID: 0x0a2e 11:14:10 INFO - Revision ID: 0x0009 11:14:10 INFO - Displays: 11:14:10 INFO - Display: 11:14:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:14:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:14:10 INFO - Display Serial Number: 1600x1200 60 11:14:10 INFO - Main Display: Yes 11:14:10 INFO - Mirror: Off 11:14:10 INFO - Online: Yes 11:14:10 INFO - Rotation: Supported 11:14:10 INFO - Return code: 0 11:14:10 INFO - Running post-action listener: _resource_record_post_action 11:14:10 INFO - [mozharness: 2016-10-31 18:14:10.147982Z] Finished run-tests step (success) 11:14:10 INFO - Running post-run listener: _resource_record_post_run 11:14:10 INFO - Total resource usage - Wall time: 1213s; CPU: 55.0%; Read bytes: 1578496; Write bytes: 710569984; Read time: 15; Write time: 2009 11:14:10 INFO - TinderboxPrint: CPU usage
54.6% 11:14:10 INFO - TinderboxPrint: I/O read bytes / time
1,578,496 / 15 11:14:10 INFO - TinderboxPrint: I/O write bytes / time
710,569,984 / 2,009 11:14:10 INFO - TinderboxPrint: CPU idle
2,200.6 (45.4%) 11:14:10 INFO - TinderboxPrint: CPU system
982.3 (20.3%) 11:14:10 INFO - TinderboxPrint: CPU user
1,666.9 (34.4%) 11:14:10 INFO - TinderboxPrint: Swap in / out
408,944,640 / 0 11:14:10 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404296192; Write bytes: 397928448; Read time: 29793; Write time: 811 11:14:10 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 1541632; Write bytes: 300263424; Read time: 15; Write time: 1154 11:14:10 INFO - Running post-run listener: _upload_blobber_files 11:14:10 INFO - Blob upload gear active. 11:14:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:14:10 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 11:14:10 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'] 11:14:10 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 11:14:11 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:14:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:12 INFO - (blobuploader) - INFO - Done attempting. 11:14:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:14:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:14:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:13 INFO - (blobuploader) - INFO - Done attempting. 11:14:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:14:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:14:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:15 INFO - (blobuploader) - INFO - Done attempting. 11:14:15 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:15 INFO - Return code: 0 11:14:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:14:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb16e7312cb6f1033fbb6ddadd58b3e1768717d3b9a679d97ae3ad69270f5698438d6071ba88e958fc66c9c3ce36bb8c6f7dce6211aeefdbd828ee9c2f384944", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/663c0cfcaa7a4bd0db7230d4f207869443e9a809c16519c38a294f6505d326480089d3f2775093c4f8daacc3719900c1edf3cef2b3cc6ead3c32088b2c0446bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a7cdf78ea14441a6ee78c6b78c36dfae9c1d708c59e2e4267eb96d32433c0ec6f4f2c04c3f98021ea66fd92cc97944e9de0f29d3a4c94221af7fad7ca5a204b"} 11:14:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:14:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:14:15 INFO - Contents: 11:14:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb16e7312cb6f1033fbb6ddadd58b3e1768717d3b9a679d97ae3ad69270f5698438d6071ba88e958fc66c9c3ce36bb8c6f7dce6211aeefdbd828ee9c2f384944", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/663c0cfcaa7a4bd0db7230d4f207869443e9a809c16519c38a294f6505d326480089d3f2775093c4f8daacc3719900c1edf3cef2b3cc6ead3c32088b2c0446bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a7cdf78ea14441a6ee78c6b78c36dfae9c1d708c59e2e4267eb96d32433c0ec6f4f2c04c3f98021ea66fd92cc97944e9de0f29d3a4c94221af7fad7ca5a204b"} 11:14:15 INFO - Running post-run listener: copy_logs_to_upload_dir 11:14:15 INFO - Copying logs to upload dir... 11:14:15 INFO - mkdir: /builds/slave/test/build/upload/logs 11:14:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.329804 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-31 11:14:16.068459) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 11:14:16.076076) ========= 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.orpOXxkme2/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.i9ZWWiqL9h/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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/cb16e7312cb6f1033fbb6ddadd58b3e1768717d3b9a679d97ae3ad69270f5698438d6071ba88e958fc66c9c3ce36bb8c6f7dce6211aeefdbd828ee9c2f384944", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/663c0cfcaa7a4bd0db7230d4f207869443e9a809c16519c38a294f6505d326480089d3f2775093c4f8daacc3719900c1edf3cef2b3cc6ead3c32088b2c0446bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a7cdf78ea14441a6ee78c6b78c36dfae9c1d708c59e2e4267eb96d32433c0ec6f4f2c04c3f98021ea66fd92cc97944e9de0f29d3a4c94221af7fad7ca5a204b"} build_url:https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/U1jcSPuASzK5m4aewQ7aWA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb16e7312cb6f1033fbb6ddadd58b3e1768717d3b9a679d97ae3ad69270f5698438d6071ba88e958fc66c9c3ce36bb8c6f7dce6211aeefdbd828ee9c2f384944", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/663c0cfcaa7a4bd0db7230d4f207869443e9a809c16519c38a294f6505d326480089d3f2775093c4f8daacc3719900c1edf3cef2b3cc6ead3c32088b2c0446bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a7cdf78ea14441a6ee78c6b78c36dfae9c1d708c59e2e4267eb96d32433c0ec6f4f2c04c3f98021ea66fd92cc97944e9de0f29d3a4c94221af7fad7ca5a204b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 11:14:16.114863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 11:14:16.115188) ========= 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.orpOXxkme2/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.i9ZWWiqL9h/Listeners TMPDIR=/var/folders/qc/ph39qp3s3z90v747tyg95m6m00000w/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.005299 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 11:14:16.163230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 11:14:16.163557) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 11:14:16.163881) ========= ========= Total master_lag: 1.81 =========