builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0367 starttime: 1473303038.17 results: success (0) buildid: 20160907180916 builduid: f25b6be883c242b4b30a3402f2ac020f revision: fb7c6b0343295392bac590c19b14e7e5dcccdc33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.168455) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.168884) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.169164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.200357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.200795) ========= 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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-09-07 19:50:38-- 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% 161M=0s 2016-09-07 19:50:38 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140921 ========= master_lag: 0.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.725066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.725381) ========= 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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.032117 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.779282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:38.779647) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fb7c6b0343295392bac590c19b14e7e5dcccdc33 --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 fb7c6b0343295392bac590c19b14e7e5dcccdc33 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oJ5H18d1dF/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.dDyL3vRBBU/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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-09-07 19:50:38,866 truncating revision to first 12 chars 2016-09-07 19:50:38,866 Setting DEBUG logging. 2016-09-07 19:50:38,866 attempt 1/10 2016-09-07 19:50:38,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fb7c6b034329?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 19:50:39,494 unpacking tar archive at: fx-team-fb7c6b034329/testing/mozharness/ program finished with exit code 0 elapsedTime=0.916977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:39.718838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:39.719156) ========= script_repo_revision: fb7c6b0343295392bac590c19b14e7e5dcccdc33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:39.719567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:39.719833) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 19:50:39.738818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-07 19:50:39.739193) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:50:39 INFO - MultiFileLogger online at 20160907 19:50:39 in /builds/slave/test 19:50:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:50:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:50:39 INFO - {'append_to_log': False, 19:50:39 INFO - 'base_work_dir': '/builds/slave/test', 19:50:39 INFO - 'blob_upload_branch': 'Fx-Team', 19:50:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:50:39 INFO - 'branch': 'Fx-Team', 19:50:39 INFO - 'buildbot_json_path': 'buildprops.json', 19:50:39 INFO - 'config_files': ('talos/mac_config.py',), 19:50:39 INFO - 'default_actions': ('clobber', 19:50:39 INFO - 'read-buildbot-config', 19:50:39 INFO - 'download-and-extract', 19:50:39 INFO - 'populate-webroot', 19:50:39 INFO - 'create-virtualenv', 19:50:39 INFO - 'install', 19:50:39 INFO - 'run-tests'), 19:50:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:50:39 INFO - 'download_minidump_stackwalk': True, 19:50:39 INFO - 'download_symbols': 'ondemand', 19:50:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:50:39 INFO - 'tooltool.py': '/tools/tooltool.py', 19:50:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:50:39 INFO - '/tools/misc-python/virtualenv.py')}, 19:50:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:50:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:50:39 INFO - 'installer_path': 'installer.exe', 19:50:39 INFO - 'log_level': 'info', 19:50:39 INFO - 'log_name': 'talos', 19:50:39 INFO - 'log_to_console': True, 19:50:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:50:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:50:39 INFO - 'opt_config_files': (), 19:50:39 INFO - 'pip_index': False, 19:50:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:50:39 INFO - 'cmd': ('bash', 19:50:39 INFO - '-c', 19:50:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:50:39 INFO - 'enabled': True, 19:50:39 INFO - 'halt_on_failure': False, 19:50:39 INFO - 'name': 'check_screen_resolution'},), 19:50:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:50:39 INFO - 'cmd': ('bash', 19:50:39 INFO - '-c', 19:50:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:50:39 INFO - 'enabled': True, 19:50:39 INFO - 'halt_on_failure': False, 19:50:39 INFO - 'name': 'check_screen_resolution'},), 19:50:39 INFO - 'run_cmd_checks_enabled': True, 19:50:39 INFO - 'sps_profile': False, 19:50:39 INFO - 'sps_profile_interval': 0, 19:50:39 INFO - 'suite': 'dromaeojs', 19:50:39 INFO - 'system_bits': '32', 19:50:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:50:39 INFO - 'title': 't-yosemite-r7-0367', 19:50:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:50:39 INFO - 'use_talos_json': True, 19:50:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:50:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:50:39 INFO - 'work_dir': 'build'} 19:50:39 INFO - [mozharness: 2016-09-08 02:50:39.939664Z] Running clobber step. 19:50:39 INFO - Running pre-action listener: _resource_record_pre_action 19:50:39 INFO - Running main action method: clobber 19:50:39 INFO - rmtree: /builds/slave/test/build 19:50:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:50:41 INFO - Running post-action listener: _resource_record_post_action 19:50:41 INFO - [mozharness: 2016-09-08 02:50:41.811984Z] Finished clobber step (success) 19:50:41 INFO - [mozharness: 2016-09-08 02:50:41.812106Z] Running read-buildbot-config step. 19:50:41 INFO - Running pre-action listener: _resource_record_pre_action 19:50:41 INFO - Running main action method: read_buildbot_config 19:50:41 INFO - Using buildbot properties: 19:50:41 INFO - { 19:50:41 INFO - "project": "", 19:50:41 INFO - "product": "firefox", 19:50:41 INFO - "script_repo_revision": "production", 19:50:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:50:41 INFO - "repository": "", 19:50:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:50:41 INFO - "buildid": "20160907180916", 19:50:41 INFO - "pgo_build": "False", 19:50:41 INFO - "basedir": "/builds/slave/test", 19:50:41 INFO - "buildnumber": 148, 19:50:41 INFO - "slavename": "t-yosemite-r7-0367", 19:50:41 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:50:41 INFO - "platform": "yosemite_r7", 19:50:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:50:41 INFO - "branch": "fx-team", 19:50:41 INFO - "repo_path": "integration/fx-team", 19:50:41 INFO - "revision": "fb7c6b0343295392bac590c19b14e7e5dcccdc33", 19:50:41 INFO - "stage_platform": "macosx64", 19:50:41 INFO - "builduid": "f25b6be883c242b4b30a3402f2ac020f", 19:50:41 INFO - "slavebuilddir": "test" 19:50:41 INFO - } 19:50:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 19:50:41 INFO - Running post-action listener: _resource_record_post_action 19:50:41 INFO - [mozharness: 2016-09-08 02:50:41.815605Z] Finished read-buildbot-config step (success) 19:50:41 INFO - [mozharness: 2016-09-08 02:50:41.815708Z] Running download-and-extract step. 19:50:41 INFO - Running pre-action listener: _resource_record_pre_action 19:50:41 INFO - Running main action method: download_and_extract 19:50:41 INFO - mkdir: /builds/slave/test/build/tests 19:50: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')]} 19:50:41 INFO - trying https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 19:50:41 INFO - Downloading https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 19:50:43 INFO - Downloaded 1199 bytes. 19:50:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 19:50:43 INFO - Using the following test package requirements: 19:50:43 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:50:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:43 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 19:50:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:43 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 19:50:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:43 INFO - u'jsshell-mac.zip'], 19:50:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:43 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 19:50:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 19:50:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:43 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 19:50:43 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:43 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 19:50:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:43 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 19:50:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 19:50:43 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 19:50:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:50:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:50:43 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:50:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:50:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 19:50:51 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 19:50:59 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 19:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:59 INFO - trying https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:50:59 INFO - Downloading https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 19:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 19:51:03 INFO - Downloaded 111446428 bytes. 19:51:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:51:03 INFO - mkdir: /builds/slave/test/properties 19:51:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:51:03 INFO - Writing to file /builds/slave/test/properties/build_url 19:51:03 INFO - Contents: 19:51:03 INFO - build_url:https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 19:51:03 INFO - Running post-action listener: _resource_record_post_action 19:51:03 INFO - Running post-action listener: set_extra_try_arguments 19:51:03 INFO - [mozharness: 2016-09-08 02:51:03.758180Z] Finished download-and-extract step (success) 19:51:03 INFO - [mozharness: 2016-09-08 02:51:03.758337Z] Running populate-webroot step. 19:51:03 INFO - Running pre-action listener: _resource_record_pre_action 19:51:03 INFO - Running main action method: populate_webroot 19:51:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:03 INFO - '--tppagecycles', 19:51:03 INFO - '7'], 19:51:03 INFO - 'tests': ['tsvgm']}}, 19:51:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:51:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:51:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:51:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:03 INFO - 'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:03 INFO - 'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['damp', 'tps']}, 19:51:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:03 INFO - 'tests': ['damp', 'tps']}, 19:51:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['dromaeo_dom']}, 19:51:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['basic_compositor_video']}, 19:51:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:51:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['a11yr', 19:51:03 INFO - 'ts_paint', 19:51:03 INFO - 'tpaint', 19:51:03 INFO - 'sessionrestore', 19:51:03 INFO - 'sessionrestore_no_auto_restore', 19:51:03 INFO - 'tabpaint']}, 19:51:03 INFO - 'other-e10s': {'tests': ['a11yr', 19:51:03 INFO - 'ts_paint', 19:51:03 INFO - 'tpaint', 19:51:03 INFO - 'sessionrestore', 19:51:03 INFO - 'sessionrestore_no_auto_restore', 19:51:03 INFO - 'tabpaint']}, 19:51:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:51:03 INFO - 'ts_paint', 19:51:03 INFO - 'tpaint', 19:51:03 INFO - 'sessionrestore', 19:51:03 INFO - 'sessionrestore_no_auto_restore', 19:51:03 INFO - 'tabpaint']}, 19:51:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:51:03 INFO - 'ts_paint', 19:51:03 INFO - 'tpaint', 19:51:03 INFO - 'sessionrestore', 19:51:03 INFO - 'sessionrestore_no_auto_restore', 19:51:03 INFO - 'tabpaint']}, 19:51:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['a11yr', 19:51:03 INFO - 'ts_paint', 19:51:03 INFO - 'tpaint', 19:51:03 INFO - 'sessionrestore', 19:51:03 INFO - 'sessionrestore_no_auto_restore', 19:51:03 INFO - 'tabpaint']}, 19:51:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['a11yr', 19:51:03 INFO - 'ts_paint', 19:51:03 INFO - 'tpaint', 19:51:03 INFO - 'sessionrestore', 19:51:03 INFO - 'sessionrestore_no_auto_restore', 19:51:03 INFO - 'tabpaint']}, 19:51:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['tsvgx', 19:51:03 INFO - 'tsvgr_opacity', 19:51:03 INFO - 'tart', 19:51:03 INFO - 'tscrollx', 19:51:03 INFO - 'cart']}, 19:51:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:51:03 INFO - 'tsvgr_opacity', 19:51:03 INFO - 'tart', 19:51:03 INFO - 'tscrollx', 19:51:03 INFO - 'cart']}, 19:51:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:03 INFO - 'talos_options': ['--disable-e10s'], 19:51:03 INFO - 'tests': ['tp5o']}, 19:51:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:03 INFO - 'tests': ['tp5o']}, 19:51:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:03 INFO - 'talos_options': ['--disable-e10s', 19:51:03 INFO - '--xperf_path', 19:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:03 INFO - 'tests': ['tp5n']}, 19:51:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:51:03 INFO - 'talos_options': ['--xperf_path', 19:51:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:03 INFO - 'tests': ['tp5n']}}, 19:51:03 INFO - 'talos.zip': {'path': '', 19:51:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:03 INFO - Running post-action listener: _resource_record_post_action 19:51:03 INFO - [mozharness: 2016-09-08 02:51:03.777797Z] Finished populate-webroot step (success) 19:51:03 INFO - [mozharness: 2016-09-08 02:51:03.777916Z] Running create-virtualenv step. 19:51:03 INFO - Running pre-action listener: _resource_record_pre_action 19:51:03 INFO - Running main action method: create_virtualenv 19:51:03 INFO - Creating virtualenv /builds/slave/test/build/venv 19:51:03 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 19:51:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:51:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:03 INFO - Using real prefix '/tools/python27' 19:51:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:51:04 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:07 INFO - Installing pip.................done. 19:51:07 INFO - Return code: 0 19:51:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:51:07 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')]} 19:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:07 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')]} 19:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:07 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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:07 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 19:51:07 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 19:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:07 INFO - 'HOME': '/Users/cltbld', 19:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:07 INFO - 'LOGNAME': 'cltbld', 19:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:07 INFO - 'MOZ_NO_REMOTE': '1', 19:51:07 INFO - 'NO_EM_RESTART': '1', 19:51:07 INFO - 'PAGER': '/bin/cat', 19:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:07 INFO - 'PWD': '/builds/slave/test', 19:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:07 INFO - 'SHELL': '/bin/bash', 19:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:07 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:07 INFO - 'USER': 'cltbld', 19:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:07 INFO - 'XPC_FLAGS': '0x0', 19:51:07 INFO - 'XPC_SERVICE_NAME': '0', 19:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:07 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 19:51:07 INFO - Cleaning up... 19:51:07 INFO - Return code: 0 19:51:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:51:07 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')]} 19:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:07 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')]} 19:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:07 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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:07 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 19:51:07 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 19:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:07 INFO - 'HOME': '/Users/cltbld', 19:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:07 INFO - 'LOGNAME': 'cltbld', 19:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:07 INFO - 'MOZ_NO_REMOTE': '1', 19:51:07 INFO - 'NO_EM_RESTART': '1', 19:51:07 INFO - 'PAGER': '/bin/cat', 19:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:07 INFO - 'PWD': '/builds/slave/test', 19:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:07 INFO - 'SHELL': '/bin/bash', 19:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:07 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:07 INFO - 'USER': 'cltbld', 19:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:07 INFO - 'XPC_FLAGS': '0x0', 19:51:07 INFO - 'XPC_SERVICE_NAME': '0', 19:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:07 INFO - Downloading/unpacking psutil>=3.1.1 19:51:07 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 19:51:07 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 19:51:07 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 19:51:07 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 19:51:07 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 19:51:07 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 19:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:10 INFO - Installing collected packages: psutil 19:51:10 INFO - Running setup.py install for psutil 19:51:10 INFO - building 'psutil._psutil_osx' extension 19:51:10 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 19:51:11 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 19:51:11 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 19:51:11 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 19:51:11 INFO - building 'psutil._psutil_posix' extension 19:51:11 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 19:51:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:51:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:51:11 INFO - ^ 19:51:11 INFO - 1 warning generated. 19:51:11 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 19:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:11 INFO - Successfully installed psutil 19:51:11 INFO - Cleaning up... 19:51:11 INFO - Return code: 0 19:51:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:11 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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:11 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 19:51:11 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 19:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:11 INFO - 'HOME': '/Users/cltbld', 19:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:11 INFO - 'LOGNAME': 'cltbld', 19:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:11 INFO - 'MOZ_NO_REMOTE': '1', 19:51:11 INFO - 'NO_EM_RESTART': '1', 19:51:11 INFO - 'PAGER': '/bin/cat', 19:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:11 INFO - 'PWD': '/builds/slave/test', 19:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:11 INFO - 'SHELL': '/bin/bash', 19:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:11 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:11 INFO - 'USER': 'cltbld', 19:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:11 INFO - 'XPC_FLAGS': '0x0', 19:51:11 INFO - 'XPC_SERVICE_NAME': '0', 19:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:51:12 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 19:51:12 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 19:51:12 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 19:51:12 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 19:51:12 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 19:51:12 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 19:51:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:51:14 INFO - Installing collected packages: mozsystemmonitor 19:51:14 INFO - Running setup.py install for mozsystemmonitor 19:51:14 INFO - Successfully installed mozsystemmonitor 19:51:14 INFO - Cleaning up... 19:51:14 INFO - Return code: 0 19:51:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:51: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')]} 19:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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', '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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:51: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 jsonschema==2.5.1 19:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:14 INFO - 'HOME': '/Users/cltbld', 19:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:14 INFO - 'LOGNAME': 'cltbld', 19:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:14 INFO - 'MOZ_NO_REMOTE': '1', 19:51:14 INFO - 'NO_EM_RESTART': '1', 19:51:14 INFO - 'PAGER': '/bin/cat', 19:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:14 INFO - 'PWD': '/builds/slave/test', 19:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:14 INFO - 'SHELL': '/bin/bash', 19:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:14 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:14 INFO - 'USER': 'cltbld', 19:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:14 INFO - 'XPC_FLAGS': '0x0', 19:51:14 INFO - 'XPC_SERVICE_NAME': '0', 19:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:15 INFO - Downloading/unpacking jsonschema==2.5.1 19:51:15 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 19:51:15 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 19:51:15 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 19:51:15 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 19:51:15 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 19:51:15 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 19:51:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:17 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:18 INFO - warning: no files found matching '*.txt' 19:51:18 INFO - no previously-included directories found matching 'build' 19:51:18 INFO - no previously-included directories found matching 'dist' 19:51:18 INFO - no previously-included directories found matching '.git*' 19:51:18 INFO - Installing collected packages: jsonschema, functools32 19:51:18 INFO - Running setup.py install for functools32 19:51:18 INFO - warning: no files found matching '*.txt' 19:51:18 INFO - no previously-included directories found matching 'build' 19:51:18 INFO - no previously-included directories found matching 'dist' 19:51:18 INFO - no previously-included directories found matching '.git*' 19:51:18 INFO - Successfully installed jsonschema functools32 19:51:18 INFO - Cleaning up... 19:51:18 INFO - Return code: 0 19:51:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:51:18 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')]} 19:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:18 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')]} 19:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:18 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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:18 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 19:51:18 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 19:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:18 INFO - 'HOME': '/Users/cltbld', 19:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:18 INFO - 'LOGNAME': 'cltbld', 19:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:18 INFO - 'MOZ_NO_REMOTE': '1', 19:51:18 INFO - 'NO_EM_RESTART': '1', 19:51:18 INFO - 'PAGER': '/bin/cat', 19:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:18 INFO - 'PWD': '/builds/slave/test', 19:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:18 INFO - 'SHELL': '/bin/bash', 19:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:18 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:18 INFO - 'USER': 'cltbld', 19:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:18 INFO - 'XPC_FLAGS': '0x0', 19:51:18 INFO - 'XPC_SERVICE_NAME': '0', 19:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:51:18 INFO - Cleaning up... 19:51:18 INFO - Return code: 0 19:51:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:51:18 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')]} 19:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:18 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')]} 19:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:18 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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:18 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 19:51:18 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 19:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:18 INFO - 'HOME': '/Users/cltbld', 19:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:18 INFO - 'LOGNAME': 'cltbld', 19:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:18 INFO - 'MOZ_NO_REMOTE': '1', 19:51:18 INFO - 'NO_EM_RESTART': '1', 19:51:18 INFO - 'PAGER': '/bin/cat', 19:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:18 INFO - 'PWD': '/builds/slave/test', 19:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:18 INFO - 'SHELL': '/bin/bash', 19:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:18 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:18 INFO - 'USER': 'cltbld', 19:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:18 INFO - 'XPC_FLAGS': '0x0', 19:51:18 INFO - 'XPC_SERVICE_NAME': '0', 19:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:18 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:18 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 19:51:18 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 19:51:18 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 19:51:18 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 19:51:18 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 19:51:18 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 19:51:21 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:51:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51: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 19:51:22 INFO - Downloading docopt-0.6.1.tar.gz 19:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:22 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:22 INFO - Running setup.py install for blobuploader 19:51:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:51:22 INFO - Running setup.py install for requests 19:51:23 INFO - Running setup.py install for docopt 19:51:23 INFO - Successfully installed blobuploader requests docopt 19:51:23 INFO - Cleaning up... 19:51:23 INFO - Return code: 0 19:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:23 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')]} 19:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:23 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')]} 19:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:23 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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:23 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 19:51:23 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 19:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:23 INFO - 'HOME': '/Users/cltbld', 19:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:23 INFO - 'LOGNAME': 'cltbld', 19:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:23 INFO - 'MOZ_NO_REMOTE': '1', 19:51:23 INFO - 'NO_EM_RESTART': '1', 19:51:23 INFO - 'PAGER': '/bin/cat', 19:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:23 INFO - 'PWD': '/builds/slave/test', 19:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:23 INFO - 'SHELL': '/bin/bash', 19:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:23 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:23 INFO - 'USER': 'cltbld', 19:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:23 INFO - 'XPC_FLAGS': '0x0', 19:51:23 INFO - 'XPC_SERVICE_NAME': '0', 19:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-2fjdTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Z6Z8nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:23 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-sxeexf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-lRZQNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-E9YVXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-yibwUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ONrB52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-yL7wpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-kdz4hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-nc_fmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-skd2kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-CibndH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:24 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-3z4rZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ETP4BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-srtco7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-C6x97U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:25 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-E6VQxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:25 INFO - Running setup.py install for manifestparser 19:51:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:51:25 INFO - Running setup.py install for mozcrash 19:51:25 INFO - Running setup.py install for mozdebug 19:51:25 INFO - Running setup.py install for mozdevice 19:51:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for mozfile 19:51:26 INFO - Running setup.py install for mozhttpd 19:51:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for mozinfo 19:51:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for mozInstall 19:51:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for mozleak 19:51:26 INFO - Running setup.py install for mozlog 19:51:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:51:26 INFO - Running setup.py install for moznetwork 19:51:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Running setup.py install for mozprocess 19:51:27 INFO - Running setup.py install for mozprofile 19:51:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Running setup.py install for mozrunner 19:51:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:51:27 INFO - Running setup.py install for mozscreenshot 19:51:27 INFO - Running setup.py install for moztest 19:51:27 INFO - Running setup.py install for mozversion 19:51:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:51:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:28 INFO - Cleaning up... 19:51:28 INFO - Return code: 0 19:51:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:28 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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:28 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 19:51:28 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 19:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:28 INFO - 'HOME': '/Users/cltbld', 19:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:28 INFO - 'LOGNAME': 'cltbld', 19:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:28 INFO - 'MOZ_NO_REMOTE': '1', 19:51:28 INFO - 'NO_EM_RESTART': '1', 19:51:28 INFO - 'PAGER': '/bin/cat', 19:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:28 INFO - 'PWD': '/builds/slave/test', 19:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:28 INFO - 'SHELL': '/bin/bash', 19:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:28 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:28 INFO - 'USER': 'cltbld', 19:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:28 INFO - 'XPC_FLAGS': '0x0', 19:51:28 INFO - 'XPC_SERVICE_NAME': '0', 19:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-MuYFMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:28 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)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-CI8_vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:28 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)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-ncoPmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:28 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)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-2oTl9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:28 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)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-CmjzTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:28 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)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-_8nQyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:28 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)) 19:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:28 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-vX1q6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-bGfTF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-7Ib9oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-JQfCzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-x8oLiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-jdvjay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-zTuy9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-OGqKBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-IBouxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:29 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)) 19:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:29 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-Z4qkXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:30 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)) 19:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:30 INFO - Running setup.py (path:/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/pip-EJww8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:30 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)) 19:51:30 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)) 19:51:30 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)) 19:51:30 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)) 19:51:30 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)) 19:51:30 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)) 19:51:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:30 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 19:51:30 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 19:51:30 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 19:51:30 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 19:51:30 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 19:51:30 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 19:51:32 INFO - Downloading blessings-1.6.tar.gz 19:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:32 INFO - Installing collected packages: blessings 19:51:32 INFO - Running setup.py install for blessings 19:51:32 INFO - Successfully installed blessings 19:51:32 INFO - Cleaning up... 19:51:32 INFO - Return code: 0 19:51:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:33 INFO - Reading from file tmpfile_stdout 19:51:33 INFO - Current package versions: 19:51:33 INFO - blessings == 1.6 19:51:33 INFO - blobuploader == 1.2.4 19:51:33 INFO - docopt == 0.6.1 19:51:33 INFO - functools32 == 3.2.3-2 19:51:33 INFO - jsonschema == 2.5.1 19:51:33 INFO - manifestparser == 1.1 19:51:33 INFO - mozInstall == 1.12 19:51:33 INFO - mozcrash == 0.17 19:51:33 INFO - mozdebug == 0.1 19:51:33 INFO - mozdevice == 0.48 19:51:33 INFO - mozfile == 1.2 19:51:33 INFO - mozhttpd == 0.7 19:51:33 INFO - mozinfo == 0.9 19:51:33 INFO - mozleak == 0.1 19:51:33 INFO - mozlog == 3.3 19:51:33 INFO - moznetwork == 0.27 19:51:33 INFO - mozprocess == 0.23 19:51:33 INFO - mozprofile == 0.28 19:51:33 INFO - mozrunner == 6.12 19:51:33 INFO - mozscreenshot == 0.1 19:51:33 INFO - mozsystemmonitor == 0.3 19:51:33 INFO - moztest == 0.7 19:51:33 INFO - mozversion == 1.4 19:51:33 INFO - psutil == 3.1.1 19:51:33 INFO - requests == 1.2.3 19:51:33 INFO - wsgiref == 0.1.2 19:51:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:33 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 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:33 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 19:51:33 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 19:51:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:33 INFO - 'HOME': '/Users/cltbld', 19:51:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:33 INFO - 'LOGNAME': 'cltbld', 19:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:33 INFO - 'MOZ_NO_REMOTE': '1', 19:51:33 INFO - 'NO_EM_RESTART': '1', 19:51:33 INFO - 'PAGER': '/bin/cat', 19:51:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:33 INFO - 'PWD': '/builds/slave/test', 19:51:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:33 INFO - 'SHELL': '/bin/bash', 19:51:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:33 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:33 INFO - 'USER': 'cltbld', 19:51:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:33 INFO - 'XPC_FLAGS': '0x0', 19:51:33 INFO - 'XPC_SERVICE_NAME': '0', 19:51:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 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)) 19:51:34 INFO - Cleaning up... 19:51:34 INFO - Return code: 0 19:51:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107614a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1076a9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb783c5dcb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, '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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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 19:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:34 INFO - 'HOME': '/Users/cltbld', 19:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:34 INFO - 'LOGNAME': 'cltbld', 19:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:34 INFO - 'MOZ_NO_REMOTE': '1', 19:51:34 INFO - 'NO_EM_RESTART': '1', 19:51:34 INFO - 'PAGER': '/bin/cat', 19:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:34 INFO - 'PWD': '/builds/slave/test', 19:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:34 INFO - 'SHELL': '/bin/bash', 19:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:51:34 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:34 INFO - 'USER': 'cltbld', 19:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:34 INFO - 'XPC_FLAGS': '0x0', 19:51:34 INFO - 'XPC_SERVICE_NAME': '0', 19:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:51:34 INFO - Cleaning up... 19:51:34 INFO - Return code: 0 19:51:34 INFO - Running post-action listener: _resource_record_post_action 19:51:34 INFO - Running post-action listener: _start_resource_monitoring 19:51:34 INFO - Starting resource monitoring. 19:51:34 INFO - [mozharness: 2016-09-08 02:51:34.514218Z] Finished create-virtualenv step (success) 19:51:34 INFO - [mozharness: 2016-09-08 02:51:34.515196Z] Running install step. 19:51:34 INFO - Running pre-action listener: _resource_record_pre_action 19:51:34 INFO - Running main action method: install 19:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:34 INFO - Reading from file tmpfile_stdout 19:51:34 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:51:34 INFO - Reading from file tmpfile_stdout 19:51:34 INFO - Output received: 19:51:34 INFO - Usage: mozinstall [options] installer 19:51:34 INFO - Options: 19:51:34 INFO - -h, --help show this help message and exit 19:51:34 INFO - -d DEST, --destination=DEST 19:51:34 INFO - Directory to install application into. [default: 19:51:34 INFO - "/builds/slave/test"] 19:51:34 INFO - --app=APP Application being installed. [default: firefox] 19:51:34 INFO - mkdir: /builds/slave/test/build/application 19:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:52:09 INFO - Reading from file tmpfile_stdout 19:52:09 INFO - Output received: 19:52:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:52:09 INFO - Running post-action listener: _resource_record_post_action 19:52:09 INFO - [mozharness: 2016-09-08 02:52:09.403161Z] Finished install step (success) 19:52:09 INFO - [mozharness: 2016-09-08 02:52:09.403303Z] Running run-tests step. 19:52:09 INFO - Running pre-action listener: _resource_record_pre_action 19:52:09 INFO - Running main action method: run_tests 19:52:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:52:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:52:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:52:09 INFO - 2016-09-07 19:52:09.417 screenresolution[1642:7493] starting screenresolution argv=screenresolution get 19:52:09 INFO - 2016-09-07 19:52:09.420 screenresolution[1642:7493] Display 0: 1600x1200x32@60 19:52:09 INFO - 2016-09-07 19:52:09.426 screenresolution[1643:7495] starting screenresolution argv=screenresolution list 19:52:09 INFO - Available Modes on Display 0 19:52:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:52:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:52:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:52:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:52:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:52:09 INFO - Intel Iris: 19:52:09 INFO - Chipset Model: Intel Iris 19:52:09 INFO - Type: GPU 19:52:09 INFO - Bus: Built-In 19:52:09 INFO - VRAM (Dynamic, Max): 1536 MB 19:52:09 INFO - Vendor: Intel (0x8086) 19:52:09 INFO - Device ID: 0x0a2e 19:52:09 INFO - Revision ID: 0x0009 19:52:09 INFO - Displays: 19:52:09 INFO - Display: 19:52:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:52:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:52:09 INFO - Display Serial Number: 1600x1200 60 19:52:09 INFO - Main Display: Yes 19:52:09 INFO - Mirror: Off 19:52:09 INFO - Online: Yes 19:52:09 INFO - Rotation: Supported 19:52:09 INFO - Return code: 0 19:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:52:09 INFO - Python 2.7.3 19:52:09 INFO - Return code: 0 19:52:09 INFO - grabbing minidump binary from tooltool 19:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:52:09 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 0x107578d30>, '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 0x1072dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107570b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:52:09 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 19:52:09 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 19:52:09 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 19:52:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:09 INFO - Return code: 0 19:52:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:52:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:52:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:52:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:52:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:52:09 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:52:09 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0367 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:52:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJ5H18d1dF/Render', 19:52:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:52:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:52:09 INFO - 'HOME': '/Users/cltbld', 19:52:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:52:09 INFO - 'LOGNAME': 'cltbld', 19:52:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:52:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:09 INFO - 'MOZ_NO_REMOTE': '1', 19:52:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:52:09 INFO - 'NO_EM_RESTART': '1', 19:52:09 INFO - 'PAGER': '/bin/cat', 19:52:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:09 INFO - 'PWD': '/builds/slave/test', 19:52:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:52:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:52:09 INFO - 'SHELL': '/bin/bash', 19:52:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dDyL3vRBBU/Listeners', 19:52:09 INFO - 'TMPDIR': '/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/', 19:52:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:52:09 INFO - 'USER': 'cltbld', 19:52:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:52:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:09 INFO - 'XPC_FLAGS': '0x0', 19:52:09 INFO - 'XPC_SERVICE_NAME': '0', 19:52:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:52:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0367', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:52:10 INFO - mozversion application_buildid: 20160907180916 19:52:10 INFO - mozversion application_changeset: fb7c6b0343295392bac590c19b14e7e5dcccdc33 19:52:10 INFO - mozversion application_display_name: Nightly 19:52:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:10 INFO - mozversion application_name: Firefox 19:52:10 INFO - mozversion application_remotingname: firefox 19:52:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:52:10 INFO - mozversion application_vendor: Mozilla 19:52:10 INFO - mozversion application_version: 51.0a1 19:52:10 INFO - mozversion platform_buildid: 20160907180916 19:52:10 INFO - mozversion platform_changeset: fb7c6b0343295392bac590c19b14e7e5dcccdc33 19:52:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:52:10 INFO - mozversion platform_version: 51.0a1 19:52:10 INFO - using testdate: 1473303130 19:52:10 INFO - actual date: 1473303130 19:52:10 INFO - starting webserver on 'localhost:49268' 19:52:10 INFO - SUITE-START | Running 2 tests 19:52:10 INFO - TEST-START | dromaeo_css 19:52:10 INFO - operating with platform_type : mac_ 19:52:10 INFO - Initialising browser for dromaeo_css test... 19:52:10 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmp5225mK/profile http://localhost:49268/getInfo.html) 19:52:12 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 19:52:12 INFO - PROCESS | 1653 | colorDepth:24 19:52:12 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 19:52:12 INFO - PROCESS | 1653 | __metrics 19:52:12 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:52:12 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:52:13 INFO - TEST-INFO | 1653: exit 0 19:52:13 INFO - Browser initialized. 19:52:13 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:13 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmp5225mK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:25 INFO - PROCESS | 1655 | RSS: Main: 232083456 19:52:25 INFO - PROCESS | 1655 | 19:53:17 INFO - PROCESS | 1655 | 1473303197452 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] 19:55:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 19:55:29 INFO - PROCESS | 1655 | RSS: Main: 387768320 19:55:29 INFO - PROCESS | 1655 | 19:58:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 19:58:33 INFO - PROCESS | 1655 | RSS: Main: 368619520 19:58:33 INFO - PROCESS | 1655 | 20:01:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 20:01:36 INFO - PROCESS | 1655 | RSS: Main: 356405248 20:01:36 INFO - PROCESS | 1655 | 20:04:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 20:04:39 INFO - PROCESS | 1655 | RSS: Main: 337559552 20:04:39 INFO - PROCESS | 1655 | 20:07:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 20:07:43 INFO - PROCESS | 1655 | RSS: Main: 331984896 20:07:43 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 20:10:46 INFO - PROCESS | 1655 | RSS: Main: 477306880 20:10:46 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | __start_tp_report 20:10:46 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 20:10:46 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 20:10:46 INFO - PROCESS | 1655 | |i|pagename|runs| 20:10:46 INFO - PROCESS | 1655 | |0;dojo.html;2943.632045994251;3311.9337613247726;3325.7505687073462;3327.733781297496;3406.863725450982;5677.914831277524;5761.625494342865;5762.711864406779;5824.67964261966;5848.385919478452;5726.1697053927155;5762;5796.652200867951;5821.243238379005;5836.9124463133085;5145.922811157836;5169.302144210521;5257.815976440826;5264.710440925747;5287.101192797234;4626.676132670715;5214.556762675177;5329.866753331159;5337.2794672719265;5355.0896347621;5204.34945631796;5232.947670523284;5242.423333433319;5258.92111618326;5290.39160496544;5153.922691159635;5275.815346462894;5343.812966546152;5368.0605893968395;5371.086915224421;5131.204663277198;5153.484651534816;5214.243934629495;5216.947830521722;5218.60860435465;5749.482546570787;5754.251947246873;5790.913136302959;5826.096954971944;5841.503472204868;6145.139680444741;6220.87558248837;6268.811935641938;6271.843203919893;6301.936980630181;5520.861978450531;6278.874422511524;6292.2134733158355;6306.211723534559;6316.336784637593;5726.484616384545;5872.706364681749;5874.23634927461;5886.23478947734;5887.882242355129;6228.47058000066;6235.719392627343;6274.466670332981;6285.5600107992;6344.49244060474;6230.875382492325;6248.4376406123665;6261.843453913689;6262.499000079983;6276.529260305495;6232.376762323732;6265.498760099181;6280.340564240689;6285.717142728588;6313.715882785285;6118.771466971993;6139.676133582418;6179.783707570214;6206.286277078104;6283.937160628427;6299.4330510253385;6305.4009869062365;6328.746850125944;6335.9228931081825;6347.714352854133;4962.404511458648;4965.230389289666;4973.204287314013;4974.27872958419;4996.875078123076;4370.366296886998;4373;4476.37330773692;4484.529124441887;4501.7524036177665;5777.451142141574;5796.1305804129715;5801.448862358069;5814.244148260784;5911.172435858984;6242.563020588515;6265.8120256392385;6295.087212354183;6297.685115744194;6302.65335406557;5823.679697616587;5837.328707198726;5853.970730146322;5857.707114644336;5908;5315.6013299002725;5435.347758269033;5454.699991500505;5487.5609951203805;5494.148406996922;6354.523410744213;6364.872702546016;6374.904376434357;6377.7767778127545;6383.616982981036;6189.226346706661;6245.938190507715;6252.187215661935;6272.059191121369;6284.717187726655;6217.906731399123;6315.715792789244;6334.841628959313;6353.047042943411;6378.2346118466085;6208.81373558794;6272.4982001440685;6274.968625156845;6291.937080629135;6292.52806039558;6140.140380346845;6265.874682506415;6288.11966324724;6293.181886354744;6293.213348331458;6002.129691194665;6144.1398204250545;6191.133241346125;6196.47329976939;6210.472109870711;6182.567220294536;6183.876322473615;6188.071789231652;6216;6221.160143380585;5957.523398128226;6068.17954613623;6076.179715738319;6087.69561521931;6102.51954821894;5085.618578606545;6061.72722227492;6110.467630727307;6119.868162944114;6218.502519798315;6043.969780151247;6067.939320606914;6069.939300606938;6091.329953705001;6129.816105516842 20:10:46 INFO - PROCESS | 1655 | |1;ext.html;515.4021335251108;521.8356217791396;527.2802624417671;536.5412572250727;556.9721513924305;30386.848065759666;39479.407808882854;40797;40818.59181408185;40864.59135408645;42219.15561688764;42469;42470.787646061726;42479.725608231725;42589.787051064704;9685.95157024214;9846.212303015778;9854.556544955494;9863.210943124568;9870.851937220947;8781.56092195391;9055.456672599632;11725.179237453382;12049.277043377382;12053.578124765634;12051.819222711667;12121.212121212136;12134;12146.39268036599;12178.756424871497;10431.530581123867;11903.107266955012;12037.458314375874;12122.454489547992;12132.150749447543;8515.233628973423;8766.649334026632;8775.692850750193;8872.512011839346;11480.942595287053;40377.99055023619;40561.79719101386;40619.390709139385;40647.98380040493;40690;3277.3281477297096;3368.6631336866362;3954.268460334847;4138.634250697292;4159.168166366709;29863.16299951523;30878.691213087804;30880.227994300098;31139.37721245585;31265.749370025173;3185.311784754084;3261.7390608751243;3275.96724032759;3297.4559197732347;3366.2762506061313;516304;517344;517508.4124579353;518242.9999999962;518946;56541.71729141328;56885.715571422705;56944.430555693914;56957.86084278291;57026.714866425405;59503.702481487315;59712;59766;59829.70085149634;59841.70079149664;15716.13561254142;15903.840961590236;15905.045697258201;15918.60203494922;15935.362585496681;11175.105991520659;12358.258504489759;12431.005519558594;12435.502579896704;12458.563950261698;14029.438822446988;14428.783568246485;14458.783118253235;14485.78271325931;14488.275586220858;4574.642955264072;6587.73649054042;6689.929611262175;7300.926990730131;7473.4021278297605;868.2793281576403;918.4122161816442;974.2317693386481;1101.6144349477618;1107.9585189921447;29145.417091658048;29563.85218073896;29916.252093697833;29928.700712993028;29964.850175748983;1052.6894566103017;1058.9205809564314;1063.0963680871198;1089.4226060187955;1149.7298134938283;14692.191929443983;15235.61910952213;15354.078755274495;15371.61570960735;15638.765418518504;655852;660118;660884;660901;661626;56287.43712562822;56542.43457565454;56550.71724641351;56593;56712;1359.5309618181711;1372.835259768834;1382.5575815739069;1384.494659449314;1393.463516546137;28453.715462845106;29195.562066569444;29226;29766.553501697057;30139.945101921327;49490.75254623848;49914;49918.00163996627;49959.50040499549;50025.49974500354;401106;469713;470179.2455188648;470703;470987;29244.70755292505;33168.190612361555;33821.15447113842;39847.00382490461;40109.79670609887;45475.54524454713;46127.07745845131;46232.30651540297;46820.7658961703;47304.763476183776;37591.6240837599;37844.864654060424;37891.81054094822;38753.806230968665;39338.606613933494;36671.81664091662;37241.62758372381;37602.62397375991;38119.42820857634;38693.22613547657;36447.45328820123;36952.44571331486;37212.44181337336;37401.62598373982;37406.438903415925;31193.37613247768;33754.32491350208;33886;34010.489842652874;34024.319513610084;24717.25848224556;24778.15051269127;25212.873935630203;25360.112396066048;25735 20:10:46 INFO - PROCESS | 1655 | |2;jquery.html;305.3663647930544;347.60373174580997;362.7714539839899;366.0902656897609;399.2992298516104;15269.389224431023;17557.385491507783;19862.20551177951;20021.899890500546;20434.489137771565;18521.907390463064;18543.980081095535;18970.62058758824;19160.137793799277;21043.789562104375;5678.091505359153;5994.910076348837;6006.8798624027495;6011.489023433013;6014.188084608566;5041.924371134418;5899.705014749266;5965.4929331006915;5970.8805823883495;5972.134040564116;5650.237217975582;5885.676287804169;5904.084866845646;5907.852303692399;5911.054231322989;5796.62321949072;5830.125481177814;5845;5860.267466566679;5889.057750759879;4863;5109.693418394908;5110.6422550421485;5113.795448182068;5488.643238189505;12655.430505627177;12886.742265154644;12900.290484023375;12905.225686458842;19882.801171988383;2023.9392818215476;2056.95886082279;2058.8455865810124;2075.30477290108;2079.480129967508;10186.847197292047;10405.53175107122;10987.725306867313;11522.596709115225;13116.409761560657;1830.9176087076114;1836.4307064809952;1839.2275244397251;1883.5197024758736;1927.5277556998485;81883.3623327536;115591;127883;130024.34987825001;130661.34669326592;11037.944810275898;11235.157363197794;11305.943470282597;11345.489452974636;11555.306681599131;13980.231087290296;13981.23103229332;14003.789943150861;14005;14006.509772157926;7452.403807695479;8017.639206235617;8138.877916831252;8362.916370836336;8528.573571321409;8364.958175209085;8371.288440482505;8378.53918034514;8521.233089021895;8580.871286930702;4294.613484786384;4404.436425069119;4413.256763578369;4414.139242847614;4522.140793249272;1550.6666066795692;1638.4101723379574;1878.2205384765443;1903.486058764126;1949.31773879144;721.9494635375473;843.8270154618289;874.5758307220992;893.5442924108752;947.4315410753493;20116.497087572927;20859.957002150135;20926.116649501313;20998.790012099988;21037.789622103584;760.2625453310391;903.8056817784208;905.9048799875918;915.3866909170738;929.7861491856911;10159.492025398848;11047.502862371213;11093.778124437466;11102.944485277521;11127.666170014912;562732;578296;586084;586587;597640;90673.57253915753;98144.50927745315;104581;129276;133925;865.2342676731138;918.2837386838144;951.8619800128943;952.9809403812023;962.2061799015839;18797.718034229223;18932.242710291433;19051.523711907314;19062.904685476486;19266.940318282068;43715.78142109396;54681.72659136679;54959.900801982934;55819;57489;67868.6606566964;77192;78318.6084069576;79840.00799959863;81681.64865162164;7750.302472777477;7853;7906.367490600623;8000.959995199987;8037.477563958324;10150.390976541432;12067;12663.303518306582;12949.935250323688;12982.93508532489;9791.85312220303;10871.565137394417;11149.554017839195;11196;11206.38364889939;10737.141028717528;10916.617918372818;10979.615713449992;11332.490037948148;11357.829632555684;11098.889011110108;11101.722456938642;11129.610463634059;11395.430228488376;11488.483018264365;7695.615219238904;7879.803004924923;7882;7947.8807817881625;8195.385346099185;8106.635201415833;9947.850782238127;10919.836202457129;11222.551097956317;11339.149563782914 20:10:46 INFO - PROCESS | 1655 | |3;mootools.html;1469.2580246975276;1509.117166457622;1674.5897255172486;1800.9909950450246;1860.116444688773;8446.366522510813;9053.818923621531;9057.00372958974;9059.50172740499;9062.093790620951;7962.3232025277775;8164.550949697779;8546.871796923035;8758.737237882859;8801.779955501115;2375.631777074552;2404.4229384947575;2413.1433341163897;2416.9637455438183;2418.6613874057557;2039.2250944641016;2406.7111946566347;2422.6002709552904;2427.745086765891;2430.1373012580543;2397.0172229385958;2406.0616359619676;2418.262429958862;2426.7815896569305;2427.5751743444916;2390.6414037894283;2397.7242617098996;2407.229686500312;2408.494216214597;2411.3730430088126;2377.7741114594087;2391.5216956608747;2392.2225276785116;2397.700287464067;2404.4589967257402;8871.157240062184;8948.149925757043;8990.595423205972;8993.415427997159;9009.279257659437;5282.867928301823;5450.672959622435;5451.236826844245;5460.699661518614;5472.98749731301;3615.620359862203;3653.8355773990234;3678.5401824771902;3680.061584296014;3729.1050147964565;1099.1866019145855;1099.6755956992706;1105.3588918427374;1118.2340097033557;1130.4630300607228;11963.700907477296;12073.27560346382;12075.698107547294;12096.576619818265;12124.969377602914;4655.301704744315;4710.436060754532;4781.235002399669;4846.29728689338;4894.412670479494;10160.847587286196;10170.389776613427;10174.389536627677;10174.440405777754;10175;5396.487333703292;5396.595255355864;5402.8919421611345;5406.189071639285;5410.458954104637;4414.933775993362;4569.908601827945;4744.857654270378;4879.487653796371;4932.383452068491;3905.9804700976315;3909.100906791454;4017.276890159799;4038.252923209157;4042.2521833460905;1279.1685404486973;1289.38109707341;1291.438224372401;1299.123091912955;1303.1789972317379;802.9116797152309;888.2760550151605;919.3702313914989;942.1850099663878;964.2237998411206;5461.208124821958;5865.853353666107;6025.367336429612;6030.939690603125;6194.349593292639;380.2490082087854;854.2909385210261;938.7842743646994;951.6431338248157;983.0611765763822;3502.8949131526097;3733.1227161617;3965.6232657897453;4029.4761680981283;4067.6745860331102;9980.401175929468;10819.729506762236;10867.239293249397;10881.075108615698;10916.454177291103;10813.83779243312;10819.296745711503;10824;10832.40421776794;10837.729056773485;8159.224873636995;8277.875831862406;8278.544680042656;8284.25441710249;8286.875696864552;5355.758990845499;5983.55123365758;6016.187814645142;6162.7534898605345;6220.533459990609;8048.476849004796;10017.098461138532;10231.590736370461;10236.385816851012;10330.845037324596;9172.715819785102;9728.513574321398;10329.173666106542;10403.566822948258;10494.317869338469;7116;7295.598742069024;7339.70641174347;7632.084149902047;7836.09884863248;8145.918540814516;8430.241278284984;8444.324454043539;8447.324214062983;8451.957740211259;7275.890861636974;7357.8160545986775;7431.219721929336;7494.662740176596;7543.47195696296;6451.6774161290805;7277.818054548678;7323.523970941872;7348.375388091858;7502.099748030271;6902.275261097512;7062.3996960258955;7068.257832927468;7072.823179420556;7090.397316228178;4988.650794444354;5029.84910452687;5067.822626208065;5094.1849304111165;5152.948470515247;4917.311576379381;4940.912999140183;5087.898242035212;5237.2929654497675;5244.187150991603 20:10:46 INFO - PROCESS | 1655 | |4;prototype.html;302.09070697201423;304.1104768551986;308.7298613713001;316.63428739805516;317.5078628126403;4690.5074967128385;5537.252470916425;5583.246261754667;5607.869009776289;5610.523105536035;5034.597232221414;5429.375621803494;5457.5633949284065;5487.451254874511;5490.313710786152;3496.388132076883;3977.9856136685103;4123.257813593552;4215.831366745342;4227.302495088306;4179.226843034034;4180.749155050707;4203.435904098497;4234.259004674185;4243.745375277494;3440.7419443541708;3469.826508674556;4118.052847844982;4156.605122513356;4169.833206671729;3911.198204368098;4138.337865941435;4169.541350451463;4169.812358443862;4173.749575025508;3545.7163426925786;3551.5438670145377;3559.323728491578;3563.734874119676;3568.4468907319406;4713.242752989471;4934.654574179809;5024.69851808889;5027.949720502785;5412.404635490093;3772.2455508898056;4692.389989301403;4760.714357138548;4786.880327991793;4800.4719480857075;4865.683730557503;5522.585806064561;5549.5837812164245;5807.025611292181;5828.795992140254;3588.766730162531;3913.3934240192816;3926.548446928611;3931.5085614298214;3939.625735555118;5331.20031995196;5833.970830145865;6108.602940808833;6134.294556126013;6227.782027629011;3826.44516545105;3985.3822657488136;3989.4215338775716;3989.8005099744896;4009.558948515661;4064.309067458539;4076.490438695163;4082.3876418537457;4087.509498860156;4093.324601440729;4254.808533615995;4732.834350797705;4752.976235118802;4761.619070474354;4773.785179666923;5237.8428647140645;5539.977908063528;5562.415946325658;5864.2083318752275;5869.853253668693;1310.9905372862843;1335.5792925228523;1382.3826123435604;1382.7511048011454;1384.3424373422745;784.9175836537196;823.8640624296924;841.2050612171439;842.8200519273066;845.8392905347964;4211.399668126092;4747.572718455355;5086.516780905808;5444.080262211201;5510.338759348823;5440.945590544123;5910.468057874812;6053.182820319201;6063.848403789941;6070.6357618543025;5050.787810925352;5426.457354264542;5456.90861827636;5473.972630136824;5540.058190107691;2784.373515958893;3097.519884417919;3182.9363412732077;3184.5541624172633;3205.4390481666082;6245.969415046467;6291.6854157291955;6305.464035556937;6323.588966717149;6349.587276826992;5733.655980641175;6173.098643637483;6238.656873871981;6242.250929888442;6265.373462653789;5471.945280547223;6241.344658810759;6291.433770960544;6330.77130663365;6368.64972426521;4795.784189711541;5883.382244864228;5973.342932277533;6008.204170862946;6125.173101631222;4977.352944117241;5569.8607534810335;5850.829834033296;5986.461218490357;5992.101184822312;5864.970675146597;5879.823605291677;6334.556581039283;6369.49044076482;6397.936020639921;3245.3184831185717;3880.6701430378735;3976.2445135424177;3993.0017495626093;4014.5583985762128;5579.832605021856;5857.656937225144;6044.697765111815;6045.244344456943;6076.483498902643;5568.470995255444;5879;5900.970495147497;5963.956307646231;6011.759529618941;5113.386393632788;5721.742521586455;5822.94177058241;5827.05733604527;5840.970795145997;5636.830895073154;5723.656580605177;5769.547942124665;5805.561664101172;5815.563832712648;5531.778728850801;5562.276904002454;5670.979223739767;5839.708014599338;5859.835688728039;4813.879653008703;5216.556592689664;5622.128570071645;5759.293132227846;5793.420657934173 20:10:46 INFO - PROCESS | 1655 | |5;yui.html;684.5276759036265;710.7618947652536;717.6017310392733;730.1238513783461;762.7063580521504;15287.69424611507;16599.41902033429;16602.50192494224;16631.750523742154;16641.50075497737;14949;15103.924480377582;15124.243787810594;15153.621159471018;15156.014859034156;677.9254282028973;693.4868197533814;831.4927893984665;848.503625379154;863.9222469977701;857.901341345747;865.4677373415336;873.6374404622075;876.6011464783509;876.7457437343163;924.4037595750737;926.7729406295467;927.0544045074021;928.299134153713;932.5477143585356;707.1125737199833;891.7636826241052;919.72868003939;920.9317192057182;921.3228277216241;688.9483288753313;691.7751730687546;693.8577591593711;695.0963747128762;695.5791745993702;15293.847061529354;15358.616034599112;15368.692626147526;15373.538793836204;15378.231088445646;13889.513867014706;14120.082194657418;14149.363278652485;14237.074590151711;14368;12859.099863009593;12907.677308067374;12913.160644558073;13058;13160.60518184456;4512.8286868465475;4523.86428407145;4579.290210017452;4665.066986602659;4683.929741053887;119040;121229;121299;121940;124837;11091.389973551532;11093.278936869077;11236.719082023015;11246.831297530543;11631.185816992729;21714.674279885814;21724.56550868974;21749.456263593536;21751.891240543697;21754;7735.49719268257;7755.72854950074;7788.883166752503;7887.605619718991;7949.284564389232;4311.547287534764;4358.760268185217;4367.301231802896;4521.683482156283;4526.79629416677;3453.689167974894;3554.2713743682484;3554.626764189723;3557.8576856925433;3564.572251329857;626.7493002798917;647.740903638539;647.9676016199265;650.0703993289546;664.7108507799123;538.6633354153654;545.5717261949351;601.5067446177051;602.7016626769777;643.0161852365887;8825.470471771714;8864.512451815212;8869.201771840566;8880.692863960974;9070.637174513078;477.4080140625599;587.4096532984323;595.8748662780864;629.804760524239;645.8094862015716;4329.15581461612;4408.515063343029;4557.908841823211;4564.680472366902;4581.610563102174;112332;114899;153956.14394704308;167284;170285;115100;115452;116900;130516;146703;67932.660336698;76576.23423765691;76670.58264803638;103249.9999999985;107338;9539;9574.56914438838;9620.615175392906;9657.517124143906;9781.804363912825;53423;57671.846563067666;58157.70921145367;58881.70559147348;62086.0687089685;69942;90024;92782;93225;96495;11988.64034078979;12152.453139608562;12369.072319575887;12763.425645846144;12818.743625127632;14201.928990354982;14567.41730330775;14859.554213373616;14964.775528367301;15048.322825473098;13512.324383780968;13533.729325413633;13838.4464621414;13948.721025579229;14126.929365353108;13326.400311986177;13395.776617611336;13549.390277437737;14005.719885602435;14096.718065638424;11873.346965916611;12899.93550032244;13311.46754129824;13589.388477518338;13741.450341986609;9502.429854208493;11249.71875703114;11344.20590558686;11507.942460287644;11644.486216791764;7987.600619969095;8829.33779966518;10350.5342259597;10529.420881851265;11403.258788178742 20:10:46 INFO - PROCESS | 1655 | __end_tp_report 20:10:46 INFO - PROCESS | 1655 | __start_cc_report 20:10:46 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1522 20:10:46 INFO - PROCESS | 1655 | __end_cc_report 20:10:46 INFO - PROCESS | 1655 | __startTimestamp1473304246650__endTimestamp 20:10:46 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | ------- Summary: start ------- 20:10:46 INFO - PROCESS | 1655 | Number of tests: 6 20:10:46 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5787.29 Median:6068.18 stddev:664.41 (10.9%) stddev-sans-first:627.89 20:10:46 INFO - PROCESS | 1655 | Values: 2943.6 3311.9 3325.8 3327.7 3406.9 5677.9 5761.6 5762.7 5824.7 5848.4 5726.2 5762.0 5796.7 5821.2 5836.9 5145.9 5169.3 5257.8 5264.7 5287.1 4626.7 5214.6 5329.9 5337.3 5355.1 5204.3 5232.9 5242.4 5258.9 5290.4 5153.9 5275.8 5343.8 5368.1 5371.1 5131.2 5153.5 5214.2 5216.9 5218.6 5749.5 5754.3 5790.9 5826.1 5841.5 6145.1 6220.9 6268.8 6271.8 6301.9 5520.9 6278.9 6292.2 6306.2 6316.3 5726.5 5872.7 5874.2 5886.2 5887.9 6228.5 6235.7 6274.5 6285.6 6344.5 6230.9 6248.4 6261.8 6262.5 6276.5 6232.4 6265.5 6280.3 6285.7 6313.7 6118.8 6139.7 6179.8 6206.3 6283.9 6299.4 6305.4 6328.7 6335.9 6347.7 4962.4 4965.2 4973.2 4974.3 4996.9 4370.4 4373.0 4476.4 4484.5 4501.8 5777.5 5796.1 5801.4 5814.2 5911.2 6242.6 6265.8 6295.1 6297.7 6302.7 5823.7 5837.3 5854.0 5857.7 5908.0 5315.6 5435.3 5454.7 5487.6 5494.1 6354.5 6364.9 6374.9 6377.8 6383.6 6189.2 6245.9 6252.2 6272.1 6284.7 6217.9 6315.7 6334.8 6353.0 6378.2 6208.8 6272.5 6275.0 6291.9 6292.5 6140.1 6265.9 6288.1 6293.2 6293.2 6002.1 6144.1 6191.1 6196.5 6210.5 6182.6 6183.9 6188.1 6216.0 6221.2 5957.5 6068.2 6076.2 6087.7 6102.5 5085.6 6061.7 6110.5 6119.9 6218.5 6044.0 6067.9 6069.9 6091.3 6129.8 20:10:46 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:68071.86 Median:37723.74 stddev:147307.83 (390.5%) stddev-sans-first:147633.74 20:10:46 INFO - PROCESS | 1655 | Values: 515.4 521.8 527.3 536.5 557.0 30386.8 39479.4 40797.0 40818.6 40864.6 42219.2 42469.0 42470.8 42479.7 42589.8 9686.0 9846.2 9854.6 9863.2 9870.9 8781.6 9055.5 11725.2 12049.3 12053.6 12051.8 12121.2 12134.0 12146.4 12178.8 10431.5 11903.1 12037.5 12122.5 12132.2 8515.2 8766.6 8775.7 8872.5 11480.9 40378.0 40561.8 40619.4 40648.0 40690.0 3277.3 3368.7 3954.3 4138.6 4159.2 29863.2 30878.7 30880.2 31139.4 31265.7 3185.3 3261.7 3276.0 3297.5 3366.3 516304.0 517344.0 517508.4 518243.0 518946.0 56541.7 56885.7 56944.4 56957.9 57026.7 59503.7 59712.0 59766.0 59829.7 59841.7 15716.1 15903.8 15905.0 15918.6 15935.4 11175.1 12358.3 12431.0 12435.5 12458.6 14029.4 14428.8 14458.8 14485.8 14488.3 4574.6 6587.7 6689.9 7300.9 7473.4 868.3 918.4 974.2 1101.6 1108.0 29145.4 29563.9 29916.3 29928.7 29964.9 1052.7 1058.9 1063.1 1089.4 1149.7 14692.2 15235.6 15354.1 15371.6 15638.8 655852.0 660118.0 660884.0 660901.0 661626.0 56287.4 56542.4 56550.7 56593.0 56712.0 1359.5 1372.8 1382.6 1384.5 1393.5 28453.7 29195.6 29226.0 29766.6 30139.9 49490.8 49914.0 49918.0 49959.5 50025.5 401106.0 469713.0 470179.2 470703.0 470987.0 29244.7 33168.2 33821.2 39847.0 40109.8 45475.5 46127.1 46232.3 46820.8 47304.8 37591.6 37844.9 37891.8 38753.8 39338.6 36671.8 37241.6 37602.6 38119.4 38693.2 36447.5 36952.4 37212.4 37401.6 37406.4 31193.4 33754.3 33886.0 34010.5 34024.3 24717.3 24778.2 25212.9 25360.1 25735.0 20:10:46 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33615.68 Median:355.19 stddev:97087.99 (27334.3%) stddev-sans-first:97328.13 20:10:46 INFO - PROCESS | 1655 | Values: 305.4 347.6 362.8 366.1 399.3 15269.4 17557.4 19862.2 20021.9 20434.5 18521.9 18544.0 18970.6 19160.1 21043.8 5678.1 5994.9 6006.9 6011.5 6014.2 5041.9 5899.7 5965.5 5970.9 5972.1 5650.2 5885.7 5904.1 5907.9 5911.1 5796.6 5830.1 5845.0 5860.3 5889.1 4863.0 5109.7 5110.6 5113.8 5488.6 12655.4 12886.7 12900.3 12905.2 19882.8 2023.9 2057.0 2058.8 2075.3 2079.5 10186.8 10405.5 10987.7 11522.6 13116.4 1830.9 1836.4 1839.2 1883.5 1927.5 81883.4 115591.0 127883.0 130024.3 130661.3 11037.9 11235.2 11305.9 11345.5 11555.3 13980.2 13981.2 14003.8 14005.0 14006.5 7452.4 8017.6 8138.9 8362.9 8528.6 8365.0 8371.3 8378.5 8521.2 8580.9 4294.6 4404.4 4413.3 4414.1 4522.1 1550.7 1638.4 1878.2 1903.5 1949.3 721.9 843.8 874.6 893.5 947.4 20116.5 20860.0 20926.1 20998.8 21037.8 760.3 903.8 905.9 915.4 929.8 10159.5 11047.5 11093.8 11102.9 11127.7 562732.0 578296.0 586084.0 586587.0 597640.0 90673.6 98144.5 104581.0 129276.0 133925.0 865.2 918.3 951.9 953.0 962.2 18797.7 18932.2 19051.5 19062.9 19266.9 43715.8 54681.7 54959.9 55819.0 57489.0 67868.7 77192.0 78318.6 79840.0 81681.6 7750.3 7853.0 7906.4 8001.0 8037.5 10150.4 12067.0 12663.3 12949.9 12982.9 9791.9 10871.6 11149.6 11196.0 11206.4 10737.1 10916.6 10979.6 11332.5 11357.8 11098.9 11101.7 11129.6 11395.4 11488.5 7695.6 7879.8 7882.0 7947.9 8195.4 8106.6 9947.9 10919.8 11222.6 11339.1 20:10:46 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5756.11 Median:4905.86 stddev:3227.27 (65.8%) stddev-sans-first:3220.25 20:10:46 INFO - PROCESS | 1655 | Values: 1469.3 1509.1 1674.6 1801.0 1860.1 8446.4 9053.8 9057.0 9059.5 9062.1 7962.3 8164.6 8546.9 8758.7 8801.8 2375.6 2404.4 2413.1 2417.0 2418.7 2039.2 2406.7 2422.6 2427.7 2430.1 2397.0 2406.1 2418.3 2426.8 2427.6 2390.6 2397.7 2407.2 2408.5 2411.4 2377.8 2391.5 2392.2 2397.7 2404.5 8871.2 8948.1 8990.6 8993.4 9009.3 5282.9 5450.7 5451.2 5460.7 5473.0 3615.6 3653.8 3678.5 3680.1 3729.1 1099.2 1099.7 1105.4 1118.2 1130.5 11963.7 12073.3 12075.7 12096.6 12125.0 4655.3 4710.4 4781.2 4846.3 4894.4 10160.8 10170.4 10174.4 10174.4 10175.0 5396.5 5396.6 5402.9 5406.2 5410.5 4414.9 4569.9 4744.9 4879.5 4932.4 3906.0 3909.1 4017.3 4038.3 4042.3 1279.2 1289.4 1291.4 1299.1 1303.2 802.9 888.3 919.4 942.2 964.2 5461.2 5865.9 6025.4 6030.9 6194.3 380.2 854.3 938.8 951.6 983.1 3502.9 3733.1 3965.6 4029.5 4067.7 9980.4 10819.7 10867.2 10881.1 10916.5 10813.8 10819.3 10824.0 10832.4 10837.7 8159.2 8277.9 8278.5 8284.3 8286.9 5355.8 5983.6 6016.2 6162.8 6220.5 8048.5 10017.1 10231.6 10236.4 10330.8 9172.7 9728.5 10329.2 10403.6 10494.3 7116.0 7295.6 7339.7 7632.1 7836.1 8145.9 8430.2 8444.3 8447.3 8452.0 7275.9 7357.8 7431.2 7494.7 7543.5 6451.7 7277.8 7323.5 7348.4 7502.1 6902.3 7062.4 7068.3 7072.8 7090.4 4988.7 5029.8 5067.8 5094.2 5152.9 4917.3 4940.9 5087.9 5237.3 5244.2 20:10:46 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4721.12 Median:5435.16 stddev:1487.02 (27.4%) stddev-sans-first:1453.73 20:10:46 INFO - PROCESS | 1655 | Values: 302.1 304.1 308.7 316.6 317.5 4690.5 5537.3 5583.2 5607.9 5610.5 5034.6 5429.4 5457.6 5487.5 5490.3 3496.4 3978.0 4123.3 4215.8 4227.3 4179.2 4180.7 4203.4 4234.3 4243.7 3440.7 3469.8 4118.1 4156.6 4169.8 3911.2 4138.3 4169.5 4169.8 4173.7 3545.7 3551.5 3559.3 3563.7 3568.4 4713.2 4934.7 5024.7 5027.9 5412.4 3772.2 4692.4 4760.7 4786.9 4800.5 4865.7 5522.6 5549.6 5807.0 5828.8 3588.8 3913.4 3926.5 3931.5 3939.6 5331.2 5834.0 6108.6 6134.3 6227.8 3826.4 3985.4 3989.4 3989.8 4009.6 4064.3 4076.5 4082.4 4087.5 4093.3 4254.8 4732.8 4753.0 4761.6 4773.8 5237.8 5540.0 5562.4 5864.2 5869.9 1311.0 1335.6 1382.4 1382.8 1384.3 784.9 823.9 841.2 842.8 845.8 4211.4 4747.6 5086.5 5444.1 5510.3 5440.9 5910.5 6053.2 6063.8 6070.6 5050.8 5426.5 5456.9 5474.0 5540.1 2784.4 3097.5 3182.9 3184.6 3205.4 6246.0 6291.7 6305.5 6323.6 6349.6 5733.7 6173.1 6238.7 6242.3 6265.4 5471.9 6241.3 6291.4 6330.8 6368.6 4795.8 5883.4 5973.3 6008.2 6125.2 4977.4 5569.9 5850.8 5986.5 5992.1 5865.0 5879.8 6334.6 6369.5 6397.9 3245.3 3880.7 3976.2 3993.0 4014.6 5579.8 5857.7 6044.7 6045.2 6076.5 5568.5 5879.0 5901.0 5964.0 6011.8 5113.4 5721.7 5822.9 5827.1 5841.0 5636.8 5723.7 5769.5 5805.6 5815.6 5531.8 5562.3 5671.0 5839.7 5859.8 4813.9 5216.6 5622.1 5759.3 5793.4 20:10:46 INFO - PROCESS | 1655 | 20:10:46 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24134.23 Median:4343.96 stddev:38497.30 (886.2%) stddev-sans-first:38565.03 20:10:46 INFO - PROCESS | 1655 | Values: 684.5 710.8 717.6 730.1 762.7 15287.7 16599.4 16602.5 16631.8 16641.5 14949.0 15103.9 15124.2 15153.6 15156.0 677.9 693.5 831.5 848.5 863.9 857.9 865.5 873.6 876.6 876.7 924.4 926.8 927.1 928.3 932.5 707.1 891.8 919.7 920.9 921.3 688.9 691.8 693.9 695.1 695.6 15293.8 15358.6 15368.7 15373.5 15378.2 13889.5 14120.1 14149.4 14237.1 14368.0 12859.1 12907.7 12913.2 13058.0 13160.6 4512.8 4523.9 4579.3 4665.1 4683.9 119040.0 121229.0 121299.0 121940.0 124837.0 11091.4 11093.3 11236.7 11246.8 11631.2 21714.7 21724.6 21749.5 21751.9 21754.0 7735.5 7755.7 7788.9 7887.6 7949.3 4311.5 4358.8 4367.3 4521.7 4526.8 3453.7 3554.3 3554.6 3557.9 3564.6 626.7 647.7 648.0 650.1 664.7 538.7 545.6 601.5 602.7 643.0 8825.5 8864.5 8869.2 8880.7 9070.6 477.4 587.4 595.9 629.8 645.8 4329.2 4408.5 4557.9 4564.7 4581.6 112332.0 114899.0 153956.1 167284.0 170285.0 115100.0 115452.0 116900.0 130516.0 146703.0 67932.7 76576.2 76670.6 103250.0 107338.0 9539.0 9574.6 9620.6 9657.5 9781.8 53423.0 57671.8 58157.7 58881.7 62086.1 69942.0 90024.0 92782.0 93225.0 96495.0 11988.6 12152.5 12369.1 12763.4 12818.7 14201.9 14567.4 14859.6 14964.8 15048.3 13512.3 13533.7 13838.4 13948.7 14126.9 13326.4 13395.8 13549.4 14005.7 14096.7 11873.3 12899.9 13311.5 13589.4 13741.5 9502.4 11249.7 11344.2 11507.9 11644.5 7987.6 8829.3 10350.5 10529.4 11403.3 20:10:46 INFO - PROCESS | 1655 | -------- Summary: end -------- 20:10:46 INFO - PROCESS | 1655 | 20:10:47 INFO - TEST-INFO | 1655: exit 0 20:10:47 INFO - TEST-OK | dromaeo_css | took 1117263ms 20:10:47 INFO - TEST-START | kraken 20:10:47 INFO - operating with platform_type : mac_ 20:10:47 INFO - Initialising browser for kraken test... 20:10:47 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpKtIj8S/profile http://localhost:49268/getInfo.html) 20:10:49 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 20:10:49 INFO - PROCESS | 1662 | colorDepth:24 20:10:49 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 20:10:49 INFO - PROCESS | 1662 | __metrics 20:10:49 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:10:49 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:50 INFO - TEST-INFO | 1662: exit 0 20:10:50 INFO - Browser initialized. 20:10:50 INFO - Running cycle 1/1 for kraken test... 20:10:50 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/tmpKtIj8S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:11:02 INFO - PROCESS | 1663 | RSS: Main: 232353792 20:11:02 INFO - PROCESS | 1663 | 20:11:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:06 INFO - PROCESS | 1663 | RSS: Main: 293838848 20:11:06 INFO - PROCESS | 1663 | 20:11:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 20:11:09 INFO - PROCESS | 1663 | RSS: Main: 289402880 20:11:09 INFO - PROCESS | 1663 | 20:11:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 20:11:13 INFO - PROCESS | 1663 | RSS: Main: 375459840 20:11:13 INFO - PROCESS | 1663 | 20:11:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 20:11:16 INFO - PROCESS | 1663 | RSS: Main: 277700608 20:11:16 INFO - PROCESS | 1663 | 20:11:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:19 INFO - PROCESS | 1663 | RSS: Main: 282828800 20:11:19 INFO - PROCESS | 1663 | 20:11:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:22 INFO - PROCESS | 1663 | RSS: Main: 322449408 20:11:22 INFO - PROCESS | 1663 | 20:11:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:25 INFO - PROCESS | 1663 | RSS: Main: 321843200 20:11:25 INFO - PROCESS | 1663 | 20:11:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 20:11:29 INFO - PROCESS | 1663 | RSS: Main: 321359872 20:11:29 INFO - PROCESS | 1663 | 20:11:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:31 INFO - PROCESS | 1663 | RSS: Main: 297713664 20:11:31 INFO - PROCESS | 1663 | 20:11:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:34 INFO - PROCESS | 1663 | RSS: Main: 304435200 20:11:34 INFO - PROCESS | 1663 | 20:11:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:37 INFO - PROCESS | 1663 | RSS: Main: 306450432 20:11:37 INFO - PROCESS | 1663 | 20:11:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:40 INFO - PROCESS | 1663 | RSS: Main: 317112320 20:11:40 INFO - PROCESS | 1663 | 20:11:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:44 INFO - PROCESS | 1663 | RSS: Main: 319062016 20:11:44 INFO - PROCESS | 1663 | 20:11:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 20:11:46 INFO - PROCESS | 1663 | RSS: Main: 363077632 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | __start_tp_report 20:11:46 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 20:11:46 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 20:11:46 INFO - PROCESS | 1663 | |i|pagename|runs| 20:11:46 INFO - PROCESS | 1663 | |0;ai-astar;113;113;115;113;91;160;165;166;111;122 20:11:46 INFO - PROCESS | 1663 | |1;audio-beat-detection;149;115;130;171;137;134;129;108;160;110 20:11:46 INFO - PROCESS | 1663 | |2;audio-dft;186;182;183;186;184;183;204;262;186;181 20:11:46 INFO - PROCESS | 1663 | |3;audio-fft;83;73;77;159;73;81;81;60;146;57 20:11:46 INFO - PROCESS | 1663 | |4;audio-oscillator;83;88;138;71;70;78;119;70;71;117 20:11:46 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;117;130;96;86;88;85;88;86;87;83 20:11:46 INFO - PROCESS | 1663 | |6;imaging-darkroom;95;95;94;95;94;94;94;94;94;94 20:11:46 INFO - PROCESS | 1663 | |7;imaging-desaturate;85;84;84;86;84;84;85;93;82;83 20:11:46 INFO - PROCESS | 1663 | |8;json-parse-financial;54;54;56;54;53;54;54;54;54;53 20:11:46 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;65;72;73;71;75;72;69;68;73 20:11:46 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;86;85;84;90;86;85;102;104;85;89 20:11:46 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;135;144;137;149;122;142;122;153;246;148 20:11:46 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;168;170;171;169;168;168;170;168;169;166 20:11:46 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;66;67;69;66;67;67;68;65;67 20:11:46 INFO - PROCESS | 1663 | __end_tp_report 20:11:46 INFO - PROCESS | 1663 | __start_cc_report 20:11:46 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2032 20:11:46 INFO - PROCESS | 1663 | __end_cc_report 20:11:46 INFO - PROCESS | 1663 | __startTimestamp1473304306088__endTimestamp 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | ------- Summary: start ------- 20:11:46 INFO - PROCESS | 1663 | Number of tests: 14 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:126.90 Median:141.00 stddev:26.59 (18.9%) stddev-sans-first:27.72 20:11:46 INFO - PROCESS | 1663 | Values: 113.0 113.0 115.0 113.0 91.0 160.0 165.0 166.0 111.0 122.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:135.50 stddev:20.90 (15.4%) stddev-sans-first:21.48 20:11:46 INFO - PROCESS | 1663 | Values: 149.0 115.0 130.0 171.0 137.0 134.0 129.0 108.0 160.0 110.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:193.70 Median:186.00 stddev:24.88 (13.4%) stddev-sans-first:26.23 20:11:46 INFO - PROCESS | 1663 | Values: 186.0 182.0 183.0 186.0 184.0 183.0 204.0 262.0 186.0 181.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:89.00 Median:75.00 stddev:34.70 (46.3%) stddev-sans-first:36.73 20:11:46 INFO - PROCESS | 1663 | Values: 83.0 73.0 77.0 159.0 73.0 81.0 81.0 60.0 146.0 57.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:71.00 stddev:24.92 (35.1%) stddev-sans-first:26.29 20:11:46 INFO - PROCESS | 1663 | Values: 83.0 88.0 138.0 71.0 70.0 78.0 119.0 70.0 71.0 117.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:86.50 stddev:15.90 (18.4%) stddev-sans-first:14.66 20:11:46 INFO - PROCESS | 1663 | Values: 117.0 130.0 96.0 86.0 88.0 85.0 88.0 86.0 87.0 83.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 20:11:46 INFO - PROCESS | 1663 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:84.50 stddev:3.02 (3.6%) stddev-sans-first:3.20 20:11:46 INFO - PROCESS | 1663 | Values: 85.0 84.0 84.0 86.0 84.0 84.0 85.0 93.0 82.0 83.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 20:11:46 INFO - PROCESS | 1663 | Values: 54.0 54.0 56.0 54.0 53.0 54.0 54.0 54.0 54.0 53.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:72.00 stddev:3.43 (4.8%) stddev-sans-first:3.06 20:11:46 INFO - PROCESS | 1663 | Values: 65.0 65.0 72.0 73.0 71.0 75.0 72.0 69.0 68.0 73.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:85.50 stddev:7.32 (8.6%) stddev-sans-first:7.65 20:11:46 INFO - PROCESS | 1663 | Values: 86.0 85.0 84.0 90.0 86.0 85.0 102.0 104.0 85.0 89.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:146.00 stddev:35.42 (24.3%) stddev-sans-first:37.16 20:11:46 INFO - PROCESS | 1663 | Values: 135.0 144.0 137.0 149.0 122.0 142.0 122.0 153.0 246.0 148.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.00 stddev:1.42 (0.8%) stddev-sans-first:1.48 20:11:46 INFO - PROCESS | 1663 | Values: 168.0 170.0 171.0 169.0 168.0 168.0 170.0 168.0 169.0 166.0 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 20:11:46 INFO - PROCESS | 1663 | Values: 67.0 66.0 67.0 69.0 66.0 67.0 67.0 68.0 65.0 67.0 20:11:46 INFO - PROCESS | 1663 | -------- Summary: end -------- 20:11:46 INFO - PROCESS | 1663 | 20:11:46 INFO - TEST-INFO | 1663: exit 0 20:11:46 INFO - TEST-OK | kraken | took 59630ms 20:11:46 INFO - SUITE-END | took 1176s 20:11:47 INFO - Completed test suite (00:19:37) 20:11:47 INFO - javascript benchmark 20:11:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2943.632045994251, 3311.9337613247726, 3325.7505687073462, 3327.733781297496, 3406.863725450982, 5677.914831277524, 5761.625494342865, 5762.711864406779, 5824.67964261966, 5848.385919478452, 5726.1697053927155, 5762.0, 5796.652200867951, 5821.243238379005, 5836.9124463133085, 5145.922811157836, 5169.302144210521, 5257.815976440826, 5264.710440925747, 5287.101192797234, 4626.676132670715, 5214.556762675177, 5329.866753331159, 5337.2794672719265, 5355.0896347621, 5204.34945631796, 5232.947670523284, 5242.423333433319, 5258.92111618326, 5290.39160496544, 5153.922691159635, 5275.815346462894, 5343.812966546152, 5368.0605893968395, 5371.086915224421, 5131.204663277198, 5153.484651534816, 5214.243934629495, 5216.947830521722, 5218.60860435465, 5749.482546570787, 5754.251947246873, 5790.913136302959, 5826.096954971944, 5841.503472204868, 6145.139680444741, 6220.87558248837, 6268.811935641938, 6271.843203919893, 6301.936980630181, 5520.861978450531, 6278.874422511524, 6292.2134733158355, 6306.211723534559, 6316.336784637593, 5726.484616384545, 5872.706364681749, 5874.23634927461, 5886.23478947734, 5887.882242355129, 6228.47058000066, 6235.719392627343, 6274.466670332981, 6285.5600107992, 6344.49244060474, 6230.875382492325, 6248.4376406123665, 6261.843453913689, 6262.499000079983, 6276.529260305495, 6232.376762323732, 6265.498760099181, 6280.340564240689, 6285.717142728588, 6313.715882785285, 6118.771466971993, 6139.676133582418, 6179.783707570214, 6206.286277078104, 6283.937160628427, 6299.4330510253385, 6305.4009869062365, 6328.746850125944, 6335.9228931081825, 6347.714352854133, 4962.404511458648, 4965.230389289666, 4973.204287314013, 4974.27872958419, 4996.875078123076, 4370.366296886998, 4373.0, 4476.37330773692, 4484.529124441887, 4501.7524036177665, 5777.451142141574, 5796.1305804129715, 5801.448862358069, 5814.244148260784, 5911.172435858984, 6242.563020588515, 6265.8120256392385, 6295.087212354183, 6297.685115744194, 6302.65335406557, 5823.679697616587, 5837.328707198726, 5853.970730146322, 5857.707114644336, 5908.0, 5315.6013299002725, 5435.347758269033, 5454.699991500505, 5487.5609951203805, 5494.148406996922, 6354.523410744213, 6364.872702546016, 6374.904376434357, 6377.7767778127545, 6383.616982981036, 6189.226346706661, 6245.938190507715, 6252.187215661935, 6272.059191121369, 6284.717187726655, 6217.906731399123, 6315.715792789244, 6334.841628959313, 6353.047042943411, 6378.2346118466085, 6208.81373558794, 6272.4982001440685, 6274.968625156845, 6291.937080629135, 6292.52806039558, 6140.140380346845, 6265.874682506415, 6288.11966324724, 6293.181886354744, 6293.213348331458, 6002.129691194665, 6144.1398204250545, 6191.133241346125, 6196.47329976939, 6210.472109870711, 6182.567220294536, 6183.876322473615, 6188.071789231652, 6216.0, 6221.160143380585, 5957.523398128226, 6068.17954613623, 6076.179715738319, 6087.69561521931, 6102.51954821894, 5085.618578606545, 6061.72722227492, 6110.467630727307, 6119.868162944114, 6218.502519798315, 6043.969780151247, 6067.939320606914, 6069.939300606938, 6091.329953705001, 6129.816105516842], "value": 5742.480206364091, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.4021335251108, 521.8356217791396, 527.2802624417671, 536.5412572250727, 556.9721513924305, 30386.848065759666, 39479.407808882854, 40797.0, 40818.59181408185, 40864.59135408645, 42219.15561688764, 42469.0, 42470.787646061726, 42479.725608231725, 42589.787051064704, 9685.95157024214, 9846.212303015778, 9854.556544955494, 9863.210943124568, 9870.851937220947, 8781.56092195391, 9055.456672599632, 11725.179237453382, 12049.277043377382, 12053.578124765634, 12051.819222711667, 12121.212121212136, 12134.0, 12146.39268036599, 12178.756424871497, 10431.530581123867, 11903.107266955012, 12037.458314375874, 12122.454489547992, 12132.150749447543, 8515.233628973423, 8766.649334026632, 8775.692850750193, 8872.512011839346, 11480.942595287053, 40377.99055023619, 40561.79719101386, 40619.390709139385, 40647.98380040493, 40690.0, 3277.3281477297096, 3368.6631336866362, 3954.268460334847, 4138.634250697292, 4159.168166366709, 29863.16299951523, 30878.691213087804, 30880.227994300098, 31139.37721245585, 31265.749370025173, 3185.311784754084, 3261.7390608751243, 3275.96724032759, 3297.4559197732347, 3366.2762506061313, 516304.0, 517344.0, 517508.4124579353, 518242.9999999962, 518946.0, 56541.71729141328, 56885.715571422705, 56944.430555693914, 56957.86084278291, 57026.714866425405, 59503.702481487315, 59712.0, 59766.0, 59829.70085149634, 59841.70079149664, 15716.13561254142, 15903.840961590236, 15905.045697258201, 15918.60203494922, 15935.362585496681, 11175.105991520659, 12358.258504489759, 12431.005519558594, 12435.502579896704, 12458.563950261698, 14029.438822446988, 14428.783568246485, 14458.783118253235, 14485.78271325931, 14488.275586220858, 4574.642955264072, 6587.73649054042, 6689.929611262175, 7300.926990730131, 7473.4021278297605, 868.2793281576403, 918.4122161816442, 974.2317693386481, 1101.6144349477618, 1107.9585189921447, 29145.417091658048, 29563.85218073896, 29916.252093697833, 29928.700712993028, 29964.850175748983, 1052.6894566103017, 1058.9205809564314, 1063.0963680871198, 1089.4226060187955, 1149.7298134938283, 14692.191929443983, 15235.61910952213, 15354.078755274495, 15371.61570960735, 15638.765418518504, 655852.0, 660118.0, 660884.0, 660901.0, 661626.0, 56287.43712562822, 56542.43457565454, 56550.71724641351, 56593.0, 56712.0, 1359.5309618181711, 1372.835259768834, 1382.5575815739069, 1384.494659449314, 1393.463516546137, 28453.715462845106, 29195.562066569444, 29226.0, 29766.553501697057, 30139.945101921327, 49490.75254623848, 49914.0, 49918.00163996627, 49959.50040499549, 50025.49974500354, 401106.0, 469713.0, 470179.2455188648, 470703.0, 470987.0, 29244.70755292505, 33168.190612361555, 33821.15447113842, 39847.00382490461, 40109.79670609887, 45475.54524454713, 46127.07745845131, 46232.30651540297, 46820.7658961703, 47304.763476183776, 37591.6240837599, 37844.864654060424, 37891.81054094822, 38753.806230968665, 39338.606613933494, 36671.81664091662, 37241.62758372381, 37602.62397375991, 38119.42820857634, 38693.22613547657, 36447.45328820123, 36952.44571331486, 37212.44181337336, 37401.62598373982, 37406.438903415925, 31193.37613247768, 33754.32491350208, 33886.0, 34010.489842652874, 34024.319513610084, 24717.25848224556, 24778.15051269127, 25212.873935630203, 25360.112396066048, 25735.0], "value": 20039.2418661865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.3663647930544, 347.60373174580997, 362.7714539839899, 366.0902656897609, 399.2992298516104, 15269.389224431023, 17557.385491507783, 19862.20551177951, 20021.899890500546, 20434.489137771565, 18521.907390463064, 18543.980081095535, 18970.62058758824, 19160.137793799277, 21043.789562104375, 5678.091505359153, 5994.910076348837, 6006.8798624027495, 6011.489023433013, 6014.188084608566, 5041.924371134418, 5899.705014749266, 5965.4929331006915, 5970.8805823883495, 5972.134040564116, 5650.237217975582, 5885.676287804169, 5904.084866845646, 5907.852303692399, 5911.054231322989, 5796.62321949072, 5830.125481177814, 5845.0, 5860.267466566679, 5889.057750759879, 4863.0, 5109.693418394908, 5110.6422550421485, 5113.795448182068, 5488.643238189505, 12655.430505627177, 12886.742265154644, 12900.290484023375, 12905.225686458842, 19882.801171988383, 2023.9392818215476, 2056.95886082279, 2058.8455865810124, 2075.30477290108, 2079.480129967508, 10186.847197292047, 10405.53175107122, 10987.725306867313, 11522.596709115225, 13116.409761560657, 1830.9176087076114, 1836.4307064809952, 1839.2275244397251, 1883.5197024758736, 1927.5277556998485, 81883.3623327536, 115591.0, 127883.0, 130024.34987825001, 130661.34669326592, 11037.944810275898, 11235.157363197794, 11305.943470282597, 11345.489452974636, 11555.306681599131, 13980.231087290296, 13981.23103229332, 14003.789943150861, 14005.0, 14006.509772157926, 7452.403807695479, 8017.639206235617, 8138.877916831252, 8362.916370836336, 8528.573571321409, 8364.958175209085, 8371.288440482505, 8378.53918034514, 8521.233089021895, 8580.871286930702, 4294.613484786384, 4404.436425069119, 4413.256763578369, 4414.139242847614, 4522.140793249272, 1550.6666066795692, 1638.4101723379574, 1878.2205384765443, 1903.486058764126, 1949.31773879144, 721.9494635375473, 843.8270154618289, 874.5758307220992, 893.5442924108752, 947.4315410753493, 20116.497087572927, 20859.957002150135, 20926.116649501313, 20998.790012099988, 21037.789622103584, 760.2625453310391, 903.8056817784208, 905.9048799875918, 915.3866909170738, 929.7861491856911, 10159.492025398848, 11047.502862371213, 11093.778124437466, 11102.944485277521, 11127.666170014912, 562732.0, 578296.0, 586084.0, 586587.0, 597640.0, 90673.57253915753, 98144.50927745315, 104581.0, 129276.0, 133925.0, 865.2342676731138, 918.2837386838144, 951.8619800128943, 952.9809403812023, 962.2061799015839, 18797.718034229223, 18932.242710291433, 19051.523711907314, 19062.904685476486, 19266.940318282068, 43715.78142109396, 54681.72659136679, 54959.900801982934, 55819.0, 57489.0, 67868.6606566964, 77192.0, 78318.6084069576, 79840.00799959863, 81681.64865162164, 7750.302472777477, 7853.0, 7906.367490600623, 8000.959995199987, 8037.477563958324, 10150.390976541432, 12067.0, 12663.303518306582, 12949.935250323688, 12982.93508532489, 9791.85312220303, 10871.565137394417, 11149.554017839195, 11196.0, 11206.38364889939, 10737.141028717528, 10916.617918372818, 10979.615713449992, 11332.490037948148, 11357.829632555684, 11098.889011110108, 11101.722456938642, 11129.610463634059, 11395.430228488376, 11488.483018264365, 7695.615219238904, 7879.803004924923, 7882.0, 7947.8807817881625, 8195.385346099185, 8106.635201415833, 9947.850782238127, 10919.836202457129, 11222.551097956317, 11339.149563782914], "value": 9148.245361101874, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.2580246975276, 1509.117166457622, 1674.5897255172486, 1800.9909950450246, 1860.116444688773, 8446.366522510813, 9053.818923621531, 9057.00372958974, 9059.50172740499, 9062.093790620951, 7962.3232025277775, 8164.550949697779, 8546.871796923035, 8758.737237882859, 8801.779955501115, 2375.631777074552, 2404.4229384947575, 2413.1433341163897, 2416.9637455438183, 2418.6613874057557, 2039.2250944641016, 2406.7111946566347, 2422.6002709552904, 2427.745086765891, 2430.1373012580543, 2397.0172229385958, 2406.0616359619676, 2418.262429958862, 2426.7815896569305, 2427.5751743444916, 2390.6414037894283, 2397.7242617098996, 2407.229686500312, 2408.494216214597, 2411.3730430088126, 2377.7741114594087, 2391.5216956608747, 2392.2225276785116, 2397.700287464067, 2404.4589967257402, 8871.157240062184, 8948.149925757043, 8990.595423205972, 8993.415427997159, 9009.279257659437, 5282.867928301823, 5450.672959622435, 5451.236826844245, 5460.699661518614, 5472.98749731301, 3615.620359862203, 3653.8355773990234, 3678.5401824771902, 3680.061584296014, 3729.1050147964565, 1099.1866019145855, 1099.6755956992706, 1105.3588918427374, 1118.2340097033557, 1130.4630300607228, 11963.700907477296, 12073.27560346382, 12075.698107547294, 12096.576619818265, 12124.969377602914, 4655.301704744315, 4710.436060754532, 4781.235002399669, 4846.29728689338, 4894.412670479494, 10160.847587286196, 10170.389776613427, 10174.389536627677, 10174.440405777754, 10175.0, 5396.487333703292, 5396.595255355864, 5402.8919421611345, 5406.189071639285, 5410.458954104637, 4414.933775993362, 4569.908601827945, 4744.857654270378, 4879.487653796371, 4932.383452068491, 3905.9804700976315, 3909.100906791454, 4017.276890159799, 4038.252923209157, 4042.2521833460905, 1279.1685404486973, 1289.38109707341, 1291.438224372401, 1299.123091912955, 1303.1789972317379, 802.9116797152309, 888.2760550151605, 919.3702313914989, 942.1850099663878, 964.2237998411206, 5461.208124821958, 5865.853353666107, 6025.367336429612, 6030.939690603125, 6194.349593292639, 380.2490082087854, 854.2909385210261, 938.7842743646994, 951.6431338248157, 983.0611765763822, 3502.8949131526097, 3733.1227161617, 3965.6232657897453, 4029.4761680981283, 4067.6745860331102, 9980.401175929468, 10819.729506762236, 10867.239293249397, 10881.075108615698, 10916.454177291103, 10813.83779243312, 10819.296745711503, 10824.0, 10832.40421776794, 10837.729056773485, 8159.224873636995, 8277.875831862406, 8278.544680042656, 8284.25441710249, 8286.875696864552, 5355.758990845499, 5983.55123365758, 6016.187814645142, 6162.7534898605345, 6220.533459990609, 8048.476849004796, 10017.098461138532, 10231.590736370461, 10236.385816851012, 10330.845037324596, 9172.715819785102, 9728.513574321398, 10329.173666106542, 10403.566822948258, 10494.317869338469, 7116.0, 7295.598742069024, 7339.70641174347, 7632.084149902047, 7836.09884863248, 8145.918540814516, 8430.241278284984, 8444.324454043539, 8447.324214062983, 8451.957740211259, 7275.890861636974, 7357.8160545986775, 7431.219721929336, 7494.662740176596, 7543.47195696296, 6451.6774161290805, 7277.818054548678, 7323.523970941872, 7348.375388091858, 7502.099748030271, 6902.275261097512, 7062.3996960258955, 7068.257832927468, 7072.823179420556, 7090.397316228178, 4988.650794444354, 5029.84910452687, 5067.822626208065, 5094.1849304111165, 5152.948470515247, 4917.311576379381, 4940.912999140183, 5087.898242035212, 5237.2929654497675, 5244.187150991603], "value": 4621.3603440903735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.09070697201423, 304.1104768551986, 308.7298613713001, 316.63428739805516, 317.5078628126403, 4690.5074967128385, 5537.252470916425, 5583.246261754667, 5607.869009776289, 5610.523105536035, 5034.597232221414, 5429.375621803494, 5457.5633949284065, 5487.451254874511, 5490.313710786152, 3496.388132076883, 3977.9856136685103, 4123.257813593552, 4215.831366745342, 4227.302495088306, 4179.226843034034, 4180.749155050707, 4203.435904098497, 4234.259004674185, 4243.745375277494, 3440.7419443541708, 3469.826508674556, 4118.052847844982, 4156.605122513356, 4169.833206671729, 3911.198204368098, 4138.337865941435, 4169.541350451463, 4169.812358443862, 4173.749575025508, 3545.7163426925786, 3551.5438670145377, 3559.323728491578, 3563.734874119676, 3568.4468907319406, 4713.242752989471, 4934.654574179809, 5024.69851808889, 5027.949720502785, 5412.404635490093, 3772.2455508898056, 4692.389989301403, 4760.714357138548, 4786.880327991793, 4800.4719480857075, 4865.683730557503, 5522.585806064561, 5549.5837812164245, 5807.025611292181, 5828.795992140254, 3588.766730162531, 3913.3934240192816, 3926.548446928611, 3931.5085614298214, 3939.625735555118, 5331.20031995196, 5833.970830145865, 6108.602940808833, 6134.294556126013, 6227.782027629011, 3826.44516545105, 3985.3822657488136, 3989.4215338775716, 3989.8005099744896, 4009.558948515661, 4064.309067458539, 4076.490438695163, 4082.3876418537457, 4087.509498860156, 4093.324601440729, 4254.808533615995, 4732.834350797705, 4752.976235118802, 4761.619070474354, 4773.785179666923, 5237.8428647140645, 5539.977908063528, 5562.415946325658, 5864.2083318752275, 5869.853253668693, 1310.9905372862843, 1335.5792925228523, 1382.3826123435604, 1382.7511048011454, 1384.3424373422745, 784.9175836537196, 823.8640624296924, 841.2050612171439, 842.8200519273066, 845.8392905347964, 4211.399668126092, 4747.572718455355, 5086.516780905808, 5444.080262211201, 5510.338759348823, 5440.945590544123, 5910.468057874812, 6053.182820319201, 6063.848403789941, 6070.6357618543025, 5050.787810925352, 5426.457354264542, 5456.90861827636, 5473.972630136824, 5540.058190107691, 2784.373515958893, 3097.519884417919, 3182.9363412732077, 3184.5541624172633, 3205.4390481666082, 6245.969415046467, 6291.6854157291955, 6305.464035556937, 6323.588966717149, 6349.587276826992, 5733.655980641175, 6173.098643637483, 6238.656873871981, 6242.250929888442, 6265.373462653789, 5471.945280547223, 6241.344658810759, 6291.433770960544, 6330.77130663365, 6368.64972426521, 4795.784189711541, 5883.382244864228, 5973.342932277533, 6008.204170862946, 6125.173101631222, 4977.352944117241, 5569.8607534810335, 5850.829834033296, 5986.461218490357, 5992.101184822312, 5864.970675146597, 5879.823605291677, 6334.556581039283, 6369.49044076482, 6397.936020639921, 3245.3184831185717, 3880.6701430378735, 3976.2445135424177, 3993.0017495626093, 4014.5583985762128, 5579.832605021856, 5857.656937225144, 6044.697765111815, 6045.244344456943, 6076.483498902643, 5568.470995255444, 5879.0, 5900.970495147497, 5963.956307646231, 6011.759529618941, 5113.386393632788, 5721.742521586455, 5822.94177058241, 5827.05733604527, 5840.970795145997, 5636.830895073154, 5723.656580605177, 5769.547942124665, 5805.561664101172, 5815.563832712648, 5531.778728850801, 5562.276904002454, 5670.979223739767, 5839.708014599338, 5859.835688728039, 4813.879653008703, 5216.556592689664, 5622.128570071645, 5759.293132227846, 5793.420657934173], "value": 4236.701138935864, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5276759036265, 710.7618947652536, 717.6017310392733, 730.1238513783461, 762.7063580521504, 15287.69424611507, 16599.41902033429, 16602.50192494224, 16631.750523742154, 16641.50075497737, 14949.0, 15103.924480377582, 15124.243787810594, 15153.621159471018, 15156.014859034156, 677.9254282028973, 693.4868197533814, 831.4927893984665, 848.503625379154, 863.9222469977701, 857.901341345747, 865.4677373415336, 873.6374404622075, 876.6011464783509, 876.7457437343163, 924.4037595750737, 926.7729406295467, 927.0544045074021, 928.299134153713, 932.5477143585356, 707.1125737199833, 891.7636826241052, 919.72868003939, 920.9317192057182, 921.3228277216241, 688.9483288753313, 691.7751730687546, 693.8577591593711, 695.0963747128762, 695.5791745993702, 15293.847061529354, 15358.616034599112, 15368.692626147526, 15373.538793836204, 15378.231088445646, 13889.513867014706, 14120.082194657418, 14149.363278652485, 14237.074590151711, 14368.0, 12859.099863009593, 12907.677308067374, 12913.160644558073, 13058.0, 13160.60518184456, 4512.8286868465475, 4523.86428407145, 4579.290210017452, 4665.066986602659, 4683.929741053887, 119040.0, 121229.0, 121299.0, 121940.0, 124837.0, 11091.389973551532, 11093.278936869077, 11236.719082023015, 11246.831297530543, 11631.185816992729, 21714.674279885814, 21724.56550868974, 21749.456263593536, 21751.891240543697, 21754.0, 7735.49719268257, 7755.72854950074, 7788.883166752503, 7887.605619718991, 7949.284564389232, 4311.547287534764, 4358.760268185217, 4367.301231802896, 4521.683482156283, 4526.79629416677, 3453.689167974894, 3554.2713743682484, 3554.626764189723, 3557.8576856925433, 3564.572251329857, 626.7493002798917, 647.740903638539, 647.9676016199265, 650.0703993289546, 664.7108507799123, 538.6633354153654, 545.5717261949351, 601.5067446177051, 602.7016626769777, 643.0161852365887, 8825.470471771714, 8864.512451815212, 8869.201771840566, 8880.692863960974, 9070.637174513078, 477.4080140625599, 587.4096532984323, 595.8748662780864, 629.804760524239, 645.8094862015716, 4329.15581461612, 4408.515063343029, 4557.908841823211, 4564.680472366902, 4581.610563102174, 112332.0, 114899.0, 153956.14394704308, 167284.0, 170285.0, 115100.0, 115452.0, 116900.0, 130516.0, 146703.0, 67932.660336698, 76576.23423765691, 76670.58264803638, 103249.9999999985, 107338.0, 9539.0, 9574.56914438838, 9620.615175392906, 9657.517124143906, 9781.804363912825, 53423.0, 57671.846563067666, 58157.70921145367, 58881.70559147348, 62086.0687089685, 69942.0, 90024.0, 92782.0, 93225.0, 96495.0, 11988.64034078979, 12152.453139608562, 12369.072319575887, 12763.425645846144, 12818.743625127632, 14201.928990354982, 14567.41730330775, 14859.554213373616, 14964.775528367301, 15048.322825473098, 13512.324383780968, 13533.729325413633, 13838.4464621414, 13948.721025579229, 14126.929365353108, 13326.400311986177, 13395.776617611336, 13549.390277437737, 14005.719885602435, 14096.718065638424, 11873.346965916611, 12899.93550032244, 13311.46754129824, 13589.388477518338, 13741.450341986609, 9502.429854208493, 11249.71875703114, 11344.20590558686, 11507.942460287644, 11644.486216791764, 7987.600619969095, 8829.33779966518, 10350.5342259597, 10529.420881851265, 11403.258788178742], "value": 7760.211446369534, "unit": "score"}], "name": "dromaeo_css", "value": 7367.818057305685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 115.0, 113.0, 91.0, 160.0, 165.0, 166.0, 111.0, 122.0], "value": 126.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 130.0, 171.0, 137.0, 134.0, 129.0, 108.0, 160.0, 110.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 183.0, 186.0, 184.0, 183.0, 204.0, 262.0, 186.0, 181.0], "value": 193.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 73.0, 77.0, 159.0, 73.0, 81.0, 81.0, 60.0, 146.0, 57.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 138.0, 71.0, 70.0, 78.0, 119.0, 70.0, 71.0, 117.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 130.0, 96.0, 86.0, 88.0, 85.0, 88.0, 86.0, 87.0, 83.0], "value": 94.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 86.0, 84.0, 84.0, 85.0, 93.0, 82.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 72.0, 73.0, 71.0, 75.0, 72.0, 69.0, 68.0, 73.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 90.0, 86.0, 85.0, 102.0, 104.0, 85.0, 89.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 144.0, 137.0, 149.0, 122.0, 142.0, 122.0, 153.0, 246.0, 148.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 171.0, 169.0, 168.0, 168.0, 170.0, 168.0, 169.0, 166.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 69.0, 66.0, 67.0, 67.0, 68.0, 65.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1507.6000000000001, "alertThreshold": 2.0}]} 20:11:47 INFO - Return code: 0 20:11:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:11:47 INFO - # TBPL SUCCESS # 20:11:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:11:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:11:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:11:47 INFO - 2016-09-07 20:11:47.416 screenresolution[1667:9748] starting screenresolution argv=screenresolution get 20:11:47 INFO - 2016-09-07 20:11:47.419 screenresolution[1667:9748] Display 0: 1600x1200x32@60 20:11:47 INFO - 2016-09-07 20:11:47.424 screenresolution[1668:9751] starting screenresolution argv=screenresolution list 20:11:47 INFO - Available Modes on Display 0 20:11:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:11:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:11:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:11:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:11:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:11:47 INFO - Intel Iris: 20:11:47 INFO - Chipset Model: Intel Iris 20:11:47 INFO - Type: GPU 20:11:47 INFO - Bus: Built-In 20:11:47 INFO - VRAM (Dynamic, Max): 1536 MB 20:11:47 INFO - Vendor: Intel (0x8086) 20:11:47 INFO - Device ID: 0x0a2e 20:11:47 INFO - Revision ID: 0x0009 20:11:47 INFO - Displays: 20:11:47 INFO - Display: 20:11:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:11:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:11:47 INFO - Display Serial Number: 1600x1200 60 20:11:47 INFO - Main Display: Yes 20:11:47 INFO - Mirror: Off 20:11:47 INFO - Online: Yes 20:11:47 INFO - Rotation: Supported 20:11:47 INFO - Return code: 0 20:11:47 INFO - Running post-action listener: _resource_record_post_action 20:11:47 INFO - [mozharness: 2016-09-08 03:11:47.659103Z] Finished run-tests step (success) 20:11:47 INFO - Running post-run listener: _resource_record_post_run 20:11:47 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37385216; Write bytes: 706861568; Read time: 241; Write time: 2028 20:11:47 INFO - TinderboxPrint: CPU usage
53.5% 20:11:47 INFO - TinderboxPrint: I/O read bytes / time
37,385,216 / 241 20:11:47 INFO - TinderboxPrint: I/O write bytes / time
706,861,568 / 2,028 20:11:47 INFO - TinderboxPrint: CPU idle
2,252.7 (46.5%) 20:11:47 INFO - TinderboxPrint: CPU system
966.9 (19.9%) 20:11:47 INFO - TinderboxPrint: CPU user
1,630.1 (33.6%) 20:11:47 INFO - TinderboxPrint: Swap in / out
442,159,104 / 0 20:11:47 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391131648; Write bytes: 380647424; Read time: 28594; Write time: 845 20:11:47 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31120384; Write bytes: 297869824; Read time: 184; Write time: 1114 20:11:48 INFO - Running post-run listener: _upload_blobber_files 20:11:48 INFO - Blob upload gear active. 20:11:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:11:48 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 20:11:48 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'] 20:11:48 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 20:11:48 INFO - (blobuploader) - INFO - Open directory for files ... 20:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:49 INFO - (blobuploader) - INFO - Done attempting. 20:11:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:11:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:11:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:50 INFO - (blobuploader) - INFO - Done attempting. 20:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:11:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:53 INFO - (blobuploader) - INFO - Done attempting. 20:11:53 INFO - (blobuploader) - INFO - Iteration through files over. 20:11:53 INFO - Return code: 0 20:11:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:11:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:11:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91d10826f0db216583b2b6452594333c96e35977e02411b0da1fe65c5eb1045c79f31e865506eaa50ac42f7e6d877f454903db472c4d5a4723700cac11dd7780", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fac9d261bf910db1c1d872f222bc8eb4e47911174c705fb423495306e280dfcda73e0620472dcb746e30a9dbd2f331a4f8ebbb84d9996f45bcb9af4ca65a7902", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c5c683815bf7ac4c065a09c8ba05c685250b09ef19452b797031d1b986012274b3299464ab59689d8f87838be41cf085ee2afdf96dc23757424abff69d13c9d"} 20:11:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:11:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:11:53 INFO - Contents: 20:11:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91d10826f0db216583b2b6452594333c96e35977e02411b0da1fe65c5eb1045c79f31e865506eaa50ac42f7e6d877f454903db472c4d5a4723700cac11dd7780", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fac9d261bf910db1c1d872f222bc8eb4e47911174c705fb423495306e280dfcda73e0620472dcb746e30a9dbd2f331a4f8ebbb84d9996f45bcb9af4ca65a7902", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c5c683815bf7ac4c065a09c8ba05c685250b09ef19452b797031d1b986012274b3299464ab59689d8f87838be41cf085ee2afdf96dc23757424abff69d13c9d"} 20:11:53 INFO - Running post-run listener: copy_logs_to_upload_dir 20:11:53 INFO - Copying logs to upload dir... 20:11:53 INFO - mkdir: /builds/slave/test/build/upload/logs 20:11:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.986176 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-07 20:11:53.763690) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 20:11:53.766909) ========= 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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91d10826f0db216583b2b6452594333c96e35977e02411b0da1fe65c5eb1045c79f31e865506eaa50ac42f7e6d877f454903db472c4d5a4723700cac11dd7780", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fac9d261bf910db1c1d872f222bc8eb4e47911174c705fb423495306e280dfcda73e0620472dcb746e30a9dbd2f331a4f8ebbb84d9996f45bcb9af4ca65a7902", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c5c683815bf7ac4c065a09c8ba05c685250b09ef19452b797031d1b986012274b3299464ab59689d8f87838be41cf085ee2afdf96dc23757424abff69d13c9d"} build_url:https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/91d10826f0db216583b2b6452594333c96e35977e02411b0da1fe65c5eb1045c79f31e865506eaa50ac42f7e6d877f454903db472c4d5a4723700cac11dd7780", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fac9d261bf910db1c1d872f222bc8eb4e47911174c705fb423495306e280dfcda73e0620472dcb746e30a9dbd2f331a4f8ebbb84d9996f45bcb9af4ca65a7902", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c5c683815bf7ac4c065a09c8ba05c685250b09ef19452b797031d1b986012274b3299464ab59689d8f87838be41cf085ee2afdf96dc23757424abff69d13c9d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 20:11:53.800400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 20:11:53.800703) ========= 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.oJ5H18d1dF/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.dDyL3vRBBU/Listeners TMPDIR=/var/folders/46/dyhgxyws7270nkhp4l7t8z0800000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 20:11:53.849036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 20:11:53.849342) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 20:11:53.849637) ========= ========= Total master_lag: 0.53 =========