builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0327 starttime: 1484909548.77 results: success (0) buildid: 20170120000424 builduid: 9cd368a617bb448e93d53233b1eb04c2 revision: b2e633d19d68a6777838d5730e3412d13de99474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:28.771943) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:28.772699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:28.773215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:28.799523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:28.800175) ========= 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.pig0ZlMrtG/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.khor5EYJ9h/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 --2017-01-20 02:52:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2017-01-20 02:52:28 (20.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134982 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:28.959552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:28.959908) ========= 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.pig0ZlMrtG/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.khor5EYJ9h/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.025459 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:29.008897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-20 02:52:29.009355) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b2e633d19d68a6777838d5730e3412d13de99474 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b2e633d19d68a6777838d5730e3412d13de99474 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pig0ZlMrtG/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.khor5EYJ9h/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 2017-01-20 02:52:29,108 truncating revision to first 12 chars 2017-01-20 02:52:29,109 Setting DEBUG logging. 2017-01-20 02:52:29,109 attempt 1/10 2017-01-20 02:52:29,109 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b2e633d19d68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-20 02:52:31,260 unpacking tar archive at: mozilla-aurora-b2e633d19d68/testing/mozharness/ program finished with exit code 0 elapsedTime=2.408472 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-20 02:52:31.441608) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:31.441938) ========= script_repo_revision: b2e633d19d68a6777838d5730e3412d13de99474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:31.442329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:31.442622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-20 02:52:31.462000) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-01-20 02:52:31.462283) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pig0ZlMrtG/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.khor5EYJ9h/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:52:31 INFO - MultiFileLogger online at 20170120 02:52:31 in /builds/slave/test 02:52:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:52:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:31 INFO - {'append_to_log': False, 02:52:31 INFO - 'base_work_dir': '/builds/slave/test', 02:52:31 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:52:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:31 INFO - 'branch': 'Mozilla-Aurora', 02:52:31 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:31 INFO - 'config_files': ('talos/mac_config.py',), 02:52:31 INFO - 'default_actions': ('clobber', 02:52:31 INFO - 'read-buildbot-config', 02:52:31 INFO - 'download-and-extract', 02:52:31 INFO - 'populate-webroot', 02:52:31 INFO - 'create-virtualenv', 02:52:31 INFO - 'install', 02:52:31 INFO - 'run-tests'), 02:52:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:31 INFO - 'download_minidump_stackwalk': True, 02:52:31 INFO - 'download_symbols': 'ondemand', 02:52:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:31 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:31 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:31 INFO - 'installer_path': 'installer.exe', 02:52:31 INFO - 'log_level': 'info', 02:52:31 INFO - 'log_name': 'talos', 02:52:31 INFO - 'log_to_console': True, 02:52:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:52:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:52:31 INFO - 'opt_config_files': (), 02:52:31 INFO - 'pip_index': False, 02:52:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:31 INFO - 'cmd': ('bash', 02:52:31 INFO - '-c', 02:52:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:31 INFO - 'enabled': True, 02:52:31 INFO - 'halt_on_failure': False, 02:52:31 INFO - 'name': 'check_screen_resolution'},), 02:52:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:31 INFO - 'cmd': ('bash', 02:52:31 INFO - '-c', 02:52:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:31 INFO - 'enabled': True, 02:52:31 INFO - 'halt_on_failure': False, 02:52:31 INFO - 'name': 'check_screen_resolution'},), 02:52:31 INFO - 'run_cmd_checks_enabled': True, 02:52:31 INFO - 'sps_profile': False, 02:52:31 INFO - 'sps_profile_interval': 0, 02:52:31 INFO - 'suite': 'dromaeojs-e10s', 02:52:31 INFO - 'system_bits': '32', 02:52:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:31 INFO - 'title': 't-yosemite-r7-0327', 02:52:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:31 INFO - 'use_talos_json': True, 02:52:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:31 INFO - 'work_dir': 'build'} 02:52:31 INFO - [mozharness: 2017-01-20 10:52:31.663312Z] Running clobber step. 02:52:31 INFO - Running pre-action listener: _resource_record_pre_action 02:52:31 INFO - Running main action method: clobber 02:52:31 INFO - rmtree: /builds/slave/test/build 02:52:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:33 INFO - Running post-action listener: _resource_record_post_action 02:52:33 INFO - [mozharness: 2017-01-20 10:52:33.979962Z] Finished clobber step (success) 02:52:33 INFO - [mozharness: 2017-01-20 10:52:33.980096Z] Running read-buildbot-config step. 02:52:33 INFO - Running pre-action listener: _resource_record_pre_action 02:52:33 INFO - Running main action method: read_buildbot_config 02:52:33 INFO - Using buildbot properties: 02:52:33 INFO - { 02:52:33 INFO - "project": "", 02:52:33 INFO - "product": "firefox", 02:52:33 INFO - "script_repo_revision": "production", 02:52:33 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:52:33 INFO - "repository": "", 02:52:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:52:33 INFO - "buildid": "20170120000424", 02:52:33 INFO - "pgo_build": "False", 02:52:33 INFO - "basedir": "/builds/slave/test", 02:52:33 INFO - "buildnumber": 32, 02:52:33 INFO - "slavename": "t-yosemite-r7-0327", 02:52:33 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:52:33 INFO - "platform": "yosemite_r7", 02:52:33 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:52:33 INFO - "branch": "mozilla-aurora", 02:52:33 INFO - "repo_path": "releases/mozilla-aurora", 02:52:33 INFO - "revision": "b2e633d19d68a6777838d5730e3412d13de99474", 02:52:33 INFO - "stage_platform": "macosx64", 02:52:33 INFO - "builduid": "9cd368a617bb448e93d53233b1eb04c2", 02:52:33 INFO - "slavebuilddir": "test" 02:52:33 INFO - } 02:52:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:52:33 INFO - Running post-action listener: _resource_record_post_action 02:52:33 INFO - [mozharness: 2017-01-20 10:52:33.983507Z] Finished read-buildbot-config step (success) 02:52:33 INFO - [mozharness: 2017-01-20 10:52:33.983636Z] Running download-and-extract step. 02:52:33 INFO - Running pre-action listener: _resource_record_pre_action 02:52:33 INFO - Running main action method: download_and_extract 02:52:33 INFO - mkdir: /builds/slave/test/build/tests 02:52: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')]} 02:52:33 INFO - trying https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:52:33 INFO - Downloading https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:52:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:52:34 INFO - Downloaded 1199 bytes. 02:52:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:52:34 INFO - Using the following test package requirements: 02:52:34 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:52:34 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:34 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:52:34 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:34 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:52:34 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:34 INFO - u'jsshell-mac.zip'], 02:52:34 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:34 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:52:34 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:52:34 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:34 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:52:34 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:34 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:52:34 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:34 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:52:34 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:52:34 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:52:34 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:52:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:52:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:34 INFO - Fetch https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:52:35 INFO - Http code: 200 02:52:35 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 02:52:35 INFO - x-amz-cf-id: W8-iXI5NV14H2pZ-nFAcJvHEkVXr36w0TBcBgsErJodVKG5HwnijxQ== 02:52:35 INFO - x-amz-version-id: eY8bQNGlI.ydpHa6o.0zpRIJ9t.NCQNH 02:52:35 INFO - Expected file size: 16276212 02:52:35 INFO - Obtained file size: 16276212 02:52:42 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:52:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:52:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:42 INFO - Fetch https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:52:42 INFO - Http code: 200 02:52:42 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 02:52:42 INFO - x-amz-cf-id: vIweLSj20AMj3XZG-nFeDguhLxgzEs5XUovd6kyobjMSlQDyi2AYHA== 02:52:42 INFO - x-amz-version-id: eY8bQNGlI.ydpHa6o.0zpRIJ9t.NCQNH 02:52:43 INFO - Expected file size: 16276212 02:52:43 INFO - Obtained file size: 16276212 02:52:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:52:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:52:49 INFO - Fetch https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:52:50 INFO - Http code: 200 02:52:50 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 02:52:50 INFO - x-amz-cf-id: l_pB3JfYIGmcVsRCXLyWslJPo6zVjaKFtCQxRfDtUcS-VeYi3yq42w== 02:52:50 INFO - x-amz-version-id: C.LmJcOUIW6sfRg9TRSnq_nwSeG.5j67 02:52:50 INFO - Expected file size: 14409038 02:52:50 INFO - Obtained file size: 14409038 02:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:50 INFO - trying https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:52:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:52:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:52:53 INFO - Downloaded 109971447 bytes. 02:52:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:52:53 INFO - mkdir: /builds/slave/test/properties 02:52:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:53 INFO - Contents: 02:52:53 INFO - build_url:https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:52:54 INFO - Running post-action listener: _resource_record_post_action 02:52:54 INFO - Running post-action listener: set_extra_try_arguments 02:52:54 INFO - [mozharness: 2017-01-20 10:52:54.104083Z] Finished download-and-extract step (success) 02:52:54 INFO - [mozharness: 2017-01-20 10:52:54.104238Z] Running populate-webroot step. 02:52:54 INFO - Running pre-action listener: _resource_record_pre_action 02:52:54 INFO - Running main action method: populate_webroot 02:52:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:52:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:52:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:52:54 INFO - '--tppagecycles', 02:52:54 INFO - '7'], 02:52:54 INFO - 'tests': ['tsvgm']}}, 02:52:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:52:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:52:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:54 INFO - 'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:54 INFO - 'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['damp', 'tps']}, 02:52:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:54 INFO - 'tests': ['damp', 'tps']}, 02:52:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['dromaeo_dom']}, 02:52:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['basic_compositor_video']}, 02:52:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:52:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['a11yr', 02:52:54 INFO - 'ts_paint', 02:52:54 INFO - 'tpaint', 02:52:54 INFO - 'sessionrestore', 02:52:54 INFO - 'sessionrestore_no_auto_restore', 02:52:54 INFO - 'tabpaint']}, 02:52:54 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:54 INFO - 'ts_paint', 02:52:54 INFO - 'tpaint', 02:52:54 INFO - 'sessionrestore', 02:52:54 INFO - 'sessionrestore_no_auto_restore', 02:52:54 INFO - 'tabpaint']}, 02:52:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:52:54 INFO - 'ts_paint', 02:52:54 INFO - 'tpaint', 02:52:54 INFO - 'sessionrestore', 02:52:54 INFO - 'sessionrestore_no_auto_restore', 02:52:54 INFO - 'tabpaint']}, 02:52:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:52:54 INFO - 'ts_paint', 02:52:54 INFO - 'tpaint', 02:52:54 INFO - 'sessionrestore', 02:52:54 INFO - 'sessionrestore_no_auto_restore', 02:52:54 INFO - 'tabpaint']}, 02:52:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['a11yr', 02:52:54 INFO - 'ts_paint', 02:52:54 INFO - 'tpaint', 02:52:54 INFO - 'sessionrestore', 02:52:54 INFO - 'sessionrestore_no_auto_restore', 02:52:54 INFO - 'tabpaint']}, 02:52:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['a11yr', 02:52:54 INFO - 'ts_paint', 02:52:54 INFO - 'tpaint', 02:52:54 INFO - 'sessionrestore', 02:52:54 INFO - 'sessionrestore_no_auto_restore', 02:52:54 INFO - 'tabpaint']}, 02:52:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['tsvgx', 02:52:54 INFO - 'tsvgr_opacity', 02:52:54 INFO - 'tart', 02:52:54 INFO - 'tscrollx', 02:52:54 INFO - 'cart']}, 02:52:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:54 INFO - 'tsvgr_opacity', 02:52:54 INFO - 'tart', 02:52:54 INFO - 'tscrollx', 02:52:54 INFO - 'cart']}, 02:52:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:54 INFO - 'talos_options': ['--disable-e10s'], 02:52:54 INFO - 'tests': ['tp5o']}, 02:52:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:54 INFO - 'tests': ['tp5o']}, 02:52:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:54 INFO - 'talos_options': ['--disable-e10s', 02:52:54 INFO - '--xperf_path', 02:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:54 INFO - 'tests': ['tp5n']}, 02:52:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:54 INFO - 'talos_options': ['--xperf_path', 02:52:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:54 INFO - 'tests': ['tp5n']}}, 02:52:54 INFO - 'talos.zip': {'path': '', 02:52:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:52:54 INFO - Running post-action listener: _resource_record_post_action 02:52:54 INFO - [mozharness: 2017-01-20 10:52:54.123366Z] Finished populate-webroot step (success) 02:52:54 INFO - [mozharness: 2017-01-20 10:52:54.123498Z] Running create-virtualenv step. 02:52:54 INFO - Running pre-action listener: _resource_record_pre_action 02:52:54 INFO - Running main action method: create_virtualenv 02:52:54 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:54 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 02:52:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:54 INFO - Using real prefix '/tools/python27' 02:52:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:57 INFO - Installing pip.................done. 02:52:57 INFO - Return code: 0 02:52:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:52:58 INFO - Reading from file tmpfile_stdout 02:52:58 INFO - Output received: 02:52:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:52:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:58 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')]} 02:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:58 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')]} 02:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:58 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:52:58 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 02:52:58 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 02:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:58 INFO - 'HOME': '/Users/cltbld', 02:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:58 INFO - 'LOGNAME': 'cltbld', 02:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:58 INFO - 'MOZ_NO_REMOTE': '1', 02:52:58 INFO - 'NO_EM_RESTART': '1', 02:52:58 INFO - 'PAGER': '/bin/cat', 02:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:58 INFO - 'PWD': '/builds/slave/test', 02:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:58 INFO - 'SHELL': '/bin/bash', 02:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:52:58 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:58 INFO - 'USER': 'cltbld', 02:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:58 INFO - 'XPC_FLAGS': '0x0', 02:52:58 INFO - 'XPC_SERVICE_NAME': '0', 02:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:58 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 02:52:58 INFO - Cleaning up... 02:52:58 INFO - Return code: 0 02:52:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:52:58 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')]} 02:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:58 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')]} 02:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:58 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:52:58 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 02:52:58 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 02:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:58 INFO - 'HOME': '/Users/cltbld', 02:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:58 INFO - 'LOGNAME': 'cltbld', 02:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:58 INFO - 'MOZ_NO_REMOTE': '1', 02:52:58 INFO - 'NO_EM_RESTART': '1', 02:52:58 INFO - 'PAGER': '/bin/cat', 02:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:58 INFO - 'PWD': '/builds/slave/test', 02:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:58 INFO - 'SHELL': '/bin/bash', 02:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:52:58 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:58 INFO - 'USER': 'cltbld', 02:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:58 INFO - 'XPC_FLAGS': '0x0', 02:52:58 INFO - 'XPC_SERVICE_NAME': '0', 02:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:58 INFO - Downloading/unpacking psutil>=3.1.1 02:52:58 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 02:52:58 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 02:52:58 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 02:52:58 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 02:52:58 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 02:52:58 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 02:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:53:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:02 INFO - Installing collected packages: psutil 02:53:02 INFO - Running setup.py install for psutil 02:53:02 INFO - building 'psutil._psutil_osx' extension 02:53:02 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 02:53:02 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 02:53:02 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 02:53:02 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 02:53:03 INFO - building 'psutil._psutil_posix' extension 02:53:03 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 02:53:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:53:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:53:03 INFO - ^ 02:53:03 INFO - 1 warning generated. 02:53:03 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 02:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:03 INFO - Successfully installed psutil 02:53:03 INFO - Cleaning up... 02:53:03 INFO - Return code: 0 02:53:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:53:03 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')]} 02:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:03 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')]} 02:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:03 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:53:03 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 02:53:03 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 02:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:03 INFO - 'HOME': '/Users/cltbld', 02:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:03 INFO - 'LOGNAME': 'cltbld', 02:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:03 INFO - 'MOZ_NO_REMOTE': '1', 02:53:03 INFO - 'NO_EM_RESTART': '1', 02:53:03 INFO - 'PAGER': '/bin/cat', 02:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:03 INFO - 'PWD': '/builds/slave/test', 02:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:03 INFO - 'SHELL': '/bin/bash', 02:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:03 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:03 INFO - 'USER': 'cltbld', 02:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:03 INFO - 'XPC_FLAGS': '0x0', 02:53:03 INFO - 'XPC_SERVICE_NAME': '0', 02:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:53:03 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 02:53:03 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 02:53:03 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 02:53:03 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 02:53:03 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 02:53:03 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 02:53:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:53:06 INFO - Installing collected packages: mozsystemmonitor 02:53:06 INFO - Running setup.py install for mozsystemmonitor 02:53:06 INFO - Successfully installed mozsystemmonitor 02:53:06 INFO - Cleaning up... 02:53:06 INFO - Return code: 0 02:53:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:06 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:53:06 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 02:53:06 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 02:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:06 INFO - 'HOME': '/Users/cltbld', 02:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:06 INFO - 'LOGNAME': 'cltbld', 02:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:06 INFO - 'MOZ_NO_REMOTE': '1', 02:53:06 INFO - 'NO_EM_RESTART': '1', 02:53:06 INFO - 'PAGER': '/bin/cat', 02:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:06 INFO - 'PWD': '/builds/slave/test', 02:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:06 INFO - 'SHELL': '/bin/bash', 02:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:06 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:06 INFO - 'USER': 'cltbld', 02:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:06 INFO - 'XPC_FLAGS': '0x0', 02:53:06 INFO - 'XPC_SERVICE_NAME': '0', 02:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:06 INFO - Downloading/unpacking jsonschema==2.5.1 02:53:06 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 02:53:06 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 02:53:06 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 02:53:06 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 02:53:06 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 02:53:06 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 02:53:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:09 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:09 INFO - warning: no files found matching '*.txt' 02:53:09 INFO - no previously-included directories found matching 'build' 02:53:09 INFO - no previously-included directories found matching 'dist' 02:53:09 INFO - no previously-included directories found matching '.git*' 02:53:09 INFO - Installing collected packages: jsonschema, functools32 02:53:09 INFO - Running setup.py install for functools32 02:53:10 INFO - warning: no files found matching '*.txt' 02:53:10 INFO - no previously-included directories found matching 'build' 02:53:10 INFO - no previously-included directories found matching 'dist' 02:53:10 INFO - no previously-included directories found matching '.git*' 02:53:10 INFO - Successfully installed jsonschema functools32 02:53:10 INFO - Cleaning up... 02:53:10 INFO - Return code: 0 02:53:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:53:10 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')]} 02:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:10 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')]} 02:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:10 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:53:10 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 02:53:10 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 02:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:10 INFO - 'HOME': '/Users/cltbld', 02:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:10 INFO - 'LOGNAME': 'cltbld', 02:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:10 INFO - 'MOZ_NO_REMOTE': '1', 02:53:10 INFO - 'NO_EM_RESTART': '1', 02:53:10 INFO - 'PAGER': '/bin/cat', 02:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:10 INFO - 'PWD': '/builds/slave/test', 02:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:10 INFO - 'SHELL': '/bin/bash', 02:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:10 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:10 INFO - 'USER': 'cltbld', 02:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:10 INFO - 'XPC_FLAGS': '0x0', 02:53:10 INFO - 'XPC_SERVICE_NAME': '0', 02:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:53:10 INFO - Cleaning up... 02:53:10 INFO - Return code: 0 02:53:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:53:10 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')]} 02:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:10 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')]} 02:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:10 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:53:10 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 02:53:10 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 02:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:10 INFO - 'HOME': '/Users/cltbld', 02:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:10 INFO - 'LOGNAME': 'cltbld', 02:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:10 INFO - 'MOZ_NO_REMOTE': '1', 02:53:10 INFO - 'NO_EM_RESTART': '1', 02:53:10 INFO - 'PAGER': '/bin/cat', 02:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:10 INFO - 'PWD': '/builds/slave/test', 02:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:10 INFO - 'SHELL': '/bin/bash', 02:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:10 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:10 INFO - 'USER': 'cltbld', 02:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:10 INFO - 'XPC_FLAGS': '0x0', 02:53:10 INFO - 'XPC_SERVICE_NAME': '0', 02:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:10 INFO - Downloading/unpacking blobuploader==1.2.4 02:53:10 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 02:53:10 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 02:53:10 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 02:53:10 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 02:53:10 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 02:53:10 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 02:53:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:53:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:53:13 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 02:53:13 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 02:53:13 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 02:53:13 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 02:53:13 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 02:53:13 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 02:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:53:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:14 INFO - Downloading docopt-0.6.1.tar.gz 02:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:53:14 INFO - Installing collected packages: blobuploader, requests, docopt 02:53:14 INFO - Running setup.py install for blobuploader 02:53:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:53:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:53:14 INFO - Running setup.py install for requests 02:53:15 INFO - Running setup.py install for docopt 02:53:15 INFO - Successfully installed blobuploader requests docopt 02:53:15 INFO - Cleaning up... 02:53:15 INFO - Return code: 0 02:53:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:15 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')]} 02:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:15 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')]} 02:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:15 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:53:15 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 02:53:15 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 02:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:15 INFO - 'HOME': '/Users/cltbld', 02:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:15 INFO - 'LOGNAME': 'cltbld', 02:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:15 INFO - 'MOZ_NO_REMOTE': '1', 02:53:15 INFO - 'NO_EM_RESTART': '1', 02:53:15 INFO - 'PAGER': '/bin/cat', 02:53:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:15 INFO - 'PWD': '/builds/slave/test', 02:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:15 INFO - 'SHELL': '/bin/bash', 02:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:15 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:15 INFO - 'USER': 'cltbld', 02:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:15 INFO - 'XPC_FLAGS': '0x0', 02:53:15 INFO - 'XPC_SERVICE_NAME': '0', 02:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:15 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-cbAbS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-yAeaUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-CU8BUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-8kXHZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-rQqDmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-tSNTFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-wN5vUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-VITUz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-a3WjnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:16 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-QhMhAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:17 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-vH6t39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:17 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-ZsR3L4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:17 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-U0hlQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:17 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-peAzKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:17 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-y69Qlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:17 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-cw5va1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:17 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-IJzGB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:53:17 INFO - Running setup.py install for manifestparser 02:53:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:53:17 INFO - Running setup.py install for mozcrash 02:53:18 INFO - Running setup.py install for mozdebug 02:53:18 INFO - Running setup.py install for mozdevice 02:53:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Running setup.py install for mozfile 02:53:18 INFO - Running setup.py install for mozhttpd 02:53:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Running setup.py install for mozinfo 02:53:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Running setup.py install for mozInstall 02:53:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Running setup.py install for mozleak 02:53:19 INFO - Running setup.py install for mozlog 02:53:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Running setup.py install for moznetwork 02:53:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Running setup.py install for mozprocess 02:53:19 INFO - Running setup.py install for mozprofile 02:53:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Running setup.py install for mozrunner 02:53:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Running setup.py install for mozscreenshot 02:53:19 INFO - Running setup.py install for moztest 02:53:20 INFO - Running setup.py install for mozversion 02:53:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:20 INFO - Cleaning up... 02:53:20 INFO - Return code: 0 02:53:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53: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')]} 02:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:20 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:53:20 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 02:53:20 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 02:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:20 INFO - 'HOME': '/Users/cltbld', 02:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:20 INFO - 'LOGNAME': 'cltbld', 02:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:20 INFO - 'MOZ_NO_REMOTE': '1', 02:53:20 INFO - 'NO_EM_RESTART': '1', 02:53:20 INFO - 'PAGER': '/bin/cat', 02:53:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:20 INFO - 'PWD': '/builds/slave/test', 02:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:20 INFO - 'SHELL': '/bin/bash', 02:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:20 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:20 INFO - 'USER': 'cltbld', 02:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:20 INFO - 'XPC_FLAGS': '0x0', 02:53:20 INFO - 'XPC_SERVICE_NAME': '0', 02:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:20 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-cS0w0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:20 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)) 02:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:20 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-c21s0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:20 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-1Nzr1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:20 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)) 02:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:20 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-OhYRfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-eqd3vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Q6cbtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-3RryoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-xtTmzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-g06ZXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-zeABQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-SanzLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-DargoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-GZ57Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:21 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-u6CU5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:22 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-1Ya1pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:22 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:22 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-TiiDHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:22 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-xr9gQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:22 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)) 02:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:22 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)) 02:53:22 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)) 02:53:22 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)) 02:53:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:24 INFO - Downloading blessings-1.6.tar.gz 02:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:25 INFO - Installing collected packages: blessings 02:53:25 INFO - Running setup.py install for blessings 02:53:25 INFO - Successfully installed blessings 02:53:25 INFO - Cleaning up... 02:53:25 INFO - Return code: 0 02:53:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:25 INFO - Reading from file tmpfile_stdout 02:53:25 INFO - Current package versions: 02:53:25 INFO - blessings == 1.6 02:53:25 INFO - blobuploader == 1.2.4 02:53:25 INFO - docopt == 0.6.1 02:53:25 INFO - functools32 == 3.2.3-2 02:53:25 INFO - jsonschema == 2.5.1 02:53:25 INFO - manifestparser == 1.1 02:53:25 INFO - mozInstall == 1.12 02:53:25 INFO - mozcrash == 1.0 02:53:25 INFO - mozdebug == 0.1 02:53:25 INFO - mozdevice == 0.48 02:53:25 INFO - mozfile == 1.2 02:53:25 INFO - mozhttpd == 0.7 02:53:25 INFO - mozinfo == 0.9 02:53:25 INFO - mozleak == 0.1 02:53:25 INFO - mozlog == 3.4 02:53:25 INFO - moznetwork == 0.27 02:53:25 INFO - mozprocess == 0.23 02:53:25 INFO - mozprofile == 0.28 02:53:25 INFO - mozrunner == 6.13 02:53:25 INFO - mozscreenshot == 0.1 02:53:25 INFO - mozsystemmonitor == 0.3 02:53:25 INFO - moztest == 0.8 02:53:25 INFO - mozversion == 1.4 02:53:25 INFO - psutil == 3.1.1 02:53:25 INFO - requests == 1.2.3 02:53:25 INFO - wsgiref == 0.1.2 02:53:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:26 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 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:53:26 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 02:53:26 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 02:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:26 INFO - 'HOME': '/Users/cltbld', 02:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:26 INFO - 'LOGNAME': 'cltbld', 02:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:26 INFO - 'MOZ_NO_REMOTE': '1', 02:53:26 INFO - 'NO_EM_RESTART': '1', 02:53:26 INFO - 'PAGER': '/bin/cat', 02:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:26 INFO - 'PWD': '/builds/slave/test', 02:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:26 INFO - 'SHELL': '/bin/bash', 02:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:26 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:26 INFO - 'USER': 'cltbld', 02:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:26 INFO - 'XPC_FLAGS': '0x0', 02:53:26 INFO - 'XPC_SERVICE_NAME': '0', 02:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 INFO - Cleaning up... 02:53:26 INFO - Return code: 0 02:53:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105b3d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ab3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f89004af910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, '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.pig0ZlMrtG/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.khor5EYJ9h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 02:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:27 INFO - 'HOME': '/Users/cltbld', 02:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:27 INFO - 'LOGNAME': 'cltbld', 02:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:27 INFO - 'MOZ_NO_REMOTE': '1', 02:53:27 INFO - 'NO_EM_RESTART': '1', 02:53:27 INFO - 'PAGER': '/bin/cat', 02:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:27 INFO - 'PWD': '/builds/slave/test', 02:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:27 INFO - 'SHELL': '/bin/bash', 02:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:27 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:27 INFO - 'USER': 'cltbld', 02:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:27 INFO - 'XPC_FLAGS': '0x0', 02:53:27 INFO - 'XPC_SERVICE_NAME': '0', 02:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:53:27 INFO - Cleaning up... 02:53:27 INFO - Return code: 0 02:53:27 INFO - Running post-action listener: _resource_record_post_action 02:53:27 INFO - Running post-action listener: _start_resource_monitoring 02:53:27 INFO - Starting resource monitoring. 02:53:27 INFO - [mozharness: 2017-01-20 10:53:27.297671Z] Finished create-virtualenv step (success) 02:53:27 INFO - [mozharness: 2017-01-20 10:53:27.298642Z] Running install step. 02:53:27 INFO - Running pre-action listener: _resource_record_pre_action 02:53:27 INFO - Running main action method: install 02:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:27 INFO - Reading from file tmpfile_stdout 02:53:27 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:27 INFO - Reading from file tmpfile_stdout 02:53:27 INFO - Output received: 02:53:27 INFO - Usage: mozinstall [options] installer 02:53:27 INFO - Options: 02:53:27 INFO - -h, --help show this help message and exit 02:53:27 INFO - -d DEST, --destination=DEST 02:53:27 INFO - Directory to install application into. [default: 02:53:27 INFO - "/builds/slave/test"] 02:53:27 INFO - --app=APP Application being installed. [default: firefox] 02:53:27 INFO - mkdir: /builds/slave/test/build/application 02:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:53:58 INFO - Reading from file tmpfile_stdout 02:53:58 INFO - Output received: 02:53:58 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:53:58 INFO - Running post-action listener: _resource_record_post_action 02:53:58 INFO - [mozharness: 2017-01-20 10:53:58.923850Z] Finished install step (success) 02:53:58 INFO - [mozharness: 2017-01-20 10:53:58.924001Z] Running run-tests step. 02:53:58 INFO - Running pre-action listener: _resource_record_pre_action 02:53:58 INFO - Running main action method: run_tests 02:53:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:58 INFO - 2017-01-20 02:53:58.938 screenresolution[1625:7410] starting screenresolution argv=screenresolution get 02:53:58 INFO - 2017-01-20 02:53:58.941 screenresolution[1625:7410] Display 0: 1600x1200x32@60 02:53:58 INFO - 2017-01-20 02:53:58.946 screenresolution[1626:7413] starting screenresolution argv=screenresolution list 02:53:58 INFO - Available Modes on Display 0 02:53:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:59 INFO - Intel Iris: 02:53:59 INFO - Chipset Model: Intel Iris 02:53:59 INFO - Type: GPU 02:53:59 INFO - Bus: Built-In 02:53:59 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:59 INFO - Vendor: Intel (0x8086) 02:53:59 INFO - Device ID: 0x0a2e 02:53:59 INFO - Revision ID: 0x0009 02:53:59 INFO - Displays: 02:53:59 INFO - Display: 02:53:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:59 INFO - Display Serial Number: 1600x1200 60 02:53:59 INFO - Main Display: Yes 02:53:59 INFO - Mirror: Off 02:53:59 INFO - Online: Yes 02:53:59 INFO - Rotation: Supported 02:53:59 INFO - Return code: 0 02:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:59 INFO - Python 2.7.3 02:53:59 INFO - Return code: 0 02:53:59 INFO - grabbing minidump binary from tooltool 02:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:59 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 0x105951d30>, '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 0x1057b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105949b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:59 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 02:53:59 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 02:53:59 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 02:53:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:59 INFO - Return code: 0 02:53:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:53:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:53:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0327 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pig0ZlMrtG/Render', 02:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:59 INFO - 'HOME': '/Users/cltbld', 02:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:59 INFO - 'LOGNAME': 'cltbld', 02:53:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:59 INFO - 'MOZ_NO_REMOTE': '1', 02:53:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:59 INFO - 'NO_EM_RESTART': '1', 02:53:59 INFO - 'PAGER': '/bin/cat', 02:53:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:59 INFO - 'PWD': '/builds/slave/test', 02:53:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:59 INFO - 'SHELL': '/bin/bash', 02:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.khor5EYJ9h/Listeners', 02:53:59 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 02:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:59 INFO - 'USER': 'cltbld', 02:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:59 INFO - 'XPC_FLAGS': '0x0', 02:53:59 INFO - 'XPC_SERVICE_NAME': '0', 02:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:53:59 INFO - mozversion application_buildid: 20170120000424 02:53:59 INFO - mozversion application_changeset: b2e633d19d68a6777838d5730e3412d13de99474 02:53:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:53:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:59 INFO - mozversion application_name: Firefox 02:53:59 INFO - mozversion application_remotingname: firefox-dev 02:53:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:53:59 INFO - mozversion application_vendor: Mozilla 02:53:59 INFO - mozversion application_version: 52.0a2 02:53:59 INFO - mozversion platform_buildid: 20170120000424 02:53:59 INFO - mozversion platform_changeset: b2e633d19d68a6777838d5730e3412d13de99474 02:53:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:53:59 INFO - mozversion platform_version: 52.0a2 02:53:59 INFO - using testdate: 1484909639 02:53:59 INFO - actual date: 1484909639 02:53:59 INFO - starting webserver on 'localhost:49241' 02:53:59 INFO - SUITE-START | Running 2 tests 02:53:59 INFO - TEST-START | dromaeo_css 02:53:59 INFO - operating with platform_type : mac_ 02:53:59 INFO - Initialising browser for dromaeo_css test... 02:53:59 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpDN3dsG/profile http://localhost:49241/getInfo.html) 02:54:02 INFO - PROCESS | 1636 | 2017-01-20 02:54:02.798 plugin-container[1638:7584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 02:54:02 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:54:02 INFO - PROCESS | 1636 | 2017-01-20 02:54:02.802 plugin-container[1638:7584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 02:54:02 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:54:02 INFO - PROCESS | 1636 | 2017-01-20 02:54:02.802 plugin-container[1638:7584] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:54:02 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 02:54:02 INFO - PROCESS | 1636 | colorDepth:24 02:54:02 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 02:54:02 INFO - PROCESS | 1636 | __metrics 02:54:02 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 02:54:03 INFO - TEST-INFO | 1636: exit 0 02:54:03 INFO - Browser initialized. 02:54:03 INFO - Running cycle 1/1 for dromaeo_css test... 02:54:03 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpDN3dsG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:06 INFO - PROCESS | 1639 | 2017-01-20 02:54:06.548 plugin-container[1640:7712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x854b, name = 'com.apple.tsm.portname' 02:54:06 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:54:06 INFO - PROCESS | 1639 | 2017-01-20 02:54:06.551 plugin-container[1640:7712] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c03, name = 'com.apple.CFPasteboardClient' 02:54:06 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:54:06 INFO - PROCESS | 1639 | 2017-01-20 02:54:06.551 plugin-container[1640:7712] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:54:16 INFO - PROCESS | 1639 | RSS: Main: 229089280 02:54:16 INFO - PROCESS | 1639 | 02:57:18 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 02:57:20 INFO - PROCESS | 1639 | RSS: Main: 233717760 02:57:20 INFO - PROCESS | 1639 | 03:00:22 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 03:00:23 INFO - PROCESS | 1639 | RSS: Main: 244035584 03:00:23 INFO - PROCESS | 1639 | 03:03:25 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 03:03:26 INFO - PROCESS | 1639 | RSS: Main: 246861824 03:03:26 INFO - PROCESS | 1639 | 03:06:27 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 03:06:28 INFO - PROCESS | 1639 | RSS: Main: 246046720 03:06:28 INFO - PROCESS | 1639 | 03:09:31 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 03:09:31 INFO - PROCESS | 1639 | RSS: Main: 250535936 03:09:31 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 03:12:34 INFO - PROCESS | 1639 | RSS: Main: 251871232 03:12:34 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | __start_tp_report 03:12:34 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 03:12:34 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 03:12:34 INFO - PROCESS | 1639 | |i|pagename|runs| 03:12:34 INFO - PROCESS | 1639 | |0;dojo.html;2635.341164708823;3416.812075335856;3423.708984736297;3451.6203217646053;3460.8442620082087;5692.971535142324;5754.309482862052;5756.194132821408;5761.769529218826;5775.133729940511;5791.131330300457;5855.092460668592;5881.206037184978;5896;5897.292324921015;5344.118220493624;5348.973255133719;5350.785968561253;5352.91970620441;5398;5403.675779453226;5410.431904650014;5415.187721841736;5435.782568697267;5441.809536666217;5266;5266.289050978126;5400.621956463049;5401.162819762923;5403.459654034585;5329.920051199216;5350.892982140354;5372.355317361902;5420.997115533639;5469.781208751645;5241.266222728821;5357.357117145967;5378.112611419111;5380.838574842761;5414.377346605152;5904.232449781543;5941.643501389931;5951.58338916276;6016.669083200422;6016.729247183887;6145.477634401037;6233.625982441023;6238.906416403757;6249.843753906189;6270.153529273581;6274.152989346426;6329.905051424233;6331.55679102463;6336.176297081396;6405.391487808697;6020.458158765732;6025.066114752177;6030.66831324277;6046.093086037085;6056.878862422727;6323.462505686976;6344.777932772331;6387.936120638734;6456.8062958110395;6471.061696054046;6284.43440090385;6298.811035668938;6306.716197771111;6310.558260921692;6318.905216421757;6317.526185536011;6366.331535188831;6375.71309291083;6403.583767055126;6403.743850245938;6141.670122563582;6251.4061164189325;6272.18461599989;6282.591631543935;6290.433860952445;6301.212348456443;6346.428821406095;6346.587471814318;6347.746090156342;6350.777722779773;4961.7271050092595;5075;5075.441701412841;5082.034413461431;5084.135696931457;3461.9653803462147;4401.031773009932;4427.40230068943;4476.597106260387;4542.477615074243;5688.744006519716;5967.343592204854;5993.4905533029305;6005.6396616203165;6032.668203248863;6281.856455992663;6307.590006649553;6326;6335.588186767845;6355.142055822497;5879.794207202727;5945.4351836576325;5948.702564871739;5955.851103722442;6015.909761353583;5475.479829416199;5506.394296627368;5506.669599824023;5532.1425179097305;5545.72271386429;4834;5866.442687944638;6378.904316435257;6391.392817682313;6478.028295755675;5828.038373668467;6244.613723489556;6314.463270622048;6315.115883776183;6318.557700961072;6327.810165695037;6401.583897046863;6409.166808315075;6472.514561407819;6504.479641628753;5198.402183748917;6199.628022318675;6287.528435367274;6294.118823364641;6319.9052014218905;6219.782307619212;6227.719752611053;6314.905276420949;6323.873522529431;6335.239771227482;5882.411758824083;6243.7814676486105;6254.655993920378;6258.687065646791;6284.402981716729;6110.7106460192745;6143.1706719592285;6156.353582873734;6161.137440758208;6192.659403732838;5586.916196256978;6109.868257519264;6143.539234557516;6146.354632763496;6172.4136207060255;6187.226596675416;6223.937760622336;6265.575646031858;6275.215598050244;6277.937220627735;5960.374160713062;6007;6109.009944784373;6130.724117414817;6191.81424557264 03:12:34 INFO - PROCESS | 1639 | |1;ext.html;431.75174274792005;461.3149473032546;484.4670862051743;487.99756001219987;504.96230246842725;38484.42273365898;40122.996925076885;40396;41883.371749423786;41947.580524194746;40435.39346909799;41291.174176516455;41760.791196043974;41877.790611046905;41893.743187704415;9276.165145136953;9449.669261575811;9460;9466.90533094667;9481.47851868147;9281.257499400066;9281.582328795186;9308.58111384986;9349.439033658002;9459.57431915562;9330.76673083175;9431.622735090623;9471.147596716293;9487;9495.818900668284;9383.24934005278;9402.106799854002;9461.006594307637;9474.763130921714;9511.048895110504;9345.579448924815;9371.34400591959;9427.48148851813;9436;9442.29182811285;32560.67439325624;39382.40926386107;39596;39817.60182398197;39848.80075599632;3288.523164141186;3288.819114948677;3294;3323.3685599736214;3373.8481768320485;29203.56194657082;29377.70622293771;29863.552046719316;29998.550021749692;30063.248418789488;3000.159955212544;3010.08192501287;3023.7732170087334;3025.213444504445;3123.2348074721613;349096;350183;352017.47982520104;352160;352400;56017;56346.718266409225;56528.717356412955;56532.43467565354;56631.71684141553;57161;57455;57535.84928301494;58294;58347.70826145842;15101.622459438602;15451.845481545266;15678.68642627141;15710.293036813371;15737.819663525052;11780.587679431179;11898.643040708792;11921.523139074514;11967.581134660246;11975.161738678384;13987.930060349634;14752.40990360395;14890.478833241;14920.925395372953;14960.251987400587;3130.8121512708854;5435.755391007414;5482.2873026507095;6200.627962322275;6505.642189679613;704.6969802984663;912.7353067610319;939;1000.3897622450299;1014.2545229256638;29748.256293592833;30025.69974300229;30036.399272014438;30308.969103089956;30333;911.334725650279;1020.4081632653043;1038.8493668418037;1063.1813503602339;1109.3399427340719;15050.849491505163;15453.304601292968;15516.922415387851;15546.922265388826;15905.840941590668;625246;631373;632351;632952;634797;56248.43751562514;56692.71653641788;56776.43223567794;56878.715606421705;57238.42761572414;1322.1736414740787;1344.8722371374704;1365.3309878159828;1369.4111532041118;1375.8417781955004;29244.122676319745;29434.558481623222;29633.407331853672;30303.69696303009;30318.84840575783;47777.522224778695;53699;54293;54513.909721806136;57248;614571;621862;622579;623156;623486;41207.1758564833;41720.74837754872;42099.57900420957;42268;42278.36582451204;45273;45408;45691.857703557675;45725.77137114293;46066.30900536427;38270.617293826705;38638.420423693104;38641.6135838638;39854.40218396668;39855.80072099621;37804;38100.237995240495;38319;38810.61189388183;39336.016599584094;37279.44080838736;37661.05847353838;38073.04817379477;38257;38313.808430957666;32109.678903210668;34313.65686343204;34328;34484.53455089243;34758.65241347554;20442.38672839817;25195.622065668664;25471.10851120202;25632;25850 03:12:34 INFO - PROCESS | 1639 | |2;jquery.html;373.7570579123569;375.1877185892542;383.629797245658;387.821602063051;403.8465383154401;15674.843251567481;16705.83294167058;16993.150342482873;19908.402747917567;20032.399028029147;14739.48411805587;19343.129559169873;20088.8995555022;20103.19587216513;20164;5349.197620356958;5709.885802283941;5963.522918166536;5974.55190860685;6042.758289668408;4998.425181104165;5037.823676171335;5912.586118971673;5917.319508256563;5926;5209.635325527214;5361.731913404315;5828.242328497311;5853.268341457318;5866.941330586704;5795.275590551181;5864.853378665525;5924.14099955504;5934.13954976526;5937.6140550864275;5086.487157215535;5090.414602320707;5126.53861152498;5168.320295903809;5174.43081261061;23899.40251493709;24139.758602414102;24234.636480452806;24547.509049818902;24760.638164900924;2213.3581261434165;2363.3973336799177;2456.7297597264287;2588.6505321781506;2937.089502254308;14934.551963441005;15127.773083403757;15348.386064557404;15423.383064677399;15777.842221577866;1803.5040363900032;1850.824171703686;1898.515878451;1904.2668572599648;1942.6114777044647;78757;110778;112881;116354;121924.17113743212;11374.350719145677;11628.476718547685;11692.123090768056;11716.472758725879;11724.00345970585;14447.277636118362;14575;14576.125432474086;14577.41690332396;14601.561953141423;8199.549024803573;8442.15578442151;8453.788655283666;8490.278326342206;8492.532910689848;8298.294644955246;8338.541380224025;8341.958290208631;8425.705100321582;8491.575421228914;4471.977640111779;4508.842190523382;4519.254323036662;4530.161920044737;4594.0582180653555;1750.2298988445043;1849.5283702655736;1873.5503479164902;1942.4366933589101;1946.8053194680701;867.7917299847991;868.0191383736337;919.4207649180973;922.4926290540176;934.5233930695258;20567.177312907614;21956.341309760734;22164.335069947927;22243.555128897657;22429.775702243096;821.2980685575035;893.8614514750224;917.2249449215402;938.5541867612966;1021.836506159011;9009;9456.716298511055;9964.551595178234;10236.795264094677;10799.514021869034;491449;492758;494623;599744.0012799995;606897;105319;112388.43805780918;131687;131928.3403582976;137829.3108534451;933.5985526223653;963.1764841060932;977.3402953006835;1001.4942454060798;1001.5392919257223;15831.287592058155;18141.546461338043;18459.723104153716;18750.437486875417;18773;53697.463025369245;55056.348309550776;55511.72244138754;55789.72105139448;55862.441375585724;80635;81982;82484;83771.5811420939;85291.14708852832;7615.771526854203;7674.884876726966;7833.49082309648;7894.250046245597;7945.404094692805;10816.296940698829;12069;12105.213161144497;12128.866722689869;12356.25862448256;10145.391276523433;10162.491875406347;10454.529546170288;10525.210609204187;10637.787244255227;10175.28772985884;10207.387556746618;10217.897821021694;10486.685399438029;10511.78976420452;9310.348275620641;9815.901840981784;10037.946015668542;10611.946940265248;10746.73133171677;7585.2035536267895;7637.159912409742;7819.882701759592;7879.330256927996;7991.72028978983;9755.902440975784;10480.475976201007;10645.308054976402;10752.569897204025;10884.45577721095 03:12:34 INFO - PROCESS | 1639 | |3;mootools.html;1445.5374280230324;1462.853714628537;1540.7149677309692;1635.8854880158385;1709.0087749105512;7525.698972041126;7810.9609451952665;8232.711855085074;8646.567671616418;8657.393982421225;8042.758717238477;8387.16128387161;8396.370272229577;8470.703525376613;8487.702930397438;1957.6378370001523;2115.9314546154246;2177.7495588007346;2298.540291941614;2346.495503466754;2331.755165707602;2359.4219416243045;2369.9052037918464;2392.6650268962358;2394.9342542568565;2332.2303639798824;2332.568474832153;2355.1168311883043;2368.95262094758;2371.6442533619925;2333.9183128590503;2336.240721765433;2355.3993731598503;2356.622940329556;2368.656544801003;2311.7457079721216;2366.810655147584;2377.405648587853;2377.7859992600575;2383.4041489627593;8539.06070332263;8573.01410337813;8578.18507241811;8606.526641034741;8630.870536941951;5124.359455068116;5292.894142117175;5298.125809241471;5301.787928482895;5324.8136315228785;3103.658597554267;3334.7832390894514;3476.9395334422993;3531.6644918732677;3612.0428086557085;1026.768976980181;1033.204432586904;1083.2363183955292;1093.4915264402011;1096.5010920031366;10927.945360273226;11019.559217631286;11100.389478578674;11123.666290011313;11247.606333778278;4332.935005974913;4655.580997710154;4721.386219791405;4722.677650257933;4800.495947925488;9489.810203796023;9514.524273786283;9578.9042109578;9582.904170958202;9615.56729947154;5210.452902445264;5254.632175747661;5257.894842103136;5265.76304066318;5275.947240527622;4116.764970508835;4747.738874361943;4747.810087596457;4808.495108013608;4849.660523763303;3289.901302960915;3752.0057184846037;3847.480590120354;3856.421536769507;3961.7028722845903;1123.3540714089268;1252.9060320476;1257.1953949472345;1264.2161859647078;1281.9359032048546;713.4969846258375;768.2049079202998;903.4804987132425;908.3959167153769;929.149827907457;5778.248827652463;5782.421757824184;5871.442212989759;5896.204012458349;5934.7922822701;917.2799352508249;925.8797851241226;950.3632566180676;958.1616085924816;972.8832540095234;3814.2752876953846;3941.4481972523868;3947.111899822517;3961.1483531040963;3962.484876965976;9985;10235.283530152967;10330.328528645614;10345.482725863676;10365.429901355497;10167.186625070124;10283.12593429567;10308.32995855282;10333.86327503974;10359.22305827066;6377.7448902044325;6934.47991400647;7704.6532906019365;7801.907732917396;7840.568768717661;4745.691530050535;5550.611457198119;5577.8047768327915;5721.8569535761935;5807.170741216503;9564.282678799256;9564.904350956402;9592.712218633453;9599.088086631758;9611.990740972096;9092.636294548143;9513.334066615547;9517;9698.660546880825;9736.123748862636;6622.801315960529;6859.759908403382;6862.725490980305;7292.307230813064;7486.951826744151;6739.191297044386;7656.80857978555;7813.648385822766;7877.015373078365;7893.802654933673;6999.650017499002;7071.752488662872;7090.255523169993;7122.430205583644;7244.348008679244;6936.167659880644;6959.61722105289;7030.367266945999;7050.858982820418;7063.187733410724;6755.729770809309;6779.35596118368;6795.116634837637;6860.348266914635;6866.4506839453725;4921.926171107365;4980.800767969241;4986.052649996489;4991.251312303184;5007.749612519432;4918.2376731606655;4978.32792572998;4988.226824842155;5051.4443411225475;5093.0577843099145 03:12:34 INFO - PROCESS | 1639 | |4;prototype.html;290.784819233767;297.46010990053054;311.9111053349795;313.6189529721388;316.31517764040854;5154.226865970107;5188.92216616751;5391.460853914607;5504.2018907258425;5505.504504594591;4872.658913876021;4989.800407983686;5179.949549189548;5268.130758424865;5429.131338985753;4110.424540564316;4123.525794533637;4123.546409894909;4126.587341265879;4150.854720084798;3618.3667858124854;4156.854510092147;4159.584041595846;4175.269327867626;4184.267753143203;3797.4873392092127;4014.3175660137845;4092.9795351023204;4099.3850922361735;4122.103832237174;4039.6162364575316;4052.49343832021;4068.7653315614157;4069.3489041753323;4076.634327500291;3513.877014304487;3518.577770667511;3528.947065794015;3529.94705079424;3538.2392785550974;4790.856274311776;4814;5188.844334669966;5220.530152286313;5240.737963101829;4380.561943805626;4638.744869032202;4642.930356044662;4661.580457758818;4662.184117779375;4683.414573178353;4929.235968424864;5404.1083221268445;5522.282103326582;5719.742611582489;2962.066948911086;3707.7589956653;3809;3850.9614903850884;3867.2265546890735;5080.79676812927;5446.455354464521;5676.659400435946;5889.79385721502;6032.336442991267;2941.470535303666;3246.9350612988083;3338.9666103338654;3409.7442691798215;3863.9227215456094;3431.3480438716565;3466.7399945004227;3934.4885164928946;3963.286608410514;3972.3048466518244;4181.874543763692;4579.9084018319445;4591.311303304465;4604.789700943566;4639.8144074237325;4628.60656844172;5704.260200638762;5708.4862362387585;5749.568782341341;5763.567732420085;1098.961536346224;1260.7352455984346;1276.183242724657;1280.5966120671958;1287.0475847872694;752.863176603322;791.76247125862;830.5182993863544;861.29804209569;867.0029466113893;4287.335463003239;5060.367454068241;5078.308496496863;5112.488751124858;5173.224016397495;4671.48613652498;4742.225797908193;4873.929424462566;5274.525292723597;5565.499105080562;4008.8797336079965;4571.611413029863;4740.976295118571;5064.442911279756;5076.6953982760415;2408.879556022192;2531.4177739120105;2711.9253770865303;2922.459345021178;2959.926001849971;4667.789949452283;4927.630427717864;4951.430585482643;5536.52939500147;5770.711464426762;5355.357357117093;5454.636340914772;5565.833025009175;5706.828795136153;6119.44924956756;5456.61803673747;6034.275886893513;6209.2548894133;6219.191505104308;6231.4451075059915;5222;5676.68778217202;5847.795327163699;6010.819675409744;6017.669028203491;4708.670393072452;5221.2690223368;5928.458600763919;5936.643801371932;5973.940260597338;5910.556708246812;6097.2683278006925;6117.021276595723;6213.813585592439;6220.782272620437;3331.833408329622;3865;4044.4742183515955;4091.8772436826944;4103.363978583325;4883.731394773179;5899.734511946886;5920;5922.73347699346;5949.583529152917;5166.778285337341;5718.828435146952;5735.283089613798;5776.884462310814;5820.970895145497;5320.068987927175;5769.192313076257;5769.278840144982;5792.189093526826;5802.796902108406;4677.415323084614;4950.752462376939;5416.485433883775;5747.023006088892;5754.3382511010095;5538.307711536058;5723.484886360247;5823.282131771053;5833.649981001154;5868;5655.802046928337;5655.802046928337;5656.6888821115235;5688.886222275449;5691.983248878101 03:12:34 INFO - PROCESS | 1639 | |5;yui.html;620.7020630097551;691.5781373362249;763.4121726270772;780.957047362395;783.7687882074788;13674.658133546654;14389.208593527352;14535.781963270532;14536;14638.121712697246;12492.81260781089;12605.495780168781;12618.305993170372;12642.557510487135;12690.492380304777;797.405932580227;818.4802650317062;822.1490757066438;823.2919689067427;825.6532256452274;657.934206579343;678.1252184681755;809.0695699945052;830.8006078541137;837.8282452097336;873.4148120759106;874.5321253129576;879.8592225243963;883.3242569434387;883.3419102768446;853.8164294676612;860.6170254236868;868.3660927522943;869.4261787220468;870.7213691618684;638.6615094000188;644.851684112652;645.180620611825;646.2761706888315;651.6025224612982;10032.849507257397;13908.652283692887;13942;13943.58169254924;13990.790138147935;12912.218738838854;13155;13303.40134693941;13340;13340.599782006555;10958.780824383548;11082.335059896432;11326.43367831605;11375.26060806045;11666.824997625043;3463.79217246966;3664.6885014773775;3681.4661874028384;3697.796621185834;3793.620637936212;85727.14272857254;88893.55553222193;89092;89784.55107724485;89847.81217502584;10007.199424046059;10088.949555252177;10230.751997610365;10354.223433242538;10456.581736730597;19873.60252794936;20247.29134480286;20262.797372026387;20501.897490512452;20599.38201853947;6877.3810357068105;6886.380225779704;6915.827104322432;6986.44108471321;7043.119610048744;4026.838926442968;4108.712390132662;4148.502179738451;4199.2441360554785;4218.029853133797;3204.5353423753427;3386.153461634591;3504.5268888700207;3515.226650136966;3518.0325410512314;625.7121724006917;646.6863571167979;653.6241661044918;655.5935320101568;662.1491383572087;497.5099526965936;553.4907884746043;645.8385403649088;648.9935100648933;674.2852576269072;8836.41990715325;9032.548372581345;9104.180623743894;9179.862302065474;9217.907820921839;555.2310050579975;600.3696119074954;616.6269407008784;635.6472157952288;676.8662490328679;4002.5597184310286;4143.751374917515;4262.744235345889;4319.589638984291;4553.861534616346;76418;101534;104617;115696;116405;65198.67400662966;65298.34701653018;94195.05804942;100515;104664.47667761613;63148;70979.2902070983;72318;94417;94455.52772236094;9149.359544832065;9442.15020648145;9621.27840411986;9638.9036109638;9640.180584650383;41788.79105604574;51863;53740;54155.91688166136;55077.72461137829;73072.07711691686;75134;78108.60945695463;78215.04462388485;82016;11747.412629368668;12077.69805754828;12265.448054837732;12266.570670026505;12279.140460167702;13048.739025219633;13078.934605326913;13487.190768553919;14084.22536760488;14479.85520144785;11467.623885133837;11496.54013839437;11997;12404.62786116418;13358.933205333911;12750.298733569372;13038.413271403;13204.075714700262;13337;13374.866251337362;11907.404629768303;12270.607533835755;12713.491460341484;12734.808977865525;12755.426005829575;9963.302568820112;10346.534405951901;10364.378137311785;10390.740231494274;10525.78948421012;9080.772980675272;11072.034383099071;11180.161487888277;11181.273217241178;11272.098232141245 03:12:34 INFO - PROCESS | 1639 | __end_tp_report 03:12:34 INFO - PROCESS | 1639 | __start_cc_report 03:12:34 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,368 03:12:34 INFO - PROCESS | 1639 | __end_cc_report 03:12:34 INFO - PROCESS | 1639 | __startTimestamp1484910754860__endTimestamp 03:12:34 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | ------- Summary: start ------- 03:12:34 INFO - PROCESS | 1639 | Number of tests: 6 03:12:34 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5838.83 Median:6056.88 stddev:676.83 (11.2%) stddev-sans-first:630.53 03:12:34 INFO - PROCESS | 1639 | Values: 2635.3 3416.8 3423.7 3451.6 3460.8 5693.0 5754.3 5756.2 5761.8 5775.1 5791.1 5855.1 5881.2 5896.0 5897.3 5344.1 5349.0 5350.8 5352.9 5398.0 5403.7 5410.4 5415.2 5435.8 5441.8 5266.0 5266.3 5400.6 5401.2 5403.5 5329.9 5350.9 5372.4 5421.0 5469.8 5241.3 5357.4 5378.1 5380.8 5414.4 5904.2 5941.6 5951.6 6016.7 6016.7 6145.5 6233.6 6238.9 6249.8 6270.2 6274.2 6329.9 6331.6 6336.2 6405.4 6020.5 6025.1 6030.7 6046.1 6056.9 6323.5 6344.8 6387.9 6456.8 6471.1 6284.4 6298.8 6306.7 6310.6 6318.9 6317.5 6366.3 6375.7 6403.6 6403.7 6141.7 6251.4 6272.2 6282.6 6290.4 6301.2 6346.4 6346.6 6347.7 6350.8 4961.7 5075.0 5075.4 5082.0 5084.1 3462.0 4401.0 4427.4 4476.6 4542.5 5688.7 5967.3 5993.5 6005.6 6032.7 6281.9 6307.6 6326.0 6335.6 6355.1 5879.8 5945.4 5948.7 5955.9 6015.9 5475.5 5506.4 5506.7 5532.1 5545.7 4834.0 5866.4 6378.9 6391.4 6478.0 5828.0 6244.6 6314.5 6315.1 6318.6 6327.8 6401.6 6409.2 6472.5 6504.5 5198.4 6199.6 6287.5 6294.1 6319.9 6219.8 6227.7 6314.9 6323.9 6335.2 5882.4 6243.8 6254.7 6258.7 6284.4 6110.7 6143.2 6156.4 6161.1 6192.7 5586.9 6109.9 6143.5 6146.4 6172.4 6187.2 6223.9 6265.6 6275.2 6277.9 5960.4 6007.0 6109.0 6130.7 6191.8 03:12:34 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:67211.34 Median:39851.60 stddev:147286.98 (369.6%) stddev-sans-first:147614.82 03:12:34 INFO - PROCESS | 1639 | Values: 431.8 461.3 484.5 488.0 505.0 38484.4 40123.0 40396.0 41883.4 41947.6 40435.4 41291.2 41760.8 41877.8 41893.7 9276.2 9449.7 9460.0 9466.9 9481.5 9281.3 9281.6 9308.6 9349.4 9459.6 9330.8 9431.6 9471.1 9487.0 9495.8 9383.2 9402.1 9461.0 9474.8 9511.0 9345.6 9371.3 9427.5 9436.0 9442.3 32560.7 39382.4 39596.0 39817.6 39848.8 3288.5 3288.8 3294.0 3323.4 3373.8 29203.6 29377.7 29863.6 29998.6 30063.2 3000.2 3010.1 3023.8 3025.2 3123.2 349096.0 350183.0 352017.5 352160.0 352400.0 56017.0 56346.7 56528.7 56532.4 56631.7 57161.0 57455.0 57535.8 58294.0 58347.7 15101.6 15451.8 15678.7 15710.3 15737.8 11780.6 11898.6 11921.5 11967.6 11975.2 13987.9 14752.4 14890.5 14920.9 14960.3 3130.8 5435.8 5482.3 6200.6 6505.6 704.7 912.7 939.0 1000.4 1014.3 29748.3 30025.7 30036.4 30309.0 30333.0 911.3 1020.4 1038.8 1063.2 1109.3 15050.8 15453.3 15516.9 15546.9 15905.8 625246.0 631373.0 632351.0 632952.0 634797.0 56248.4 56692.7 56776.4 56878.7 57238.4 1322.2 1344.9 1365.3 1369.4 1375.8 29244.1 29434.6 29633.4 30303.7 30318.8 47777.5 53699.0 54293.0 54513.9 57248.0 614571.0 621862.0 622579.0 623156.0 623486.0 41207.2 41720.7 42099.6 42268.0 42278.4 45273.0 45408.0 45691.9 45725.8 46066.3 38270.6 38638.4 38641.6 39854.4 39855.8 37804.0 38100.2 38319.0 38810.6 39336.0 37279.4 37661.1 38073.0 38257.0 38313.8 32109.7 34313.7 34328.0 34484.5 34758.7 20442.4 25195.6 25471.1 25632.0 25850.0 03:12:34 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:32971.34 Median:1655.42 stddev:90525.44 (5468.4%) stddev-sans-first:90746.29 03:12:34 INFO - PROCESS | 1639 | Values: 373.8 375.2 383.6 387.8 403.8 15674.8 16705.8 16993.2 19908.4 20032.4 14739.5 19343.1 20088.9 20103.2 20164.0 5349.2 5709.9 5963.5 5974.6 6042.8 4998.4 5037.8 5912.6 5917.3 5926.0 5209.6 5361.7 5828.2 5853.3 5866.9 5795.3 5864.9 5924.1 5934.1 5937.6 5086.5 5090.4 5126.5 5168.3 5174.4 23899.4 24139.8 24234.6 24547.5 24760.6 2213.4 2363.4 2456.7 2588.7 2937.1 14934.6 15127.8 15348.4 15423.4 15777.8 1803.5 1850.8 1898.5 1904.3 1942.6 78757.0 110778.0 112881.0 116354.0 121924.2 11374.4 11628.5 11692.1 11716.5 11724.0 14447.3 14575.0 14576.1 14577.4 14601.6 8199.5 8442.2 8453.8 8490.3 8492.5 8298.3 8338.5 8342.0 8425.7 8491.6 4472.0 4508.8 4519.3 4530.2 4594.1 1750.2 1849.5 1873.6 1942.4 1946.8 867.8 868.0 919.4 922.5 934.5 20567.2 21956.3 22164.3 22243.6 22429.8 821.3 893.9 917.2 938.6 1021.8 9009.0 9456.7 9964.6 10236.8 10799.5 491449.0 492758.0 494623.0 599744.0 606897.0 105319.0 112388.4 131687.0 131928.3 137829.3 933.6 963.2 977.3 1001.5 1001.5 15831.3 18141.5 18459.7 18750.4 18773.0 53697.5 55056.3 55511.7 55789.7 55862.4 80635.0 81982.0 82484.0 83771.6 85291.1 7615.8 7674.9 7833.5 7894.3 7945.4 10816.3 12069.0 12105.2 12128.9 12356.3 10145.4 10162.5 10454.5 10525.2 10637.8 10175.3 10207.4 10217.9 10486.7 10511.8 9310.3 9815.9 10037.9 10611.9 10746.7 7585.2 7637.2 7819.9 7879.3 7991.7 9755.9 10480.5 10645.3 10752.6 10884.5 03:12:34 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5493.30 Median:5167.41 stddev:3023.24 (58.5%) stddev-sans-first:3016.41 03:12:34 INFO - PROCESS | 1639 | Values: 1445.5 1462.9 1540.7 1635.9 1709.0 7525.7 7811.0 8232.7 8646.6 8657.4 8042.8 8387.2 8396.4 8470.7 8487.7 1957.6 2115.9 2177.7 2298.5 2346.5 2331.8 2359.4 2369.9 2392.7 2394.9 2332.2 2332.6 2355.1 2369.0 2371.6 2333.9 2336.2 2355.4 2356.6 2368.7 2311.7 2366.8 2377.4 2377.8 2383.4 8539.1 8573.0 8578.2 8606.5 8630.9 5124.4 5292.9 5298.1 5301.8 5324.8 3103.7 3334.8 3476.9 3531.7 3612.0 1026.8 1033.2 1083.2 1093.5 1096.5 10927.9 11019.6 11100.4 11123.7 11247.6 4332.9 4655.6 4721.4 4722.7 4800.5 9489.8 9514.5 9578.9 9582.9 9615.6 5210.5 5254.6 5257.9 5265.8 5275.9 4116.8 4747.7 4747.8 4808.5 4849.7 3289.9 3752.0 3847.5 3856.4 3961.7 1123.4 1252.9 1257.2 1264.2 1281.9 713.5 768.2 903.5 908.4 929.1 5778.2 5782.4 5871.4 5896.2 5934.8 917.3 925.9 950.4 958.2 972.9 3814.3 3941.4 3947.1 3961.1 3962.5 9985.0 10235.3 10330.3 10345.5 10365.4 10167.2 10283.1 10308.3 10333.9 10359.2 6377.7 6934.5 7704.7 7801.9 7840.6 4745.7 5550.6 5577.8 5721.9 5807.2 9564.3 9564.9 9592.7 9599.1 9612.0 9092.6 9513.3 9517.0 9698.7 9736.1 6622.8 6859.8 6862.7 7292.3 7487.0 6739.2 7656.8 7813.6 7877.0 7893.8 6999.7 7071.8 7090.3 7122.4 7244.3 6936.2 6959.6 7030.4 7050.9 7063.2 6755.7 6779.4 6795.1 6860.3 6866.5 4921.9 4980.8 4986.1 4991.3 5007.7 4918.2 4978.3 4988.2 5051.4 5093.1 03:12:34 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4535.39 Median:5025.08 stddev:1439.59 (28.6%) stddev-sans-first:1407.94 03:12:34 INFO - PROCESS | 1639 | Values: 290.8 297.5 311.9 313.6 316.3 5154.2 5188.9 5391.5 5504.2 5505.5 4872.7 4989.8 5179.9 5268.1 5429.1 4110.4 4123.5 4123.5 4126.6 4150.9 3618.4 4156.9 4159.6 4175.3 4184.3 3797.5 4014.3 4093.0 4099.4 4122.1 4039.6 4052.5 4068.8 4069.3 4076.6 3513.9 3518.6 3528.9 3529.9 3538.2 4790.9 4814.0 5188.8 5220.5 5240.7 4380.6 4638.7 4642.9 4661.6 4662.2 4683.4 4929.2 5404.1 5522.3 5719.7 2962.1 3707.8 3809.0 3851.0 3867.2 5080.8 5446.5 5676.7 5889.8 6032.3 2941.5 3246.9 3339.0 3409.7 3863.9 3431.3 3466.7 3934.5 3963.3 3972.3 4181.9 4579.9 4591.3 4604.8 4639.8 4628.6 5704.3 5708.5 5749.6 5763.6 1099.0 1260.7 1276.2 1280.6 1287.0 752.9 791.8 830.5 861.3 867.0 4287.3 5060.4 5078.3 5112.5 5173.2 4671.5 4742.2 4873.9 5274.5 5565.5 4008.9 4571.6 4741.0 5064.4 5076.7 2408.9 2531.4 2711.9 2922.5 2959.9 4667.8 4927.6 4951.4 5536.5 5770.7 5355.4 5454.6 5565.8 5706.8 6119.4 5456.6 6034.3 6209.3 6219.2 6231.4 5222.0 5676.7 5847.8 6010.8 6017.7 4708.7 5221.3 5928.5 5936.6 5973.9 5910.6 6097.3 6117.0 6213.8 6220.8 3331.8 3865.0 4044.5 4091.9 4103.4 4883.7 5899.7 5920.0 5922.7 5949.6 5166.8 5718.8 5735.3 5776.9 5821.0 5320.1 5769.2 5769.3 5792.2 5802.8 4677.4 4950.8 5416.5 5747.0 5754.3 5538.3 5723.5 5823.3 5833.6 5868.0 5655.8 5655.8 5656.7 5688.9 5692.0 03:12:34 INFO - PROCESS | 1639 | 03:12:34 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19794.02 Median:4208.64 stddev:28945.82 (687.8%) stddev-sans-first:28991.21 03:12:34 INFO - PROCESS | 1639 | Values: 620.7 691.6 763.4 781.0 783.8 13674.7 14389.2 14535.8 14536.0 14638.1 12492.8 12605.5 12618.3 12642.6 12690.5 797.4 818.5 822.1 823.3 825.7 657.9 678.1 809.1 830.8 837.8 873.4 874.5 879.9 883.3 883.3 853.8 860.6 868.4 869.4 870.7 638.7 644.9 645.2 646.3 651.6 10032.8 13908.7 13942.0 13943.6 13990.8 12912.2 13155.0 13303.4 13340.0 13340.6 10958.8 11082.3 11326.4 11375.3 11666.8 3463.8 3664.7 3681.5 3697.8 3793.6 85727.1 88893.6 89092.0 89784.6 89847.8 10007.2 10088.9 10230.8 10354.2 10456.6 19873.6 20247.3 20262.8 20501.9 20599.4 6877.4 6886.4 6915.8 6986.4 7043.1 4026.8 4108.7 4148.5 4199.2 4218.0 3204.5 3386.2 3504.5 3515.2 3518.0 625.7 646.7 653.6 655.6 662.1 497.5 553.5 645.8 649.0 674.3 8836.4 9032.5 9104.2 9179.9 9217.9 555.2 600.4 616.6 635.6 676.9 4002.6 4143.8 4262.7 4319.6 4553.9 76418.0 101534.0 104617.0 115696.0 116405.0 65198.7 65298.3 94195.1 100515.0 104664.5 63148.0 70979.3 72318.0 94417.0 94455.5 9149.4 9442.2 9621.3 9638.9 9640.2 41788.8 51863.0 53740.0 54155.9 55077.7 73072.1 75134.0 78108.6 78215.0 82016.0 11747.4 12077.7 12265.4 12266.6 12279.1 13048.7 13078.9 13487.2 14084.2 14479.9 11467.6 11496.5 11997.0 12404.6 13358.9 12750.3 13038.4 13204.1 13337.0 13374.9 11907.4 12270.6 12713.5 12734.8 12755.4 9963.3 10346.5 10364.4 10390.7 10525.8 9080.8 11072.0 11180.2 11181.3 11272.1 03:12:34 INFO - PROCESS | 1639 | -------- Summary: end -------- 03:12:34 INFO - PROCESS | 1639 | 03:12:35 INFO - TEST-INFO | 1639: exit 0 03:12:35 INFO - TEST-OK | dromaeo_css | took 1116083ms 03:12:35 INFO - TEST-START | kraken 03:12:35 INFO - operating with platform_type : mac_ 03:12:35 INFO - Initialising browser for kraken test... 03:12:35 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpQFO5N0/profile http://localhost:49241/getInfo.html) 03:12:38 INFO - PROCESS | 1651 | 2017-01-20 03:12:38.393 plugin-container[1652:10166] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 03:12:38 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:12:38 INFO - PROCESS | 1651 | 2017-01-20 03:12:38.396 plugin-container[1652:10166] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x420f, name = 'com.apple.CFPasteboardClient' 03:12:38 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:12:38 INFO - PROCESS | 1651 | 2017-01-20 03:12:38.396 plugin-container[1652:10166] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:12:38 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 03:12:38 INFO - PROCESS | 1651 | colorDepth:24 03:12:38 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 03:12:38 INFO - PROCESS | 1651 | __metrics 03:12:38 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 03:12:39 INFO - TEST-INFO | 1651: exit 0 03:12:39 INFO - Browser initialized. 03:12:39 INFO - Running cycle 1/1 for kraken test... 03:12:39 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpQFO5N0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:42 INFO - PROCESS | 1653 | 2017-01-20 03:12:42.186 plugin-container[1654:10286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 03:12:42 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:12:42 INFO - PROCESS | 1653 | 2017-01-20 03:12:42.187 plugin-container[1654:10286] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 03:12:42 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:12:42 INFO - PROCESS | 1653 | 2017-01-20 03:12:42.187 plugin-container[1654:10286] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:12:51 INFO - PROCESS | 1653 | RSS: Main: 229179392 03:12:51 INFO - PROCESS | 1653 | 03:12:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:55 INFO - PROCESS | 1653 | RSS: Main: 241385472 03:12:55 INFO - PROCESS | 1653 | 03:12:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 03:12:59 INFO - PROCESS | 1653 | RSS: Main: 249626624 03:12:59 INFO - PROCESS | 1653 | 03:13:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 03:13:03 INFO - PROCESS | 1653 | RSS: Main: 253321216 03:13:03 INFO - PROCESS | 1653 | 03:13:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 03:13:05 INFO - PROCESS | 1653 | RSS: Main: 253734912 03:13:05 INFO - PROCESS | 1653 | 03:13:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:13:08 INFO - PROCESS | 1653 | RSS: Main: 253739008 03:13:08 INFO - PROCESS | 1653 | 03:13:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 03:13:11 INFO - PROCESS | 1653 | RSS: Main: 258043904 03:13:11 INFO - PROCESS | 1653 | 03:13:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 03:13:15 INFO - PROCESS | 1653 | RSS: Main: 257200128 03:13:15 INFO - PROCESS | 1653 | 03:13:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 03:13:19 INFO - PROCESS | 1653 | RSS: Main: 258498560 03:13:19 INFO - PROCESS | 1653 | 03:13:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:13:21 INFO - PROCESS | 1653 | RSS: Main: 257679360 03:13:21 INFO - PROCESS | 1653 | 03:13:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:13:24 INFO - PROCESS | 1653 | RSS: Main: 257753088 03:13:24 INFO - PROCESS | 1653 | 03:13:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:13:26 INFO - PROCESS | 1653 | RSS: Main: 257814528 03:13:26 INFO - PROCESS | 1653 | 03:13:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:30 INFO - PROCESS | 1653 | RSS: Main: 258068480 03:13:30 INFO - PROCESS | 1653 | 03:13:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:34 INFO - PROCESS | 1653 | RSS: Main: 258236416 03:13:34 INFO - PROCESS | 1653 | 03:13:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 03:13:36 INFO - PROCESS | 1653 | RSS: Main: 260108288 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | __start_tp_report 03:13:36 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 03:13:36 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 03:13:36 INFO - PROCESS | 1653 | |i|pagename|runs| 03:13:36 INFO - PROCESS | 1653 | |0;ai-astar;141;161;96;136;111;164;173;155;174;95 03:13:36 INFO - PROCESS | 1653 | |1;audio-beat-detection;193;144;141;147;140;119;102;152;176;111 03:13:36 INFO - PROCESS | 1653 | |2;audio-dft;193;194;197;193;191;194;195;195;198;238 03:13:36 INFO - PROCESS | 1653 | |3;audio-fft;86;60;61;96;51;72;83;82;67;82 03:13:36 INFO - PROCESS | 1653 | |4;audio-oscillator;84;73;83;104;100;105;95;68;72;88 03:13:36 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;90;87;89;87;105;86;90;87;90;86 03:13:36 INFO - PROCESS | 1653 | |6;imaging-darkroom;95;96;95;95;97;95;96;102;95;96 03:13:36 INFO - PROCESS | 1653 | |7;imaging-desaturate;93;144;73;142;140;127;89;97;88;117 03:13:36 INFO - PROCESS | 1653 | |8;json-parse-financial;57;58;56;59;61;60;57;64;83;95 03:13:36 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;71;76;68;80;81;79;74;68;67;69 03:13:36 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;86;85;85;85;86;84;84;88;84;100 03:13:36 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;141;144;142;139;144;148;177;149;177;161 03:13:36 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;166;168;167;168;172;211;167;168;165;166 03:13:36 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;68;70;68;68;70;66;70;67;68;69 03:13:36 INFO - PROCESS | 1653 | __end_tp_report 03:13:36 INFO - PROCESS | 1653 | __start_cc_report 03:13:36 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,970 03:13:36 INFO - PROCESS | 1653 | __end_cc_report 03:13:36 INFO - PROCESS | 1653 | __startTimestamp1484910816006__endTimestamp 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | ------- Summary: start ------- 03:13:36 INFO - PROCESS | 1653 | Number of tests: 14 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:140.60 Median:168.50 stddev:30.37 (18.0%) stddev-sans-first:32.21 03:13:36 INFO - PROCESS | 1653 | Values: 141.0 161.0 96.0 136.0 111.0 164.0 173.0 155.0 174.0 95.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:145.50 stddev:27.85 (19.1%) stddev-sans-first:22.76 03:13:36 INFO - PROCESS | 1653 | Values: 193.0 144.0 141.0 147.0 140.0 119.0 102.0 152.0 176.0 111.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:198.80 Median:195.00 stddev:13.92 (7.1%) stddev-sans-first:14.60 03:13:36 INFO - PROCESS | 1653 | Values: 193.0 194.0 197.0 193.0 191.0 194.0 195.0 195.0 198.0 238.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:74.00 Median:82.00 stddev:14.08 (17.2%) stddev-sans-first:14.25 03:13:36 INFO - PROCESS | 1653 | Values: 86.0 60.0 61.0 96.0 51.0 72.0 83.0 82.0 67.0 82.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:78.00 stddev:13.55 (17.4%) stddev-sans-first:14.33 03:13:36 INFO - PROCESS | 1653 | Values: 84.0 73.0 83.0 104.0 100.0 105.0 95.0 68.0 72.0 88.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:88.00 stddev:5.62 (6.4%) stddev-sans-first:5.96 03:13:36 INFO - PROCESS | 1653 | Values: 90.0 87.0 89.0 87.0 105.0 86.0 90.0 87.0 90.0 86.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:95.50 stddev:2.15 (2.3%) stddev-sans-first:2.24 03:13:36 INFO - PROCESS | 1653 | Values: 95.0 96.0 95.0 95.0 97.0 95.0 96.0 102.0 95.0 96.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:111.00 Median:80.50 stddev:26.16 (32.5%) stddev-sans-first:26.93 03:13:36 INFO - PROCESS | 1653 | Values: 93.0 144.0 73.0 142.0 140.0 127.0 89.0 97.0 88.0 117.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:60.50 stddev:13.17 (21.8%) stddev-sans-first:13.64 03:13:36 INFO - PROCESS | 1653 | Values: 57.0 58.0 56.0 59.0 61.0 60.0 57.0 64.0 83.0 95.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:75.00 stddev:5.42 (7.2%) stddev-sans-first:5.68 03:13:36 INFO - PROCESS | 1653 | Values: 71.0 76.0 68.0 80.0 81.0 79.0 74.0 68.0 67.0 69.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.00 stddev:4.83 (5.7%) stddev-sans-first:5.12 03:13:36 INFO - PROCESS | 1653 | Values: 86.0 85.0 85.0 85.0 86.0 84.0 84.0 88.0 84.0 100.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:148.50 stddev:14.43 (9.7%) stddev-sans-first:14.72 03:13:36 INFO - PROCESS | 1653 | Values: 141.0 144.0 142.0 139.0 144.0 148.0 177.0 149.0 177.0 161.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:168.00 stddev:13.90 (8.3%) stddev-sans-first:14.59 03:13:36 INFO - PROCESS | 1653 | Values: 166.0 168.0 167.0 168.0 172.0 211.0 167.0 168.0 165.0 166.0 03:13:36 INFO - PROCESS | 1653 | 03:13:36 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.42 03:13:36 INFO - PROCESS | 1653 | Values: 68.0 70.0 68.0 68.0 70.0 66.0 70.0 67.0 68.0 69.0 03:13:36 INFO - PROCESS | 1653 | -------- Summary: end -------- 03:13:36 INFO - PROCESS | 1653 | 03:13:37 INFO - TEST-INFO | 1653: exit 0 03:13:37 INFO - TEST-OK | kraken | took 61459ms 03:13:37 INFO - SUITE-END | took 1177s 03:13:37 INFO - Completed test suite (00:19:37) 03:13:37 INFO - javascript benchmark 03:13:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7169.099708709771, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.341164708823, 3416.812075335856, 3423.708984736297, 3451.6203217646053, 3460.8442620082087, 5692.971535142324, 5754.309482862052, 5756.194132821408, 5761.769529218826, 5775.133729940511, 5791.131330300457, 5855.092460668592, 5881.206037184978, 5896.0, 5897.292324921015, 5344.118220493624, 5348.973255133719, 5350.785968561253, 5352.91970620441, 5398.0, 5403.675779453226, 5410.431904650014, 5415.187721841736, 5435.782568697267, 5441.809536666217, 5266.0, 5266.289050978126, 5400.621956463049, 5401.162819762923, 5403.459654034585, 5329.920051199216, 5350.892982140354, 5372.355317361902, 5420.997115533639, 5469.781208751645, 5241.266222728821, 5357.357117145967, 5378.112611419111, 5380.838574842761, 5414.377346605152, 5904.232449781543, 5941.643501389931, 5951.58338916276, 6016.669083200422, 6016.729247183887, 6145.477634401037, 6233.625982441023, 6238.906416403757, 6249.843753906189, 6270.153529273581, 6274.152989346426, 6329.905051424233, 6331.55679102463, 6336.176297081396, 6405.391487808697, 6020.458158765732, 6025.066114752177, 6030.66831324277, 6046.093086037085, 6056.878862422727, 6323.462505686976, 6344.777932772331, 6387.936120638734, 6456.8062958110395, 6471.061696054046, 6284.43440090385, 6298.811035668938, 6306.716197771111, 6310.558260921692, 6318.905216421757, 6317.526185536011, 6366.331535188831, 6375.71309291083, 6403.583767055126, 6403.743850245938, 6141.670122563582, 6251.4061164189325, 6272.18461599989, 6282.591631543935, 6290.433860952445, 6301.212348456443, 6346.428821406095, 6346.587471814318, 6347.746090156342, 6350.777722779773, 4961.7271050092595, 5075.0, 5075.441701412841, 5082.034413461431, 5084.135696931457, 3461.9653803462147, 4401.031773009932, 4427.40230068943, 4476.597106260387, 4542.477615074243, 5688.744006519716, 5967.343592204854, 5993.4905533029305, 6005.6396616203165, 6032.668203248863, 6281.856455992663, 6307.590006649553, 6326.0, 6335.588186767845, 6355.142055822497, 5879.794207202727, 5945.4351836576325, 5948.702564871739, 5955.851103722442, 6015.909761353583, 5475.479829416199, 5506.394296627368, 5506.669599824023, 5532.1425179097305, 5545.72271386429, 4834.0, 5866.442687944638, 6378.904316435257, 6391.392817682313, 6478.028295755675, 5828.038373668467, 6244.613723489556, 6314.463270622048, 6315.115883776183, 6318.557700961072, 6327.810165695037, 6401.583897046863, 6409.166808315075, 6472.514561407819, 6504.479641628753, 5198.402183748917, 6199.628022318675, 6287.528435367274, 6294.118823364641, 6319.9052014218905, 6219.782307619212, 6227.719752611053, 6314.905276420949, 6323.873522529431, 6335.239771227482, 5882.411758824083, 6243.7814676486105, 6254.655993920378, 6258.687065646791, 6284.402981716729, 6110.7106460192745, 6143.1706719592285, 6156.353582873734, 6161.137440758208, 6192.659403732838, 5586.916196256978, 6109.868257519264, 6143.539234557516, 6146.354632763496, 6172.4136207060255, 6187.226596675416, 6223.937760622336, 6265.575646031858, 6275.215598050244, 6277.937220627735, 5960.374160713062, 6007.0, 6109.009944784373, 6130.724117414817, 6191.81424557264], "value": 5793.717228912145, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.75174274792005, 461.3149473032546, 484.4670862051743, 487.99756001219987, 504.96230246842725, 38484.42273365898, 40122.996925076885, 40396.0, 41883.371749423786, 41947.580524194746, 40435.39346909799, 41291.174176516455, 41760.791196043974, 41877.790611046905, 41893.743187704415, 9276.165145136953, 9449.669261575811, 9460.0, 9466.90533094667, 9481.47851868147, 9281.257499400066, 9281.582328795186, 9308.58111384986, 9349.439033658002, 9459.57431915562, 9330.76673083175, 9431.622735090623, 9471.147596716293, 9487.0, 9495.818900668284, 9383.24934005278, 9402.106799854002, 9461.006594307637, 9474.763130921714, 9511.048895110504, 9345.579448924815, 9371.34400591959, 9427.48148851813, 9436.0, 9442.29182811285, 32560.67439325624, 39382.40926386107, 39596.0, 39817.60182398197, 39848.80075599632, 3288.523164141186, 3288.819114948677, 3294.0, 3323.3685599736214, 3373.8481768320485, 29203.56194657082, 29377.70622293771, 29863.552046719316, 29998.550021749692, 30063.248418789488, 3000.159955212544, 3010.08192501287, 3023.7732170087334, 3025.213444504445, 3123.2348074721613, 349096.0, 350183.0, 352017.47982520104, 352160.0, 352400.0, 56017.0, 56346.718266409225, 56528.717356412955, 56532.43467565354, 56631.71684141553, 57161.0, 57455.0, 57535.84928301494, 58294.0, 58347.70826145842, 15101.622459438602, 15451.845481545266, 15678.68642627141, 15710.293036813371, 15737.819663525052, 11780.587679431179, 11898.643040708792, 11921.523139074514, 11967.581134660246, 11975.161738678384, 13987.930060349634, 14752.40990360395, 14890.478833241, 14920.925395372953, 14960.251987400587, 3130.8121512708854, 5435.755391007414, 5482.2873026507095, 6200.627962322275, 6505.642189679613, 704.6969802984663, 912.7353067610319, 939.0, 1000.3897622450299, 1014.2545229256638, 29748.256293592833, 30025.69974300229, 30036.399272014438, 30308.969103089956, 30333.0, 911.334725650279, 1020.4081632653043, 1038.8493668418037, 1063.1813503602339, 1109.3399427340719, 15050.849491505163, 15453.304601292968, 15516.922415387851, 15546.922265388826, 15905.840941590668, 625246.0, 631373.0, 632351.0, 632952.0, 634797.0, 56248.43751562514, 56692.71653641788, 56776.43223567794, 56878.715606421705, 57238.42761572414, 1322.1736414740787, 1344.8722371374704, 1365.3309878159828, 1369.4111532041118, 1375.8417781955004, 29244.122676319745, 29434.558481623222, 29633.407331853672, 30303.69696303009, 30318.84840575783, 47777.522224778695, 53699.0, 54293.0, 54513.909721806136, 57248.0, 614571.0, 621862.0, 622579.0, 623156.0, 623486.0, 41207.1758564833, 41720.74837754872, 42099.57900420957, 42268.0, 42278.36582451204, 45273.0, 45408.0, 45691.857703557675, 45725.77137114293, 46066.30900536427, 38270.617293826705, 38638.420423693104, 38641.6135838638, 39854.40218396668, 39855.80072099621, 37804.0, 38100.237995240495, 38319.0, 38810.61189388183, 39336.016599584094, 37279.44080838736, 37661.05847353838, 38073.04817379477, 38257.0, 38313.808430957666, 32109.678903210668, 34313.65686343204, 34328.0, 34484.53455089243, 34758.65241347554, 20442.38672839817, 25195.622065668664, 25471.10851120202, 25632.0, 25850.0], "value": 19366.500673630206, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7570579123569, 375.1877185892542, 383.629797245658, 387.821602063051, 403.8465383154401, 15674.843251567481, 16705.83294167058, 16993.150342482873, 19908.402747917567, 20032.399028029147, 14739.48411805587, 19343.129559169873, 20088.8995555022, 20103.19587216513, 20164.0, 5349.197620356958, 5709.885802283941, 5963.522918166536, 5974.55190860685, 6042.758289668408, 4998.425181104165, 5037.823676171335, 5912.586118971673, 5917.319508256563, 5926.0, 5209.635325527214, 5361.731913404315, 5828.242328497311, 5853.268341457318, 5866.941330586704, 5795.275590551181, 5864.853378665525, 5924.14099955504, 5934.13954976526, 5937.6140550864275, 5086.487157215535, 5090.414602320707, 5126.53861152498, 5168.320295903809, 5174.43081261061, 23899.40251493709, 24139.758602414102, 24234.636480452806, 24547.509049818902, 24760.638164900924, 2213.3581261434165, 2363.3973336799177, 2456.7297597264287, 2588.6505321781506, 2937.089502254308, 14934.551963441005, 15127.773083403757, 15348.386064557404, 15423.383064677399, 15777.842221577866, 1803.5040363900032, 1850.824171703686, 1898.515878451, 1904.2668572599648, 1942.6114777044647, 78757.0, 110778.0, 112881.0, 116354.0, 121924.17113743212, 11374.350719145677, 11628.476718547685, 11692.123090768056, 11716.472758725879, 11724.00345970585, 14447.277636118362, 14575.0, 14576.125432474086, 14577.41690332396, 14601.561953141423, 8199.549024803573, 8442.15578442151, 8453.788655283666, 8490.278326342206, 8492.532910689848, 8298.294644955246, 8338.541380224025, 8341.958290208631, 8425.705100321582, 8491.575421228914, 4471.977640111779, 4508.842190523382, 4519.254323036662, 4530.161920044737, 4594.0582180653555, 1750.2298988445043, 1849.5283702655736, 1873.5503479164902, 1942.4366933589101, 1946.8053194680701, 867.7917299847991, 868.0191383736337, 919.4207649180973, 922.4926290540176, 934.5233930695258, 20567.177312907614, 21956.341309760734, 22164.335069947927, 22243.555128897657, 22429.775702243096, 821.2980685575035, 893.8614514750224, 917.2249449215402, 938.5541867612966, 1021.836506159011, 9009.0, 9456.716298511055, 9964.551595178234, 10236.795264094677, 10799.514021869034, 491449.0, 492758.0, 494623.0, 599744.0012799995, 606897.0, 105319.0, 112388.43805780918, 131687.0, 131928.3403582976, 137829.3108534451, 933.5985526223653, 963.1764841060932, 977.3402953006835, 1001.4942454060798, 1001.5392919257223, 15831.287592058155, 18141.546461338043, 18459.723104153716, 18750.437486875417, 18773.0, 53697.463025369245, 55056.348309550776, 55511.72244138754, 55789.72105139448, 55862.441375585724, 80635.0, 81982.0, 82484.0, 83771.5811420939, 85291.14708852832, 7615.771526854203, 7674.884876726966, 7833.49082309648, 7894.250046245597, 7945.404094692805, 10816.296940698829, 12069.0, 12105.213161144497, 12128.866722689869, 12356.25862448256, 10145.391276523433, 10162.491875406347, 10454.529546170288, 10525.210609204187, 10637.787244255227, 10175.28772985884, 10207.387556746618, 10217.897821021694, 10486.685399438029, 10511.78976420452, 9310.348275620641, 9815.901840981784, 10037.946015668542, 10611.946940265248, 10746.73133171677, 7585.2035536267895, 7637.159912409742, 7819.882701759592, 7879.330256927996, 7991.72028978983, 9755.902440975784, 10480.475976201007, 10645.308054976402, 10752.569897204025, 10884.45577721095], "value": 9401.186443698962, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.5374280230324, 1462.853714628537, 1540.7149677309692, 1635.8854880158385, 1709.0087749105512, 7525.698972041126, 7810.9609451952665, 8232.711855085074, 8646.567671616418, 8657.393982421225, 8042.758717238477, 8387.16128387161, 8396.370272229577, 8470.703525376613, 8487.702930397438, 1957.6378370001523, 2115.9314546154246, 2177.7495588007346, 2298.540291941614, 2346.495503466754, 2331.755165707602, 2359.4219416243045, 2369.9052037918464, 2392.6650268962358, 2394.9342542568565, 2332.2303639798824, 2332.568474832153, 2355.1168311883043, 2368.95262094758, 2371.6442533619925, 2333.9183128590503, 2336.240721765433, 2355.3993731598503, 2356.622940329556, 2368.656544801003, 2311.7457079721216, 2366.810655147584, 2377.405648587853, 2377.7859992600575, 2383.4041489627593, 8539.06070332263, 8573.01410337813, 8578.18507241811, 8606.526641034741, 8630.870536941951, 5124.359455068116, 5292.894142117175, 5298.125809241471, 5301.787928482895, 5324.8136315228785, 3103.658597554267, 3334.7832390894514, 3476.9395334422993, 3531.6644918732677, 3612.0428086557085, 1026.768976980181, 1033.204432586904, 1083.2363183955292, 1093.4915264402011, 1096.5010920031366, 10927.945360273226, 11019.559217631286, 11100.389478578674, 11123.666290011313, 11247.606333778278, 4332.935005974913, 4655.580997710154, 4721.386219791405, 4722.677650257933, 4800.495947925488, 9489.810203796023, 9514.524273786283, 9578.9042109578, 9582.904170958202, 9615.56729947154, 5210.452902445264, 5254.632175747661, 5257.894842103136, 5265.76304066318, 5275.947240527622, 4116.764970508835, 4747.738874361943, 4747.810087596457, 4808.495108013608, 4849.660523763303, 3289.901302960915, 3752.0057184846037, 3847.480590120354, 3856.421536769507, 3961.7028722845903, 1123.3540714089268, 1252.9060320476, 1257.1953949472345, 1264.2161859647078, 1281.9359032048546, 713.4969846258375, 768.2049079202998, 903.4804987132425, 908.3959167153769, 929.149827907457, 5778.248827652463, 5782.421757824184, 5871.442212989759, 5896.204012458349, 5934.7922822701, 917.2799352508249, 925.8797851241226, 950.3632566180676, 958.1616085924816, 972.8832540095234, 3814.2752876953846, 3941.4481972523868, 3947.111899822517, 3961.1483531040963, 3962.484876965976, 9985.0, 10235.283530152967, 10330.328528645614, 10345.482725863676, 10365.429901355497, 10167.186625070124, 10283.12593429567, 10308.32995855282, 10333.86327503974, 10359.22305827066, 6377.7448902044325, 6934.47991400647, 7704.6532906019365, 7801.907732917396, 7840.568768717661, 4745.691530050535, 5550.611457198119, 5577.8047768327915, 5721.8569535761935, 5807.170741216503, 9564.282678799256, 9564.904350956402, 9592.712218633453, 9599.088086631758, 9611.990740972096, 9092.636294548143, 9513.334066615547, 9517.0, 9698.660546880825, 9736.123748862636, 6622.801315960529, 6859.759908403382, 6862.725490980305, 7292.307230813064, 7486.951826744151, 6739.191297044386, 7656.80857978555, 7813.648385822766, 7877.015373078365, 7893.802654933673, 6999.650017499002, 7071.752488662872, 7090.255523169993, 7122.430205583644, 7244.348008679244, 6936.167659880644, 6959.61722105289, 7030.367266945999, 7050.858982820418, 7063.187733410724, 6755.729770809309, 6779.35596118368, 6795.116634837637, 6860.348266914635, 6866.4506839453725, 4921.926171107365, 4980.800767969241, 4986.052649996489, 4991.251312303184, 5007.749612519432, 4918.2376731606655, 4978.32792572998, 4988.226824842155, 5051.4443411225475, 5093.0577843099145], "value": 4445.208502658508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.784819233767, 297.46010990053054, 311.9111053349795, 313.6189529721388, 316.31517764040854, 5154.226865970107, 5188.92216616751, 5391.460853914607, 5504.2018907258425, 5505.504504594591, 4872.658913876021, 4989.800407983686, 5179.949549189548, 5268.130758424865, 5429.131338985753, 4110.424540564316, 4123.525794533637, 4123.546409894909, 4126.587341265879, 4150.854720084798, 3618.3667858124854, 4156.854510092147, 4159.584041595846, 4175.269327867626, 4184.267753143203, 3797.4873392092127, 4014.3175660137845, 4092.9795351023204, 4099.3850922361735, 4122.103832237174, 4039.6162364575316, 4052.49343832021, 4068.7653315614157, 4069.3489041753323, 4076.634327500291, 3513.877014304487, 3518.577770667511, 3528.947065794015, 3529.94705079424, 3538.2392785550974, 4790.856274311776, 4814.0, 5188.844334669966, 5220.530152286313, 5240.737963101829, 4380.561943805626, 4638.744869032202, 4642.930356044662, 4661.580457758818, 4662.184117779375, 4683.414573178353, 4929.235968424864, 5404.1083221268445, 5522.282103326582, 5719.742611582489, 2962.066948911086, 3707.7589956653, 3809.0, 3850.9614903850884, 3867.2265546890735, 5080.79676812927, 5446.455354464521, 5676.659400435946, 5889.79385721502, 6032.336442991267, 2941.470535303666, 3246.9350612988083, 3338.9666103338654, 3409.7442691798215, 3863.9227215456094, 3431.3480438716565, 3466.7399945004227, 3934.4885164928946, 3963.286608410514, 3972.3048466518244, 4181.874543763692, 4579.9084018319445, 4591.311303304465, 4604.789700943566, 4639.8144074237325, 4628.60656844172, 5704.260200638762, 5708.4862362387585, 5749.568782341341, 5763.567732420085, 1098.961536346224, 1260.7352455984346, 1276.183242724657, 1280.5966120671958, 1287.0475847872694, 752.863176603322, 791.76247125862, 830.5182993863544, 861.29804209569, 867.0029466113893, 4287.335463003239, 5060.367454068241, 5078.308496496863, 5112.488751124858, 5173.224016397495, 4671.48613652498, 4742.225797908193, 4873.929424462566, 5274.525292723597, 5565.499105080562, 4008.8797336079965, 4571.611413029863, 4740.976295118571, 5064.442911279756, 5076.6953982760415, 2408.879556022192, 2531.4177739120105, 2711.9253770865303, 2922.459345021178, 2959.926001849971, 4667.789949452283, 4927.630427717864, 4951.430585482643, 5536.52939500147, 5770.711464426762, 5355.357357117093, 5454.636340914772, 5565.833025009175, 5706.828795136153, 6119.44924956756, 5456.61803673747, 6034.275886893513, 6209.2548894133, 6219.191505104308, 6231.4451075059915, 5222.0, 5676.68778217202, 5847.795327163699, 6010.819675409744, 6017.669028203491, 4708.670393072452, 5221.2690223368, 5928.458600763919, 5936.643801371932, 5973.940260597338, 5910.556708246812, 6097.2683278006925, 6117.021276595723, 6213.813585592439, 6220.782272620437, 3331.833408329622, 3865.0, 4044.4742183515955, 4091.8772436826944, 4103.363978583325, 4883.731394773179, 5899.734511946886, 5920.0, 5922.73347699346, 5949.583529152917, 5166.778285337341, 5718.828435146952, 5735.283089613798, 5776.884462310814, 5820.970895145497, 5320.068987927175, 5769.192313076257, 5769.278840144982, 5792.189093526826, 5802.796902108406, 4677.415323084614, 4950.752462376939, 5416.485433883775, 5747.023006088892, 5754.3382511010095, 5538.307711536058, 5723.484886360247, 5823.282131771053, 5833.649981001154, 5868.0, 5655.802046928337, 5655.802046928337, 5656.6888821115235, 5688.886222275449, 5691.983248878101], "value": 4068.982960293967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.7020630097551, 691.5781373362249, 763.4121726270772, 780.957047362395, 783.7687882074788, 13674.658133546654, 14389.208593527352, 14535.781963270532, 14536.0, 14638.121712697246, 12492.81260781089, 12605.495780168781, 12618.305993170372, 12642.557510487135, 12690.492380304777, 797.405932580227, 818.4802650317062, 822.1490757066438, 823.2919689067427, 825.6532256452274, 657.934206579343, 678.1252184681755, 809.0695699945052, 830.8006078541137, 837.8282452097336, 873.4148120759106, 874.5321253129576, 879.8592225243963, 883.3242569434387, 883.3419102768446, 853.8164294676612, 860.6170254236868, 868.3660927522943, 869.4261787220468, 870.7213691618684, 638.6615094000188, 644.851684112652, 645.180620611825, 646.2761706888315, 651.6025224612982, 10032.849507257397, 13908.652283692887, 13942.0, 13943.58169254924, 13990.790138147935, 12912.218738838854, 13155.0, 13303.40134693941, 13340.0, 13340.599782006555, 10958.780824383548, 11082.335059896432, 11326.43367831605, 11375.26060806045, 11666.824997625043, 3463.79217246966, 3664.6885014773775, 3681.4661874028384, 3697.796621185834, 3793.620637936212, 85727.14272857254, 88893.55553222193, 89092.0, 89784.55107724485, 89847.81217502584, 10007.199424046059, 10088.949555252177, 10230.751997610365, 10354.223433242538, 10456.581736730597, 19873.60252794936, 20247.29134480286, 20262.797372026387, 20501.897490512452, 20599.38201853947, 6877.3810357068105, 6886.380225779704, 6915.827104322432, 6986.44108471321, 7043.119610048744, 4026.838926442968, 4108.712390132662, 4148.502179738451, 4199.2441360554785, 4218.029853133797, 3204.5353423753427, 3386.153461634591, 3504.5268888700207, 3515.226650136966, 3518.0325410512314, 625.7121724006917, 646.6863571167979, 653.6241661044918, 655.5935320101568, 662.1491383572087, 497.5099526965936, 553.4907884746043, 645.8385403649088, 648.9935100648933, 674.2852576269072, 8836.41990715325, 9032.548372581345, 9104.180623743894, 9179.862302065474, 9217.907820921839, 555.2310050579975, 600.3696119074954, 616.6269407008784, 635.6472157952288, 676.8662490328679, 4002.5597184310286, 4143.751374917515, 4262.744235345889, 4319.589638984291, 4553.861534616346, 76418.0, 101534.0, 104617.0, 115696.0, 116405.0, 65198.67400662966, 65298.34701653018, 94195.05804942, 100515.0, 104664.47667761613, 63148.0, 70979.2902070983, 72318.0, 94417.0, 94455.52772236094, 9149.359544832065, 9442.15020648145, 9621.27840411986, 9638.9036109638, 9640.180584650383, 41788.79105604574, 51863.0, 53740.0, 54155.91688166136, 55077.72461137829, 73072.07711691686, 75134.0, 78108.60945695463, 78215.04462388485, 82016.0, 11747.412629368668, 12077.69805754828, 12265.448054837732, 12266.570670026505, 12279.140460167702, 13048.739025219633, 13078.934605326913, 13487.190768553919, 14084.22536760488, 14479.85520144785, 11467.623885133837, 11496.54013839437, 11997.0, 12404.62786116418, 13358.933205333911, 12750.298733569372, 13038.413271403, 13204.075714700262, 13337.0, 13374.866251337362, 11907.404629768303, 12270.607533835755, 12713.491460341484, 12734.808977865525, 12755.426005829575, 9963.302568820112, 10346.534405951901, 10364.378137311785, 10390.740231494274, 10525.78948421012, 9080.772980675272, 11072.034383099071, 11180.161487888277, 11181.273217241178, 11272.098232141245], "value": 7114.969335771417, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 161.0, 96.0, 136.0, 111.0, 164.0, 173.0, 155.0, 174.0, 95.0], "value": 140.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 144.0, 141.0, 147.0, 140.0, 119.0, 102.0, 152.0, 176.0, 111.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 194.0, 197.0, 193.0, 191.0, 194.0, 195.0, 195.0, 198.0, 238.0], "value": 198.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 60.0, 61.0, 96.0, 51.0, 72.0, 83.0, 82.0, 67.0, 82.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 73.0, 83.0, 104.0, 100.0, 105.0, 95.0, 68.0, 72.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 105.0, 86.0, 90.0, 87.0, 90.0, 86.0], "value": 89.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 97.0, 95.0, 96.0, 102.0, 95.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 144.0, 73.0, 142.0, 140.0, 127.0, 89.0, 97.0, 88.0, 117.0], "value": 111.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 59.0, 61.0, 60.0, 57.0, 64.0, 83.0, 95.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 68.0, 80.0, 81.0, 79.0, 74.0, 68.0, 67.0, 69.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 84.0, 84.0, 88.0, 84.0, 100.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 142.0, 139.0, 144.0, 148.0, 177.0, 149.0, 177.0, 161.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 167.0, 168.0, 172.0, 211.0, 167.0, 168.0, 165.0, 166.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 68.0, 70.0, 66.0, 70.0, 67.0, 68.0, 69.0], "value": 68.4, "unit": "score"}]}]} 03:13:37 INFO - Return code: 0 03:13:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:13:37 ERROR - # TBPL SUCCESS # 03:13:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:37 INFO - 2017-01-20 03:13:37.329 screenresolution[1658:10667] starting screenresolution argv=screenresolution get 03:13:37 INFO - 2017-01-20 03:13:37.332 screenresolution[1658:10667] Display 0: 1600x1200x32@60 03:13:37 INFO - 2017-01-20 03:13:37.338 screenresolution[1659:10670] starting screenresolution argv=screenresolution list 03:13:37 INFO - Available Modes on Display 0 03:13:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:37 INFO - Intel Iris: 03:13:37 INFO - Chipset Model: Intel Iris 03:13:37 INFO - Type: GPU 03:13:37 INFO - Bus: Built-In 03:13:37 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:37 INFO - Vendor: Intel (0x8086) 03:13:37 INFO - Device ID: 0x0a2e 03:13:37 INFO - Revision ID: 0x0009 03:13:37 INFO - Displays: 03:13:37 INFO - Display: 03:13:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:37 INFO - Display Serial Number: 1600x1200 60 03:13:37 INFO - Main Display: Yes 03:13:37 INFO - Mirror: Off 03:13:37 INFO - Online: Yes 03:13:37 INFO - Rotation: Supported 03:13:37 INFO - Return code: 0 03:13:37 INFO - Running post-action listener: _resource_record_post_action 03:13:37 INFO - [mozharness: 2017-01-20 11:13:37.590050Z] Finished run-tests step (success) 03:13:37 INFO - Running post-run listener: _resource_record_post_run 03:13:37 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38509056; Write bytes: 657201664; Read time: 240; Write time: 1944 03:13:37 INFO - TinderboxPrint: CPU usage
54.0% 03:13:37 INFO - TinderboxPrint: I/O read bytes / time
38,509,056 / 240 03:13:37 INFO - TinderboxPrint: I/O write bytes / time
657,201,664 / 1,944 03:13:37 INFO - TinderboxPrint: CPU idle
2,223.0 (46.0%) 03:13:37 INFO - TinderboxPrint: CPU system
972.6 (20.1%) 03:13:37 INFO - TinderboxPrint: CPU user
1,642.1 (33.9%) 03:13:37 INFO - TinderboxPrint: Swap in / out
388,648,960 / 0 03:13:37 INFO - install - Wall time: 32s; CPU: 55.0%; Read bytes: 344531456; Write bytes: 345130496; Read time: 26702; Write time: 750 03:13:37 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36723200; Write bytes: 305173504; Read time: 225; Write time: 1167 03:13:38 INFO - Running post-run listener: _upload_blobber_files 03:13:38 INFO - Blob upload gear active. 03:13:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:38 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 03:13:38 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:13:38 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:13:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:13:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:13:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:39 INFO - (blobuploader) - INFO - Done attempting. 03:13:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:13:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:41 INFO - (blobuploader) - INFO - Done attempting. 03:13:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:13:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:13:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:43 INFO - (blobuploader) - INFO - Done attempting. 03:13:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:43 INFO - Return code: 0 03:13:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a15ed310eba0374f52f16a9fd853ff72cba2924d7f555f423314b39be7b3b1669c08ce5234245f4cdc4349c2e9984c8ab8f7c9beba9523776ebba7de091bb41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20c1897083530f24dbfa004219f6b21806b0c49d0b7cf59f751b0716d8d13349220091e1cb462563d3cd257f5dbce35f00b9a627d6988549c52d827823ce67c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f530222185f522e0f07882835d5b1e57e6a96628d3d4fa973d0e4352030740c391404f851dc61569372215fa19b40dc6b3ebfe2762dd2c5017bbf2b680a053c2"} 03:13:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:43 INFO - Contents: 03:13:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a15ed310eba0374f52f16a9fd853ff72cba2924d7f555f423314b39be7b3b1669c08ce5234245f4cdc4349c2e9984c8ab8f7c9beba9523776ebba7de091bb41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20c1897083530f24dbfa004219f6b21806b0c49d0b7cf59f751b0716d8d13349220091e1cb462563d3cd257f5dbce35f00b9a627d6988549c52d827823ce67c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f530222185f522e0f07882835d5b1e57e6a96628d3d4fa973d0e4352030740c391404f851dc61569372215fa19b40dc6b3ebfe2762dd2c5017bbf2b680a053c2"} 03:13:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:43 INFO - Copying logs to upload dir... 03:13:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.749559 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-01-20 03:13:43.253276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 03:13:43.256805) ========= 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.pig0ZlMrtG/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.khor5EYJ9h/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a15ed310eba0374f52f16a9fd853ff72cba2924d7f555f423314b39be7b3b1669c08ce5234245f4cdc4349c2e9984c8ab8f7c9beba9523776ebba7de091bb41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20c1897083530f24dbfa004219f6b21806b0c49d0b7cf59f751b0716d8d13349220091e1cb462563d3cd257f5dbce35f00b9a627d6988549c52d827823ce67c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f530222185f522e0f07882835d5b1e57e6a96628d3d4fa973d0e4352030740c391404f851dc61569372215fa19b40dc6b3ebfe2762dd2c5017bbf2b680a053c2"} build_url:https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/UmqiumWxRYWSSsSQVeFRzw/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1a15ed310eba0374f52f16a9fd853ff72cba2924d7f555f423314b39be7b3b1669c08ce5234245f4cdc4349c2e9984c8ab8f7c9beba9523776ebba7de091bb41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/20c1897083530f24dbfa004219f6b21806b0c49d0b7cf59f751b0716d8d13349220091e1cb462563d3cd257f5dbce35f00b9a627d6988549c52d827823ce67c7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f530222185f522e0f07882835d5b1e57e6a96628d3d4fa973d0e4352030740c391404f851dc61569372215fa19b40dc6b3ebfe2762dd2c5017bbf2b680a053c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-20 03:13:43.291087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 03:13:43.291477) ========= 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.pig0ZlMrtG/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.khor5EYJ9h/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-20 03:13:43.340928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 03:13:43.341388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-20 03:13:43.341797) ========= ========= Total master_lag: 0.18 =========