builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0259 starttime: 1472972315.42 results: success (0) buildid: 20160903215151 builduid: 618e412483274c29adc0f3ea1e7616d4 revision: cf087a62374d4b2bbfa5b3903bfa450b0e90a8dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:35.422942) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:35.423848) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:35.424283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:35.503195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:35.503528) ========= 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.ymZmp1cXmr/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.12pMXqIjA2/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-03 23:58:35-- 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% 28.4M=0s 2016-09-03 23:58:36 (28.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.512379 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:36.044953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:36.045237) ========= 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.ymZmp1cXmr/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.12pMXqIjA2/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.025265 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:36.094396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-09-03 23:58:36.094713) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cf087a62374d4b2bbfa5b3903bfa450b0e90a8dd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cf087a62374d4b2bbfa5b3903bfa450b0e90a8dd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ymZmp1cXmr/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.12pMXqIjA2/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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-03 23:58:36,178 truncating revision to first 12 chars 2016-09-03 23:58:36,178 Setting DEBUG logging. 2016-09-03 23:58:36,178 attempt 1/10 2016-09-03 23:58:36,178 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cf087a62374d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 23:58:37,980 unpacking tar archive at: mozilla-central-cf087a62374d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.058552 ========= master_lag: 2.92 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-09-03 23:58:41.076712) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:41.077003) ========= script_repo_revision: cf087a62374d4b2bbfa5b3903bfa450b0e90a8dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:41.077366) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:41.077674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 23:58:42.077078) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-03 23:58:42.077353) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ymZmp1cXmr/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.12pMXqIjA2/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:58:42 INFO - MultiFileLogger online at 20160903 23:58:42 in /builds/slave/test 23:58:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 23:58:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:58:42 INFO - {'append_to_log': False, 23:58:42 INFO - 'base_work_dir': '/builds/slave/test', 23:58:42 INFO - 'blob_upload_branch': 'Firefox', 23:58:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:58:42 INFO - 'branch': 'Firefox', 23:58:42 INFO - 'buildbot_json_path': 'buildprops.json', 23:58:42 INFO - 'config_files': ('talos/mac_config.py',), 23:58:42 INFO - 'default_actions': ('clobber', 23:58:42 INFO - 'read-buildbot-config', 23:58:42 INFO - 'download-and-extract', 23:58:42 INFO - 'populate-webroot', 23:58:42 INFO - 'create-virtualenv', 23:58:42 INFO - 'install', 23:58:42 INFO - 'run-tests'), 23:58:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:58:42 INFO - 'download_minidump_stackwalk': True, 23:58:42 INFO - 'download_symbols': 'ondemand', 23:58:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:58:42 INFO - 'tooltool.py': '/tools/tooltool.py', 23:58:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:58:42 INFO - '/tools/misc-python/virtualenv.py')}, 23:58:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:58:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:58:42 INFO - 'installer_path': 'installer.exe', 23:58:42 INFO - 'log_level': 'info', 23:58:42 INFO - 'log_name': 'talos', 23:58:42 INFO - 'log_to_console': True, 23:58:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:58:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:58:42 INFO - 'opt_config_files': (), 23:58:42 INFO - 'pip_index': False, 23:58:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:58:42 INFO - 'cmd': ('bash', 23:58:42 INFO - '-c', 23:58:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:58:42 INFO - 'enabled': True, 23:58:42 INFO - 'halt_on_failure': False, 23:58:42 INFO - 'name': 'check_screen_resolution'},), 23:58:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:58:42 INFO - 'cmd': ('bash', 23:58:42 INFO - '-c', 23:58:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:58:42 INFO - 'enabled': True, 23:58:42 INFO - 'halt_on_failure': False, 23:58:42 INFO - 'name': 'check_screen_resolution'},), 23:58:42 INFO - 'run_cmd_checks_enabled': True, 23:58:42 INFO - 'sps_profile': False, 23:58:42 INFO - 'sps_profile_interval': 0, 23:58:42 INFO - 'suite': 'dromaeojs', 23:58:42 INFO - 'system_bits': '32', 23:58:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:58:42 INFO - 'title': 't-yosemite-r7-0259', 23:58:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:58:42 INFO - 'use_talos_json': True, 23:58:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:58:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:58:42 INFO - 'work_dir': 'build'} 23:58:42 INFO - [mozharness: 2016-09-04 06:58:42.286225Z] Running clobber step. 23:58:42 INFO - Running pre-action listener: _resource_record_pre_action 23:58:42 INFO - Running main action method: clobber 23:58:42 INFO - rmtree: /builds/slave/test/build 23:58:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:58:44 INFO - Running post-action listener: _resource_record_post_action 23:58:44 INFO - [mozharness: 2016-09-04 06:58:44.356944Z] Finished clobber step (success) 23:58:44 INFO - [mozharness: 2016-09-04 06:58:44.357040Z] Running read-buildbot-config step. 23:58:44 INFO - Running pre-action listener: _resource_record_pre_action 23:58:44 INFO - Running main action method: read_buildbot_config 23:58:44 INFO - Using buildbot properties: 23:58:44 INFO - { 23:58:44 INFO - "project": "", 23:58:44 INFO - "product": "firefox", 23:58:44 INFO - "script_repo_revision": "production", 23:58:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 23:58:44 INFO - "repository": "", 23:58:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 23:58:44 INFO - "buildid": "20160903215151", 23:58:44 INFO - "pgo_build": "False", 23:58:44 INFO - "basedir": "/builds/slave/test", 23:58:44 INFO - "buildnumber": 53, 23:58:44 INFO - "slavename": "t-yosemite-r7-0259", 23:58:44 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 23:58:44 INFO - "platform": "yosemite_r7", 23:58:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:58:44 INFO - "branch": "mozilla-central", 23:58:44 INFO - "repo_path": "mozilla-central", 23:58:44 INFO - "revision": "cf087a62374d4b2bbfa5b3903bfa450b0e90a8dd", 23:58:44 INFO - "stage_platform": "macosx64", 23:58:44 INFO - "builduid": "618e412483274c29adc0f3ea1e7616d4", 23:58:44 INFO - "slavebuilddir": "test" 23:58:44 INFO - } 23:58:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 23:58:44 INFO - Running post-action listener: _resource_record_post_action 23:58:44 INFO - [mozharness: 2016-09-04 06:58:44.360277Z] Finished read-buildbot-config step (success) 23:58:44 INFO - [mozharness: 2016-09-04 06:58:44.360404Z] Running download-and-extract step. 23:58:44 INFO - Running pre-action listener: _resource_record_pre_action 23:58:44 INFO - Running main action method: download_and_extract 23:58:44 INFO - mkdir: /builds/slave/test/build/tests 23:58:44 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')]} 23:58:44 INFO - trying https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 23:58:44 INFO - Downloading https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/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 23:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/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 23:58:45 INFO - Downloaded 1199 bytes. 23:58:45 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 23:58:45 INFO - Using the following test package requirements: 23:58:45 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 23:58:45 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:58:45 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 23:58:45 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:58:45 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 23:58:45 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:58:45 INFO - u'jsshell-mac.zip'], 23:58:45 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:58:45 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 23:58:45 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 23:58:45 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:58:45 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 23:58:45 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:58:45 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 23:58:45 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:58:45 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 23:58:45 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 23:58:45 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 23:58:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:58:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 23:58:45 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 23:58:52 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 23:58:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 23:58:53 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 23:59:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 23:59:00 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 23:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:59:01 INFO - trying https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:59:01 INFO - Downloading https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 23:59:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/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 23:59:07 INFO - Downloaded 111489217 bytes. 23:59:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:59:07 INFO - mkdir: /builds/slave/test/properties 23:59:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:59:07 INFO - Writing to file /builds/slave/test/properties/build_url 23:59:07 INFO - Contents: 23:59:07 INFO - build_url:https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 23:59:08 INFO - Running post-action listener: _resource_record_post_action 23:59:08 INFO - Running post-action listener: set_extra_try_arguments 23:59:08 INFO - [mozharness: 2016-09-04 06:59:08.522562Z] Finished download-and-extract step (success) 23:59:08 INFO - [mozharness: 2016-09-04 06:59:08.522704Z] Running populate-webroot step. 23:59:08 INFO - Running pre-action listener: _resource_record_pre_action 23:59:08 INFO - Running main action method: populate_webroot 23:59:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:59:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:59:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:59:08 INFO - '--tppagecycles', 23:59:08 INFO - '7'], 23:59:08 INFO - 'tests': ['tsvgm']}}, 23:59:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:59:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:59:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:59:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:59:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:08 INFO - 'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:59:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:59:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:08 INFO - 'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['damp', 'tps']}, 23:59:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:08 INFO - 'tests': ['damp', 'tps']}, 23:59:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['dromaeo_dom']}, 23:59:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:59:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['basic_compositor_video']}, 23:59:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:59:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['a11yr', 23:59:08 INFO - 'ts_paint', 23:59:08 INFO - 'tpaint', 23:59:08 INFO - 'sessionrestore', 23:59:08 INFO - 'sessionrestore_no_auto_restore', 23:59:08 INFO - 'tabpaint']}, 23:59:08 INFO - 'other-e10s': {'tests': ['a11yr', 23:59:08 INFO - 'ts_paint', 23:59:08 INFO - 'tpaint', 23:59:08 INFO - 'sessionrestore', 23:59:08 INFO - 'sessionrestore_no_auto_restore', 23:59:08 INFO - 'tabpaint']}, 23:59:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:59:08 INFO - 'ts_paint', 23:59:08 INFO - 'tpaint', 23:59:08 INFO - 'sessionrestore', 23:59:08 INFO - 'sessionrestore_no_auto_restore', 23:59:08 INFO - 'tabpaint']}, 23:59:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:59:08 INFO - 'ts_paint', 23:59:08 INFO - 'tpaint', 23:59:08 INFO - 'sessionrestore', 23:59:08 INFO - 'sessionrestore_no_auto_restore', 23:59:08 INFO - 'tabpaint']}, 23:59:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['a11yr', 23:59:08 INFO - 'ts_paint', 23:59:08 INFO - 'tpaint', 23:59:08 INFO - 'sessionrestore', 23:59:08 INFO - 'sessionrestore_no_auto_restore', 23:59:08 INFO - 'tabpaint']}, 23:59:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['a11yr', 23:59:08 INFO - 'ts_paint', 23:59:08 INFO - 'tpaint', 23:59:08 INFO - 'sessionrestore', 23:59:08 INFO - 'sessionrestore_no_auto_restore', 23:59:08 INFO - 'tabpaint']}, 23:59:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['tsvgx', 23:59:08 INFO - 'tsvgr_opacity', 23:59:08 INFO - 'tart', 23:59:08 INFO - 'tscrollx', 23:59:08 INFO - 'cart']}, 23:59:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:59:08 INFO - 'tsvgr_opacity', 23:59:08 INFO - 'tart', 23:59:08 INFO - 'tscrollx', 23:59:08 INFO - 'cart']}, 23:59:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:08 INFO - 'talos_options': ['--disable-e10s'], 23:59:08 INFO - 'tests': ['tp5o']}, 23:59:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:08 INFO - 'tests': ['tp5o']}, 23:59:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:08 INFO - 'talos_options': ['--disable-e10s', 23:59:08 INFO - '--xperf_path', 23:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:59:08 INFO - 'tests': ['tp5n']}, 23:59:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:59:08 INFO - 'talos_options': ['--xperf_path', 23:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:59:08 INFO - 'tests': ['tp5n']}}, 23:59:08 INFO - 'talos.zip': {'path': '', 23:59:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:59:08 INFO - Running post-action listener: _resource_record_post_action 23:59:08 INFO - [mozharness: 2016-09-04 06:59:08.541348Z] Finished populate-webroot step (success) 23:59:08 INFO - [mozharness: 2016-09-04 06:59:08.541458Z] Running create-virtualenv step. 23:59:08 INFO - Running pre-action listener: _resource_record_pre_action 23:59:08 INFO - Running main action method: create_virtualenv 23:59:08 INFO - Creating virtualenv /builds/slave/test/build/venv 23:59:08 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 23:59:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:59:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:59:08 INFO - Using real prefix '/tools/python27' 23:59:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 23:59:12 INFO - Installing pip.................done. 23:59:12 INFO - Return code: 0 23:59:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:59:12 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')]} 23:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:12 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')]} 23:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:12 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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:12 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 23:59:12 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 23:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:12 INFO - 'HOME': '/Users/cltbld', 23:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:12 INFO - 'LOGNAME': 'cltbld', 23:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:12 INFO - 'MOZ_NO_REMOTE': '1', 23:59:12 INFO - 'NO_EM_RESTART': '1', 23:59:12 INFO - 'PAGER': '/bin/cat', 23:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:12 INFO - 'PWD': '/builds/slave/test', 23:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:12 INFO - 'SHELL': '/bin/bash', 23:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:12 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:12 INFO - 'USER': 'cltbld', 23:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:12 INFO - 'XPC_FLAGS': '0x0', 23:59:12 INFO - 'XPC_SERVICE_NAME': '0', 23:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:12 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 23:59:12 INFO - Cleaning up... 23:59:12 INFO - Return code: 0 23:59:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:59:12 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')]} 23:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:12 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')]} 23:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:12 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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:12 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 23:59:12 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 23:59:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:12 INFO - 'HOME': '/Users/cltbld', 23:59:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:12 INFO - 'LOGNAME': 'cltbld', 23:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:12 INFO - 'MOZ_NO_REMOTE': '1', 23:59:12 INFO - 'NO_EM_RESTART': '1', 23:59:12 INFO - 'PAGER': '/bin/cat', 23:59:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:12 INFO - 'PWD': '/builds/slave/test', 23:59:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:12 INFO - 'SHELL': '/bin/bash', 23:59:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:12 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:12 INFO - 'USER': 'cltbld', 23:59:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:12 INFO - 'XPC_FLAGS': '0x0', 23:59:12 INFO - 'XPC_SERVICE_NAME': '0', 23:59:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:12 INFO - Downloading/unpacking psutil>=3.1.1 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:59:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:59:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:59:16 INFO - Installing collected packages: psutil 23:59:16 INFO - Running setup.py install for psutil 23:59:16 INFO - building 'psutil._psutil_osx' extension 23:59:16 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 23:59:17 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 23:59:17 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 23:59:17 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 23:59:17 INFO - building 'psutil._psutil_posix' extension 23:59:17 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 23:59:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:59:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:59:17 INFO - ^ 23:59:17 INFO - 1 warning generated. 23:59:17 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 23:59:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:59:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:59:17 INFO - Successfully installed psutil 23:59:17 INFO - Cleaning up... 23:59:17 INFO - Return code: 0 23:59:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:17 INFO - 'HOME': '/Users/cltbld', 23:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:17 INFO - 'LOGNAME': 'cltbld', 23:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:17 INFO - 'MOZ_NO_REMOTE': '1', 23:59:17 INFO - 'NO_EM_RESTART': '1', 23:59:17 INFO - 'PAGER': '/bin/cat', 23:59:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:17 INFO - 'PWD': '/builds/slave/test', 23:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:17 INFO - 'SHELL': '/bin/bash', 23:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:17 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:17 INFO - 'USER': 'cltbld', 23:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:17 INFO - 'XPC_FLAGS': '0x0', 23:59:17 INFO - 'XPC_SERVICE_NAME': '0', 23:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:59:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:59:20 INFO - Installing collected packages: mozsystemmonitor 23:59:20 INFO - Running setup.py install for mozsystemmonitor 23:59:20 INFO - Successfully installed mozsystemmonitor 23:59:20 INFO - Cleaning up... 23:59:20 INFO - Return code: 0 23:59:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:20 INFO - 'HOME': '/Users/cltbld', 23:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:20 INFO - 'LOGNAME': 'cltbld', 23:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:20 INFO - 'MOZ_NO_REMOTE': '1', 23:59:20 INFO - 'NO_EM_RESTART': '1', 23:59:20 INFO - 'PAGER': '/bin/cat', 23:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:20 INFO - 'PWD': '/builds/slave/test', 23:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:20 INFO - 'SHELL': '/bin/bash', 23:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:20 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:20 INFO - 'USER': 'cltbld', 23:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:20 INFO - 'XPC_FLAGS': '0x0', 23:59:20 INFO - 'XPC_SERVICE_NAME': '0', 23:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:21 INFO - Downloading/unpacking jsonschema==2.5.1 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59: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 23:59:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:59:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:23 INFO - Downloading functools32-3.2.3-2.tar.gz 23:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:59:23 INFO - warning: no files found matching '*.txt' 23:59:23 INFO - no previously-included directories found matching 'build' 23:59:23 INFO - no previously-included directories found matching 'dist' 23:59:23 INFO - no previously-included directories found matching '.git*' 23:59:23 INFO - Installing collected packages: jsonschema, functools32 23:59:24 INFO - Running setup.py install for functools32 23:59:24 INFO - warning: no files found matching '*.txt' 23:59:24 INFO - no previously-included directories found matching 'build' 23:59:24 INFO - no previously-included directories found matching 'dist' 23:59:24 INFO - no previously-included directories found matching '.git*' 23:59:24 INFO - Successfully installed jsonschema functools32 23:59:24 INFO - Cleaning up... 23:59:24 INFO - Return code: 0 23:59:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:59:24 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')]} 23:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:24 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')]} 23:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:24 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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:24 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 23:59:24 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 23:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:24 INFO - 'HOME': '/Users/cltbld', 23:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:24 INFO - 'LOGNAME': 'cltbld', 23:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:24 INFO - 'MOZ_NO_REMOTE': '1', 23:59:24 INFO - 'NO_EM_RESTART': '1', 23:59:24 INFO - 'PAGER': '/bin/cat', 23:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:24 INFO - 'PWD': '/builds/slave/test', 23:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:24 INFO - 'SHELL': '/bin/bash', 23:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:24 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:24 INFO - 'USER': 'cltbld', 23:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:24 INFO - 'XPC_FLAGS': '0x0', 23:59:24 INFO - 'XPC_SERVICE_NAME': '0', 23:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:59:24 INFO - Cleaning up... 23:59:24 INFO - Return code: 0 23:59:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:59:24 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')]} 23:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:24 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')]} 23:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:24 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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:24 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 23:59:24 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 23:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:24 INFO - 'HOME': '/Users/cltbld', 23:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:24 INFO - 'LOGNAME': 'cltbld', 23:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:24 INFO - 'MOZ_NO_REMOTE': '1', 23:59:24 INFO - 'NO_EM_RESTART': '1', 23:59:24 INFO - 'PAGER': '/bin/cat', 23:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:24 INFO - 'PWD': '/builds/slave/test', 23:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:24 INFO - 'SHELL': '/bin/bash', 23:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:24 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:24 INFO - 'USER': 'cltbld', 23:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:24 INFO - 'XPC_FLAGS': '0x0', 23:59:24 INFO - 'XPC_SERVICE_NAME': '0', 23:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:24 INFO - Downloading/unpacking blobuploader==1.2.4 23:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:59:27 INFO - Downloading blobuploader-1.2.4.tar.gz 23:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:59:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:59:27 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 23:59:27 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 23:59:27 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 23:59:27 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 23:59:27 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 23:59:27 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 23:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:59:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:59:27 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 23:59:27 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 23:59:27 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 23:59:27 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 23:59:27 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 23:59:27 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 23:59:28 INFO - Downloading docopt-0.6.1.tar.gz 23:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:59:28 INFO - Installing collected packages: blobuploader, requests, docopt 23:59:28 INFO - Running setup.py install for blobuploader 23:59:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:59:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:59:28 INFO - Running setup.py install for requests 23:59:29 INFO - Running setup.py install for docopt 23:59:29 INFO - Successfully installed blobuploader requests docopt 23:59:29 INFO - Cleaning up... 23:59:29 INFO - Return code: 0 23:59:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:29 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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:29 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 23:59:29 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 23:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:29 INFO - 'HOME': '/Users/cltbld', 23:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:29 INFO - 'LOGNAME': 'cltbld', 23:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:29 INFO - 'MOZ_NO_REMOTE': '1', 23:59:29 INFO - 'NO_EM_RESTART': '1', 23:59:29 INFO - 'PAGER': '/bin/cat', 23:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:29 INFO - 'PWD': '/builds/slave/test', 23:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:29 INFO - 'SHELL': '/bin/bash', 23:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:29 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:29 INFO - 'USER': 'cltbld', 23:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:29 INFO - 'XPC_FLAGS': '0x0', 23:59:29 INFO - 'XPC_SERVICE_NAME': '0', 23:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:59:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-_HWLWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:59:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-8uRSlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:59:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-wy7qpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:59:29 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-wXxfGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-jShENZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-wcfeVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-tPciS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-dEjo70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-F23WdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-xklF7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-CvXhal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-xf0xQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-V4deMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:59:30 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-2RYBJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:31 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Hix64S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:59:31 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-VQIRgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:59:31 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-l2XZQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:59:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:59:31 INFO - Running setup.py install for manifestparser 23:59:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Running setup.py install for mozcrash 23:59:31 INFO - Running setup.py install for mozdebug 23:59:31 INFO - Running setup.py install for mozdevice 23:59:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:59:31 INFO - Running setup.py install for mozfile 23:59:32 INFO - Running setup.py install for mozhttpd 23:59:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:59:32 INFO - Running setup.py install for mozinfo 23:59:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:59:32 INFO - Running setup.py install for mozInstall 23:59:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:59:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:59:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:59:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:59:32 INFO - Running setup.py install for mozleak 23:59:32 INFO - Running setup.py install for mozlog 23:59:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:59:32 INFO - Running setup.py install for moznetwork 23:59:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:59:33 INFO - Running setup.py install for mozprocess 23:59:33 INFO - Running setup.py install for mozprofile 23:59:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:59:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:59:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:59:33 INFO - Running setup.py install for mozrunner 23:59:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:59:33 INFO - Running setup.py install for mozscreenshot 23:59:33 INFO - Running setup.py install for moztest 23:59:33 INFO - Running setup.py install for mozversion 23:59:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:59:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:59:33 INFO - Cleaning up... 23:59:33 INFO - Return code: 0 23:59:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:59: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')]} 23:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59: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')]} 23:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:33 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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:33 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 23:59:33 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 23:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:33 INFO - 'HOME': '/Users/cltbld', 23:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:33 INFO - 'LOGNAME': 'cltbld', 23:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:33 INFO - 'MOZ_NO_REMOTE': '1', 23:59:33 INFO - 'NO_EM_RESTART': '1', 23:59:33 INFO - 'PAGER': '/bin/cat', 23:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:33 INFO - 'PWD': '/builds/slave/test', 23:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:33 INFO - 'SHELL': '/bin/bash', 23:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:33 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:33 INFO - 'USER': 'cltbld', 23:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:33 INFO - 'XPC_FLAGS': '0x0', 23:59:33 INFO - 'XPC_SERVICE_NAME': '0', 23:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:59:34 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-J6HjQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:59:34 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)) 23:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:59:34 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-9jFmXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:59:34 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)) 23:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:59:34 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-Vsltuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:59:34 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)) 23:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:59:34 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-iPv3yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:59:34 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)) 23:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:59:34 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-tJKz8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:59:34 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)) 23:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:59:34 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-xiAAE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:59:34 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)) 23:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:59:34 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-u47YxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:59:34 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)) 23:59:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:59:34 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-nKNvS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-7ZH79A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-RndST5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-PsxUni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-KDoVSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-d2oSkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-mDUgfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-mCA5qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-kceSrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:59:35 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)) 23:59:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:59:35 INFO - Running setup.py (path:/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/pip-qIYnJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 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)) 23:59:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:59:36 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 23:59:36 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 23:59:36 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 23:59:36 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 23:59:36 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 23:59:36 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 23:59:38 INFO - Downloading blessings-1.6.tar.gz 23:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:59:38 INFO - Installing collected packages: blessings 23:59:38 INFO - Running setup.py install for blessings 23:59:38 INFO - Successfully installed blessings 23:59:38 INFO - Cleaning up... 23:59:38 INFO - Return code: 0 23:59:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:59:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:59:39 INFO - Reading from file tmpfile_stdout 23:59:39 INFO - Current package versions: 23:59:39 INFO - blessings == 1.6 23:59:39 INFO - blobuploader == 1.2.4 23:59:39 INFO - docopt == 0.6.1 23:59:39 INFO - functools32 == 3.2.3-2 23:59:39 INFO - jsonschema == 2.5.1 23:59:39 INFO - manifestparser == 1.1 23:59:39 INFO - mozInstall == 1.12 23:59:39 INFO - mozcrash == 0.17 23:59:39 INFO - mozdebug == 0.1 23:59:39 INFO - mozdevice == 0.48 23:59:39 INFO - mozfile == 1.2 23:59:39 INFO - mozhttpd == 0.7 23:59:39 INFO - mozinfo == 0.9 23:59:39 INFO - mozleak == 0.1 23:59:39 INFO - mozlog == 3.3 23:59:39 INFO - moznetwork == 0.27 23:59:39 INFO - mozprocess == 0.23 23:59:39 INFO - mozprofile == 0.28 23:59:39 INFO - mozrunner == 6.12 23:59:39 INFO - mozscreenshot == 0.1 23:59:39 INFO - mozsystemmonitor == 0.3 23:59:39 INFO - moztest == 0.7 23:59:39 INFO - mozversion == 1.4 23:59:39 INFO - psutil == 3.1.1 23:59:39 INFO - requests == 1.2.3 23:59:39 INFO - wsgiref == 0.1.2 23:59:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:59:39 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')]} 23:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:39 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')]} 23:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:39 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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:39 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 23:59:39 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 23:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:39 INFO - 'HOME': '/Users/cltbld', 23:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:39 INFO - 'LOGNAME': 'cltbld', 23:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:39 INFO - 'MOZ_NO_REMOTE': '1', 23:59:39 INFO - 'NO_EM_RESTART': '1', 23:59:39 INFO - 'PAGER': '/bin/cat', 23:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:39 INFO - 'PWD': '/builds/slave/test', 23:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:39 INFO - 'SHELL': '/bin/bash', 23:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:39 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:39 INFO - 'USER': 'cltbld', 23:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:39 INFO - 'XPC_FLAGS': '0x0', 23:59:39 INFO - 'XPC_SERVICE_NAME': '0', 23:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 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)) 23:59:39 INFO - Cleaning up... 23:59:39 INFO - Return code: 0 23:59:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:59:39 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')]} 23:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:39 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')]} 23:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:59:39 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 0x103899a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10392e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe841c8df50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, '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.ymZmp1cXmr/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.12pMXqIjA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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 23:59:39 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 23:59:39 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 23:59:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 23:59:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:39 INFO - 'HOME': '/Users/cltbld', 23:59:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:39 INFO - 'LOGNAME': 'cltbld', 23:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:39 INFO - 'MOZ_NO_REMOTE': '1', 23:59:39 INFO - 'NO_EM_RESTART': '1', 23:59:39 INFO - 'PAGER': '/bin/cat', 23:59:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:39 INFO - 'PWD': '/builds/slave/test', 23:59:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:39 INFO - 'SHELL': '/bin/bash', 23:59:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 23:59:39 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 23:59:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:39 INFO - 'USER': 'cltbld', 23:59:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:39 INFO - 'XPC_FLAGS': '0x0', 23:59:39 INFO - 'XPC_SERVICE_NAME': '0', 23:59:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:59:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:59:39 INFO - Cleaning up... 23:59:39 INFO - Return code: 0 23:59:39 INFO - Running post-action listener: _resource_record_post_action 23:59:39 INFO - Running post-action listener: _start_resource_monitoring 23:59:39 INFO - Starting resource monitoring. 23:59:39 INFO - [mozharness: 2016-09-04 06:59:39.662845Z] Finished create-virtualenv step (success) 23:59:39 INFO - [mozharness: 2016-09-04 06:59:39.663866Z] Running install step. 23:59:39 INFO - Running pre-action listener: _resource_record_pre_action 23:59:39 INFO - Running main action method: install 23:59:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:59:39 INFO - Reading from file tmpfile_stdout 23:59:39 INFO - Detecting whether we're running mozinstall >=1.0... 23:59:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:59:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:59:40 INFO - Reading from file tmpfile_stdout 23:59:40 INFO - Output received: 23:59:40 INFO - Usage: mozinstall [options] installer 23:59:40 INFO - Options: 23:59:40 INFO - -h, --help show this help message and exit 23:59:40 INFO - -d DEST, --destination=DEST 23:59:40 INFO - Directory to install application into. [default: 23:59:40 INFO - "/builds/slave/test"] 23:59:40 INFO - --app=APP Application being installed. [default: firefox] 23:59:40 INFO - mkdir: /builds/slave/test/build/application 23:59:40 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'] 23:59:40 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 00:00:13 INFO - Reading from file tmpfile_stdout 00:00:13 INFO - Output received: 00:00:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:00:13 INFO - Running post-action listener: _resource_record_post_action 00:00:13 INFO - [mozharness: 2016-09-04 07:00:13.933499Z] Finished install step (success) 00:00:13 INFO - [mozharness: 2016-09-04 07:00:13.933638Z] Running run-tests step. 00:00:13 INFO - Running pre-action listener: _resource_record_pre_action 00:00:13 INFO - Running main action method: run_tests 00:00:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:00:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:00:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:00:13 INFO - 2016-09-04 00:00:13.948 screenresolution[1644:8122] starting screenresolution argv=screenresolution get 00:00:13 INFO - 2016-09-04 00:00:13.950 screenresolution[1644:8122] Display 0: 1600x1200x32@60 00:00:13 INFO - 2016-09-04 00:00:13.956 screenresolution[1645:8124] starting screenresolution argv=screenresolution list 00:00:13 INFO - Available Modes on Display 0 00:00:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:00:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:00:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:00:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:00:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:00:14 INFO - Intel Iris: 00:00:14 INFO - Chipset Model: Intel Iris 00:00:14 INFO - Type: GPU 00:00:14 INFO - Bus: Built-In 00:00:14 INFO - VRAM (Dynamic, Max): 1536 MB 00:00:14 INFO - Vendor: Intel (0x8086) 00:00:14 INFO - Device ID: 0x0a2e 00:00:14 INFO - Revision ID: 0x0009 00:00:14 INFO - Displays: 00:00:14 INFO - Display: 00:00:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:00:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:00:14 INFO - Display Serial Number: 1600x1200 60 00:00:14 INFO - Main Display: Yes 00:00:14 INFO - Mirror: Off 00:00:14 INFO - Online: Yes 00:00:14 INFO - Rotation: Supported 00:00:14 INFO - Return code: 0 00:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:00:14 INFO - Python 2.7.3 00:00:14 INFO - Return code: 0 00:00:14 INFO - grabbing minidump binary from tooltool 00:00: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')]} 00:00:14 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 0x1037fdd30>, '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 0x103562db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037f5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:00:14 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 00:00:14 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 00:00:14 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 00:00:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:00:14 INFO - Return code: 0 00:00:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:00:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:00:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:00:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:00:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 00:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0259 --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 00:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ymZmp1cXmr/Render', 00:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:00:14 INFO - 'HOME': '/Users/cltbld', 00:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:00:14 INFO - 'LOGNAME': 'cltbld', 00:00:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:00:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:00:14 INFO - 'MOZ_NO_REMOTE': '1', 00:00:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:00:14 INFO - 'NO_EM_RESTART': '1', 00:00:14 INFO - 'PAGER': '/bin/cat', 00:00:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:00:14 INFO - 'PWD': '/builds/slave/test', 00:00:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:00:14 INFO - 'SHELL': '/bin/bash', 00:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.12pMXqIjA2/Listeners', 00:00:14 INFO - 'TMPDIR': '/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/', 00:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:00:14 INFO - 'USER': 'cltbld', 00:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:00:14 INFO - 'XPC_FLAGS': '0x0', 00:00:14 INFO - 'XPC_SERVICE_NAME': '0', 00:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:00:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0259', '--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 00:00:14 INFO - mozversion application_buildid: 20160903215151 00:00:14 INFO - mozversion application_changeset: cf087a62374d4b2bbfa5b3903bfa450b0e90a8dd 00:00:14 INFO - mozversion application_display_name: Nightly 00:00:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:00:14 INFO - mozversion application_name: Firefox 00:00:14 INFO - mozversion application_remotingname: firefox 00:00:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:00:14 INFO - mozversion application_vendor: Mozilla 00:00:14 INFO - mozversion application_version: 51.0a1 00:00:14 INFO - mozversion platform_buildid: 20160903215151 00:00:14 INFO - mozversion platform_changeset: cf087a62374d4b2bbfa5b3903bfa450b0e90a8dd 00:00:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:00:14 INFO - mozversion platform_version: 51.0a1 00:00:14 INFO - using testdate: 1472972414 00:00:14 INFO - actual date: 1472972414 00:00:14 INFO - starting webserver on 'localhost:49279' 00:00:14 INFO - SUITE-START | Running 2 tests 00:00:14 INFO - TEST-START | dromaeo_css 00:00:14 INFO - operating with platform_type : mac_ 00:00:14 INFO - Initialising browser for dromaeo_css test... 00:00:14 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpVzU5vJ/profile http://localhost:49279/getInfo.html) 00:00:17 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 00:00:17 INFO - PROCESS | 1655 | colorDepth:24 00:00:17 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 00:00:17 INFO - PROCESS | 1655 | __metrics 00:00:17 INFO - PROCESS | 1655 | 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" 00:00:17 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:00:17 INFO - TEST-INFO | 1655: exit 0 00:00:17 INFO - Browser initialized. 00:00:17 INFO - Running cycle 1/1 for dromaeo_css test... 00:00:17 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpVzU5vJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:00:30 INFO - PROCESS | 1658 | RSS: Main: 234098688 00:00:30 INFO - PROCESS | 1658 | 00:01:21 INFO - PROCESS | 1658 | 1472972481437 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] 00:03:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 00:03:34 INFO - PROCESS | 1658 | RSS: Main: 344199168 00:03:34 INFO - PROCESS | 1658 | 00:06:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 00:06:38 INFO - PROCESS | 1658 | RSS: Main: 377225216 00:06:38 INFO - PROCESS | 1658 | 00:09:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 00:09:41 INFO - PROCESS | 1658 | RSS: Main: 337584128 00:09:41 INFO - PROCESS | 1658 | 00:12:43 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 00:12:44 INFO - PROCESS | 1658 | RSS: Main: 362434560 00:12:44 INFO - PROCESS | 1658 | 00:15:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 00:15:48 INFO - PROCESS | 1658 | RSS: Main: 322473984 00:15:48 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 00:18:51 INFO - PROCESS | 1658 | RSS: Main: 380112896 00:18:51 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | __start_tp_report 00:18:51 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 00:18:51 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 00:18:51 INFO - PROCESS | 1658 | |i|pagename|runs| 00:18:51 INFO - PROCESS | 1658 | |0;dojo.html;2868.956965645515;3304.8512816923235;3335.749818763592;3367.276035652337;3402.2685122698613;5622.100463925773;5668.234788303583;5701;5718.113692377683;5735.569832262576;5712.11462223356;5744.597878148531;5768.019436695761;5769.596128271022;5771.480566748992;5188.455212202721;5229.084910140729;5235;5240.947590524103;5286.524212820846;5268.525832675058;5268.736563171826;5269.789208431658;5273.709945952971;5281.815136470224;5163.535281824635;5204.505571970676;5230.790768369261;5231.24146998685;5257.789688412478;5299.390570084451;5338.893222135574;5346.866328341823;5353.362583971634;5371.301730775013;5123.052235336475;5133.871653208662;5154.304168937183;5239.266502689627;5274.7626356814035;5680.4319568043275;5693.402192769741;5735;5752.827415177551;5806.941930580682;6245.125682404467;6246.937530624681;6251;6256.15541901842;6260.812175634738;6137.508999280047;6223.626582405025;6261.749530018839;6295.842603934938;6317.273513545955;5846.327672317653;5846.327672317738;5890.263717035371;5900.881982360329;5909.084091965795;6299.307076221612;6302.432781049728;6308.369163083655;6321.146645202839;6326.398992095744;5907.616004959664;6057.446438767604;6098.069176274479;6185.350538193515;6194.566380353423;6283.183186185766;6312;6330.588511746721;6343.207099112611;6363.681815909186;6233.594816337014;6256.092866534327;6263.686815659199;6265.71804268809;6284.654344011124;6055.212822333068;6081.331053584102;6091.6925608203255;6271.184745983084;6288;4965.602751779849;4974.030064137531;4988.226824842155;4988.7505624718615;4992.750362481861;4434.024514606781;4488.102379524108;4489.349044388546;4502.977485112553;4522.23122069249;5672.404397538282;5713.257276554022;5719.19931209631;5723.7424315905055;5772.509336706343;6295.968520157461;6312.810615681537;6320.5575609706875;6327.683615819191;6329.113924050636;5609.775608975595;5657.349404818417;5677.602567820213;5709.857253568694;5720.685362305113;5452.073147564924;5481.725913704299;5487.122060470386;5535.03136951032;5540;6246.000639897686;6308.495320374359;6310.6844657766005;6324.114623952651;6325.399087086719;6125.907024958145;6217.875642487215;6314.715837787218;6345.682715864281;6352.650604216812;6242.032484964838;6285.1515045470105;6311.274203466476;6313.2424109107205;6321.367863213642;6207.565470417027;6230.345813689497;6235.563510554218;6253.062040693932;6260.092286618506;6121.087175196906;6164.3835616438;6323.462505687068;6332.050192471166;6335.3981371769605;6143.642898274451;6143.938560614337;6175.5677102602385;6187.381261873777;6191.442770150528;6114.541409394402;6114.847128821815;6139.986902161093;6150.261968563801;6197.442230199304;5803.854903627274;5862.765489380377;6005.3075707426715;6009.429104235091;6084.148219249397;4612.4926258112255;6099.359567245376;6126.9757403264;6186.876262474635;6192.938070619236;4888.364512613338;5977.372375900468;5983.55123365758;6002.069679199731;6044.214252147192 00:18:51 INFO - PROCESS | 1658 | |1;ext.html;485.19457700217635;522.581934452438;528.4029047176691;542.9321334833146;549.9037668408033;30477.847610761943;31223.843880780594;32302.515462268027;32372.895761775468;32383.51424728625;32627;33409.498857517094;41118;42405.36391954123;42748.358774618326;9656.517174141283;9804.509774511245;9807.754806129868;9815.65645202418;9820;9738.853917191247;9838.36050656705;9848.803023939518;9850.605975760996;9865.654702085429;9761.951190244074;9835.45904975226;9855.310128291023;9884.604615815395;9884.851727224097;9707.563159657833;9785.07041831025;9811.362261452983;9841.311108222462;9878.308518403715;9734.977827328099;9797.559109840004;9805.754856128653;9808.411495310304;9824.115829575301;39859;40109.99725006869;40164.59835401667;40178.593749218926;40275.375216230386;3180.9522857157162;3320.4355259605927;3324.817135057571;3332.8333583320978;3399.932001359959;30268.69731302681;31236.531452028237;31238.53142202869;31277.905273315326;31649.36701265962;3160.2099475131217;3195.984020079908;3284.9343013139605;3322.368749937504;3383.932321353559;497470.9999999964;497974;499112;499516;499976;52984.47015529795;58561.12158317629;58636;58670.41329586649;58702;60562;60590.697046514484;60704;60711.69644151751;60807.04754190963;16240.59398515023;16474.670506589802;16476.258568364214;16478.011319320878;16501;12892.935535322264;12951.028672849574;12970.546030888874;12982.15615984958;12986.610401687965;15190.620234494227;15923.840761592468;15932.601684957737;15970.281337339848;15992.600184995468;5896.882062358729;6937.861242775116;6937.89593156093;7008.789736307919;7049.3655570997835;823.2960818500096;1011.7690492464098;1014.5282443663732;1022.7801022779989;1027.5838285494387;29091;29507.114786556438;29530.704692952797;30257;30453.23866903345;824.5712229640674;1023.2683631203726;1058.7564860082225;1066.4188017530464;1116.3469370418234;14757.262136893112;15264.236788160548;15290.923545382424;15442;15733.213339332988;633275.1681207914;639201;639312;641095;641649;57150.42849571534;57176.71411642998;57180.71409642925;57250.56873578194;57255.99999999916;1056.7463808686014;1164.8468016663442;1276.2278821312973;1377.6762460821699;1397.881180099703;28706.569401459412;30963.84518077395;31238.687613123577;31647.84176079197;31821.522677160323;48606;49084;54813.451865480834;56026;56207.718961404935;607717;613792;614198;615371;615444;25013.874375653504;25233.369165771004;25277.11530096438;25684.486310274064;25779.742202577734;46461.535384647075;46806.76596617131;46833.531664682916;47223;47496.287555686;37981.62018379781;38523.614763852005;38666;39053.80473097616;39972.600273998054;37998.43002355022;38131;38697.41953870638;39070.4139437903;39181.2163756729;32291.031269061965;37004.81497592495;37630.435543467414;38407.61592384041;38736.22527549489;30807;33001;34404.311913761085;34573.48139777956;34663.48004779981;24881.751182487944;25387.36531586725;25522.872385637955;25787.226383208534;25987.18388490317 00:18:51 INFO - PROCESS | 1658 | |2;jquery.html;321.67350139608294;377.5073529044596;380.4901432081011;395.6221808173195;405.8721502726641;19026.41010473571;20797.272095476663;21078.367648970518;21291.893540532314;21450.249241276557;19963.500912477197;20590.073446694896;20632.793672063275;20873.165073397086;21246.468838279052;5836.15375770513;5839.7664093436215;6119.296280927706;6149.692515374213;6208.286047104596;3899.2396482685886;4111.958880411203;6121.602095863755;6154.784582539612;6172.87654246917;5879.441453061973;6141;6188;6198.535109866778;6205.286392064902;5969.761209551612;6051.394860513958;6165.568410211287;6176.042713379411;6177.073438984144;5968.1644569760265;5968.432998865144;5968.731407086691;5979.641221526722;5990.281166260077;12924.35378231094;12957;13213;13319.934405247557;13376.264305463195;2167.1981366894192;2201.7798220178015;2291.9885400573057;2348.859068455898;2696.730326967307;9690.75773105671;9914.157296629795;10056.396616203052;10371.896281037169;10518.368897866076;1830.7070868661083;1872.2885303584687;1902.1060101752294;1912.3306842605116;1916.7795703494137;116209;125784;126138;127083.36458317649;128150.3592482041;11345.829812552818;11360.375179365048;11547.595834145764;11684.47419866108;11764.294142351486;14603.196824174773;14625.976181667182;14646;14648.12111273327;14650.487232946796;8168.469049511763;8478.788030299293;8493.745187644257;8615.483071015758;8651.95674021626;8362.038365588036;8382.16178382157;8422.368322375723;8581.442206256574;8622.180892815173;4474.127545128668;4494.10117976406;4504.909901801946;4520.321951707205;4594.1271158479785;1667.7331626939874;1723.7672914156428;1853.6570734413906;1895.9336423225398;1896.1183049881872;845.7251393297203;938.5823308627731;959.9040095990345;961.8412961861214;993.965211217604;14880.70238595222;18848.434546963614;19741.40775776729;20702;21416.678749818766;795.1890068607445;840.6301227459898;874.505904164158;930.4928813796497;954.6849539651898;8433.704820331259;8659.826803464022;10615.628453004263;11160.441977901073;11224.214304998572;563155;564538;573277;574971;576134;79966;124951;131887.02169467465;133117;136541.3172934129;993.2600212841335;995.5868314649484;995.6316163019729;1007.969760907174;1016.3546148195949;18917.148728306984;19106.904465477583;19313.90343048276;19346.613067738286;19398.90300548545;50364.49635503598;51062;52851.73574132258;55781.442185579246;56367;79759.80360294717;80906.3818723634;81828;82861.58569207115;83032;7934.920650793418;8020.318272946864;8154.877676834971;8200.343972482067;8234.917650823416;10620.734481638021;12711.936440317739;12735;13040.478380865039;13045.217286962434;11078.279911805706;11107.278026928223;11181.217314787888;11251.437428128724;11318.660440186808;10830.891691082988;10935.61725339641;11061.723456913642;11215.158863085138;11227.21409501327;11262.986331230228;11331.716707082389;11436;11550.826737598774;11633.451797201935;7851.939988101533;7863.84272314562;8030.27727504504;8284.792880178044;8318.417710760188;8276.379271554779;9839.901600983898;10662;10955.616553420592;10984 00:18:51 INFO - PROCESS | 1658 | |3;mootools.html;1404.957851264462;1492.4477943161025;1690.3323187341;1859.4607563806496;1902.5529000684828;8348.958255208723;8871.95564022179;8880.555972201397;8895.822083558332;8907.82184356314;7758.806029849256;7991;8393.53835539045;8600.8709869352;8656.523891185981;2365.6451532270125;2396.6764486794323;2400.1119585753295;2404.1825779235055;2408.602580574212;2353.0470159585393;2378.0131245533084;2399.4121440247163;2402.4954759500524;2405.4226985523437;2374.1453076892303;2381.7975472084895;2395.928122156329;2398.9880050599722;2399.940001499959;2342.8711420871846;2351.5532048910736;2355.328731311585;2358.2689366296418;2375.798057165143;2331.568659797943;2350.001249468969;2354.8587084774967;2358.0449917783326;2360.834741568091;8651.65393384264;8697.52163631;8776.341774366949;8778.385513014091;8790.120987901222;5119.59043276537;5293.788248470057;5295.073362161606;5295.523402893758;5304.151335786256;3628.2924829658227;3634.6728794408364;3685.6130106338715;3714.7956862372557;3715.479832823407;951.7858481841599;1085.1264731890824;1087.9510422031028;1088.4612117002055;1091.154355374583;11369.772604547945;11491.59779407725;11494.827577586342;11501.424928753613;11502.942485287604;4164.646005089601;4281.422008028876;4530.88672783183;4752;4752.429708434941;9833.360831545926;9843.75390615226;9845.704628861145;9846.409215447096;9850.950745246228;5314.73426328682;5324.988252232063;5327.094393953037;5332.786688532493;5333.679979201261;4369.191699535596;4542.659300552472;4718.103560323528;4842.564169224786;4887.633427492952;3800.600936901641;3821.3885778275344;3930.8427662893164;3943.9014024649614;4006.859759908389;1069.946502674863;1092.7215158264848;1265.5446236827722;1274.5602767045355;1286.9935650321688;871.4858233642054;881.8104107616765;902.1880307723102;902.3863772634671;916;4525.7510836904285;5640.830775076673;5949.375315591887;5987.982043052692;6080.391960803884;409.2328332134944;424.4609346130459;432.9889707532883;435.7320248047428;454.0215834875848;3942.822572984165;3954.6045395460224;3967.3453880110037;4071.185762847442;4086.7752273625238;10105.090541851268;10598.894011059945;10600.310979786444;10610.363378197178;10615.416152111553;10161.745956351151;10569.471526423647;10579.682609521727;10586.57653693859;10616.787664246673;7977.481463704957;8000.63997120131;8095.919040809635;8113.553754543556;8151.5109093454585;5655.123455864347;5719.399463056319;5794.82615521535;5852.853678657897;5887.116932460165;8563.272121869712;9685.515724213621;9851.802963940538;9925.801483970135;9979.251556133175;9714.514274286399;9877.753056173653;10059.949700251453;10072.748181295527;10090.596376144871;6740.12378390806;6955.200151982587;7090.539114957512;7125.893111603434;7218.855622887618;8132.349412046904;8308.12764659702;8311.792205194919;8321.500709957421;8323.95838020806;7276.7816965489;7388.113426388652;7408.9629551851895;7504;7508.061492313461;7119.715211391486;7247.456440766858;7268.636568171464;7297.051383320135;7339.339459448675;6707.765228217184;6887.345702158287;6970.895436568557;6979.476539259677;6989.825254368478;4807.735574543433;4927.827526036572;5007.674501157413;5046.47012063728;5106.055379754757;4933.367758336529;4945.925811112764;5066.721330326867;5203.687778733288;5204.219367094966 00:18:51 INFO - PROCESS | 1658 | |4;prototype.html;280.26710152950034;295.48585461297347;310.773135611004;312.9311551458678;317.7140573483863;4387.1445068211715;5269.314989051422;5312.07038768215;5320.946790532098;5347.411784703684;3972.2849887020325;4016.698747593935;5152.716600586966;5215.556677682402;5252.820079666933;4006.8597599084037;4008.7594744315434;4012.2176175645686;4030.2141082488924;4073.8370465181506;4013.8193781279765;4019.648505624213;4020.718549701522;4036.8587099451524;4055.5336136344254;3736.383496723051;3942.704297177723;4001.659858911996;4021.8793436196815;4035.556088830226;3491.14466955595;3797.658210761017;3942.6057394260633;3988.082740969579;3993.3410987187226;2852.857357132135;3411.96588034119;3420.521127042216;3444.1733983843947;3470.8264586770815;4996.7001979881325;5133.6149788765615;5179.482051794828;5187.46969643956;5210.76551555181;3990.2618015667194;4494.68537202396;4500.977495112504;4536.024754677727;4567.378580603904;4544.659150563721;5463.453654634544;5498.5978575463005;5519.724013799294;5592.462072929936;3225.983870080658;3277.475603903364;3710.089304008438;3784.4890939723336;3799.4870692456443;5362.962074411698;5481.917771233435;5619.269494965669;5689.345725241567;5817.418258174191;3530.7881527108457;3647.9238624605805;3686.4101743720876;3698.7410881238593;3851.326017946904;3884.9611503885167;3888.5333759948985;3890.9805450972563;3900.395438707005;3911.4940747812298;3747.362948298796;4503.954960450419;4517.774111294422;4522.186006518858;4533.614642755337;4754.380073873586;4871.61554600862;5087.821926232564;5133.717645529532;5553.77784888608;1115.609536662178;1152.8558930133734;1214.7145420826098;1246.389269258057;1247.8956123830476;764.9235076492306;798.9121196668361;809.4091313341177;812.3501199040744;813.2924355810483;3601.8019008954757;4125.092479654471;4285.849995250152;4300.849575212394;4341.848035318749;4321.783910804447;4740.881477963078;4778;4873.415190177201;4876.683015603974;4293.350651945883;4300.2904520754355;4317.525072242051;4338.978305108518;4342.435483387139;2342.524209747848;2365.5032443187124;2385.9880700596386;2495.463475352808;2532.683414573178;4098.545016519093;4335.653147748172;4879.731614761222;4896.698551680775;4900.534449227318;4165.937510937339;4722.338872557844;4782.715099814724;4819.734914579662;4930;4887.462379138292;5187.740612969261;5288.576913846883;5889.411058894162;5956.910646340309;5640.661560306395;5709;5712.258470701697;5731.369549349485;5754.827355179351;5027.139958215484;5177.834987128017;5411.512963833274;5413.431589683027;5693.430656934273;5036.546710796046;5585.245991791056;5767.68277744728;5774.682392468287;5891.793787217427;3371.477420999749;3580.7314451415727;3651.7626354286886;3712;3734.2158146788393;4986.703457101107;5231.869203269796;5607.953097119604;5647.378788333198;5651.180578816131;4465.888352791206;4607.815687372602;5275.736213189249;5456.836294911159;5465.69938653362;4708.905821883474;5437.8368648940595;5452.127659574449;5453.918191227055;5488.341399032141;4414.381986521954;5325.7337133143965;5347.759350829144;5349.598780091431;5378.354597448331;4828.589569886599;5015.22264049073;5192.688438693691;5351.946480535301;5438.728063596725;4048.9190216196102;4559.840405585788;4898.142825005681;5440.428754980829;5538.529225015757 00:18:51 INFO - PROCESS | 1658 | |5;yui.html;702.4205030849549;720.531654424624;765.8812884002981;799.2167675677836;800.4596897094467;15911.84088159118;16523.91738041308;16535.594474469654;16539.58651033725;16565.171741412927;14417;14492.20292883891;14507.347169377377;14513.20177390243;15046.322915468803;658.7299207324997;666.9199696036483;684.6816230452838;824.6289169873551;831.4844796226317;820.4871955028108;835.2232423845821;835.3985130705883;835.5028757889046;836.0928392693935;812.2851890336495;841.4993079117914;895.5298468304127;897.1970086772335;900.7928176519405;705.5449235243291;870.9912900871037;892.4868200784575;895.2837729816154;897.2911399993997;673.5891106425076;673.8281738156738;674.9932500674979;675.4157653629575;675.6587923098804;15074.773878391832;15100.622484437978;15103.39586416553;15107.924460377628;15108.093514389062;11153.330800151936;13215.933920330337;13762.036657433984;14002.159870407808;14009.369578368998;11173.49719262627;12325.260484370967;12634.368281585885;12727.490900364068;13023.158168340362;4544.409226800528;4568.794404251817;4583.083383323348;4685.554872287127;4747.691400058985;112744.43627781891;113324;113350.43324783405;114767;115352.84647153589;8834;10697.946510267555;10719.410432426292;10846;10913.727156820984;21031.8948405257;21271.680924786142;21419.57160856774;21420.143194272056;21462.141514339564;7613.505122167041;7686.961565192139;7747.2640099190485;7748.92251077482;7808.921910780933;4324.1567894260315;4330.39374487572;4353.107612939403;4476.37330773692;4497.932531011972;3465.4455287153933;3567.0725611341236;3571.5892672342493;3576.962680822532;3579.83890724918;493.2674977658175;656.7668477690352;661.2362721057186;679.419096672338;682.2324884504932;509.32768745256647;548.6625725179066;603.9577229593887;615.4184295840388;623.6351734235433;8747.562621868881;8921.821563568692;8955.104489550993;8998.190162885372;9110.362274640844;525.8711615654113;544.9155380915964;583.2505230778514;595.7110801261384;600.3696119074954;3452.7755695879687;4348.673849461303;4377.124575084996;4396.45735894115;4520.683552151384;123864;154865;157396;160433.19783401242;168832.15583922;134461.32769336092;135431;136862.63137368698;136910;140386;78413;94105.52947235495;95287.57068643977;95745;95877.52061239649;8382.83234335322;8407.3694472916;8459.154084591491;8485.236328730443;8603;56459.15311270252;60622.787544247985;64337;65318.34681653313;65914.34085659082;85844;93769;100411;100560.49719751354;100845;10249.897501024894;10759.30064545802;10840.403777792297;11162.944185279022;11269.71825704364;12082.516699331929;12124.27254364741;12235.265884046985;12557.93721031389;12630.989520838495;11743.647690569296;11938.880611193777;11997.580084696994;12150.149489535648;12397.008239341012;11662.88337116652;11683.649490515298;11857.407129643656;11941.701457463632;12306.953908917485;10096.242781791248;11718.531258749554;11833.881661183277;11882.76234475323;12253.387330633255;9434.48110353937;9620;9621.807563848824;9728.416295022322;9946.303758736818;9813.55838987233;9950.900490994998;9972.750681233027;9994.500274986367;10003.499825008867 00:18:51 INFO - PROCESS | 1658 | __end_tp_report 00:18:51 INFO - PROCESS | 1658 | __start_cc_report 00:18:51 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1467 00:18:51 INFO - PROCESS | 1658 | __end_cc_report 00:18:51 INFO - PROCESS | 1658 | __startTimestamp1472973531963__endTimestamp 00:18:51 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | ------- Summary: start ------- 00:18:51 INFO - PROCESS | 1658 | Number of tests: 6 00:18:51 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5761.75 Median:6002.07 stddev:657.97 (11.0%) stddev-sans-first:619.62 00:18:51 INFO - PROCESS | 1658 | Values: 2869.0 3304.9 3335.7 3367.3 3402.3 5622.1 5668.2 5701.0 5718.1 5735.6 5712.1 5744.6 5768.0 5769.6 5771.5 5188.5 5229.1 5235.0 5240.9 5286.5 5268.5 5268.7 5269.8 5273.7 5281.8 5163.5 5204.5 5230.8 5231.2 5257.8 5299.4 5338.9 5346.9 5353.4 5371.3 5123.1 5133.9 5154.3 5239.3 5274.8 5680.4 5693.4 5735.0 5752.8 5806.9 6245.1 6246.9 6251.0 6256.2 6260.8 6137.5 6223.6 6261.7 6295.8 6317.3 5846.3 5846.3 5890.3 5900.9 5909.1 6299.3 6302.4 6308.4 6321.1 6326.4 5907.6 6057.4 6098.1 6185.4 6194.6 6283.2 6312.0 6330.6 6343.2 6363.7 6233.6 6256.1 6263.7 6265.7 6284.7 6055.2 6081.3 6091.7 6271.2 6288.0 4965.6 4974.0 4988.2 4988.8 4992.8 4434.0 4488.1 4489.3 4503.0 4522.2 5672.4 5713.3 5719.2 5723.7 5772.5 6296.0 6312.8 6320.6 6327.7 6329.1 5609.8 5657.3 5677.6 5709.9 5720.7 5452.1 5481.7 5487.1 5535.0 5540.0 6246.0 6308.5 6310.7 6324.1 6325.4 6125.9 6217.9 6314.7 6345.7 6352.7 6242.0 6285.2 6311.3 6313.2 6321.4 6207.6 6230.3 6235.6 6253.1 6260.1 6121.1 6164.4 6323.5 6332.1 6335.4 6143.6 6143.9 6175.6 6187.4 6191.4 6114.5 6114.8 6140.0 6150.3 6197.4 5803.9 5862.8 6005.3 6009.4 6084.1 4612.5 6099.4 6127.0 6186.9 6192.9 4888.4 5977.4 5983.6 6002.1 6044.2 00:18:51 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:70938.02 Median:38895.02 stddev:157004.46 (403.7%) stddev-sans-first:157355.79 00:18:51 INFO - PROCESS | 1658 | Values: 485.2 522.6 528.4 542.9 549.9 30477.8 31223.8 32302.5 32372.9 32383.5 32627.0 33409.5 41118.0 42405.4 42748.4 9656.5 9804.5 9807.8 9815.7 9820.0 9738.9 9838.4 9848.8 9850.6 9865.7 9762.0 9835.5 9855.3 9884.6 9884.9 9707.6 9785.1 9811.4 9841.3 9878.3 9735.0 9797.6 9805.8 9808.4 9824.1 39859.0 40110.0 40164.6 40178.6 40275.4 3181.0 3320.4 3324.8 3332.8 3399.9 30268.7 31236.5 31238.5 31277.9 31649.4 3160.2 3196.0 3284.9 3322.4 3383.9 497471.0 497974.0 499112.0 499516.0 499976.0 52984.5 58561.1 58636.0 58670.4 58702.0 60562.0 60590.7 60704.0 60711.7 60807.0 16240.6 16474.7 16476.3 16478.0 16501.0 12892.9 12951.0 12970.5 12982.2 12986.6 15190.6 15923.8 15932.6 15970.3 15992.6 5896.9 6937.9 6937.9 7008.8 7049.4 823.3 1011.8 1014.5 1022.8 1027.6 29091.0 29507.1 29530.7 30257.0 30453.2 824.6 1023.3 1058.8 1066.4 1116.3 14757.3 15264.2 15290.9 15442.0 15733.2 633275.2 639201.0 639312.0 641095.0 641649.0 57150.4 57176.7 57180.7 57250.6 57256.0 1056.7 1164.8 1276.2 1377.7 1397.9 28706.6 30963.8 31238.7 31647.8 31821.5 48606.0 49084.0 54813.5 56026.0 56207.7 607717.0 613792.0 614198.0 615371.0 615444.0 25013.9 25233.4 25277.1 25684.5 25779.7 46461.5 46806.8 46833.5 47223.0 47496.3 37981.6 38523.6 38666.0 39053.8 39972.6 37998.4 38131.0 38697.4 39070.4 39181.2 32291.0 37004.8 37630.4 38407.6 38736.2 30807.0 33001.0 34404.3 34573.5 34663.5 24881.8 25387.4 25522.9 25787.2 25987.2 00:18:51 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:33977.84 Median:349.59 stddev:95648.40 (27360.1%) stddev-sans-first:95883.33 00:18:51 INFO - PROCESS | 1658 | Values: 321.7 377.5 380.5 395.6 405.9 19026.4 20797.3 21078.4 21291.9 21450.2 19963.5 20590.1 20632.8 20873.2 21246.5 5836.2 5839.8 6119.3 6149.7 6208.3 3899.2 4112.0 6121.6 6154.8 6172.9 5879.4 6141.0 6188.0 6198.5 6205.3 5969.8 6051.4 6165.6 6176.0 6177.1 5968.2 5968.4 5968.7 5979.6 5990.3 12924.4 12957.0 13213.0 13319.9 13376.3 2167.2 2201.8 2292.0 2348.9 2696.7 9690.8 9914.2 10056.4 10371.9 10518.4 1830.7 1872.3 1902.1 1912.3 1916.8 116209.0 125784.0 126138.0 127083.4 128150.4 11345.8 11360.4 11547.6 11684.5 11764.3 14603.2 14626.0 14646.0 14648.1 14650.5 8168.5 8478.8 8493.7 8615.5 8652.0 8362.0 8382.2 8422.4 8581.4 8622.2 4474.1 4494.1 4504.9 4520.3 4594.1 1667.7 1723.8 1853.7 1895.9 1896.1 845.7 938.6 959.9 961.8 994.0 14880.7 18848.4 19741.4 20702.0 21416.7 795.2 840.6 874.5 930.5 954.7 8433.7 8659.8 10615.6 11160.4 11224.2 563155.0 564538.0 573277.0 574971.0 576134.0 79966.0 124951.0 131887.0 133117.0 136541.3 993.3 995.6 995.6 1008.0 1016.4 18917.1 19106.9 19313.9 19346.6 19398.9 50364.5 51062.0 52851.7 55781.4 56367.0 79759.8 80906.4 81828.0 82861.6 83032.0 7934.9 8020.3 8154.9 8200.3 8234.9 10620.7 12711.9 12735.0 13040.5 13045.2 11078.3 11107.3 11181.2 11251.4 11318.7 10830.9 10935.6 11061.7 11215.2 11227.2 11263.0 11331.7 11436.0 11550.8 11633.5 7851.9 7863.8 8030.3 8284.8 8318.4 8276.4 9839.9 10662.0 10955.6 10984.0 00:18:51 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5627.31 Median:4939.65 stddev:3150.38 (63.8%) stddev-sans-first:3143.24 00:18:51 INFO - PROCESS | 1658 | Values: 1405.0 1492.4 1690.3 1859.5 1902.6 8349.0 8872.0 8880.6 8895.8 8907.8 7758.8 7991.0 8393.5 8600.9 8656.5 2365.6 2396.7 2400.1 2404.2 2408.6 2353.0 2378.0 2399.4 2402.5 2405.4 2374.1 2381.8 2395.9 2399.0 2399.9 2342.9 2351.6 2355.3 2358.3 2375.8 2331.6 2350.0 2354.9 2358.0 2360.8 8651.7 8697.5 8776.3 8778.4 8790.1 5119.6 5293.8 5295.1 5295.5 5304.2 3628.3 3634.7 3685.6 3714.8 3715.5 951.8 1085.1 1088.0 1088.5 1091.2 11369.8 11491.6 11494.8 11501.4 11502.9 4164.6 4281.4 4530.9 4752.0 4752.4 9833.4 9843.8 9845.7 9846.4 9851.0 5314.7 5325.0 5327.1 5332.8 5333.7 4369.2 4542.7 4718.1 4842.6 4887.6 3800.6 3821.4 3930.8 3943.9 4006.9 1069.9 1092.7 1265.5 1274.6 1287.0 871.5 881.8 902.2 902.4 916.0 4525.8 5640.8 5949.4 5988.0 6080.4 409.2 424.5 433.0 435.7 454.0 3942.8 3954.6 3967.3 4071.2 4086.8 10105.1 10598.9 10600.3 10610.4 10615.4 10161.7 10569.5 10579.7 10586.6 10616.8 7977.5 8000.6 8095.9 8113.6 8151.5 5655.1 5719.4 5794.8 5852.9 5887.1 8563.3 9685.5 9851.8 9925.8 9979.3 9714.5 9877.8 10059.9 10072.7 10090.6 6740.1 6955.2 7090.5 7125.9 7218.9 8132.3 8308.1 8311.8 8321.5 8324.0 7276.8 7388.1 7409.0 7504.0 7508.1 7119.7 7247.5 7268.6 7297.1 7339.3 6707.8 6887.3 6970.9 6979.5 6989.8 4807.7 4927.8 5007.7 5046.5 5106.1 4933.4 4945.9 5066.7 5203.7 5204.2 00:18:51 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4277.89 Median:4563.61 stddev:1327.82 (29.1%) stddev-sans-first:1297.20 00:18:51 INFO - PROCESS | 1658 | Values: 280.3 295.5 310.8 312.9 317.7 4387.1 5269.3 5312.1 5320.9 5347.4 3972.3 4016.7 5152.7 5215.6 5252.8 4006.9 4008.8 4012.2 4030.2 4073.8 4013.8 4019.6 4020.7 4036.9 4055.5 3736.4 3942.7 4001.7 4021.9 4035.6 3491.1 3797.7 3942.6 3988.1 3993.3 2852.9 3412.0 3420.5 3444.2 3470.8 4996.7 5133.6 5179.5 5187.5 5210.8 3990.3 4494.7 4501.0 4536.0 4567.4 4544.7 5463.5 5498.6 5519.7 5592.5 3226.0 3277.5 3710.1 3784.5 3799.5 5363.0 5481.9 5619.3 5689.3 5817.4 3530.8 3647.9 3686.4 3698.7 3851.3 3885.0 3888.5 3891.0 3900.4 3911.5 3747.4 4504.0 4517.8 4522.2 4533.6 4754.4 4871.6 5087.8 5133.7 5553.8 1115.6 1152.9 1214.7 1246.4 1247.9 764.9 798.9 809.4 812.4 813.3 3601.8 4125.1 4285.8 4300.8 4341.8 4321.8 4740.9 4778.0 4873.4 4876.7 4293.4 4300.3 4317.5 4339.0 4342.4 2342.5 2365.5 2386.0 2495.5 2532.7 4098.5 4335.7 4879.7 4896.7 4900.5 4165.9 4722.3 4782.7 4819.7 4930.0 4887.5 5187.7 5288.6 5889.4 5956.9 5640.7 5709.0 5712.3 5731.4 5754.8 5027.1 5177.8 5411.5 5413.4 5693.4 5036.5 5585.2 5767.7 5774.7 5891.8 3371.5 3580.7 3651.8 3712.0 3734.2 4986.7 5231.9 5608.0 5647.4 5651.2 4465.9 4607.8 5275.7 5456.8 5465.7 4708.9 5437.8 5452.1 5453.9 5488.3 4414.4 5325.7 5347.8 5349.6 5378.4 4828.6 5015.2 5192.7 5351.9 5438.7 4048.9 4559.8 4898.1 5440.4 5538.5 00:18:51 INFO - PROCESS | 1658 | 00:18:51 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24573.96 Median:4487.15 stddev:40291.15 (897.9%) stddev-sans-first:40364.31 00:18:51 INFO - PROCESS | 1658 | Values: 702.4 720.5 765.9 799.2 800.5 15911.8 16523.9 16535.6 16539.6 16565.2 14417.0 14492.2 14507.3 14513.2 15046.3 658.7 666.9 684.7 824.6 831.5 820.5 835.2 835.4 835.5 836.1 812.3 841.5 895.5 897.2 900.8 705.5 871.0 892.5 895.3 897.3 673.6 673.8 675.0 675.4 675.7 15074.8 15100.6 15103.4 15107.9 15108.1 11153.3 13215.9 13762.0 14002.2 14009.4 11173.5 12325.3 12634.4 12727.5 13023.2 4544.4 4568.8 4583.1 4685.6 4747.7 112744.4 113324.0 113350.4 114767.0 115352.8 8834.0 10697.9 10719.4 10846.0 10913.7 21031.9 21271.7 21419.6 21420.1 21462.1 7613.5 7687.0 7747.3 7748.9 7808.9 4324.2 4330.4 4353.1 4476.4 4497.9 3465.4 3567.1 3571.6 3577.0 3579.8 493.3 656.8 661.2 679.4 682.2 509.3 548.7 604.0 615.4 623.6 8747.6 8921.8 8955.1 8998.2 9110.4 525.9 544.9 583.3 595.7 600.4 3452.8 4348.7 4377.1 4396.5 4520.7 123864.0 154865.0 157396.0 160433.2 168832.2 134461.3 135431.0 136862.6 136910.0 140386.0 78413.0 94105.5 95287.6 95745.0 95877.5 8382.8 8407.4 8459.2 8485.2 8603.0 56459.2 60622.8 64337.0 65318.3 65914.3 85844.0 93769.0 100411.0 100560.5 100845.0 10249.9 10759.3 10840.4 11162.9 11269.7 12082.5 12124.3 12235.3 12557.9 12631.0 11743.6 11938.9 11997.6 12150.1 12397.0 11662.9 11683.6 11857.4 11941.7 12307.0 10096.2 11718.5 11833.9 11882.8 12253.4 9434.5 9620.0 9621.8 9728.4 9946.3 9813.6 9950.9 9972.8 9994.5 10003.5 00:18:51 INFO - PROCESS | 1658 | -------- Summary: end -------- 00:18:51 INFO - PROCESS | 1658 | 00:18:52 INFO - TEST-INFO | 1658: exit 0 00:18:52 INFO - TEST-OK | dromaeo_css | took 1118060ms 00:18:52 INFO - TEST-START | kraken 00:18:52 INFO - operating with platform_type : mac_ 00:18:52 INFO - Initialising browser for kraken test... 00:18:52 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpIMMJ_u/profile http://localhost:49279/getInfo.html) 00:18:54 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 00:18:54 INFO - PROCESS | 1663 | colorDepth:24 00:18:54 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 00:18:54 INFO - PROCESS | 1663 | __metrics 00:18:55 INFO - PROCESS | 1663 | 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" 00:18:55 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:18:55 INFO - TEST-INFO | 1663: exit 0 00:18:55 INFO - Browser initialized. 00:18:55 INFO - Running cycle 1/1 for kraken test... 00:18:55 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/T/tmpIMMJ_u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:19:07 INFO - PROCESS | 1664 | RSS: Main: 233795584 00:19:07 INFO - PROCESS | 1664 | 00:19:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 00:19:11 INFO - PROCESS | 1664 | RSS: Main: 293609472 00:19:11 INFO - PROCESS | 1664 | 00:19:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 00:19:14 INFO - PROCESS | 1664 | RSS: Main: 290287616 00:19:14 INFO - PROCESS | 1664 | 00:19:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 00:19:18 INFO - PROCESS | 1664 | RSS: Main: 376221696 00:19:18 INFO - PROCESS | 1664 | 00:19:20 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 00:19:20 INFO - PROCESS | 1664 | RSS: Main: 281186304 00:19:20 INFO - PROCESS | 1664 | 00:19:23 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:19:23 INFO - PROCESS | 1664 | RSS: Main: 285040640 00:19:23 INFO - PROCESS | 1664 | 00:19:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 00:19:27 INFO - PROCESS | 1664 | RSS: Main: 323497984 00:19:27 INFO - PROCESS | 1664 | 00:19:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 00:19:30 INFO - PROCESS | 1664 | RSS: Main: 324272128 00:19:30 INFO - PROCESS | 1664 | 00:19:33 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 00:19:34 INFO - PROCESS | 1664 | RSS: Main: 323026944 00:19:34 INFO - PROCESS | 1664 | 00:19:35 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:19:36 INFO - PROCESS | 1664 | RSS: Main: 298061824 00:19:36 INFO - PROCESS | 1664 | 00:19:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:19:38 INFO - PROCESS | 1664 | RSS: Main: 303996928 00:19:38 INFO - PROCESS | 1664 | 00:19:40 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:19:41 INFO - PROCESS | 1664 | RSS: Main: 301789184 00:19:41 INFO - PROCESS | 1664 | 00:19:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:19:45 INFO - PROCESS | 1664 | RSS: Main: 319037440 00:19:45 INFO - PROCESS | 1664 | 00:19:48 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:19:48 INFO - PROCESS | 1664 | RSS: Main: 315072512 00:19:48 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 00:19:50 INFO - PROCESS | 1664 | RSS: Main: 358891520 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | __start_tp_report 00:19:50 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 00:19:50 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 00:19:50 INFO - PROCESS | 1664 | |i|pagename|runs| 00:19:50 INFO - PROCESS | 1664 | |0;ai-astar;112;111;115;110;112;113;112;111;112;122 00:19:50 INFO - PROCESS | 1664 | |1;audio-beat-detection;145;113;128;163;106;131;129;107;161;110 00:19:50 INFO - PROCESS | 1664 | |2;audio-dft;186;185;185;181;184;181;183;185;192;181 00:19:50 INFO - PROCESS | 1664 | |3;audio-fft;78;76;73;145;59;58;61;66;137;57 00:19:50 INFO - PROCESS | 1664 | |4;audio-oscillator;77;81;132;56;98;63;114;90;101;151 00:19:50 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;86;83;86;83;85;83;87;83;85;82 00:19:50 INFO - PROCESS | 1664 | |6;imaging-darkroom;96;95;95;97;95;95;96;96;94;94 00:19:50 INFO - PROCESS | 1664 | |7;imaging-desaturate;84;84;86;84;87;84;99;134;136;87 00:19:50 INFO - PROCESS | 1664 | |8;json-parse-financial;55;54;58;56;56;55;56;56;54;54 00:19:50 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;66;65;77;79;74;71;70;70;70;71 00:19:50 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;85;89;86;85;85;95;103;103;82;85 00:19:50 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;139;138;139;137;140;137;139;137;181;152 00:19:50 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;169;168;169;170;170;169;172;167;170;167 00:19:50 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;69;66;66;78;86;85;72;68;64;67 00:19:50 INFO - PROCESS | 1664 | __end_tp_report 00:19:50 INFO - PROCESS | 1664 | __start_cc_report 00:19:50 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,2000 00:19:50 INFO - PROCESS | 1664 | __end_cc_report 00:19:50 INFO - PROCESS | 1664 | __startTimestamp1472973590726__endTimestamp 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | ------- Summary: start ------- 00:19:50 INFO - PROCESS | 1664 | Number of tests: 14 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.00 Median:112.00 stddev:3.43 (3.1%) stddev-sans-first:3.62 00:19:50 INFO - PROCESS | 1664 | Values: 112.0 111.0 115.0 110.0 112.0 113.0 112.0 111.0 112.0 122.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:130.00 stddev:21.27 (16.4%) stddev-sans-first:21.78 00:19:50 INFO - PROCESS | 1664 | Values: 145.0 113.0 128.0 163.0 106.0 131.0 129.0 107.0 161.0 110.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:3.30 (1.8%) stddev-sans-first:3.44 00:19:50 INFO - PROCESS | 1664 | Values: 186.0 185.0 185.0 181.0 184.0 181.0 183.0 185.0 192.0 181.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:81.00 Median:63.50 stddev:32.56 (51.3%) stddev-sans-first:34.52 00:19:50 INFO - PROCESS | 1664 | Values: 78.0 76.0 73.0 145.0 59.0 58.0 61.0 66.0 137.0 57.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:70.00 stddev:29.78 (42.5%) stddev-sans-first:30.76 00:19:50 INFO - PROCESS | 1664 | Values: 77.0 81.0 132.0 56.0 98.0 63.0 114.0 90.0 101.0 151.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:84.30 Median:85.00 stddev:1.70 (2.0%) stddev-sans-first:1.69 00:19:50 INFO - PROCESS | 1664 | Values: 86.0 83.0 86.0 83.0 85.0 83.0 87.0 83.0 85.0 82.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:0.95 (1.0%) stddev-sans-first:0.97 00:19:50 INFO - PROCESS | 1664 | Values: 96.0 95.0 95.0 97.0 95.0 95.0 96.0 96.0 94.0 94.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:85.00 stddev:20.79 (24.5%) stddev-sans-first:21.55 00:19:50 INFO - PROCESS | 1664 | Values: 84.0 84.0 86.0 84.0 87.0 84.0 99.0 134.0 136.0 87.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.33 00:19:50 INFO - PROCESS | 1664 | Values: 55.0 54.0 58.0 56.0 56.0 55.0 56.0 56.0 54.0 54.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.00 stddev:4.37 (6.2%) stddev-sans-first:4.20 00:19:50 INFO - PROCESS | 1664 | Values: 66.0 65.0 77.0 79.0 74.0 71.0 70.0 70.0 70.0 71.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:85.00 stddev:7.77 (9.1%) stddev-sans-first:8.05 00:19:50 INFO - PROCESS | 1664 | Values: 85.0 89.0 86.0 85.0 85.0 95.0 103.0 103.0 82.0 85.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:139.00 stddev:13.77 (9.9%) stddev-sans-first:14.49 00:19:50 INFO - PROCESS | 1664 | Values: 139.0 138.0 139.0 137.0 140.0 137.0 139.0 137.0 181.0 152.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:169.50 stddev:1.52 (0.9%) stddev-sans-first:1.62 00:19:50 INFO - PROCESS | 1664 | Values: 169.0 168.0 169.0 170.0 170.0 169.0 172.0 167.0 170.0 167.0 00:19:50 INFO - PROCESS | 1664 | 00:19:50 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:70.50 stddev:8.08 (11.5%) stddev-sans-first:8.49 00:19:50 INFO - PROCESS | 1664 | Values: 69.0 66.0 66.0 78.0 86.0 85.0 72.0 68.0 64.0 67.0 00:19:50 INFO - PROCESS | 1664 | -------- Summary: end -------- 00:19:50 INFO - PROCESS | 1664 | 00:19:51 INFO - TEST-INFO | 1664: exit 0 00:19:51 INFO - TEST-OK | kraken | took 58961ms 00:19:51 INFO - SUITE-END | took 1177s 00:19:51 INFO - Completed test suite (00:19:37) 00:19:51 INFO - javascript benchmark 00:19:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2868.956965645515, 3304.8512816923235, 3335.749818763592, 3367.276035652337, 3402.2685122698613, 5622.100463925773, 5668.234788303583, 5701.0, 5718.113692377683, 5735.569832262576, 5712.11462223356, 5744.597878148531, 5768.019436695761, 5769.596128271022, 5771.480566748992, 5188.455212202721, 5229.084910140729, 5235.0, 5240.947590524103, 5286.524212820846, 5268.525832675058, 5268.736563171826, 5269.789208431658, 5273.709945952971, 5281.815136470224, 5163.535281824635, 5204.505571970676, 5230.790768369261, 5231.24146998685, 5257.789688412478, 5299.390570084451, 5338.893222135574, 5346.866328341823, 5353.362583971634, 5371.301730775013, 5123.052235336475, 5133.871653208662, 5154.304168937183, 5239.266502689627, 5274.7626356814035, 5680.4319568043275, 5693.402192769741, 5735.0, 5752.827415177551, 5806.941930580682, 6245.125682404467, 6246.937530624681, 6251.0, 6256.15541901842, 6260.812175634738, 6137.508999280047, 6223.626582405025, 6261.749530018839, 6295.842603934938, 6317.273513545955, 5846.327672317653, 5846.327672317738, 5890.263717035371, 5900.881982360329, 5909.084091965795, 6299.307076221612, 6302.432781049728, 6308.369163083655, 6321.146645202839, 6326.398992095744, 5907.616004959664, 6057.446438767604, 6098.069176274479, 6185.350538193515, 6194.566380353423, 6283.183186185766, 6312.0, 6330.588511746721, 6343.207099112611, 6363.681815909186, 6233.594816337014, 6256.092866534327, 6263.686815659199, 6265.71804268809, 6284.654344011124, 6055.212822333068, 6081.331053584102, 6091.6925608203255, 6271.184745983084, 6288.0, 4965.602751779849, 4974.030064137531, 4988.226824842155, 4988.7505624718615, 4992.750362481861, 4434.024514606781, 4488.102379524108, 4489.349044388546, 4502.977485112553, 4522.23122069249, 5672.404397538282, 5713.257276554022, 5719.19931209631, 5723.7424315905055, 5772.509336706343, 6295.968520157461, 6312.810615681537, 6320.5575609706875, 6327.683615819191, 6329.113924050636, 5609.775608975595, 5657.349404818417, 5677.602567820213, 5709.857253568694, 5720.685362305113, 5452.073147564924, 5481.725913704299, 5487.122060470386, 5535.03136951032, 5540.0, 6246.000639897686, 6308.495320374359, 6310.6844657766005, 6324.114623952651, 6325.399087086719, 6125.907024958145, 6217.875642487215, 6314.715837787218, 6345.682715864281, 6352.650604216812, 6242.032484964838, 6285.1515045470105, 6311.274203466476, 6313.2424109107205, 6321.367863213642, 6207.565470417027, 6230.345813689497, 6235.563510554218, 6253.062040693932, 6260.092286618506, 6121.087175196906, 6164.3835616438, 6323.462505687068, 6332.050192471166, 6335.3981371769605, 6143.642898274451, 6143.938560614337, 6175.5677102602385, 6187.381261873777, 6191.442770150528, 6114.541409394402, 6114.847128821815, 6139.986902161093, 6150.261968563801, 6197.442230199304, 5803.854903627274, 5862.765489380377, 6005.3075707426715, 6009.429104235091, 6084.148219249397, 4612.4926258112255, 6099.359567245376, 6126.9757403264, 6186.876262474635, 6192.938070619236, 4888.364512613338, 5977.372375900468, 5983.55123365758, 6002.069679199731, 6044.214252147192], "value": 5718.541544989956, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.19457700217635, 522.581934452438, 528.4029047176691, 542.9321334833146, 549.9037668408033, 30477.847610761943, 31223.843880780594, 32302.515462268027, 32372.895761775468, 32383.51424728625, 32627.0, 33409.498857517094, 41118.0, 42405.36391954123, 42748.358774618326, 9656.517174141283, 9804.509774511245, 9807.754806129868, 9815.65645202418, 9820.0, 9738.853917191247, 9838.36050656705, 9848.803023939518, 9850.605975760996, 9865.654702085429, 9761.951190244074, 9835.45904975226, 9855.310128291023, 9884.604615815395, 9884.851727224097, 9707.563159657833, 9785.07041831025, 9811.362261452983, 9841.311108222462, 9878.308518403715, 9734.977827328099, 9797.559109840004, 9805.754856128653, 9808.411495310304, 9824.115829575301, 39859.0, 40109.99725006869, 40164.59835401667, 40178.593749218926, 40275.375216230386, 3180.9522857157162, 3320.4355259605927, 3324.817135057571, 3332.8333583320978, 3399.932001359959, 30268.69731302681, 31236.531452028237, 31238.53142202869, 31277.905273315326, 31649.36701265962, 3160.2099475131217, 3195.984020079908, 3284.9343013139605, 3322.368749937504, 3383.932321353559, 497470.9999999964, 497974.0, 499112.0, 499516.0, 499976.0, 52984.47015529795, 58561.12158317629, 58636.0, 58670.41329586649, 58702.0, 60562.0, 60590.697046514484, 60704.0, 60711.69644151751, 60807.04754190963, 16240.59398515023, 16474.670506589802, 16476.258568364214, 16478.011319320878, 16501.0, 12892.935535322264, 12951.028672849574, 12970.546030888874, 12982.15615984958, 12986.610401687965, 15190.620234494227, 15923.840761592468, 15932.601684957737, 15970.281337339848, 15992.600184995468, 5896.882062358729, 6937.861242775116, 6937.89593156093, 7008.789736307919, 7049.3655570997835, 823.2960818500096, 1011.7690492464098, 1014.5282443663732, 1022.7801022779989, 1027.5838285494387, 29091.0, 29507.114786556438, 29530.704692952797, 30257.0, 30453.23866903345, 824.5712229640674, 1023.2683631203726, 1058.7564860082225, 1066.4188017530464, 1116.3469370418234, 14757.262136893112, 15264.236788160548, 15290.923545382424, 15442.0, 15733.213339332988, 633275.1681207914, 639201.0, 639312.0, 641095.0, 641649.0, 57150.42849571534, 57176.71411642998, 57180.71409642925, 57250.56873578194, 57255.99999999916, 1056.7463808686014, 1164.8468016663442, 1276.2278821312973, 1377.6762460821699, 1397.881180099703, 28706.569401459412, 30963.84518077395, 31238.687613123577, 31647.84176079197, 31821.522677160323, 48606.0, 49084.0, 54813.451865480834, 56026.0, 56207.718961404935, 607717.0, 613792.0, 614198.0, 615371.0, 615444.0, 25013.874375653504, 25233.369165771004, 25277.11530096438, 25684.486310274064, 25779.742202577734, 46461.535384647075, 46806.76596617131, 46833.531664682916, 47223.0, 47496.287555686, 37981.62018379781, 38523.614763852005, 38666.0, 39053.80473097616, 39972.600273998054, 37998.43002355022, 38131.0, 38697.41953870638, 39070.4139437903, 39181.2163756729, 32291.031269061965, 37004.81497592495, 37630.435543467414, 38407.61592384041, 38736.22527549489, 30807.0, 33001.0, 34404.311913761085, 34573.48139777956, 34663.48004779981, 24881.751182487944, 25387.36531586725, 25522.872385637955, 25787.226383208534, 25987.18388490317], "value": 19657.97503562686, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.67350139608294, 377.5073529044596, 380.4901432081011, 395.6221808173195, 405.8721502726641, 19026.41010473571, 20797.272095476663, 21078.367648970518, 21291.893540532314, 21450.249241276557, 19963.500912477197, 20590.073446694896, 20632.793672063275, 20873.165073397086, 21246.468838279052, 5836.15375770513, 5839.7664093436215, 6119.296280927706, 6149.692515374213, 6208.286047104596, 3899.2396482685886, 4111.958880411203, 6121.602095863755, 6154.784582539612, 6172.87654246917, 5879.441453061973, 6141.0, 6188.0, 6198.535109866778, 6205.286392064902, 5969.761209551612, 6051.394860513958, 6165.568410211287, 6176.042713379411, 6177.073438984144, 5968.1644569760265, 5968.432998865144, 5968.731407086691, 5979.641221526722, 5990.281166260077, 12924.35378231094, 12957.0, 13213.0, 13319.934405247557, 13376.264305463195, 2167.1981366894192, 2201.7798220178015, 2291.9885400573057, 2348.859068455898, 2696.730326967307, 9690.75773105671, 9914.157296629795, 10056.396616203052, 10371.896281037169, 10518.368897866076, 1830.7070868661083, 1872.2885303584687, 1902.1060101752294, 1912.3306842605116, 1916.7795703494137, 116209.0, 125784.0, 126138.0, 127083.36458317649, 128150.3592482041, 11345.829812552818, 11360.375179365048, 11547.595834145764, 11684.47419866108, 11764.294142351486, 14603.196824174773, 14625.976181667182, 14646.0, 14648.12111273327, 14650.487232946796, 8168.469049511763, 8478.788030299293, 8493.745187644257, 8615.483071015758, 8651.95674021626, 8362.038365588036, 8382.16178382157, 8422.368322375723, 8581.442206256574, 8622.180892815173, 4474.127545128668, 4494.10117976406, 4504.909901801946, 4520.321951707205, 4594.1271158479785, 1667.7331626939874, 1723.7672914156428, 1853.6570734413906, 1895.9336423225398, 1896.1183049881872, 845.7251393297203, 938.5823308627731, 959.9040095990345, 961.8412961861214, 993.965211217604, 14880.70238595222, 18848.434546963614, 19741.40775776729, 20702.0, 21416.678749818766, 795.1890068607445, 840.6301227459898, 874.505904164158, 930.4928813796497, 954.6849539651898, 8433.704820331259, 8659.826803464022, 10615.628453004263, 11160.441977901073, 11224.214304998572, 563155.0, 564538.0, 573277.0, 574971.0, 576134.0, 79966.0, 124951.0, 131887.02169467465, 133117.0, 136541.3172934129, 993.2600212841335, 995.5868314649484, 995.6316163019729, 1007.969760907174, 1016.3546148195949, 18917.148728306984, 19106.904465477583, 19313.90343048276, 19346.613067738286, 19398.90300548545, 50364.49635503598, 51062.0, 52851.73574132258, 55781.442185579246, 56367.0, 79759.80360294717, 80906.3818723634, 81828.0, 82861.58569207115, 83032.0, 7934.920650793418, 8020.318272946864, 8154.877676834971, 8200.343972482067, 8234.917650823416, 10620.734481638021, 12711.936440317739, 12735.0, 13040.478380865039, 13045.217286962434, 11078.279911805706, 11107.278026928223, 11181.217314787888, 11251.437428128724, 11318.660440186808, 10830.891691082988, 10935.61725339641, 11061.723456913642, 11215.158863085138, 11227.21409501327, 11262.986331230228, 11331.716707082389, 11436.0, 11550.826737598774, 11633.451797201935, 7851.939988101533, 7863.84272314562, 8030.27727504504, 8284.792880178044, 8318.417710760188, 8276.379271554779, 9839.901600983898, 10662.0, 10955.616553420592, 10984.0], "value": 9352.871195948235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.957851264462, 1492.4477943161025, 1690.3323187341, 1859.4607563806496, 1902.5529000684828, 8348.958255208723, 8871.95564022179, 8880.555972201397, 8895.822083558332, 8907.82184356314, 7758.806029849256, 7991.0, 8393.53835539045, 8600.8709869352, 8656.523891185981, 2365.6451532270125, 2396.6764486794323, 2400.1119585753295, 2404.1825779235055, 2408.602580574212, 2353.0470159585393, 2378.0131245533084, 2399.4121440247163, 2402.4954759500524, 2405.4226985523437, 2374.1453076892303, 2381.7975472084895, 2395.928122156329, 2398.9880050599722, 2399.940001499959, 2342.8711420871846, 2351.5532048910736, 2355.328731311585, 2358.2689366296418, 2375.798057165143, 2331.568659797943, 2350.001249468969, 2354.8587084774967, 2358.0449917783326, 2360.834741568091, 8651.65393384264, 8697.52163631, 8776.341774366949, 8778.385513014091, 8790.120987901222, 5119.59043276537, 5293.788248470057, 5295.073362161606, 5295.523402893758, 5304.151335786256, 3628.2924829658227, 3634.6728794408364, 3685.6130106338715, 3714.7956862372557, 3715.479832823407, 951.7858481841599, 1085.1264731890824, 1087.9510422031028, 1088.4612117002055, 1091.154355374583, 11369.772604547945, 11491.59779407725, 11494.827577586342, 11501.424928753613, 11502.942485287604, 4164.646005089601, 4281.422008028876, 4530.88672783183, 4752.0, 4752.429708434941, 9833.360831545926, 9843.75390615226, 9845.704628861145, 9846.409215447096, 9850.950745246228, 5314.73426328682, 5324.988252232063, 5327.094393953037, 5332.786688532493, 5333.679979201261, 4369.191699535596, 4542.659300552472, 4718.103560323528, 4842.564169224786, 4887.633427492952, 3800.600936901641, 3821.3885778275344, 3930.8427662893164, 3943.9014024649614, 4006.859759908389, 1069.946502674863, 1092.7215158264848, 1265.5446236827722, 1274.5602767045355, 1286.9935650321688, 871.4858233642054, 881.8104107616765, 902.1880307723102, 902.3863772634671, 916.0, 4525.7510836904285, 5640.830775076673, 5949.375315591887, 5987.982043052692, 6080.391960803884, 409.2328332134944, 424.4609346130459, 432.9889707532883, 435.7320248047428, 454.0215834875848, 3942.822572984165, 3954.6045395460224, 3967.3453880110037, 4071.185762847442, 4086.7752273625238, 10105.090541851268, 10598.894011059945, 10600.310979786444, 10610.363378197178, 10615.416152111553, 10161.745956351151, 10569.471526423647, 10579.682609521727, 10586.57653693859, 10616.787664246673, 7977.481463704957, 8000.63997120131, 8095.919040809635, 8113.553754543556, 8151.5109093454585, 5655.123455864347, 5719.399463056319, 5794.82615521535, 5852.853678657897, 5887.116932460165, 8563.272121869712, 9685.515724213621, 9851.802963940538, 9925.801483970135, 9979.251556133175, 9714.514274286399, 9877.753056173653, 10059.949700251453, 10072.748181295527, 10090.596376144871, 6740.12378390806, 6955.200151982587, 7090.539114957512, 7125.893111603434, 7218.855622887618, 8132.349412046904, 8308.12764659702, 8311.792205194919, 8321.500709957421, 8323.95838020806, 7276.7816965489, 7388.113426388652, 7408.9629551851895, 7504.0, 7508.061492313461, 7119.715211391486, 7247.456440766858, 7268.636568171464, 7297.051383320135, 7339.339459448675, 6707.765228217184, 6887.345702158287, 6970.895436568557, 6979.476539259677, 6989.825254368478, 4807.735574543433, 4927.827526036572, 5007.674501157413, 5046.47012063728, 5106.055379754757, 4933.367758336529, 4945.925811112764, 5066.721330326867, 5203.687778733288, 5204.219367094966], "value": 4455.290191460909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.26710152950034, 295.48585461297347, 310.773135611004, 312.9311551458678, 317.7140573483863, 4387.1445068211715, 5269.314989051422, 5312.07038768215, 5320.946790532098, 5347.411784703684, 3972.2849887020325, 4016.698747593935, 5152.716600586966, 5215.556677682402, 5252.820079666933, 4006.8597599084037, 4008.7594744315434, 4012.2176175645686, 4030.2141082488924, 4073.8370465181506, 4013.8193781279765, 4019.648505624213, 4020.718549701522, 4036.8587099451524, 4055.5336136344254, 3736.383496723051, 3942.704297177723, 4001.659858911996, 4021.8793436196815, 4035.556088830226, 3491.14466955595, 3797.658210761017, 3942.6057394260633, 3988.082740969579, 3993.3410987187226, 2852.857357132135, 3411.96588034119, 3420.521127042216, 3444.1733983843947, 3470.8264586770815, 4996.7001979881325, 5133.6149788765615, 5179.482051794828, 5187.46969643956, 5210.76551555181, 3990.2618015667194, 4494.68537202396, 4500.977495112504, 4536.024754677727, 4567.378580603904, 4544.659150563721, 5463.453654634544, 5498.5978575463005, 5519.724013799294, 5592.462072929936, 3225.983870080658, 3277.475603903364, 3710.089304008438, 3784.4890939723336, 3799.4870692456443, 5362.962074411698, 5481.917771233435, 5619.269494965669, 5689.345725241567, 5817.418258174191, 3530.7881527108457, 3647.9238624605805, 3686.4101743720876, 3698.7410881238593, 3851.326017946904, 3884.9611503885167, 3888.5333759948985, 3890.9805450972563, 3900.395438707005, 3911.4940747812298, 3747.362948298796, 4503.954960450419, 4517.774111294422, 4522.186006518858, 4533.614642755337, 4754.380073873586, 4871.61554600862, 5087.821926232564, 5133.717645529532, 5553.77784888608, 1115.609536662178, 1152.8558930133734, 1214.7145420826098, 1246.389269258057, 1247.8956123830476, 764.9235076492306, 798.9121196668361, 809.4091313341177, 812.3501199040744, 813.2924355810483, 3601.8019008954757, 4125.092479654471, 4285.849995250152, 4300.849575212394, 4341.848035318749, 4321.783910804447, 4740.881477963078, 4778.0, 4873.415190177201, 4876.683015603974, 4293.350651945883, 4300.2904520754355, 4317.525072242051, 4338.978305108518, 4342.435483387139, 2342.524209747848, 2365.5032443187124, 2385.9880700596386, 2495.463475352808, 2532.683414573178, 4098.545016519093, 4335.653147748172, 4879.731614761222, 4896.698551680775, 4900.534449227318, 4165.937510937339, 4722.338872557844, 4782.715099814724, 4819.734914579662, 4930.0, 4887.462379138292, 5187.740612969261, 5288.576913846883, 5889.411058894162, 5956.910646340309, 5640.661560306395, 5709.0, 5712.258470701697, 5731.369549349485, 5754.827355179351, 5027.139958215484, 5177.834987128017, 5411.512963833274, 5413.431589683027, 5693.430656934273, 5036.546710796046, 5585.245991791056, 5767.68277744728, 5774.682392468287, 5891.793787217427, 3371.477420999749, 3580.7314451415727, 3651.7626354286886, 3712.0, 3734.2158146788393, 4986.703457101107, 5231.869203269796, 5607.953097119604, 5647.378788333198, 5651.180578816131, 4465.888352791206, 4607.815687372602, 5275.736213189249, 5456.836294911159, 5465.69938653362, 4708.905821883474, 5437.8368648940595, 5452.127659574449, 5453.918191227055, 5488.341399032141, 4414.381986521954, 5325.7337133143965, 5347.759350829144, 5349.598780091431, 5378.354597448331, 4828.589569886599, 5015.22264049073, 5192.688438693691, 5351.946480535301, 5438.728063596725, 4048.9190216196102, 4559.840405585788, 4898.142825005681, 5440.428754980829, 5538.529225015757], "value": 3854.7189672269515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.4205030849549, 720.531654424624, 765.8812884002981, 799.2167675677836, 800.4596897094467, 15911.84088159118, 16523.91738041308, 16535.594474469654, 16539.58651033725, 16565.171741412927, 14417.0, 14492.20292883891, 14507.347169377377, 14513.20177390243, 15046.322915468803, 658.7299207324997, 666.9199696036483, 684.6816230452838, 824.6289169873551, 831.4844796226317, 820.4871955028108, 835.2232423845821, 835.3985130705883, 835.5028757889046, 836.0928392693935, 812.2851890336495, 841.4993079117914, 895.5298468304127, 897.1970086772335, 900.7928176519405, 705.5449235243291, 870.9912900871037, 892.4868200784575, 895.2837729816154, 897.2911399993997, 673.5891106425076, 673.8281738156738, 674.9932500674979, 675.4157653629575, 675.6587923098804, 15074.773878391832, 15100.622484437978, 15103.39586416553, 15107.924460377628, 15108.093514389062, 11153.330800151936, 13215.933920330337, 13762.036657433984, 14002.159870407808, 14009.369578368998, 11173.49719262627, 12325.260484370967, 12634.368281585885, 12727.490900364068, 13023.158168340362, 4544.409226800528, 4568.794404251817, 4583.083383323348, 4685.554872287127, 4747.691400058985, 112744.43627781891, 113324.0, 113350.43324783405, 114767.0, 115352.84647153589, 8834.0, 10697.946510267555, 10719.410432426292, 10846.0, 10913.727156820984, 21031.8948405257, 21271.680924786142, 21419.57160856774, 21420.143194272056, 21462.141514339564, 7613.505122167041, 7686.961565192139, 7747.2640099190485, 7748.92251077482, 7808.921910780933, 4324.1567894260315, 4330.39374487572, 4353.107612939403, 4476.37330773692, 4497.932531011972, 3465.4455287153933, 3567.0725611341236, 3571.5892672342493, 3576.962680822532, 3579.83890724918, 493.2674977658175, 656.7668477690352, 661.2362721057186, 679.419096672338, 682.2324884504932, 509.32768745256647, 548.6625725179066, 603.9577229593887, 615.4184295840388, 623.6351734235433, 8747.562621868881, 8921.821563568692, 8955.104489550993, 8998.190162885372, 9110.362274640844, 525.8711615654113, 544.9155380915964, 583.2505230778514, 595.7110801261384, 600.3696119074954, 3452.7755695879687, 4348.673849461303, 4377.124575084996, 4396.45735894115, 4520.683552151384, 123864.0, 154865.0, 157396.0, 160433.19783401242, 168832.15583922, 134461.32769336092, 135431.0, 136862.63137368698, 136910.0, 140386.0, 78413.0, 94105.52947235495, 95287.57068643977, 95745.0, 95877.52061239649, 8382.83234335322, 8407.3694472916, 8459.154084591491, 8485.236328730443, 8603.0, 56459.15311270252, 60622.787544247985, 64337.0, 65318.34681653313, 65914.34085659082, 85844.0, 93769.0, 100411.0, 100560.49719751354, 100845.0, 10249.897501024894, 10759.30064545802, 10840.403777792297, 11162.944185279022, 11269.71825704364, 12082.516699331929, 12124.27254364741, 12235.265884046985, 12557.93721031389, 12630.989520838495, 11743.647690569296, 11938.880611193777, 11997.580084696994, 12150.149489535648, 12397.008239341012, 11662.88337116652, 11683.649490515298, 11857.407129643656, 11941.701457463632, 12306.953908917485, 10096.242781791248, 11718.531258749554, 11833.881661183277, 11882.76234475323, 12253.387330633255, 9434.48110353937, 9620.0, 9621.807563848824, 9728.416295022322, 9946.303758736818, 9813.55838987233, 9950.900490994998, 9972.750681233027, 9994.500274986367, 10003.499825008867], "value": 7503.357653351456, "unit": "score"}], "name": "dromaeo_css", "value": 7166.774038883563, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 115.0, 110.0, 112.0, 113.0, 112.0, 111.0, 112.0, 122.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 113.0, 128.0, 163.0, 106.0, 131.0, 129.0, 107.0, 161.0, 110.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 185.0, 181.0, 184.0, 181.0, 183.0, 185.0, 192.0, 181.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 73.0, 145.0, 59.0, 58.0, 61.0, 66.0, 137.0, 57.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 132.0, 56.0, 98.0, 63.0, 114.0, 90.0, 101.0, 151.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 83.0, 85.0, 83.0, 87.0, 83.0, 85.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 94.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 84.0, 87.0, 84.0, 99.0, 134.0, 136.0, 87.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 58.0, 56.0, 56.0, 55.0, 56.0, 56.0, 54.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 77.0, 79.0, 74.0, 71.0, 70.0, 70.0, 70.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 86.0, 85.0, 85.0, 95.0, 103.0, 103.0, 82.0, 85.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 139.0, 137.0, 140.0, 137.0, 139.0, 137.0, 181.0, 152.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 169.0, 170.0, 170.0, 169.0, 172.0, 167.0, 170.0, 167.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 66.0, 78.0, 86.0, 85.0, 72.0, 68.0, 64.0, 67.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1481.5999999999997, "alertThreshold": 2.0}]} 00:19:51 INFO - Return code: 0 00:19:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:19:52 INFO - # TBPL SUCCESS # 00:19:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:19:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:19:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:19:52 INFO - 2016-09-04 00:19:52.050 screenresolution[1668:10384] starting screenresolution argv=screenresolution get 00:19:52 INFO - 2016-09-04 00:19:52.053 screenresolution[1668:10384] Display 0: 1600x1200x32@60 00:19:52 INFO - 2016-09-04 00:19:52.059 screenresolution[1669:10387] starting screenresolution argv=screenresolution list 00:19:52 INFO - Available Modes on Display 0 00:19:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:19:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:19:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:19:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:19:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:19:52 INFO - Intel Iris: 00:19:52 INFO - Chipset Model: Intel Iris 00:19:52 INFO - Type: GPU 00:19:52 INFO - Bus: Built-In 00:19:52 INFO - VRAM (Dynamic, Max): 1536 MB 00:19:52 INFO - Vendor: Intel (0x8086) 00:19:52 INFO - Device ID: 0x0a2e 00:19:52 INFO - Revision ID: 0x0009 00:19:52 INFO - Displays: 00:19:52 INFO - Display: 00:19:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:19:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:19:52 INFO - Display Serial Number: 1600x1200 60 00:19:52 INFO - Main Display: Yes 00:19:52 INFO - Mirror: Off 00:19:52 INFO - Online: Yes 00:19:52 INFO - Rotation: Supported 00:19:52 INFO - Return code: 0 00:19:52 INFO - Running post-action listener: _resource_record_post_action 00:19:52 INFO - [mozharness: 2016-09-04 07:19:52.294251Z] Finished run-tests step (success) 00:19:52 INFO - Running post-run listener: _resource_record_post_run 00:19:52 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 33659904; Write bytes: 707539968; Read time: 249; Write time: 1972 00:19:52 INFO - TinderboxPrint: CPU usage
53.5% 00:19:52 INFO - TinderboxPrint: I/O read bytes / time
33,659,904 / 249 00:19:52 INFO - TinderboxPrint: I/O write bytes / time
707,539,968 / 1,972 00:19:52 INFO - TinderboxPrint: CPU idle
2,256.0 (46.5%) 00:19:52 INFO - TinderboxPrint: CPU system
968.0 (20.0%) 00:19:52 INFO - TinderboxPrint: CPU user
1,625.6 (33.5%) 00:19:52 INFO - TinderboxPrint: Swap in / out
434,638,848 / 0 00:19:52 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402625024; Write bytes: 396818432; Read time: 29826; Write time: 815 00:19:52 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 31300608; Write bytes: 297888768; Read time: 220; Write time: 1121 00:19:52 INFO - Running post-run listener: _upload_blobber_files 00:19:52 INFO - Blob upload gear active. 00:19:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:19:52 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 00:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:19:53 INFO - (blobuploader) - INFO - Open directory for files ... 00:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:19:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:19:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:19:55 INFO - (blobuploader) - INFO - Done attempting. 00:19:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:19:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:19:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:19:56 INFO - (blobuploader) - INFO - Done attempting. 00:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:19:59 INFO - (blobuploader) - INFO - Done attempting. 00:19:59 INFO - (blobuploader) - INFO - Iteration through files over. 00:19:59 INFO - Return code: 0 00:19:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:19:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:19:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de8cb0e4858c6f08860ef68b78766d66ab5c1dee2921b37dc55f674be43a2c5aaaa7bfb16074866681c09e9c974e9cd7563a9a49aac1d44e2409bc4d2a17b874", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb8596a8c27af389c58b6ee392aab57d4e59fa702bb882b0ddd0894e6e5976ae152f8f0963041a018ff02f505536c5c24fd33fff31348e525c665121f8c0b55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/851107d6711b0b7119b9da44dbbbc7cc4623bac1656d4dea670cf4b605db71f13a553b8e70b0b97f29d162530dea7be2b23532a68db750323c80a7528bdb6494"} 00:19:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:19:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:19:59 INFO - Contents: 00:19:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de8cb0e4858c6f08860ef68b78766d66ab5c1dee2921b37dc55f674be43a2c5aaaa7bfb16074866681c09e9c974e9cd7563a9a49aac1d44e2409bc4d2a17b874", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb8596a8c27af389c58b6ee392aab57d4e59fa702bb882b0ddd0894e6e5976ae152f8f0963041a018ff02f505536c5c24fd33fff31348e525c665121f8c0b55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/851107d6711b0b7119b9da44dbbbc7cc4623bac1656d4dea670cf4b605db71f13a553b8e70b0b97f29d162530dea7be2b23532a68db750323c80a7528bdb6494"} 00:19:59 INFO - Running post-run listener: copy_logs_to_upload_dir 00:19:59 INFO - Copying logs to upload dir... 00:19:59 INFO - mkdir: /builds/slave/test/build/upload/logs 00:19:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.146595 ========= master_lag: 1.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-09-04 00:20:00.250720) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-04 00:20:00.253890) ========= 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.ymZmp1cXmr/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.12pMXqIjA2/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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/Firefox/sha512/de8cb0e4858c6f08860ef68b78766d66ab5c1dee2921b37dc55f674be43a2c5aaaa7bfb16074866681c09e9c974e9cd7563a9a49aac1d44e2409bc4d2a17b874", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb8596a8c27af389c58b6ee392aab57d4e59fa702bb882b0ddd0894e6e5976ae152f8f0963041a018ff02f505536c5c24fd33fff31348e525c665121f8c0b55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/851107d6711b0b7119b9da44dbbbc7cc4623bac1656d4dea670cf4b605db71f13a553b8e70b0b97f29d162530dea7be2b23532a68db750323c80a7528bdb6494"} build_url:https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/dNmifxkdTtSL3z3Fo_oNhA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de8cb0e4858c6f08860ef68b78766d66ab5c1dee2921b37dc55f674be43a2c5aaaa7bfb16074866681c09e9c974e9cd7563a9a49aac1d44e2409bc4d2a17b874", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bb8596a8c27af389c58b6ee392aab57d4e59fa702bb882b0ddd0894e6e5976ae152f8f0963041a018ff02f505536c5c24fd33fff31348e525c665121f8c0b55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/851107d6711b0b7119b9da44dbbbc7cc4623bac1656d4dea670cf4b605db71f13a553b8e70b0b97f29d162530dea7be2b23532a68db750323c80a7528bdb6494"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-04 00:20:00.287845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 00:20:00.288182) ========= 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.ymZmp1cXmr/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.12pMXqIjA2/Listeners TMPDIR=/var/folders/sw/s26whz2n6pbfv14p7p8hkdxw00000w/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.005203 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-04 00:20:00.337398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-04 00:20:00.337725) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-04 00:20:00.338073) ========= ========= Total master_lag: 4.07 =========