builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0155 starttime: 1475639564.53 results: success (0) buildid: 20161004174501 builduid: 390c0f768f53402bbee0bfb378a985f0 revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:44.528385) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:44.528862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:44.529206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:44.554724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:44.555079) ========= 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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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-04 20:52:44-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.3M=0s 2016-10-04 20:52:44 (26.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:44.767611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:44.767985) ========= 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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.029134 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:44.817343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 20:52:44.817848) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C1vOwkBLPs/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.tWZG7xIHEn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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-04 20:52:44,889 truncating revision to first 12 chars 2016-10-04 20:52:44,889 Setting DEBUG logging. 2016-10-04 20:52:44,889 attempt 1/10 2016-10-04 20:52:44,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea104eeb14cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 20:52:46,769 unpacking tar archive at: fx-team-ea104eeb14cc/testing/mozharness/ program finished with exit code 0 elapsedTime=2.155266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-04 20:52:46.994965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:46.995288) ========= script_repo_revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:46.995679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:46.995945) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 20:52:47.013838) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-04 20:52:47.014184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C1vOwkBLPs/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.tWZG7xIHEn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:52:47 INFO - MultiFileLogger online at 20161004 20:52:47 in /builds/slave/test 20:52:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:52:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:52:47 INFO - {'append_to_log': False, 20:52:47 INFO - 'base_work_dir': '/builds/slave/test', 20:52:47 INFO - 'blob_upload_branch': 'Fx-Team', 20:52:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:52:47 INFO - 'branch': 'Fx-Team', 20:52:47 INFO - 'buildbot_json_path': 'buildprops.json', 20:52:47 INFO - 'config_files': ('talos/mac_config.py',), 20:52:47 INFO - 'default_actions': ('clobber', 20:52:47 INFO - 'read-buildbot-config', 20:52:47 INFO - 'download-and-extract', 20:52:47 INFO - 'populate-webroot', 20:52:47 INFO - 'create-virtualenv', 20:52:47 INFO - 'install', 20:52:47 INFO - 'run-tests'), 20:52:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:52:47 INFO - 'download_minidump_stackwalk': True, 20:52:47 INFO - 'download_symbols': 'ondemand', 20:52:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:52:47 INFO - 'tooltool.py': '/tools/tooltool.py', 20:52:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:52:47 INFO - '/tools/misc-python/virtualenv.py')}, 20:52:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:52:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:52:47 INFO - 'installer_path': 'installer.exe', 20:52:47 INFO - 'log_level': 'info', 20:52:47 INFO - 'log_name': 'talos', 20:52:47 INFO - 'log_to_console': True, 20:52:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:52:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:52:47 INFO - 'opt_config_files': (), 20:52:47 INFO - 'pip_index': False, 20:52:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:52:47 INFO - 'cmd': ('bash', 20:52:47 INFO - '-c', 20:52:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:52:47 INFO - 'enabled': True, 20:52:47 INFO - 'halt_on_failure': False, 20:52:47 INFO - 'name': 'check_screen_resolution'},), 20:52:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:52:47 INFO - 'cmd': ('bash', 20:52:47 INFO - '-c', 20:52:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:52:47 INFO - 'enabled': True, 20:52:47 INFO - 'halt_on_failure': False, 20:52:47 INFO - 'name': 'check_screen_resolution'},), 20:52:47 INFO - 'run_cmd_checks_enabled': True, 20:52:47 INFO - 'sps_profile': False, 20:52:47 INFO - 'sps_profile_interval': 0, 20:52:47 INFO - 'suite': 'dromaeojs-e10s', 20:52:47 INFO - 'system_bits': '32', 20:52:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:52:47 INFO - 'title': 't-yosemite-r7-0155', 20:52:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:52:47 INFO - 'use_talos_json': True, 20:52:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:52:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:52:47 INFO - 'work_dir': 'build'} 20:52:47 INFO - [mozharness: 2016-10-05 03:52:47.214675Z] Running clobber step. 20:52:47 INFO - Running pre-action listener: _resource_record_pre_action 20:52:47 INFO - Running main action method: clobber 20:52:47 INFO - rmtree: /builds/slave/test/build 20:52:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:52:49 INFO - Running post-action listener: _resource_record_post_action 20:52:49 INFO - [mozharness: 2016-10-05 03:52:49.364994Z] Finished clobber step (success) 20:52:49 INFO - [mozharness: 2016-10-05 03:52:49.365117Z] Running read-buildbot-config step. 20:52:49 INFO - Running pre-action listener: _resource_record_pre_action 20:52:49 INFO - Running main action method: read_buildbot_config 20:52:49 INFO - Using buildbot properties: 20:52:49 INFO - { 20:52:49 INFO - "project": "", 20:52:49 INFO - "product": "firefox", 20:52:49 INFO - "script_repo_revision": "production", 20:52:49 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 20:52:49 INFO - "repository": "", 20:52:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 20:52:49 INFO - "buildid": "20161004174501", 20:52:49 INFO - "pgo_build": "False", 20:52:49 INFO - "basedir": "/builds/slave/test", 20:52:49 INFO - "buildnumber": 4, 20:52:49 INFO - "slavename": "t-yosemite-r7-0155", 20:52:49 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:52:49 INFO - "platform": "yosemite_r7", 20:52:49 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 20:52:49 INFO - "branch": "fx-team", 20:52:49 INFO - "repo_path": "integration/fx-team", 20:52:49 INFO - "revision": "ea104eeb14cc54da9a06c3766da63f73117723a0", 20:52:49 INFO - "stage_platform": "macosx64", 20:52:49 INFO - "builduid": "390c0f768f53402bbee0bfb378a985f0", 20:52:49 INFO - "slavebuilddir": "test" 20:52:49 INFO - } 20:52:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 20:52:49 INFO - Running post-action listener: _resource_record_post_action 20:52:49 INFO - [mozharness: 2016-10-05 03:52:49.368441Z] Finished read-buildbot-config step (success) 20:52:49 INFO - [mozharness: 2016-10-05 03:52:49.368541Z] Running download-and-extract step. 20:52:49 INFO - Running pre-action listener: _resource_record_pre_action 20:52:49 INFO - Running main action method: download_and_extract 20:52:49 INFO - mkdir: /builds/slave/test/build/tests 20:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:52:49 INFO - trying https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 20:52:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/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 20:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/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 20:52:50 INFO - Downloaded 1199 bytes. 20:52:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:52:50 INFO - Using the following test package requirements: 20:52:50 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:52:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:52:50 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 20:52:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:52:50 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 20:52:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:52:50 INFO - u'jsshell-mac.zip'], 20:52:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:52:50 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 20:52:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:52:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:52:50 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 20:52:50 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:52:50 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 20:52:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:52:50 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 20:52:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:52:50 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 20:52:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:52:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:52:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:52:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:52:51 INFO - Http code: 200 20:52:51 INFO - via: 1.1 3d3d633d266d05d90a4eea7a6a59b514.cloudfront.net (CloudFront) 20:52:51 INFO - x-amz-cf-id: nhZxnjQHS5d83-QtdMXgn-iCR6PGfJASrS_MICqYjh26mccmP9MT8Q== 20:52:51 INFO - x-amz-version-id: hv7dmv7gR.MlDDR3lakCeQxBYlHPzYqS 20:52:51 INFO - Expected file size: 16476890 20:52:51 INFO - Obtained file size: 16476890 20:52:58 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 20:52:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:52:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:52:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:52:58 INFO - Http code: 200 20:52:58 INFO - via: 1.1 ca024aca72de992a25bcd7fdcfe84b67.cloudfront.net (CloudFront) 20:52:58 INFO - x-amz-cf-id: 8r7sWPNiiG-vP2ZxFvsrCovicrI8cj_J_t-lo-JfAZW3PRxat0v3CA== 20:52:58 INFO - x-amz-version-id: hv7dmv7gR.MlDDR3lakCeQxBYlHPzYqS 20:52:59 INFO - Expected file size: 16476890 20:52:59 INFO - Obtained file size: 16476890 20:53:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 20:53:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:53:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 20:53:06 INFO - Http code: 200 20:53:06 INFO - via: 1.1 939ea9d62ec616846d41b16cea0dc65b.cloudfront.net (CloudFront) 20:53:06 INFO - x-amz-cf-id: hbPtTPJcIBj6PJS3EDjKlO45Tf7P9dfOcEx1_qVblC2QXD3VEn1cqA== 20:53:06 INFO - x-amz-version-id: SIkCNULxoGpwtAahh9prtCPjKoo7agSv 20:53:06 INFO - Expected file size: 14409006 20:53:06 INFO - Obtained file size: 14409006 20:53:06 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')]} 20:53:06 INFO - trying https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 20:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/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 20:53:09 INFO - Downloaded 111719294 bytes. 20:53:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:09 INFO - mkdir: /builds/slave/test/properties 20:53:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:53:09 INFO - Writing to file /builds/slave/test/properties/build_url 20:53:09 INFO - Contents: 20:53:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:53:10 INFO - Running post-action listener: _resource_record_post_action 20:53:10 INFO - Running post-action listener: set_extra_try_arguments 20:53:10 INFO - [mozharness: 2016-10-05 03:53:10.267782Z] Finished download-and-extract step (success) 20:53:10 INFO - [mozharness: 2016-10-05 03:53:10.267930Z] Running populate-webroot step. 20:53:10 INFO - Running pre-action listener: _resource_record_pre_action 20:53:10 INFO - Running main action method: populate_webroot 20:53:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:53:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:53:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:53:10 INFO - '--tppagecycles', 20:53:10 INFO - '7'], 20:53:10 INFO - 'tests': ['tsvgm']}}, 20:53:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:53:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:53:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:53:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:53:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:10 INFO - 'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:53:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:53:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:10 INFO - 'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['damp', 'tps']}, 20:53:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:10 INFO - 'tests': ['damp', 'tps']}, 20:53:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['dromaeo_dom']}, 20:53:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:53:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['basic_compositor_video']}, 20:53:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:53:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['a11yr', 20:53:10 INFO - 'ts_paint', 20:53:10 INFO - 'tpaint', 20:53:10 INFO - 'sessionrestore', 20:53:10 INFO - 'sessionrestore_no_auto_restore', 20:53:10 INFO - 'tabpaint']}, 20:53:10 INFO - 'other-e10s': {'tests': ['a11yr', 20:53:10 INFO - 'ts_paint', 20:53:10 INFO - 'tpaint', 20:53:10 INFO - 'sessionrestore', 20:53:10 INFO - 'sessionrestore_no_auto_restore', 20:53:10 INFO - 'tabpaint']}, 20:53:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:53:10 INFO - 'ts_paint', 20:53:10 INFO - 'tpaint', 20:53:10 INFO - 'sessionrestore', 20:53:10 INFO - 'sessionrestore_no_auto_restore', 20:53:10 INFO - 'tabpaint']}, 20:53:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:53:10 INFO - 'ts_paint', 20:53:10 INFO - 'tpaint', 20:53:10 INFO - 'sessionrestore', 20:53:10 INFO - 'sessionrestore_no_auto_restore', 20:53:10 INFO - 'tabpaint']}, 20:53:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['a11yr', 20:53:10 INFO - 'ts_paint', 20:53:10 INFO - 'tpaint', 20:53:10 INFO - 'sessionrestore', 20:53:10 INFO - 'sessionrestore_no_auto_restore', 20:53:10 INFO - 'tabpaint']}, 20:53:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['a11yr', 20:53:10 INFO - 'ts_paint', 20:53:10 INFO - 'tpaint', 20:53:10 INFO - 'sessionrestore', 20:53:10 INFO - 'sessionrestore_no_auto_restore', 20:53:10 INFO - 'tabpaint']}, 20:53:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['tsvgx', 20:53:10 INFO - 'tsvgr_opacity', 20:53:10 INFO - 'tart', 20:53:10 INFO - 'tscrollx', 20:53:10 INFO - 'cart']}, 20:53:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:53:10 INFO - 'tsvgr_opacity', 20:53:10 INFO - 'tart', 20:53:10 INFO - 'tscrollx', 20:53:10 INFO - 'cart']}, 20:53:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:10 INFO - 'talos_options': ['--disable-e10s'], 20:53:10 INFO - 'tests': ['tp5o']}, 20:53:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:10 INFO - 'tests': ['tp5o']}, 20:53:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:10 INFO - 'talos_options': ['--disable-e10s', 20:53:10 INFO - '--xperf_path', 20:53:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:53:10 INFO - 'tests': ['tp5n']}, 20:53:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:53:10 INFO - 'talos_options': ['--xperf_path', 20:53:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:53:10 INFO - 'tests': ['tp5n']}}, 20:53:10 INFO - 'talos.zip': {'path': '', 20:53:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:53:10 INFO - Running post-action listener: _resource_record_post_action 20:53:10 INFO - [mozharness: 2016-10-05 03:53:10.286357Z] Finished populate-webroot step (success) 20:53:10 INFO - [mozharness: 2016-10-05 03:53:10.286488Z] Running create-virtualenv step. 20:53:10 INFO - Running pre-action listener: _resource_record_pre_action 20:53:10 INFO - Running main action method: create_virtualenv 20:53:10 INFO - Creating virtualenv /builds/slave/test/build/venv 20:53:10 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 20:53:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:53:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:53:10 INFO - Using real prefix '/tools/python27' 20:53:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:53:11 INFO - Installing distribute.............................................................................................................................................................................................done. 20:53:13 INFO - Installing pip.................done. 20:53:13 INFO - Return code: 0 20:53:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:53:14 INFO - Reading from file tmpfile_stdout 20:53:14 INFO - Output received: 20:53:14 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) 20:53:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:14 INFO - 'HOME': '/Users/cltbld', 20:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:14 INFO - 'LOGNAME': 'cltbld', 20:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:14 INFO - 'MOZ_NO_REMOTE': '1', 20:53:14 INFO - 'NO_EM_RESTART': '1', 20:53:14 INFO - 'PAGER': '/bin/cat', 20:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:14 INFO - 'PWD': '/builds/slave/test', 20:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:14 INFO - 'SHELL': '/bin/bash', 20:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:14 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:14 INFO - 'USER': 'cltbld', 20:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:14 INFO - 'XPC_FLAGS': '0x0', 20:53:14 INFO - 'XPC_SERVICE_NAME': '0', 20:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:14 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 20:53:14 INFO - Cleaning up... 20:53:14 INFO - Return code: 0 20:53:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:14 INFO - 'HOME': '/Users/cltbld', 20:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:14 INFO - 'LOGNAME': 'cltbld', 20:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:14 INFO - 'MOZ_NO_REMOTE': '1', 20:53:14 INFO - 'NO_EM_RESTART': '1', 20:53:14 INFO - 'PAGER': '/bin/cat', 20:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:14 INFO - 'PWD': '/builds/slave/test', 20:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:14 INFO - 'SHELL': '/bin/bash', 20:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:14 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:14 INFO - 'USER': 'cltbld', 20:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:14 INFO - 'XPC_FLAGS': '0x0', 20:53:14 INFO - 'XPC_SERVICE_NAME': '0', 20:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:14 INFO - Downloading/unpacking psutil>=3.1.1 20:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:53:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:18 INFO - Installing collected packages: psutil 20:53:18 INFO - Running setup.py install for psutil 20:53:18 INFO - building 'psutil._psutil_osx' extension 20:53:18 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 20:53:18 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 20:53:18 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 20:53:18 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 20:53:19 INFO - building 'psutil._psutil_posix' extension 20:53:19 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 20:53:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:53:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:53:19 INFO - ^ 20:53:19 INFO - 1 warning generated. 20:53:19 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 20:53:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:53:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:53:19 INFO - Successfully installed psutil 20:53:19 INFO - Cleaning up... 20:53:19 INFO - Return code: 0 20:53:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:19 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 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:19 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 20:53:19 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 20:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:19 INFO - 'HOME': '/Users/cltbld', 20:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:19 INFO - 'LOGNAME': 'cltbld', 20:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:19 INFO - 'MOZ_NO_REMOTE': '1', 20:53:19 INFO - 'NO_EM_RESTART': '1', 20:53:19 INFO - 'PAGER': '/bin/cat', 20:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:19 INFO - 'PWD': '/builds/slave/test', 20:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:19 INFO - 'SHELL': '/bin/bash', 20:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:19 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:19 INFO - 'USER': 'cltbld', 20:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:19 INFO - 'XPC_FLAGS': '0x0', 20:53:19 INFO - 'XPC_SERVICE_NAME': '0', 20:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:53:22 INFO - Installing collected packages: mozsystemmonitor 20:53:22 INFO - Running setup.py install for mozsystemmonitor 20:53:22 INFO - Successfully installed mozsystemmonitor 20:53:22 INFO - Cleaning up... 20:53:22 INFO - Return code: 0 20:53:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20: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')]} 20:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20: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')]} 20:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:22 INFO - 'HOME': '/Users/cltbld', 20:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:22 INFO - 'LOGNAME': 'cltbld', 20:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:22 INFO - 'MOZ_NO_REMOTE': '1', 20:53:22 INFO - 'NO_EM_RESTART': '1', 20:53:22 INFO - 'PAGER': '/bin/cat', 20:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:22 INFO - 'PWD': '/builds/slave/test', 20:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:22 INFO - 'SHELL': '/bin/bash', 20:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:22 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:22 INFO - 'USER': 'cltbld', 20:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:22 INFO - 'XPC_FLAGS': '0x0', 20:53:22 INFO - 'XPC_SERVICE_NAME': '0', 20:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:22 INFO - Downloading/unpacking jsonschema==2.5.1 20:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:53:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:25 INFO - Downloading functools32-3.2.3-2.tar.gz 20:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:53:25 INFO - warning: no files found matching '*.txt' 20:53:25 INFO - no previously-included directories found matching 'build' 20:53:25 INFO - no previously-included directories found matching 'dist' 20:53:25 INFO - no previously-included directories found matching '.git*' 20:53:25 INFO - Installing collected packages: jsonschema, functools32 20:53:25 INFO - Running setup.py install for functools32 20:53:25 INFO - warning: no files found matching '*.txt' 20:53:25 INFO - no previously-included directories found matching 'build' 20:53:25 INFO - no previously-included directories found matching 'dist' 20:53:25 INFO - no previously-included directories found matching '.git*' 20:53:25 INFO - Successfully installed jsonschema functools32 20:53:25 INFO - Cleaning up... 20:53:25 INFO - Return code: 0 20:53:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:25 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 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:25 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 20:53:25 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 20:53:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:25 INFO - 'HOME': '/Users/cltbld', 20:53:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:25 INFO - 'LOGNAME': 'cltbld', 20:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:25 INFO - 'MOZ_NO_REMOTE': '1', 20:53:25 INFO - 'NO_EM_RESTART': '1', 20:53:25 INFO - 'PAGER': '/bin/cat', 20:53:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:25 INFO - 'PWD': '/builds/slave/test', 20:53:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:25 INFO - 'SHELL': '/bin/bash', 20:53:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:25 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:25 INFO - 'USER': 'cltbld', 20:53:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:25 INFO - 'XPC_FLAGS': '0x0', 20:53:25 INFO - 'XPC_SERVICE_NAME': '0', 20:53:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:53:26 INFO - Cleaning up... 20:53:26 INFO - Return code: 0 20:53:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:53:26 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')]} 20:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:26 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')]} 20:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:26 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 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:26 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 20:53:26 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 20:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:26 INFO - 'HOME': '/Users/cltbld', 20:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:26 INFO - 'LOGNAME': 'cltbld', 20:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:26 INFO - 'MOZ_NO_REMOTE': '1', 20:53:26 INFO - 'NO_EM_RESTART': '1', 20:53:26 INFO - 'PAGER': '/bin/cat', 20:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:26 INFO - 'PWD': '/builds/slave/test', 20:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:26 INFO - 'SHELL': '/bin/bash', 20:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:26 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:26 INFO - 'USER': 'cltbld', 20:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:26 INFO - 'XPC_FLAGS': '0x0', 20:53:26 INFO - 'XPC_SERVICE_NAME': '0', 20:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:26 INFO - Downloading/unpacking blobuploader==1.2.4 20:53:26 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 20:53:26 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 20:53:26 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 20:53:26 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 20:53:26 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 20:53:26 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 20:53:28 INFO - Downloading blobuploader-1.2.4.tar.gz 20:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:53:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:53:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20: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 20: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 20: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 20: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 20: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 20: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 20:53:29 INFO - Downloading docopt-0.6.1.tar.gz 20:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:53:30 INFO - Installing collected packages: blobuploader, requests, docopt 20:53:30 INFO - Running setup.py install for blobuploader 20:53:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:53:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:53:30 INFO - Running setup.py install for requests 20:53:30 INFO - Running setup.py install for docopt 20:53:30 INFO - Successfully installed blobuploader requests docopt 20:53:30 INFO - Cleaning up... 20:53:30 INFO - Return code: 0 20:53:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:30 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 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:30 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 20:53:30 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 20:53:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:30 INFO - 'HOME': '/Users/cltbld', 20:53:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:30 INFO - 'LOGNAME': 'cltbld', 20:53:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:30 INFO - 'MOZ_NO_REMOTE': '1', 20:53:30 INFO - 'NO_EM_RESTART': '1', 20:53:30 INFO - 'PAGER': '/bin/cat', 20:53:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:30 INFO - 'PWD': '/builds/slave/test', 20:53:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:30 INFO - 'SHELL': '/bin/bash', 20:53:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:30 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:30 INFO - 'USER': 'cltbld', 20:53:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:30 INFO - 'XPC_FLAGS': '0x0', 20:53:30 INFO - 'XPC_SERVICE_NAME': '0', 20:53:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-9uTjs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-CUbw6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-XYnkwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Owh469-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-GwvOlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-rxPrx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-YRfXyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:53:31 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-rpeb_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Q3nYll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-HYTylT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-5M0Q7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-G9r6Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-g4rksb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-AAEKP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Td3hTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-dkOPh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:53:32 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-FvTlbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:53:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:53:32 INFO - Running setup.py install for manifestparser 20:53:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:53:33 INFO - Running setup.py install for mozcrash 20:53:33 INFO - Running setup.py install for mozdebug 20:53:33 INFO - Running setup.py install for mozdevice 20:53:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:53:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:53:33 INFO - Running setup.py install for mozfile 20:53:33 INFO - Running setup.py install for mozhttpd 20:53:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:53:33 INFO - Running setup.py install for mozinfo 20:53:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Running setup.py install for mozInstall 20:53:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Running setup.py install for mozleak 20:53:34 INFO - Running setup.py install for mozlog 20:53:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Running setup.py install for moznetwork 20:53:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Running setup.py install for mozprocess 20:53:34 INFO - Running setup.py install for mozprofile 20:53:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:53:34 INFO - Running setup.py install for mozrunner 20:53:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:53:35 INFO - Running setup.py install for mozscreenshot 20:53:35 INFO - Running setup.py install for moztest 20:53:35 INFO - Running setup.py install for mozversion 20:53:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:53:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:53:35 INFO - Cleaning up... 20:53:35 INFO - Return code: 0 20:53:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:35 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 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:35 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 20:53:35 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 20:53:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:35 INFO - 'HOME': '/Users/cltbld', 20:53:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:35 INFO - 'LOGNAME': 'cltbld', 20:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:35 INFO - 'MOZ_NO_REMOTE': '1', 20:53:35 INFO - 'NO_EM_RESTART': '1', 20:53:35 INFO - 'PAGER': '/bin/cat', 20:53:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:35 INFO - 'PWD': '/builds/slave/test', 20:53:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:35 INFO - 'SHELL': '/bin/bash', 20:53:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:35 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:35 INFO - 'USER': 'cltbld', 20:53:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:35 INFO - 'XPC_FLAGS': '0x0', 20:53:35 INFO - 'XPC_SERVICE_NAME': '0', 20:53:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:53:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-KcGIkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:53:35 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)) 20:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:53:35 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-63jPkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Gv0PgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-D0ICpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-OfQDuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-2Apfzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-KGDOxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-cIi41a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-2sFP5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-wen7J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:53:36 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Vxmir4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:53:36 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)) 20:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:53:37 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-JgmYgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:53:37 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)) 20:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:53:37 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-1lE9aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:53:37 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)) 20:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:53:37 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-mYhN6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:53:37 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)) 20:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:37 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-VmdeHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:53:37 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)) 20:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:53:37 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-C2lWVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:53:37 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)) 20:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:53:37 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-1fnM60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:53:37 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)) 20:53:37 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)) 20:53:37 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)) 20:53:37 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)) 20:53:37 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)) 20:53:37 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)) 20:53:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20: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 20: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 20: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 20: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 20: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 20: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 20:53:40 INFO - Downloading blessings-1.6.tar.gz 20:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:53:40 INFO - Installing collected packages: blessings 20:53:40 INFO - Running setup.py install for blessings 20:53:40 INFO - Successfully installed blessings 20:53:40 INFO - Cleaning up... 20:53:40 INFO - Return code: 0 20:53:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:53:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:53:40 INFO - Reading from file tmpfile_stdout 20:53:40 INFO - Current package versions: 20:53:40 INFO - blessings == 1.6 20:53:40 INFO - blobuploader == 1.2.4 20:53:40 INFO - docopt == 0.6.1 20:53:40 INFO - functools32 == 3.2.3-2 20:53:40 INFO - jsonschema == 2.5.1 20:53:40 INFO - manifestparser == 1.1 20:53:40 INFO - mozInstall == 1.12 20:53:40 INFO - mozcrash == 0.17 20:53:40 INFO - mozdebug == 0.1 20:53:40 INFO - mozdevice == 0.48 20:53:40 INFO - mozfile == 1.2 20:53:40 INFO - mozhttpd == 0.7 20:53:40 INFO - mozinfo == 0.9 20:53:40 INFO - mozleak == 0.1 20:53:40 INFO - mozlog == 3.4 20:53:40 INFO - moznetwork == 0.27 20:53:40 INFO - mozprocess == 0.23 20:53:40 INFO - mozprofile == 0.28 20:53:40 INFO - mozrunner == 6.12 20:53:40 INFO - mozscreenshot == 0.1 20:53:40 INFO - mozsystemmonitor == 0.3 20:53:40 INFO - moztest == 0.7 20:53:40 INFO - mozversion == 1.4 20:53:40 INFO - psutil == 3.1.1 20:53:40 INFO - requests == 1.2.3 20:53:40 INFO - wsgiref == 0.1.2 20:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20: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')]} 20:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20: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')]} 20:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:53:40 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 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20:53:40 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 20:53:40 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 20:53:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:40 INFO - 'HOME': '/Users/cltbld', 20:53:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:40 INFO - 'LOGNAME': 'cltbld', 20:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:40 INFO - 'MOZ_NO_REMOTE': '1', 20:53:40 INFO - 'NO_EM_RESTART': '1', 20:53:40 INFO - 'PAGER': '/bin/cat', 20:53:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:40 INFO - 'PWD': '/builds/slave/test', 20:53:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:40 INFO - 'SHELL': '/bin/bash', 20:53:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:40 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:40 INFO - 'USER': 'cltbld', 20:53:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:40 INFO - 'XPC_FLAGS': '0x0', 20:53:40 INFO - 'XPC_SERVICE_NAME': '0', 20:53:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 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)) 20:53:40 INFO - Cleaning up... 20:53:40 INFO - Return code: 0 20:53:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20: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')]} 20:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20: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')]} 20:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a7a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1009f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fbc35a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, '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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 20: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', 'jsonschema'] in /builds/slave/test/build 20: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 jsonschema 20:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:53:41 INFO - 'HOME': '/Users/cltbld', 20:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:53:41 INFO - 'LOGNAME': 'cltbld', 20:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:53:41 INFO - 'MOZ_NO_REMOTE': '1', 20:53:41 INFO - 'NO_EM_RESTART': '1', 20:53:41 INFO - 'PAGER': '/bin/cat', 20:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:53:41 INFO - 'PWD': '/builds/slave/test', 20:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:53:41 INFO - 'SHELL': '/bin/bash', 20:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:53:41 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:53:41 INFO - 'USER': 'cltbld', 20:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:53:41 INFO - 'XPC_FLAGS': '0x0', 20:53:41 INFO - 'XPC_SERVICE_NAME': '0', 20:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:53:41 INFO - Cleaning up... 20:53:41 INFO - Return code: 0 20:53:41 INFO - Running post-action listener: _resource_record_post_action 20:53:41 INFO - Running post-action listener: _start_resource_monitoring 20:53:42 INFO - Starting resource monitoring. 20:53:42 INFO - [mozharness: 2016-10-05 03:53:42.023930Z] Finished create-virtualenv step (success) 20:53:42 INFO - [mozharness: 2016-10-05 03:53:42.024890Z] Running install step. 20:53:42 INFO - Running pre-action listener: _resource_record_pre_action 20:53:42 INFO - Running main action method: install 20:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:53:42 INFO - Reading from file tmpfile_stdout 20:53:42 INFO - Detecting whether we're running mozinstall >=1.0... 20:53:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:53:42 INFO - Reading from file tmpfile_stdout 20:53:42 INFO - Output received: 20:53:42 INFO - Usage: mozinstall [options] installer 20:53:42 INFO - Options: 20:53:42 INFO - -h, --help show this help message and exit 20:53:42 INFO - -d DEST, --destination=DEST 20:53:42 INFO - Directory to install application into. [default: 20:53:42 INFO - "/builds/slave/test"] 20:53:42 INFO - --app=APP Application being installed. [default: firefox] 20:53:42 INFO - mkdir: /builds/slave/test/build/application 20:53:42 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'] 20:53:42 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 20:54:16 INFO - Reading from file tmpfile_stdout 20:54:16 INFO - Output received: 20:54:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:54:16 INFO - Running post-action listener: _resource_record_post_action 20:54:16 INFO - [mozharness: 2016-10-05 03:54:16.071920Z] Finished install step (success) 20:54:16 INFO - [mozharness: 2016-10-05 03:54:16.072049Z] Running run-tests step. 20:54:16 INFO - Running pre-action listener: _resource_record_pre_action 20:54:16 INFO - Running main action method: run_tests 20:54:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:54:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:54:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:54:16 INFO - 2016-10-04 20:54:16.085 screenresolution[1638:7514] starting screenresolution argv=screenresolution get 20:54:16 INFO - 2016-10-04 20:54:16.087 screenresolution[1638:7514] Display 0: 1600x1200x32@60 20:54:16 INFO - 2016-10-04 20:54:16.093 screenresolution[1639:7516] starting screenresolution argv=screenresolution list 20:54:16 INFO - Available Modes on Display 0 20:54:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:54:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:54:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:54:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:54:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:54:16 INFO - Intel Iris: 20:54:16 INFO - Chipset Model: Intel Iris 20:54:16 INFO - Type: GPU 20:54:16 INFO - Bus: Built-In 20:54:16 INFO - VRAM (Dynamic, Max): 1536 MB 20:54:16 INFO - Vendor: Intel (0x8086) 20:54:16 INFO - Device ID: 0x0a2e 20:54:16 INFO - Revision ID: 0x0009 20:54:16 INFO - Displays: 20:54:16 INFO - Display: 20:54:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:54:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:54:16 INFO - Display Serial Number: 1600x1200 60 20:54:16 INFO - Main Display: Yes 20:54:16 INFO - Mirror: Off 20:54:16 INFO - Online: Yes 20:54:16 INFO - Rotation: Supported 20:54:16 INFO - Return code: 0 20:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:54:16 INFO - Python 2.7.3 20:54:16 INFO - Return code: 0 20:54:16 INFO - grabbing minidump binary from tooltool 20:54:16 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')]} 20:54:16 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 0x10088ed30>, '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 0x1006b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100886b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:54:16 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 20:54:16 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 20:54:16 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 20:54:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:54:16 INFO - Return code: 0 20:54:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:54:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:54:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:54:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:54:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 20:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0155 --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 20:54:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C1vOwkBLPs/Render', 20:54:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:54:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:54:16 INFO - 'HOME': '/Users/cltbld', 20:54:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:54:16 INFO - 'LOGNAME': 'cltbld', 20:54:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:54:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:54:16 INFO - 'MOZ_NO_REMOTE': '1', 20:54:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:54:16 INFO - 'NO_EM_RESTART': '1', 20:54:16 INFO - 'PAGER': '/bin/cat', 20:54:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:54:16 INFO - 'PWD': '/builds/slave/test', 20:54:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:54:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:54:16 INFO - 'SHELL': '/bin/bash', 20:54:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tWZG7xIHEn/Listeners', 20:54:16 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 20:54:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:54:16 INFO - 'USER': 'cltbld', 20:54:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:54:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:54:16 INFO - 'XPC_FLAGS': '0x0', 20:54:16 INFO - 'XPC_SERVICE_NAME': '0', 20:54:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:54:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 20:54:16 INFO - mozversion application_buildid: 20161004174501 20:54:16 INFO - mozversion application_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 20:54:16 INFO - mozversion application_display_name: Nightly 20:54:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:54:16 INFO - mozversion application_name: Firefox 20:54:16 INFO - mozversion application_remotingname: firefox 20:54:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:54:16 INFO - mozversion application_vendor: Mozilla 20:54:16 INFO - mozversion application_version: 52.0a1 20:54:16 INFO - mozversion platform_buildid: 20161004174501 20:54:16 INFO - mozversion platform_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 20:54:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:54:16 INFO - mozversion platform_version: 52.0a1 20:54:16 INFO - using testdate: 1475639656 20:54:16 INFO - actual date: 1475639656 20:54:16 INFO - starting webserver on 'localhost:49274' 20:54:16 INFO - SUITE-START | Running 2 tests 20:54:16 INFO - TEST-START | dromaeo_css 20:54:16 INFO - operating with platform_type : mac_ 20:54:16 INFO - Initialising browser for dromaeo_css test... 20:54:16 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpuailxL/profile http://localhost:49274/getInfo.html) 20:54:19 INFO - PROCESS | 1649 | 2016-10-04 20:54:19.607 plugin-container[1651:7694] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 20:54:19 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:19 INFO - PROCESS | 1649 | 2016-10-04 20:54:19.610 plugin-container[1651:7694] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x491b, name = 'com.apple.CFPasteboardClient' 20:54:19 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:19 INFO - PROCESS | 1649 | 2016-10-04 20:54:19.610 plugin-container[1651:7694] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:54:19 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 20:54:19 INFO - PROCESS | 1649 | colorDepth:24 20:54:19 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 20:54:19 INFO - PROCESS | 1649 | __metrics 20:54:19 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 20:54:20 INFO - TEST-INFO | 1649: exit 0 20:54:20 INFO - Browser initialized. 20:54:20 INFO - Running cycle 1/1 for dromaeo_css test... 20:54:20 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpuailxL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:23 INFO - PROCESS | 1652 | 2016-10-04 20:54:23.260 plugin-container[1653:7812] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441f, name = 'com.apple.tsm.portname' 20:54:23 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:23 INFO - PROCESS | 1652 | 2016-10-04 20:54:23.266 plugin-container[1653:7812] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 20:54:23 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:54:23 INFO - PROCESS | 1652 | 2016-10-04 20:54:23.266 plugin-container[1653:7812] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:54:32 INFO - PROCESS | 1652 | RSS: Main: 240091136 20:54:32 INFO - PROCESS | 1652 | 20:55:22 INFO - PROCESS | 1652 | 1475639722479 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] 20:57:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 20:57:38 INFO - PROCESS | 1652 | RSS: Main: 251719680 20:57:38 INFO - PROCESS | 1652 | 21:00:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 21:00:41 INFO - PROCESS | 1652 | RSS: Main: 266493952 21:00:41 INFO - PROCESS | 1652 | 21:03:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 21:03:44 INFO - PROCESS | 1652 | RSS: Main: 270319616 21:03:44 INFO - PROCESS | 1652 | 21:06:46 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 21:06:46 INFO - PROCESS | 1652 | RSS: Main: 269889536 21:06:46 INFO - PROCESS | 1652 | 21:09:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 21:09:50 INFO - PROCESS | 1652 | RSS: Main: 275304448 21:09:50 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 21:12:53 INFO - PROCESS | 1652 | RSS: Main: 277995520 21:12:53 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | __start_tp_report 21:12:53 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 21:12:53 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 21:12:53 INFO - PROCESS | 1652 | |i|pagename|runs| 21:12:53 INFO - PROCESS | 1652 | |0;dojo.html;3353.111425472249;3396.711279541239;3399.626041135475;3418.940128560148;3421.5894092708877;5626.381098079219;5628.915566266504;5670.036093864042;5693.914591281134;5726.856828579288;5605.747741351639;5750.05124154514;5761.625494342865;5765.827025189251;5771.624844385112;5181.404138524062;5221.738913054351;5230.555402790767;5272.393674727398;5285;5285.471452854722;5306.867328316785;5314.548263397616;5317.521423071923;5331.840044798643;5274.630775845692;5289.2859463972445;5291.523762861341;5293.311869456965;5302.337207849019;5241.633085684004;5295.020421222086;5297.682139071668;5298.841034768963;5306.70813105279;5176.301199338079;5238.05714971305;5243.86890327741;5251.789928402859;5282.366116066097;4839.564439200489;5752.223449834302;5769.1346298055205;5899.351071382144;5906.350301466835;4769.713817170981;5938.970305148489;6173.32093469718;6229.4704950079295;6261.405166509175;4893.975530122327;6135.601185922901;6184.5980011299125;6207.317195108534;6222;5868.530517558671;5884.0585506318785;5887.028640274392;5890;5933.317668468138;5777.508911742549;6197.25632924043;6338.080978258219;6366.172397588284;6381.649009304533;4996.525330093636;5840.240768700127;5845;6131.356207598138;6223.751049957951;6105.419985101408;6130.754769809247;6146.815595532141;6174.380066285981;6236.719347629368;6151.2618485781095;6152.723127459275;6192.969035154795;6230.06549017651;6231.189945307081;6132.8756461173125;6164.4760195383;6205.441510264098;6206.255249370104;6272.466840318532;4121.29937910556;4665.95334046662;4934.1611925972675;4951.009798040406;4974.676646017997;4357.564243575617;4405.471343438744;4428.7121337112985;4454.175977444183;4496.572825581565;5317.096093664087;5556.222128901957;5594.992901277809;5625.156226566048;5755.625884317506;6142.775043102407;6146.877062458815;6186.381361863778;6263.655498947602;6273.215848018997;5657.377688454267;5704.743286552115;5726.599138060295;5737.770489180386;5744.281964754406;5296.629235953446;5312.1766126250495;5327.121025030904;5405.594580406407;5411.756470958816;6199.442050215503;6259.780907668392;6262.68686565679;6263.906041409291;6289.591176573508;6264.029075493306;6280.246370435394;6291.276503202191;6292.937070629235;6297.874042519215;6142.928535732134;6217.440430361289;6269.96865015672;6275.560710750204;6280.214973128359;5099.158638824552;6120.387961203844;6141.36327073057;6152.261728592597;6217.316095229431;4915.11527924977;6128.724207410588;6277.18396608438;6279.120923070683;6287;6176.938230617637;6206.193194884636;6206.968965155145;6228.875422491616;6236.6258024518675;5920.348761636131;5949.553783466171;5984.491318237999;6033.9698301508215;6104.786332478342;5911.379305172895;6068.332483426731;6070.514358851193;6077.696115194134;6094.786682466092;6170.352113028068;6177.011678131657;6192.504599632109;6198.256209254918;6204.565680402328;5816.82549523515;5839.328477225174;5920.526357891272;5974.61165024272;6029.005214139618 21:12:53 INFO - PROCESS | 1652 | |1;ext.html;473.7228721198099;509.28191250337034;511.7390131033173;529.4308618235395;539.0970125040558;39563.80218098909;40804.183916321694;40989.33569317992;41003.9749006275;41014.58985410145;41930;42343.78828105863;42364.788176059075;42382.36426453606;42450.542693017174;9620.855687164682;9839.704808855746;9847.11375976162;9848.45833479162;9848.753781155492;8265.256126948574;9779.657711980082;9846.261530385214;9849.852252216222;9850.950745246264;8307;8436.36727245456;9852.507374631276;9891.950540247288;9911.008899110104;9780.657676981342;9828.803423931517;9853.458059806708;9868.506574671273;9883.654072107442;9658.034196580285;9765.218782497383;9778.755531111708;9789;9811.509424528816;32864.50703239453;39918.80243592697;39919.8004009981;39969.400458993136;40158.196836063114;3203.9038828835173;3213.6464988851208;3523.4362501999813;3613.4760459733193;3688.520492336006;30327.24181895448;30462.10609992047;31482.212944676336;31616;32084.197895052577;3226.709596136359;3230.224746060952;3251.9837400812844;3257.1368587324378;3291.210109573709;502029;503585;506944;508880.45559772337;510112.44943775417;56194;56289.7185514078;56660.716696417076;56712.43287567072;56839.43160568424;57723.13415298774;57953.71023144942;58041;58182;58183;15677.921610391875;15946;15981.12103834277;15992.520224393287;15998.840011599968;12485.625431237077;12632.936835315764;12638.98888088969;12639.62081137549;12643.494260229489;14600.34298456572;14979.026363286352;15032.774508382383;15092.019018763745;15197.924010379877;6526.118973938553;6663.36698013688;6669.966650166718;6685.732570697118;6735.629540375228;861.4314552395389;875.8117004843989;967.5017366056486;1011.9443430611387;1026.58423338548;28159.014434495104;29301;29458.705412946027;30027.849860750557;30166.84916575447;778.0468925566137;894.6689724801865;910.822389634015;941.1059493481221;1108.1356541897333;15299.15854627984;15300.770488442682;15320.693586128215;15360;15552;671972;689640;694403;694708;697639;53977;54620.18069728957;55865;56065.159022614695;56284.31147065594;1281.135233717237;1304.934753262333;1308.9738205236033;1352.749741297863;1366.6241783509615;28021.299467513476;28988.710112899444;30395.544066838575;30982.380352392374;31073.53389699111;47097.293540596234;53044;54364;54439.72780136074;57840.1323980149;605967;609759;610022;615827;616075;25268;25504.234872953843;25518;25808.35479112962;25859.741402585732;46493;46498.535014649424;46810.531894680615;46947.295790562486;47541.28688069751;37389.439158412104;39208.80395598004;39281.803590981865;39771.989897275984;40725.592744073365;29812.254693631967;35480.93557193288;38505;38870.41694374643;40077.998050048984;29637.85181074081;37900.62099378971;38447.615523844404;38561.421578676905;38723.64467243633;32341.875912517913;34205.65794342025;34532.48201277033;34752.304953900275;34838.47742283817;24488.51022979495;25327;25812;25874.22377328683;26356.81394337221 21:12:53 INFO - PROCESS | 1652 | |2;jquery.html;355.66212098506423;367.4048042171681;376.46165982644817;380.5376467591876;385.545056832937;19396.806031939694;19744.802551974477;19831.008449577537;20492.69260961087;20714.27500037499;9546.665866694668;11408.657740267805;12046.277223366604;12054.939725301361;12065.577704780335;5256.842294731164;5498.835034948938;5555;5555.111182210847;5569.192467092269;3870;4088.2436749201343;4551.954480455202;5083.517065878754;5562.332520097594;4100.8974775630695;6760;6779.4915381346345;6842.863142737142;6849.1096157499705;4803.351547541072;6157.384261573851;6307.495400367982;6782.982552617123;6851.280615535372;5898;5955.13650520672;5964.671943043131;5969.253843269591;6003.339632640406;13561.593152205449;23160.652590210993;23585.41036474085;23892.04431822725;24314.63528047063;2087.2068613926763;2235.2958817972285;2266.3767463947383;2777.291790593386;2976.9851150744325;9848.65529706464;10025.24810639205;10031.448270345129;10400.843987340197;10414;1763.2594310389668;1810.4297146398842;1814.5372929902921;1818.7817461904524;1889.102676228794;113830;114894;133012.33493832566;137434;138005;11327.886721132849;11568.826467602992;11715.648530544097;11734.354610496504;11788.88211117895;14513.709725805425;14599.92700036493;14662.266886655838;14664.413423463155;14680;8239.299659528888;8544.2310192083;8577.270931970728;8618;8680.56597170139;8424.831503369898;8454.704085356983;8464.153584641486;8475.89813324264;8569.742907712654;4477.462704475419;4555.2711566149255;4557.863264102082;4581.587657110809;4601.4248218972625;1650.6121061550525;1901;1936.3803582853634;1951.9316823911095;1956.491312258823;804.2721337189853;808.2281421242699;900.4687234531527;904.6381447421085;962.0908241711655;20123.899380503004;20279.08744106519;21023.789762102184;21257.89371053135;21404.678929816066;896.3725392225468;945.7541039329686;946.2051876423837;950.7765675066354;956.2636769687302;9128.726138215865;10897.782044359226;11227;11255.212135150461;11256.986871181633;549028;575102;575249;581895;594928;133530;136153.31923340517;139142;141679.29160354132;143954;985.5663508056432;1004.4826914139225;1016.7763092119574;1032.3444612671008;1038.864947556828;18358.173882175066;18746.062696865374;18779.530511737317;18792;19008.904955475133;49927.00145996987;50321.741956451384;50508.747456262485;51462;52376.952460949804;57684.71157644185;71240.93138602821;71727;78080;80885.59557202176;7415.740449084256;7849.3328067114935;7902.881456778038;7957.1644977276555;8102.675892964216;9642.855357169508;9833.852492212765;12528.874711253135;12733.936330318289;12900.419481123185;9660.162682768489;10771.461426928465;11075.280106793032;11100.944495277472;11258.831117533407;9969.30214884951;10252.794944101226;10863.565457381615;10865.891341086488;11039.172062095215;9839.398454278558;10366;10976.725581860517;11212.27120237182;11218.55125794959;7669.884951725617;7832.686692532235;7893.210678932291;7944.086430060617;7972.162922893244;10413.479326033517;10571.04860562553;10654.946725266323;10776.784464310827;10802.027817496462 21:12:53 INFO - PROCESS | 1652 | |3;mootools.html;1310.855805861355;1514.0612820051567;1662.2353717290046;1805.6117934644049;1835.1558283189731;8046.959765201181;8327.042390125138;8504.957475212623;9142.588583513741;9163.037881022488;8510.446820956633;8830.82338353234;8844.91155088449;8932.55337233139;8936.8659470108;2316.224064938248;2350.9882450587725;2361.716594008713;2365.7042869641296;2370.2533701883935;2293.1973809166743;2322.2104484475276;2363.420961864346;2370.7510711375317;2382.809375249976;2342.531493701258;2352.329586067971;2367.5146594947996;2367.9763202368013;2372.110458578033;2322.8490148140318;2332.8716920569445;2339.789418952294;2346.272655476808;2346.8239882008834;2319.8376113672048;2329.918452854159;2329.9650505242435;2331.8717470539113;2337.0885354711677;8978.147076027766;8988.235999940012;9007.279417646572;9051.818963620757;9058.094190580956;5125.846224613268;5177.197534382177;5236.73816309183;5302.469753024705;5315.73421328932;3510.227749895019;3615.0420138663276;3690.6678398944223;3690.8708195213308;3709.017110465729;1052.4001319248032;1059.7403636109202;1084.8589683341115;1100.2518287564453;1106.4965440724452;11689.47397367112;11698.883011169864;11764.647060588197;11826.940865295704;11829.171957962946;4420.58004489573;4425.822967081345;4507.166174257773;4521.796519156645;4787.40157480315;7721.073471183494;9124.58939347731;9470.715878523655;9682.741243638422;10187.694369168938;5242.659227150223;5313.628046036741;5325.09473389517;5345.33183352081;5345.438728933406;4353.434053573079;4522.547745225517;4679.9298010529865;4810.903781924342;4858.076965376567;3212.646608873022;3248.3016151527536;3991.1818077294083;3992.201559688074;4032.193561287754;1020.336781092296;1094.6497120921388;1099.729812067064;1100.8733995590449;1113.9194980868706;749.9100107987076;761.8039677706059;787.7006737439851;896.5338024227365;917.454114801692;5715.485606295453;5762.827115186551;5940.55445841555;6015.969920150459;6115.84710382244;410.3721306401211;420.50170547900836;421.82072619136744;422.5267700175823;427.5211762825593;3544.4151714966742;3992.640662340345;4070.816813243411;4104.712670113123;4164.7917604119675;10233.744156396;10605;10744;10748.89251107479;10757.677269681923;10699.090577300862;10723.30298530593;10736.141108711441;10742.355458672504;10772.838407423895;7726.304632583095;8112.148224436467;8149.388795840336;8168.305694016075;8168.469049511763;5962.642241465526;5998.25021872266;6123.357047509948;6138.202033735586;6243.812685619257;10124.13944814699;10154.339967902062;10210.795784084128;10241.436720980417;10248.386661401295;9727.416355018722;10131.848022279819;10147.695569132939;10301.845472318071;10331.32846365014;7036.788896333118;7278;7390.224026477143;7587.355074818703;7764.92235077642;8290.875636865572;8394.034686010942;8481.236688698047;8598.140185981352;8653.66351085191;7495.362894154058;7614.847703046019;7652.846943061219;7741.341985931259;7771.883421748791;7489.962550187214;7502.924970750222;7557.093148822177;7573.6213189341415;7733.961330193313;6940.548864323803;7070.787876363717;7072.929270707433;7085;7088.113985751781;4961.7271050092595;5060.179564428832;5119.232115182753;5170.974145129401;5196.53231209193;5045.066662667418;5053.444121146597;5060.51925067118;5161.690298582097;5252.474752524717 21:12:53 INFO - PROCESS | 1652 | |4;prototype.html;256.9820112592118;306.92787195009186;314.83943188973626;317.29876971892116;318.6829105040482;4752.405949256343;5206.401263854648;5403.621746477748;5521.558275337973;5555.2778138841995;5168.870778230536;5338.65099356283;5392.1911713243035;5409.540189083933;5438.782448702047;3625.963740362589;4120.649744771683;4122.381642753596;4148.315527937894;4163.479565054368;3585.4084076127538;3826.349520581508;3951.604839516054;4154.252234597771;4156.833726650931;3235.964491362765;3253.137918451612;3376.96623033769;3824.972764434854;3937.7792884205846;3224.6936541028563;3246.636412706669;4006.5392479864895;4067.491563554556;4170.70805043647;3137.905862824119;3519.6832285094465;3536.45184996326;3549.7515173937836;3559.9320203938714;4849.587785038276;4911.238757992517;5194.6104042196985;5253.322674128126;5333.759980800874;4066.6136717011836;4459.554044595515;4663.463701674317;4676.69601475903;4727.503612120712;5583.860403489945;5665.943340566583;5683.5169010634145;5712.485876271156;5715.942840571624;3573.731970102253;3748.686323888075;3772.86794962175;3841.0397400649836;3877.9612203878164;5695.515881150107;5947.1971283876555;5991.191189189491;5996.730147143389;6059.45464908156;3921.2157568485845;3926.332523471017;3943.861964831217;3964.226975739703;3972.463717398172;3218.613766348053;3957.0107473131716;3996.6003399659803;4004.2391945530258;4022;3721.404575267944;3855.9036024099623;4676.3686902267755;4678.134545109166;4684.414448193976;5790.478856902899;5798.144234084287;5832.80427512359;5852.063669812895;5906.49794767441;1177.8174382970653;1266.645339304996;1325.1982550556968;1325.3969443903193;1360.4490181476517;890.5235698901057;896.9551522423852;903.8056817784208;917.6054296652503;919.0212423768666;5273.683578985273;5322.4411436799355;5334.946650533522;5346.91979620306;5347.224652425377;5205.345273910258;5215.348081489814;5866.5893387462465;5876.706164691748;5897.351291357947;4888.82889098887;4888.877778055577;4983.476734942851;5238.423773384925;5316.202569614588;2570.5630042892753;2613.2160351894354;2616.9607455888176;2617.8219801089203;2618.5810270357033;4140.171965606891;4145.274576949082;4987.875303117378;5007.574356179693;5009.423916249678;4657.883552911204;4857.441394239637;5013.749312534359;5068.518490743373;5606.421046318739;5596.768710883681;5990.9700451497465;6073.605215660968;6082.894046518671;6115.785947491817;4496.246463879024;5285.735713214401;6003.339632640494;6005.339412664691;6007.3992600739575;5534.391216966211;5702.6293290935955;5836.708164591839;5921.230240068763;5941.376155503783;5193.506616871391;5519.834404967857;6068.332483426731;6076.51387888959;6084.452399284086;3606.3688854450893;3825.407061905409;3924.941125883171;3971.8212680428874;3995.440638310697;5578;5895.7052147393315;5933;5952.315483719254;6013.639181649115;5589.608727389043;5645.266115404971;5783.537317014713;5795.681237531808;5824.242848429677;5046.697198168122;5785.681787501728;5793.391693872083;5815.76736930518;5817.680027598522;5466.512736704869;5514.724263786715;5611.9898418283465;5666.603337766317;5711.286089238845;4379.58393952574;5307.162121666136;5358.089124848863;5524.806631767869;5578.693171875586;4639.2628349272745;4672.785075880228;4747.667663263538;5025.497450254945;5265.921011184912 21:12:53 INFO - PROCESS | 1652 | |5;yui.html;637.563269160625;642.9035644653303;669.8693754717832;710.7938697777644;722.2813300765736;10948.726281842937;11474;15746.291416886239;15802.525924222264;15858.841411585881;12682.302473363961;14227.71544569108;14325.355359008843;14427.35076921541;14470.493532726357;836.4981011393177;846.124261389462;864.4251572704144;865.1132589096164;871.8038441350709;844.6452489954233;849.2993280543576;849.562475325208;850.3494826457764;851.0255757158051;876.9429987050853;878.6924576398242;890.7594949363668;892.1524551675901;896.4755617963467;879;886.4238245140646;902.5171533229691;904.1726819959729;911.4349103555771;667.4626925325111;673.1383828699272;674.5581644023173;675.0684056002685;675.7905049434642;14994.550163495112;15013.099214047083;15018.774718379233;15021.549353519302;15027;10765.730856728644;11166.665000050012;13305.800412993813;14000.369983350774;14341.498047568284;11294.853977744202;11660.591879284184;11914.225575337576;11983;12245.467085638613;3749.1189570450924;3770;3782.111203867089;3855.460235566995;3894.240623078501;87541.12458875394;93936;115800.42099789531;116133.41933290364;117693;11095.944520277348;11097.500612472459;11158.442077896072;11185.440727963569;11336.376499292453;21741.891290543444;21941;21961.780382195975;21962.69391713879;21984.120635174415;7227.74702885407;7255.165655949633;7429.665665045086;7469.514481558681;7506.812329691801;4413.029133590605;4473.7986790594505;4505.5269196734525;4516.796744146522;4516.932246016312;3522.2427178156818;3626.111602657313;3627.075095850594;3748.981255093707;3931.9213615727526;564.8051422259314;683.3166833166833;713.6645776485044;723.0166972916829;724.4421795217653;571.5456212311223;591.5858898770878;660.3627499463041;676.3439463720183;683.2586643491867;9095.909040909506;9459.290553208537;9470.479123648127;9589;9614;547.2284079447959;627.6234259444388;649.4901502320656;660.8711301296202;667.1227336053074;4246.959494923702;4339.370791235253;4405.163019026375;4744.098621262018;5057.8735531612;86295.27409451776;87478.25043499222;87967.56016220005;116157.41921290339;151058;120056.39971800259;121594.39202803929;122997.15504267444;124200;125303.74696252921;95394.04605953852;103273.48363258135;104971;105968;113228.43385783018;9764.218862491125;9831.5084245786;9986;10007.699769006942;10027.949860250652;46531.53468465272;56645.71677141588;57192.85614287774;58048;61403.385966139766;80186;85304.4695530442;90082;93300.53349733209;93312.46812723044;9482.103002798602;10105.696829095139;13168.934155329162;13475.25886076236;13666.248356340497;14881.255937203314;15064.623384415478;15370.077795332316;15585.519375659294;15622.843771562138;13292.800607990694;13585.252811095485;13878.375473103937;13878.722425551634;14122.870170386139;13759.518416855362;14170.574882753534;14224.786628200793;14370.209638469985;14432;13346.19922804635;13643.79534307006;13645.317734113452;13652.863471365557;13950.860491394957;11168.553257869595;11367.374794386387;11389.278921319645;11443.313401195956;11562.248453850809;7981.760547183594;8912.30666173425;10029.247806414402;11550.480228389575;11723.120765942418 21:12:53 INFO - PROCESS | 1652 | __end_tp_report 21:12:53 INFO - PROCESS | 1652 | __start_cc_report 21:12:53 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,351 21:12:53 INFO - PROCESS | 1652 | __end_cc_report 21:12:53 INFO - PROCESS | 1652 | __startTimestamp1475640773414__endTimestamp 21:12:53 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | ------- Summary: start ------- 21:12:53 INFO - PROCESS | 1652 | Number of tests: 6 21:12:53 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5700.45 Median:5899.35 stddev:646.68 (11.0%) stddev-sans-first:621.90 21:12:53 INFO - PROCESS | 1652 | Values: 3353.1 3396.7 3399.6 3418.9 3421.6 5626.4 5628.9 5670.0 5693.9 5726.9 5605.7 5750.1 5761.6 5765.8 5771.6 5181.4 5221.7 5230.6 5272.4 5285.0 5285.5 5306.9 5314.5 5317.5 5331.8 5274.6 5289.3 5291.5 5293.3 5302.3 5241.6 5295.0 5297.7 5298.8 5306.7 5176.3 5238.1 5243.9 5251.8 5282.4 4839.6 5752.2 5769.1 5899.4 5906.4 4769.7 5939.0 6173.3 6229.5 6261.4 4894.0 6135.6 6184.6 6207.3 6222.0 5868.5 5884.1 5887.0 5890.0 5933.3 5777.5 6197.3 6338.1 6366.2 6381.6 4996.5 5840.2 5845.0 6131.4 6223.8 6105.4 6130.8 6146.8 6174.4 6236.7 6151.3 6152.7 6193.0 6230.1 6231.2 6132.9 6164.5 6205.4 6206.3 6272.5 4121.3 4666.0 4934.2 4951.0 4974.7 4357.6 4405.5 4428.7 4454.2 4496.6 5317.1 5556.2 5595.0 5625.2 5755.6 6142.8 6146.9 6186.4 6263.7 6273.2 5657.4 5704.7 5726.6 5737.8 5744.3 5296.6 5312.2 5327.1 5405.6 5411.8 6199.4 6259.8 6262.7 6263.9 6289.6 6264.0 6280.2 6291.3 6292.9 6297.9 6142.9 6217.4 6270.0 6275.6 6280.2 5099.2 6120.4 6141.4 6152.3 6217.3 4915.1 6128.7 6277.2 6279.1 6287.0 6176.9 6206.2 6207.0 6228.9 6236.6 5920.3 5949.6 5984.5 6034.0 6104.8 5911.4 6068.3 6070.5 6077.7 6094.8 6170.4 6177.0 6192.5 6198.3 6204.6 5816.8 5839.3 5920.5 5974.6 6029.0 21:12:53 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:72544.76 Median:40996.66 stddev:162651.65 (396.7%) stddev-sans-first:163017.92 21:12:53 INFO - PROCESS | 1652 | Values: 473.7 509.3 511.7 529.4 539.1 39563.8 40804.2 40989.3 41004.0 41014.6 41930.0 42343.8 42364.8 42382.4 42450.5 9620.9 9839.7 9847.1 9848.5 9848.8 8265.3 9779.7 9846.3 9849.9 9851.0 8307.0 8436.4 9852.5 9892.0 9911.0 9780.7 9828.8 9853.5 9868.5 9883.7 9658.0 9765.2 9778.8 9789.0 9811.5 32864.5 39918.8 39919.8 39969.4 40158.2 3203.9 3213.6 3523.4 3613.5 3688.5 30327.2 30462.1 31482.2 31616.0 32084.2 3226.7 3230.2 3252.0 3257.1 3291.2 502029.0 503585.0 506944.0 508880.5 510112.4 56194.0 56289.7 56660.7 56712.4 56839.4 57723.1 57953.7 58041.0 58182.0 58183.0 15677.9 15946.0 15981.1 15992.5 15998.8 12485.6 12632.9 12639.0 12639.6 12643.5 14600.3 14979.0 15032.8 15092.0 15197.9 6526.1 6663.4 6670.0 6685.7 6735.6 861.4 875.8 967.5 1011.9 1026.6 28159.0 29301.0 29458.7 30027.8 30166.8 778.0 894.7 910.8 941.1 1108.1 15299.2 15300.8 15320.7 15360.0 15552.0 671972.0 689640.0 694403.0 694708.0 697639.0 53977.0 54620.2 55865.0 56065.2 56284.3 1281.1 1304.9 1309.0 1352.7 1366.6 28021.3 28988.7 30395.5 30982.4 31073.5 47097.3 53044.0 54364.0 54439.7 57840.1 605967.0 609759.0 610022.0 615827.0 616075.0 25268.0 25504.2 25518.0 25808.4 25859.7 46493.0 46498.5 46810.5 46947.3 47541.3 37389.4 39208.8 39281.8 39772.0 40725.6 29812.3 35480.9 38505.0 38870.4 40078.0 29637.9 37900.6 38447.6 38561.4 38723.6 32341.9 34205.7 34532.5 34752.3 34838.5 24488.5 25327.0 25812.0 25874.2 26356.8 21:12:53 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:34269.69 Median:1666.32 stddev:96846.49 (5812.0%) stddev-sans-first:97084.69 21:12:53 INFO - PROCESS | 1652 | Values: 355.7 367.4 376.5 380.5 385.5 19396.8 19744.8 19831.0 20492.7 20714.3 9546.7 11408.7 12046.3 12054.9 12065.6 5256.8 5498.8 5555.0 5555.1 5569.2 3870.0 4088.2 4552.0 5083.5 5562.3 4100.9 6760.0 6779.5 6842.9 6849.1 4803.4 6157.4 6307.5 6783.0 6851.3 5898.0 5955.1 5964.7 5969.3 6003.3 13561.6 23160.7 23585.4 23892.0 24314.6 2087.2 2235.3 2266.4 2777.3 2977.0 9848.7 10025.2 10031.4 10400.8 10414.0 1763.3 1810.4 1814.5 1818.8 1889.1 113830.0 114894.0 133012.3 137434.0 138005.0 11327.9 11568.8 11715.6 11734.4 11788.9 14513.7 14599.9 14662.3 14664.4 14680.0 8239.3 8544.2 8577.3 8618.0 8680.6 8424.8 8454.7 8464.2 8475.9 8569.7 4477.5 4555.3 4557.9 4581.6 4601.4 1650.6 1901.0 1936.4 1951.9 1956.5 804.3 808.2 900.5 904.6 962.1 20123.9 20279.1 21023.8 21257.9 21404.7 896.4 945.8 946.2 950.8 956.3 9128.7 10897.8 11227.0 11255.2 11257.0 549028.0 575102.0 575249.0 581895.0 594928.0 133530.0 136153.3 139142.0 141679.3 143954.0 985.6 1004.5 1016.8 1032.3 1038.9 18358.2 18746.1 18779.5 18792.0 19008.9 49927.0 50321.7 50508.7 51462.0 52377.0 57684.7 71240.9 71727.0 78080.0 80885.6 7415.7 7849.3 7902.9 7957.2 8102.7 9642.9 9833.9 12528.9 12733.9 12900.4 9660.2 10771.5 11075.3 11100.9 11258.8 9969.3 10252.8 10863.6 10865.9 11039.2 9839.4 10366.0 10976.7 11212.3 11218.6 7669.9 7832.7 7893.2 7944.1 7972.2 10413.5 10571.0 10654.9 10776.8 10802.0 21:12:53 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5705.52 Median:4601.24 stddev:3244.90 (70.5%) stddev-sans-first:3237.20 21:12:53 INFO - PROCESS | 1652 | Values: 1310.9 1514.1 1662.2 1805.6 1835.2 8047.0 8327.0 8505.0 9142.6 9163.0 8510.4 8830.8 8844.9 8932.6 8936.9 2316.2 2351.0 2361.7 2365.7 2370.3 2293.2 2322.2 2363.4 2370.8 2382.8 2342.5 2352.3 2367.5 2368.0 2372.1 2322.8 2332.9 2339.8 2346.3 2346.8 2319.8 2329.9 2330.0 2331.9 2337.1 8978.1 8988.2 9007.3 9051.8 9058.1 5125.8 5177.2 5236.7 5302.5 5315.7 3510.2 3615.0 3690.7 3690.9 3709.0 1052.4 1059.7 1084.9 1100.3 1106.5 11689.5 11698.9 11764.6 11826.9 11829.2 4420.6 4425.8 4507.2 4521.8 4787.4 7721.1 9124.6 9470.7 9682.7 10187.7 5242.7 5313.6 5325.1 5345.3 5345.4 4353.4 4522.5 4679.9 4810.9 4858.1 3212.6 3248.3 3991.2 3992.2 4032.2 1020.3 1094.6 1099.7 1100.9 1113.9 749.9 761.8 787.7 896.5 917.5 5715.5 5762.8 5940.6 6016.0 6115.8 410.4 420.5 421.8 422.5 427.5 3544.4 3992.6 4070.8 4104.7 4164.8 10233.7 10605.0 10744.0 10748.9 10757.7 10699.1 10723.3 10736.1 10742.4 10772.8 7726.3 8112.1 8149.4 8168.3 8168.5 5962.6 5998.3 6123.4 6138.2 6243.8 10124.1 10154.3 10210.8 10241.4 10248.4 9727.4 10131.8 10147.7 10301.8 10331.3 7036.8 7278.0 7390.2 7587.4 7764.9 8290.9 8394.0 8481.2 8598.1 8653.7 7495.4 7614.8 7652.8 7741.3 7771.9 7490.0 7502.9 7557.1 7573.6 7734.0 6940.5 7070.8 7072.9 7085.0 7088.1 4961.7 5060.2 5119.2 5171.0 5196.5 5045.1 5053.4 5060.5 5161.7 5252.5 21:12:53 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4528.06 Median:5057.61 stddev:1439.69 (28.5%) stddev-sans-first:1407.59 21:12:53 INFO - PROCESS | 1652 | Values: 257.0 306.9 314.8 317.3 318.7 4752.4 5206.4 5403.6 5521.6 5555.3 5168.9 5338.7 5392.2 5409.5 5438.8 3626.0 4120.6 4122.4 4148.3 4163.5 3585.4 3826.3 3951.6 4154.3 4156.8 3236.0 3253.1 3377.0 3825.0 3937.8 3224.7 3246.6 4006.5 4067.5 4170.7 3137.9 3519.7 3536.5 3549.8 3559.9 4849.6 4911.2 5194.6 5253.3 5333.8 4066.6 4459.6 4663.5 4676.7 4727.5 5583.9 5665.9 5683.5 5712.5 5715.9 3573.7 3748.7 3772.9 3841.0 3878.0 5695.5 5947.2 5991.2 5996.7 6059.5 3921.2 3926.3 3943.9 3964.2 3972.5 3218.6 3957.0 3996.6 4004.2 4022.0 3721.4 3855.9 4676.4 4678.1 4684.4 5790.5 5798.1 5832.8 5852.1 5906.5 1177.8 1266.6 1325.2 1325.4 1360.4 890.5 897.0 903.8 917.6 919.0 5273.7 5322.4 5334.9 5346.9 5347.2 5205.3 5215.3 5866.6 5876.7 5897.4 4888.8 4888.9 4983.5 5238.4 5316.2 2570.6 2613.2 2617.0 2617.8 2618.6 4140.2 4145.3 4987.9 5007.6 5009.4 4657.9 4857.4 5013.7 5068.5 5606.4 5596.8 5991.0 6073.6 6082.9 6115.8 4496.2 5285.7 6003.3 6005.3 6007.4 5534.4 5702.6 5836.7 5921.2 5941.4 5193.5 5519.8 6068.3 6076.5 6084.5 3606.4 3825.4 3924.9 3971.8 3995.4 5578.0 5895.7 5933.0 5952.3 6013.6 5589.6 5645.3 5783.5 5795.7 5824.2 5046.7 5785.7 5793.4 5815.8 5817.7 5466.5 5514.7 5612.0 5666.6 5711.3 4379.6 5307.2 5358.1 5524.8 5578.7 4639.3 4672.8 4747.7 5025.5 5265.9 21:12:53 INFO - PROCESS | 1652 | 21:12:53 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:22911.91 Median:3874.85 stddev:35248.01 (909.7%) stddev-sans-first:35307.22 21:12:53 INFO - PROCESS | 1652 | Values: 637.6 642.9 669.9 710.8 722.3 10948.7 11474.0 15746.3 15802.5 15858.8 12682.3 14227.7 14325.4 14427.4 14470.5 836.5 846.1 864.4 865.1 871.8 844.6 849.3 849.6 850.3 851.0 876.9 878.7 890.8 892.2 896.5 879.0 886.4 902.5 904.2 911.4 667.5 673.1 674.6 675.1 675.8 14994.6 15013.1 15018.8 15021.5 15027.0 10765.7 11166.7 13305.8 14000.4 14341.5 11294.9 11660.6 11914.2 11983.0 12245.5 3749.1 3770.0 3782.1 3855.5 3894.2 87541.1 93936.0 115800.4 116133.4 117693.0 11095.9 11097.5 11158.4 11185.4 11336.4 21741.9 21941.0 21961.8 21962.7 21984.1 7227.7 7255.2 7429.7 7469.5 7506.8 4413.0 4473.8 4505.5 4516.8 4516.9 3522.2 3626.1 3627.1 3749.0 3931.9 564.8 683.3 713.7 723.0 724.4 571.5 591.6 660.4 676.3 683.3 9095.9 9459.3 9470.5 9589.0 9614.0 547.2 627.6 649.5 660.9 667.1 4247.0 4339.4 4405.2 4744.1 5057.9 86295.3 87478.3 87967.6 116157.4 151058.0 120056.4 121594.4 122997.2 124200.0 125303.7 95394.0 103273.5 104971.0 105968.0 113228.4 9764.2 9831.5 9986.0 10007.7 10027.9 46531.5 56645.7 57192.9 58048.0 61403.4 80186.0 85304.5 90082.0 93300.5 93312.5 9482.1 10105.7 13168.9 13475.3 13666.2 14881.3 15064.6 15370.1 15585.5 15622.8 13292.8 13585.3 13878.4 13878.7 14122.9 13759.5 14170.6 14224.8 14370.2 14432.0 13346.2 13643.8 13645.3 13652.9 13950.9 11168.6 11367.4 11389.3 11443.3 11562.2 7981.8 8912.3 10029.2 11550.5 11723.1 21:12:53 INFO - PROCESS | 1652 | -------- Summary: end -------- 21:12:53 INFO - PROCESS | 1652 | 21:12:54 INFO - TEST-INFO | 1652: exit 0 21:12:54 INFO - TEST-OK | dromaeo_css | took 1117392ms 21:12:54 INFO - TEST-START | kraken 21:12:54 INFO - operating with platform_type : mac_ 21:12:54 INFO - Initialising browser for kraken test... 21:12:54 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpY3lMbg/profile http://localhost:49274/getInfo.html) 21:12:56 INFO - PROCESS | 1664 | 2016-10-04 21:12:56.895 plugin-container[1665:9994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c27, name = 'com.apple.tsm.portname' 21:12:56 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:12:56 INFO - PROCESS | 1664 | 2016-10-04 21:12:56.899 plugin-container[1665:9994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f1b, name = 'com.apple.CFPasteboardClient' 21:12:56 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:12:56 INFO - PROCESS | 1664 | 2016-10-04 21:12:56.899 plugin-container[1665:9994] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:12:56 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 21:12:56 INFO - PROCESS | 1664 | colorDepth:24 21:12:56 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 21:12:56 INFO - PROCESS | 1664 | __metrics 21:12:57 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 21:12:57 INFO - TEST-INFO | 1664: exit 0 21:12:57 INFO - Browser initialized. 21:12:57 INFO - Running cycle 1/1 for kraken test... 21:12:57 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpY3lMbg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:13:00 INFO - PROCESS | 1666 | 2016-10-04 21:13:00.502 plugin-container[1667:10112] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b23, name = 'com.apple.tsm.portname' 21:13:00 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:13:00 INFO - PROCESS | 1666 | 2016-10-04 21:13:00.509 plugin-container[1667:10112] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 21:13:00 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 21:13:00 INFO - PROCESS | 1666 | 2016-10-04 21:13:00.509 plugin-container[1667:10112] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 21:13:10 INFO - PROCESS | 1666 | RSS: Main: 240074752 21:13:10 INFO - PROCESS | 1666 | 21:13:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 21:13:13 INFO - PROCESS | 1666 | RSS: Main: 253599744 21:13:13 INFO - PROCESS | 1666 | 21:13:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 21:13:16 INFO - PROCESS | 1666 | RSS: Main: 261242880 21:13:16 INFO - PROCESS | 1666 | 21:13:20 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 21:13:21 INFO - PROCESS | 1666 | RSS: Main: 261750784 21:13:21 INFO - PROCESS | 1666 | 21:13:23 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 21:13:23 INFO - PROCESS | 1666 | RSS: Main: 264192000 21:13:23 INFO - PROCESS | 1666 | 21:13:25 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:13:26 INFO - PROCESS | 1666 | RSS: Main: 264278016 21:13:26 INFO - PROCESS | 1666 | 21:13:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 21:13:30 INFO - PROCESS | 1666 | RSS: Main: 264933376 21:13:30 INFO - PROCESS | 1666 | 21:13:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 21:13:33 INFO - PROCESS | 1666 | RSS: Main: 265428992 21:13:33 INFO - PROCESS | 1666 | 21:13:36 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 21:13:37 INFO - PROCESS | 1666 | RSS: Main: 265502720 21:13:37 INFO - PROCESS | 1666 | 21:13:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:13:39 INFO - PROCESS | 1666 | RSS: Main: 265367552 21:13:39 INFO - PROCESS | 1666 | 21:13:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:13:42 INFO - PROCESS | 1666 | RSS: Main: 265412608 21:13:42 INFO - PROCESS | 1666 | 21:13:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:13:45 INFO - PROCESS | 1666 | RSS: Main: 265564160 21:13:45 INFO - PROCESS | 1666 | 21:13:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:13:48 INFO - PROCESS | 1666 | RSS: Main: 265830400 21:13:48 INFO - PROCESS | 1666 | 21:13:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:13:52 INFO - PROCESS | 1666 | RSS: Main: 265662464 21:13:52 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 21:13:54 INFO - PROCESS | 1666 | RSS: Main: 267358208 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | __start_tp_report 21:13:54 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 21:13:54 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 21:13:54 INFO - PROCESS | 1666 | |i|pagename|runs| 21:13:54 INFO - PROCESS | 1666 | |0;ai-astar;119;119;118;118;119;119;117;118;118;117 21:13:54 INFO - PROCESS | 1666 | |1;audio-beat-detection;179;146;139;153;121;114;116;118;166;109 21:13:54 INFO - PROCESS | 1666 | |2;audio-dft;196;198;212;245;276;226;200;198;196;197 21:13:54 INFO - PROCESS | 1666 | |3;audio-fft;80;59;57;93;70;80;62;59;80;61 21:13:54 INFO - PROCESS | 1666 | |4;audio-oscillator;82;73;87;73;70;72;103;100;102;72 21:13:54 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;97;128;136;118;118;135;138;86;98;74 21:13:54 INFO - PROCESS | 1666 | |6;imaging-darkroom;96;120;147;120;146;157;155;95;95;94 21:13:54 INFO - PROCESS | 1666 | |7;imaging-desaturate;95;140;137;91;107;129;91;100;92;95 21:13:54 INFO - PROCESS | 1666 | |8;json-parse-financial;57;56;56;58;56;59;59;56;57;56 21:13:54 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;67;73;67;76;74;101;62;94;104;104 21:13:54 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;89;91;91;91;86;90;93;89;90;120 21:13:54 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;147;145;157;170;155;146;164;150;164;149 21:13:54 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;175;176;173;189;244;241;175;173;175;176 21:13:54 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;67;96;93;84;71;67;72;71;93;89 21:13:54 INFO - PROCESS | 1666 | __end_tp_report 21:13:54 INFO - PROCESS | 1666 | __start_cc_report 21:13:54 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,938 21:13:54 INFO - PROCESS | 1666 | __end_cc_report 21:13:54 INFO - PROCESS | 1666 | __startTimestamp1475640834737__endTimestamp 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | ------- Summary: start ------- 21:13:54 INFO - PROCESS | 1666 | Number of tests: 14 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:118.20 Median:118.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 21:13:54 INFO - PROCESS | 1666 | Values: 119.0 119.0 118.0 118.0 119.0 119.0 117.0 118.0 118.0 117.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:142.50 stddev:24.29 (17.0%) stddev-sans-first:20.20 21:13:54 INFO - PROCESS | 1666 | Values: 179.0 146.0 139.0 153.0 121.0 114.0 116.0 118.0 166.0 109.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:214.40 Median:206.00 stddev:27.07 (13.1%) stddev-sans-first:27.88 21:13:54 INFO - PROCESS | 1666 | Values: 196.0 198.0 212.0 245.0 276.0 226.0 200.0 198.0 196.0 197.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:70.10 Median:75.00 stddev:12.40 (16.5%) stddev-sans-first:12.63 21:13:54 INFO - PROCESS | 1666 | Values: 80.0 59.0 57.0 93.0 70.0 80.0 62.0 59.0 80.0 61.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:83.40 Median:72.50 stddev:13.65 (18.8%) stddev-sans-first:14.47 21:13:54 INFO - PROCESS | 1666 | Values: 82.0 73.0 87.0 73.0 70.0 72.0 103.0 100.0 102.0 72.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:106.00 stddev:22.71 (21.4%) stddev-sans-first:23.36 21:13:54 INFO - PROCESS | 1666 | Values: 97.0 128.0 136.0 118.0 118.0 135.0 138.0 86.0 98.0 74.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:122.50 Median:125.50 stddev:26.75 (21.3%) stddev-sans-first:26.59 21:13:54 INFO - PROCESS | 1666 | Values: 96.0 120.0 147.0 120.0 146.0 157.0 155.0 95.0 95.0 94.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:91.00 stddev:19.84 (21.8%) stddev-sans-first:20.50 21:13:54 INFO - PROCESS | 1666 | Values: 95.0 140.0 137.0 91.0 107.0 129.0 91.0 100.0 92.0 95.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.25 (2.2%) stddev-sans-first:1.32 21:13:54 INFO - PROCESS | 1666 | Values: 57.0 56.0 56.0 58.0 56.0 59.0 59.0 56.0 57.0 56.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:82.20 Median:70.00 stddev:16.68 (23.8%) stddev-sans-first:16.76 21:13:54 INFO - PROCESS | 1666 | Values: 67.0 73.0 67.0 76.0 74.0 101.0 62.0 94.0 104.0 104.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:90.50 stddev:9.66 (10.7%) stddev-sans-first:10.14 21:13:54 INFO - PROCESS | 1666 | Values: 89.0 91.0 91.0 91.0 86.0 90.0 93.0 89.0 90.0 120.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:156.00 stddev:8.79 (5.6%) stddev-sans-first:8.88 21:13:54 INFO - PROCESS | 1666 | Values: 147.0 145.0 157.0 170.0 155.0 146.0 164.0 150.0 164.0 149.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.70 Median:176.00 stddev:28.21 (16.0%) stddev-sans-first:29.42 21:13:54 INFO - PROCESS | 1666 | Values: 175.0 176.0 173.0 189.0 244.0 241.0 175.0 173.0 175.0 176.0 21:13:54 INFO - PROCESS | 1666 | 21:13:54 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:86.50 stddev:11.80 (13.6%) stddev-sans-first:11.50 21:13:54 INFO - PROCESS | 1666 | Values: 67.0 96.0 93.0 84.0 71.0 67.0 72.0 71.0 93.0 89.0 21:13:54 INFO - PROCESS | 1666 | -------- Summary: end -------- 21:13:54 INFO - PROCESS | 1666 | 21:13:55 INFO - TEST-INFO | 1666: exit 0 21:13:55 INFO - TEST-OK | kraken | took 61550ms 21:13:55 INFO - SUITE-END | took 1178s 21:13:55 INFO - Completed test suite (00:19:39) 21:13:55 INFO - javascript benchmark 21:13:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7232.449052244408, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.111425472249, 3396.711279541239, 3399.626041135475, 3418.940128560148, 3421.5894092708877, 5626.381098079219, 5628.915566266504, 5670.036093864042, 5693.914591281134, 5726.856828579288, 5605.747741351639, 5750.05124154514, 5761.625494342865, 5765.827025189251, 5771.624844385112, 5181.404138524062, 5221.738913054351, 5230.555402790767, 5272.393674727398, 5285.0, 5285.471452854722, 5306.867328316785, 5314.548263397616, 5317.521423071923, 5331.840044798643, 5274.630775845692, 5289.2859463972445, 5291.523762861341, 5293.311869456965, 5302.337207849019, 5241.633085684004, 5295.020421222086, 5297.682139071668, 5298.841034768963, 5306.70813105279, 5176.301199338079, 5238.05714971305, 5243.86890327741, 5251.789928402859, 5282.366116066097, 4839.564439200489, 5752.223449834302, 5769.1346298055205, 5899.351071382144, 5906.350301466835, 4769.713817170981, 5938.970305148489, 6173.32093469718, 6229.4704950079295, 6261.405166509175, 4893.975530122327, 6135.601185922901, 6184.5980011299125, 6207.317195108534, 6222.0, 5868.530517558671, 5884.0585506318785, 5887.028640274392, 5890.0, 5933.317668468138, 5777.508911742549, 6197.25632924043, 6338.080978258219, 6366.172397588284, 6381.649009304533, 4996.525330093636, 5840.240768700127, 5845.0, 6131.356207598138, 6223.751049957951, 6105.419985101408, 6130.754769809247, 6146.815595532141, 6174.380066285981, 6236.719347629368, 6151.2618485781095, 6152.723127459275, 6192.969035154795, 6230.06549017651, 6231.189945307081, 6132.8756461173125, 6164.4760195383, 6205.441510264098, 6206.255249370104, 6272.466840318532, 4121.29937910556, 4665.95334046662, 4934.1611925972675, 4951.009798040406, 4974.676646017997, 4357.564243575617, 4405.471343438744, 4428.7121337112985, 4454.175977444183, 4496.572825581565, 5317.096093664087, 5556.222128901957, 5594.992901277809, 5625.156226566048, 5755.625884317506, 6142.775043102407, 6146.877062458815, 6186.381361863778, 6263.655498947602, 6273.215848018997, 5657.377688454267, 5704.743286552115, 5726.599138060295, 5737.770489180386, 5744.281964754406, 5296.629235953446, 5312.1766126250495, 5327.121025030904, 5405.594580406407, 5411.756470958816, 6199.442050215503, 6259.780907668392, 6262.68686565679, 6263.906041409291, 6289.591176573508, 6264.029075493306, 6280.246370435394, 6291.276503202191, 6292.937070629235, 6297.874042519215, 6142.928535732134, 6217.440430361289, 6269.96865015672, 6275.560710750204, 6280.214973128359, 5099.158638824552, 6120.387961203844, 6141.36327073057, 6152.261728592597, 6217.316095229431, 4915.11527924977, 6128.724207410588, 6277.18396608438, 6279.120923070683, 6287.0, 6176.938230617637, 6206.193194884636, 6206.968965155145, 6228.875422491616, 6236.6258024518675, 5920.348761636131, 5949.553783466171, 5984.491318237999, 6033.9698301508215, 6104.786332478342, 5911.379305172895, 6068.332483426731, 6070.514358851193, 6077.696115194134, 6094.786682466092, 6170.352113028068, 6177.011678131657, 6192.504599632109, 6198.256209254918, 6204.565680402328, 5816.82549523515, 5839.328477225174, 5920.526357891272, 5974.61165024272, 6029.005214139618], "value": 5662.134106706977, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.7228721198099, 509.28191250337034, 511.7390131033173, 529.4308618235395, 539.0970125040558, 39563.80218098909, 40804.183916321694, 40989.33569317992, 41003.9749006275, 41014.58985410145, 41930.0, 42343.78828105863, 42364.788176059075, 42382.36426453606, 42450.542693017174, 9620.855687164682, 9839.704808855746, 9847.11375976162, 9848.45833479162, 9848.753781155492, 8265.256126948574, 9779.657711980082, 9846.261530385214, 9849.852252216222, 9850.950745246264, 8307.0, 8436.36727245456, 9852.507374631276, 9891.950540247288, 9911.008899110104, 9780.657676981342, 9828.803423931517, 9853.458059806708, 9868.506574671273, 9883.654072107442, 9658.034196580285, 9765.218782497383, 9778.755531111708, 9789.0, 9811.509424528816, 32864.50703239453, 39918.80243592697, 39919.8004009981, 39969.400458993136, 40158.196836063114, 3203.9038828835173, 3213.6464988851208, 3523.4362501999813, 3613.4760459733193, 3688.520492336006, 30327.24181895448, 30462.10609992047, 31482.212944676336, 31616.0, 32084.197895052577, 3226.709596136359, 3230.224746060952, 3251.9837400812844, 3257.1368587324378, 3291.210109573709, 502029.0, 503585.0, 506944.0, 508880.45559772337, 510112.44943775417, 56194.0, 56289.7185514078, 56660.716696417076, 56712.43287567072, 56839.43160568424, 57723.13415298774, 57953.71023144942, 58041.0, 58182.0, 58183.0, 15677.921610391875, 15946.0, 15981.12103834277, 15992.520224393287, 15998.840011599968, 12485.625431237077, 12632.936835315764, 12638.98888088969, 12639.62081137549, 12643.494260229489, 14600.34298456572, 14979.026363286352, 15032.774508382383, 15092.019018763745, 15197.924010379877, 6526.118973938553, 6663.36698013688, 6669.966650166718, 6685.732570697118, 6735.629540375228, 861.4314552395389, 875.8117004843989, 967.5017366056486, 1011.9443430611387, 1026.58423338548, 28159.014434495104, 29301.0, 29458.705412946027, 30027.849860750557, 30166.84916575447, 778.0468925566137, 894.6689724801865, 910.822389634015, 941.1059493481221, 1108.1356541897333, 15299.15854627984, 15300.770488442682, 15320.693586128215, 15360.0, 15552.0, 671972.0, 689640.0, 694403.0, 694708.0, 697639.0, 53977.0, 54620.18069728957, 55865.0, 56065.159022614695, 56284.31147065594, 1281.135233717237, 1304.934753262333, 1308.9738205236033, 1352.749741297863, 1366.6241783509615, 28021.299467513476, 28988.710112899444, 30395.544066838575, 30982.380352392374, 31073.53389699111, 47097.293540596234, 53044.0, 54364.0, 54439.72780136074, 57840.1323980149, 605967.0, 609759.0, 610022.0, 615827.0, 616075.0, 25268.0, 25504.234872953843, 25518.0, 25808.35479112962, 25859.741402585732, 46493.0, 46498.535014649424, 46810.531894680615, 46947.295790562486, 47541.28688069751, 37389.439158412104, 39208.80395598004, 39281.803590981865, 39771.989897275984, 40725.592744073365, 29812.254693631967, 35480.93557193288, 38505.0, 38870.41694374643, 40077.998050048984, 29637.85181074081, 37900.62099378971, 38447.615523844404, 38561.421578676905, 38723.64467243633, 32341.875912517913, 34205.65794342025, 34532.48201277033, 34752.304953900275, 34838.47742283817, 24488.51022979495, 25327.0, 25812.0, 25874.22377328683, 26356.81394337221], "value": 19638.58327417623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.66212098506423, 367.4048042171681, 376.46165982644817, 380.5376467591876, 385.545056832937, 19396.806031939694, 19744.802551974477, 19831.008449577537, 20492.69260961087, 20714.27500037499, 9546.665866694668, 11408.657740267805, 12046.277223366604, 12054.939725301361, 12065.577704780335, 5256.842294731164, 5498.835034948938, 5555.0, 5555.111182210847, 5569.192467092269, 3870.0, 4088.2436749201343, 4551.954480455202, 5083.517065878754, 5562.332520097594, 4100.8974775630695, 6760.0, 6779.4915381346345, 6842.863142737142, 6849.1096157499705, 4803.351547541072, 6157.384261573851, 6307.495400367982, 6782.982552617123, 6851.280615535372, 5898.0, 5955.13650520672, 5964.671943043131, 5969.253843269591, 6003.339632640406, 13561.593152205449, 23160.652590210993, 23585.41036474085, 23892.04431822725, 24314.63528047063, 2087.2068613926763, 2235.2958817972285, 2266.3767463947383, 2777.291790593386, 2976.9851150744325, 9848.65529706464, 10025.24810639205, 10031.448270345129, 10400.843987340197, 10414.0, 1763.2594310389668, 1810.4297146398842, 1814.5372929902921, 1818.7817461904524, 1889.102676228794, 113830.0, 114894.0, 133012.33493832566, 137434.0, 138005.0, 11327.886721132849, 11568.826467602992, 11715.648530544097, 11734.354610496504, 11788.88211117895, 14513.709725805425, 14599.92700036493, 14662.266886655838, 14664.413423463155, 14680.0, 8239.299659528888, 8544.2310192083, 8577.270931970728, 8618.0, 8680.56597170139, 8424.831503369898, 8454.704085356983, 8464.153584641486, 8475.89813324264, 8569.742907712654, 4477.462704475419, 4555.2711566149255, 4557.863264102082, 4581.587657110809, 4601.4248218972625, 1650.6121061550525, 1901.0, 1936.3803582853634, 1951.9316823911095, 1956.491312258823, 804.2721337189853, 808.2281421242699, 900.4687234531527, 904.6381447421085, 962.0908241711655, 20123.899380503004, 20279.08744106519, 21023.789762102184, 21257.89371053135, 21404.678929816066, 896.3725392225468, 945.7541039329686, 946.2051876423837, 950.7765675066354, 956.2636769687302, 9128.726138215865, 10897.782044359226, 11227.0, 11255.212135150461, 11256.986871181633, 549028.0, 575102.0, 575249.0, 581895.0, 594928.0, 133530.0, 136153.31923340517, 139142.0, 141679.29160354132, 143954.0, 985.5663508056432, 1004.4826914139225, 1016.7763092119574, 1032.3444612671008, 1038.864947556828, 18358.173882175066, 18746.062696865374, 18779.530511737317, 18792.0, 19008.904955475133, 49927.00145996987, 50321.741956451384, 50508.747456262485, 51462.0, 52376.952460949804, 57684.71157644185, 71240.93138602821, 71727.0, 78080.0, 80885.59557202176, 7415.740449084256, 7849.3328067114935, 7902.881456778038, 7957.1644977276555, 8102.675892964216, 9642.855357169508, 9833.852492212765, 12528.874711253135, 12733.936330318289, 12900.419481123185, 9660.162682768489, 10771.461426928465, 11075.280106793032, 11100.944495277472, 11258.831117533407, 9969.30214884951, 10252.794944101226, 10863.565457381615, 10865.891341086488, 11039.172062095215, 9839.398454278558, 10366.0, 10976.725581860517, 11212.27120237182, 11218.55125794959, 7669.884951725617, 7832.686692532235, 7893.210678932291, 7944.086430060617, 7972.162922893244, 10413.479326033517, 10571.04860562553, 10654.946725266323, 10776.784464310827, 10802.027817496462], "value": 9262.851413354467, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.855805861355, 1514.0612820051567, 1662.2353717290046, 1805.6117934644049, 1835.1558283189731, 8046.959765201181, 8327.042390125138, 8504.957475212623, 9142.588583513741, 9163.037881022488, 8510.446820956633, 8830.82338353234, 8844.91155088449, 8932.55337233139, 8936.8659470108, 2316.224064938248, 2350.9882450587725, 2361.716594008713, 2365.7042869641296, 2370.2533701883935, 2293.1973809166743, 2322.2104484475276, 2363.420961864346, 2370.7510711375317, 2382.809375249976, 2342.531493701258, 2352.329586067971, 2367.5146594947996, 2367.9763202368013, 2372.110458578033, 2322.8490148140318, 2332.8716920569445, 2339.789418952294, 2346.272655476808, 2346.8239882008834, 2319.8376113672048, 2329.918452854159, 2329.9650505242435, 2331.8717470539113, 2337.0885354711677, 8978.147076027766, 8988.235999940012, 9007.279417646572, 9051.818963620757, 9058.094190580956, 5125.846224613268, 5177.197534382177, 5236.73816309183, 5302.469753024705, 5315.73421328932, 3510.227749895019, 3615.0420138663276, 3690.6678398944223, 3690.8708195213308, 3709.017110465729, 1052.4001319248032, 1059.7403636109202, 1084.8589683341115, 1100.2518287564453, 1106.4965440724452, 11689.47397367112, 11698.883011169864, 11764.647060588197, 11826.940865295704, 11829.171957962946, 4420.58004489573, 4425.822967081345, 4507.166174257773, 4521.796519156645, 4787.40157480315, 7721.073471183494, 9124.58939347731, 9470.715878523655, 9682.741243638422, 10187.694369168938, 5242.659227150223, 5313.628046036741, 5325.09473389517, 5345.33183352081, 5345.438728933406, 4353.434053573079, 4522.547745225517, 4679.9298010529865, 4810.903781924342, 4858.076965376567, 3212.646608873022, 3248.3016151527536, 3991.1818077294083, 3992.201559688074, 4032.193561287754, 1020.336781092296, 1094.6497120921388, 1099.729812067064, 1100.8733995590449, 1113.9194980868706, 749.9100107987076, 761.8039677706059, 787.7006737439851, 896.5338024227365, 917.454114801692, 5715.485606295453, 5762.827115186551, 5940.55445841555, 6015.969920150459, 6115.84710382244, 410.3721306401211, 420.50170547900836, 421.82072619136744, 422.5267700175823, 427.5211762825593, 3544.4151714966742, 3992.640662340345, 4070.816813243411, 4104.712670113123, 4164.7917604119675, 10233.744156396, 10605.0, 10744.0, 10748.89251107479, 10757.677269681923, 10699.090577300862, 10723.30298530593, 10736.141108711441, 10742.355458672504, 10772.838407423895, 7726.304632583095, 8112.148224436467, 8149.388795840336, 8168.305694016075, 8168.469049511763, 5962.642241465526, 5998.25021872266, 6123.357047509948, 6138.202033735586, 6243.812685619257, 10124.13944814699, 10154.339967902062, 10210.795784084128, 10241.436720980417, 10248.386661401295, 9727.416355018722, 10131.848022279819, 10147.695569132939, 10301.845472318071, 10331.32846365014, 7036.788896333118, 7278.0, 7390.224026477143, 7587.355074818703, 7764.92235077642, 8290.875636865572, 8394.034686010942, 8481.236688698047, 8598.140185981352, 8653.66351085191, 7495.362894154058, 7614.847703046019, 7652.846943061219, 7741.341985931259, 7771.883421748791, 7489.962550187214, 7502.924970750222, 7557.093148822177, 7573.6213189341415, 7733.961330193313, 6940.548864323803, 7070.787876363717, 7072.929270707433, 7085.0, 7088.113985751781, 4961.7271050092595, 5060.179564428832, 5119.232115182753, 5170.974145129401, 5196.53231209193, 5045.066662667418, 5053.444121146597, 5060.51925067118, 5161.690298582097, 5252.474752524717], "value": 4467.170955887937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [256.9820112592118, 306.92787195009186, 314.83943188973626, 317.29876971892116, 318.6829105040482, 4752.405949256343, 5206.401263854648, 5403.621746477748, 5521.558275337973, 5555.2778138841995, 5168.870778230536, 5338.65099356283, 5392.1911713243035, 5409.540189083933, 5438.782448702047, 3625.963740362589, 4120.649744771683, 4122.381642753596, 4148.315527937894, 4163.479565054368, 3585.4084076127538, 3826.349520581508, 3951.604839516054, 4154.252234597771, 4156.833726650931, 3235.964491362765, 3253.137918451612, 3376.96623033769, 3824.972764434854, 3937.7792884205846, 3224.6936541028563, 3246.636412706669, 4006.5392479864895, 4067.491563554556, 4170.70805043647, 3137.905862824119, 3519.6832285094465, 3536.45184996326, 3549.7515173937836, 3559.9320203938714, 4849.587785038276, 4911.238757992517, 5194.6104042196985, 5253.322674128126, 5333.759980800874, 4066.6136717011836, 4459.554044595515, 4663.463701674317, 4676.69601475903, 4727.503612120712, 5583.860403489945, 5665.943340566583, 5683.5169010634145, 5712.485876271156, 5715.942840571624, 3573.731970102253, 3748.686323888075, 3772.86794962175, 3841.0397400649836, 3877.9612203878164, 5695.515881150107, 5947.1971283876555, 5991.191189189491, 5996.730147143389, 6059.45464908156, 3921.2157568485845, 3926.332523471017, 3943.861964831217, 3964.226975739703, 3972.463717398172, 3218.613766348053, 3957.0107473131716, 3996.6003399659803, 4004.2391945530258, 4022.0, 3721.404575267944, 3855.9036024099623, 4676.3686902267755, 4678.134545109166, 4684.414448193976, 5790.478856902899, 5798.144234084287, 5832.80427512359, 5852.063669812895, 5906.49794767441, 1177.8174382970653, 1266.645339304996, 1325.1982550556968, 1325.3969443903193, 1360.4490181476517, 890.5235698901057, 896.9551522423852, 903.8056817784208, 917.6054296652503, 919.0212423768666, 5273.683578985273, 5322.4411436799355, 5334.946650533522, 5346.91979620306, 5347.224652425377, 5205.345273910258, 5215.348081489814, 5866.5893387462465, 5876.706164691748, 5897.351291357947, 4888.82889098887, 4888.877778055577, 4983.476734942851, 5238.423773384925, 5316.202569614588, 2570.5630042892753, 2613.2160351894354, 2616.9607455888176, 2617.8219801089203, 2618.5810270357033, 4140.171965606891, 4145.274576949082, 4987.875303117378, 5007.574356179693, 5009.423916249678, 4657.883552911204, 4857.441394239637, 5013.749312534359, 5068.518490743373, 5606.421046318739, 5596.768710883681, 5990.9700451497465, 6073.605215660968, 6082.894046518671, 6115.785947491817, 4496.246463879024, 5285.735713214401, 6003.339632640494, 6005.339412664691, 6007.3992600739575, 5534.391216966211, 5702.6293290935955, 5836.708164591839, 5921.230240068763, 5941.376155503783, 5193.506616871391, 5519.834404967857, 6068.332483426731, 6076.51387888959, 6084.452399284086, 3606.3688854450893, 3825.407061905409, 3924.941125883171, 3971.8212680428874, 3995.440638310697, 5578.0, 5895.7052147393315, 5933.0, 5952.315483719254, 6013.639181649115, 5589.608727389043, 5645.266115404971, 5783.537317014713, 5795.681237531808, 5824.242848429677, 5046.697198168122, 5785.681787501728, 5793.391693872083, 5815.76736930518, 5817.680027598522, 5466.512736704869, 5514.724263786715, 5611.9898418283465, 5666.603337766317, 5711.286089238845, 4379.58393952574, 5307.162121666136, 5358.089124848863, 5524.806631767869, 5578.693171875586, 4639.2628349272745, 4672.785075880228, 4747.667663263538, 5025.497450254945, 5265.921011184912], "value": 4069.7685770910366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.563269160625, 642.9035644653303, 669.8693754717832, 710.7938697777644, 722.2813300765736, 10948.726281842937, 11474.0, 15746.291416886239, 15802.525924222264, 15858.841411585881, 12682.302473363961, 14227.71544569108, 14325.355359008843, 14427.35076921541, 14470.493532726357, 836.4981011393177, 846.124261389462, 864.4251572704144, 865.1132589096164, 871.8038441350709, 844.6452489954233, 849.2993280543576, 849.562475325208, 850.3494826457764, 851.0255757158051, 876.9429987050853, 878.6924576398242, 890.7594949363668, 892.1524551675901, 896.4755617963467, 879.0, 886.4238245140646, 902.5171533229691, 904.1726819959729, 911.4349103555771, 667.4626925325111, 673.1383828699272, 674.5581644023173, 675.0684056002685, 675.7905049434642, 14994.550163495112, 15013.099214047083, 15018.774718379233, 15021.549353519302, 15027.0, 10765.730856728644, 11166.665000050012, 13305.800412993813, 14000.369983350774, 14341.498047568284, 11294.853977744202, 11660.591879284184, 11914.225575337576, 11983.0, 12245.467085638613, 3749.1189570450924, 3770.0, 3782.111203867089, 3855.460235566995, 3894.240623078501, 87541.12458875394, 93936.0, 115800.42099789531, 116133.41933290364, 117693.0, 11095.944520277348, 11097.500612472459, 11158.442077896072, 11185.440727963569, 11336.376499292453, 21741.891290543444, 21941.0, 21961.780382195975, 21962.69391713879, 21984.120635174415, 7227.74702885407, 7255.165655949633, 7429.665665045086, 7469.514481558681, 7506.812329691801, 4413.029133590605, 4473.7986790594505, 4505.5269196734525, 4516.796744146522, 4516.932246016312, 3522.2427178156818, 3626.111602657313, 3627.075095850594, 3748.981255093707, 3931.9213615727526, 564.8051422259314, 683.3166833166833, 713.6645776485044, 723.0166972916829, 724.4421795217653, 571.5456212311223, 591.5858898770878, 660.3627499463041, 676.3439463720183, 683.2586643491867, 9095.909040909506, 9459.290553208537, 9470.479123648127, 9589.0, 9614.0, 547.2284079447959, 627.6234259444388, 649.4901502320656, 660.8711301296202, 667.1227336053074, 4246.959494923702, 4339.370791235253, 4405.163019026375, 4744.098621262018, 5057.8735531612, 86295.27409451776, 87478.25043499222, 87967.56016220005, 116157.41921290339, 151058.0, 120056.39971800259, 121594.39202803929, 122997.15504267444, 124200.0, 125303.74696252921, 95394.04605953852, 103273.48363258135, 104971.0, 105968.0, 113228.43385783018, 9764.218862491125, 9831.5084245786, 9986.0, 10007.699769006942, 10027.949860250652, 46531.53468465272, 56645.71677141588, 57192.85614287774, 58048.0, 61403.385966139766, 80186.0, 85304.4695530442, 90082.0, 93300.53349733209, 93312.46812723044, 9482.103002798602, 10105.696829095139, 13168.934155329162, 13475.25886076236, 13666.248356340497, 14881.255937203314, 15064.623384415478, 15370.077795332316, 15585.519375659294, 15622.843771562138, 13292.800607990694, 13585.252811095485, 13878.375473103937, 13878.722425551634, 14122.870170386139, 13759.518416855362, 14170.574882753534, 14224.786628200793, 14370.209638469985, 14432.0, 13346.19922804635, 13643.79534307006, 13645.317734113452, 13652.863471365557, 13950.860491394957, 11168.553257869595, 11367.374794386387, 11389.278921319645, 11443.313401195956, 11562.248453850809, 7981.760547183594, 8912.30666173425, 10029.247806414402, 11550.480228389575, 11723.120765942418], "value": 7642.383873273071, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1622.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 118.0, 119.0, 119.0, 117.0, 118.0, 118.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 146.0, 139.0, 153.0, 121.0, 114.0, 116.0, 118.0, 166.0, 109.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 198.0, 212.0, 245.0, 276.0, 226.0, 200.0, 198.0, 196.0, 197.0], "value": 214.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 57.0, 93.0, 70.0, 80.0, 62.0, 59.0, 80.0, 61.0], "value": 70.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 73.0, 87.0, 73.0, 70.0, 72.0, 103.0, 100.0, 102.0, 72.0], "value": 83.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 128.0, 136.0, 118.0, 118.0, 135.0, 138.0, 86.0, 98.0, 74.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 120.0, 147.0, 120.0, 146.0, 157.0, 155.0, 95.0, 95.0, 94.0], "value": 122.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 140.0, 137.0, 91.0, 107.0, 129.0, 91.0, 100.0, 92.0, 95.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 58.0, 56.0, 59.0, 59.0, 56.0, 57.0, 56.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 67.0, 76.0, 74.0, 101.0, 62.0, 94.0, 104.0, 104.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 91.0, 91.0, 86.0, 90.0, 93.0, 89.0, 90.0, 120.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 157.0, 170.0, 155.0, 146.0, 164.0, 150.0, 164.0, 149.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 173.0, 189.0, 244.0, 241.0, 175.0, 173.0, 175.0, 176.0], "value": 189.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 96.0, 93.0, 84.0, 71.0, 67.0, 72.0, 71.0, 93.0, 89.0], "value": 80.3, "unit": "score"}]}]} 21:13:55 INFO - Return code: 0 21:13:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:13:56 ERROR - # TBPL SUCCESS # 21:13:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:13:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:13:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:13:56 INFO - 2016-10-04 21:13:56.076 screenresolution[1671:10488] starting screenresolution argv=screenresolution get 21:13:56 INFO - 2016-10-04 21:13:56.078 screenresolution[1671:10488] Display 0: 1600x1200x32@60 21:13:56 INFO - 2016-10-04 21:13:56.084 screenresolution[1672:10491] starting screenresolution argv=screenresolution list 21:13:56 INFO - Available Modes on Display 0 21:13:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:13:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:13:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:13:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:13:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:13:56 INFO - Intel Iris: 21:13:56 INFO - Chipset Model: Intel Iris 21:13:56 INFO - Type: GPU 21:13:56 INFO - Bus: Built-In 21:13:56 INFO - VRAM (Dynamic, Max): 1536 MB 21:13:56 INFO - Vendor: Intel (0x8086) 21:13:56 INFO - Device ID: 0x0a2e 21:13:56 INFO - Revision ID: 0x0009 21:13:56 INFO - Displays: 21:13:56 INFO - Display: 21:13:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:13:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:13:56 INFO - Display Serial Number: 1600x1200 60 21:13:56 INFO - Main Display: Yes 21:13:56 INFO - Mirror: Off 21:13:56 INFO - Online: Yes 21:13:56 INFO - Rotation: Supported 21:13:56 INFO - Return code: 0 21:13:56 INFO - Running post-action listener: _resource_record_post_action 21:13:56 INFO - [mozharness: 2016-10-05 04:13:56.318703Z] Finished run-tests step (success) 21:13:56 INFO - Running post-run listener: _resource_record_post_run 21:13:56 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38803968; Write bytes: 710806528; Read time: 381; Write time: 1901 21:13:56 INFO - TinderboxPrint: CPU usage
54.4% 21:13:56 INFO - TinderboxPrint: I/O read bytes / time
38,803,968 / 381 21:13:56 INFO - TinderboxPrint: I/O write bytes / time
710,806,528 / 1,901 21:13:56 INFO - TinderboxPrint: CPU idle
2,211.6 (45.6%) 21:13:56 INFO - TinderboxPrint: CPU system
982.3 (20.2%) 21:13:56 INFO - TinderboxPrint: CPU user
1,659.8 (34.2%) 21:13:56 INFO - TinderboxPrint: Swap in / out
446,828,544 / 0 21:13:56 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 408721920; Write bytes: 411297792; Read time: 29920; Write time: 753 21:13:56 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35248640; Write bytes: 297911296; Read time: 352; Write time: 1144 21:13:56 INFO - Running post-run listener: _upload_blobber_files 21:13:56 INFO - Blob upload gear active. 21:13:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:13:56 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 21:13:56 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:13:56 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:13:57 INFO - (blobuploader) - INFO - Open directory for files ... 21:13:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:13:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:13:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:58 INFO - (blobuploader) - INFO - Done attempting. 21:13:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:13:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:13:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:13:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:13:59 INFO - (blobuploader) - INFO - Done attempting. 21:13:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:13:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:13:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:14:01 INFO - (blobuploader) - INFO - Done attempting. 21:14:01 INFO - (blobuploader) - INFO - Iteration through files over. 21:14:01 INFO - Return code: 0 21:14:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:14:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:14:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ee11f35b1866f7acb1dca0288748834e2a7cdc7e37e5344390415b10ad66422d14b9bde1c1934c64cb8076c0d8a15d158aef49e948f15b4c090b9e5e4d2153", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26bb596215259dff4829954aecfc97de3dace4cb929859712b13feab2cdf02ddd4312f252aae7adfe5600bf61399ac6af89c6b716ca8049cfb31d49d37d2f998", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f481740ed71cf2cd799e818f16b1ef9da39b30b7edb378dc8049a49d250abdd6d70666cd75fb1e14c154c8d477172091ecfc3defc632faa1bd6ccd6e709e32b9"} 21:14:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:14:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:14:01 INFO - Contents: 21:14:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ee11f35b1866f7acb1dca0288748834e2a7cdc7e37e5344390415b10ad66422d14b9bde1c1934c64cb8076c0d8a15d158aef49e948f15b4c090b9e5e4d2153", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26bb596215259dff4829954aecfc97de3dace4cb929859712b13feab2cdf02ddd4312f252aae7adfe5600bf61399ac6af89c6b716ca8049cfb31d49d37d2f998", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f481740ed71cf2cd799e818f16b1ef9da39b30b7edb378dc8049a49d250abdd6d70666cd75fb1e14c154c8d477172091ecfc3defc632faa1bd6ccd6e709e32b9"} 21:14:01 INFO - Running post-run listener: copy_logs_to_upload_dir 21:14:01 INFO - Copying logs to upload dir... 21:14:01 INFO - mkdir: /builds/slave/test/build/upload/logs 21:14:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.636425 ========= master_lag: 2.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-04 21:14:04.116277) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 21:14:04.119395) ========= 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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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/Fx-Team/sha512/94ee11f35b1866f7acb1dca0288748834e2a7cdc7e37e5344390415b10ad66422d14b9bde1c1934c64cb8076c0d8a15d158aef49e948f15b4c090b9e5e4d2153", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26bb596215259dff4829954aecfc97de3dace4cb929859712b13feab2cdf02ddd4312f252aae7adfe5600bf61399ac6af89c6b716ca8049cfb31d49d37d2f998", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f481740ed71cf2cd799e818f16b1ef9da39b30b7edb378dc8049a49d250abdd6d70666cd75fb1e14c154c8d477172091ecfc3defc632faa1bd6ccd6e709e32b9"} build_url:https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/Ypij5POoRQCFe59tGgmexw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ee11f35b1866f7acb1dca0288748834e2a7cdc7e37e5344390415b10ad66422d14b9bde1c1934c64cb8076c0d8a15d158aef49e948f15b4c090b9e5e4d2153", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/26bb596215259dff4829954aecfc97de3dace4cb929859712b13feab2cdf02ddd4312f252aae7adfe5600bf61399ac6af89c6b716ca8049cfb31d49d37d2f998", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f481740ed71cf2cd799e818f16b1ef9da39b30b7edb378dc8049a49d250abdd6d70666cd75fb1e14c154c8d477172091ecfc3defc632faa1bd6ccd6e709e32b9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 21:14:04.163547) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:14:04.163880) ========= 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.C1vOwkBLPs/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.tWZG7xIHEn/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.004956 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 21:14:04.212931) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 21:14:04.213264) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 21:14:04.213580) ========= ========= Total master_lag: 2.61 =========